[20:25:58.3615] Plugins::SqueezeScrobbler::Scrobbler::startTimingNewSong (1333) Starting to time: Incubus by Marillion from Fugazi (Progressive Rock) [20:25:58.3623] Plugins::SqueezeScrobbler::Scrobbler::Track::new (123) Track length is: 511.608 seconds [20:25:58.3631] Plugins::SqueezeScrobbler::Scrobbler::Track::new (134) checking for excluded genres... [20:25:58.3639] Plugins::SqueezeScrobbler::Scrobbler::Track::new (163) Track will be submitted after 240 seconds of play [20:25:58.3649] Plugins::SqueezeScrobbler::Scrobbler::Track::play (185) Restarting track countdown: 240 seconds remaining [20:25:58.3659] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (442) Artist: Marillion [20:25:58.3666] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (443) Track: Incubus [20:25:58.3674] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (444) Album: Fugazi [20:25:58.3681] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (446) Original Filename: file:///M:/Music/Play/M/Marillion/Fugazi/06%20-%20Marillion%20-%20Incubus.mp3 [20:25:58.3689] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (448) Duration in seconds: 511.608 [20:25:58.3698] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (460) Time showing on stopwatch: 0.004034 [20:25:58.3705] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (461) Remaining time: 239.995923 [20:25:58.3713] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (468) Current state of Track object: PLAYING [20:25:58.3721] Plugins::SqueezeScrobbler::Scrobbler::showCurrentVariables (1563) Is power on? : true [20:30:00.8442] Plugins::SqueezeScrobbler::Scrobbler::Track::catchup (299) Track Incubus has reached its play threshold [20:30:00.8450] Plugins::SqueezeScrobbler::Scrobbler::submitter (1448) Following track is ready to submit: [20:30:00.8458] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (442) Artist: Marillion [20:30:00.8466] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (443) Track: Incubus [20:30:00.8473] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (444) Album: Fugazi [20:30:00.8481] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (446) Original Filename: file:///M:/Music/Play/M/Marillion/Fugazi/06%20-%20Marillion%20-%20Incubus.mp3 [20:30:00.8488] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (448) Duration in seconds: 511.608 [20:30:00.8497] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (460) Time showing on stopwatch: 240 [20:30:00.8504] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (461) Remaining time: 0 [20:30:00.8512] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (468) Current state of Track object: READY [20:30:00.8521] Plugins::SqueezeScrobbler::Scrobbler::getSessionForClient (695) User ID: kweller [20:30:00.8529] Plugins::SqueezeScrobbler::Scrobbler::getSessionForUserIDPassword (669) Found existing Session for kweller [20:30:00.8546] Plugins::SqueezeScrobbler::Scrobbler::Session::addSongRecordToPendingFile (408) Writing song entry to "C:\WINDOWS\TEMP\PendingSongListV1.2_kweller.txt"... [20:30:00.8562] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (174) Session status for kweller: [20:30:00.8579] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (178) Pending submissions / Max : 1 / 1 [20:30:00.8587] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (180) Background Submit Status: 0 [20:30:00.8595] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (185) Interval Countdown remaining / elapsed / original : 0 / 120 / 120 [20:30:00.8612] Plugins::SqueezeScrobbler::Scrobbler::Session::shouldTryToSubmitToAudioscrobbler (343) It IS time to submit! [20:30:00.8619] Plugins::SqueezeScrobbler::Scrobbler::Session::tryToBackgroundSubmitToAudioscrobblerIfNeeded (302) About to attempt submit to Audioscrobbler.. [20:30:00.8632] Plugins::SqueezeScrobbler::Scrobbler::Session::doBackgroundSubmit (924) Requesting POST on URL: "http://87.117.229.205:80/protocol_1.2" [20:30:00.8640] Plugins::SqueezeScrobbler::Scrobbler::Session::doBackgroundSubmit (925) Posting data: s=adc25bc0f12f2d1ecde7696382e8ad44&a[0]=Marillion&t[0]=Incubus&i[0]=1194899158&l[0]=512&b[0]=Fugazi&m[0]=&n[0]=&r[0]=&o[0]=P& [20:30:01.2184] Plugins::SqueezeScrobbler::Scrobbler::Session::handleSubmitResponse (962) OK [20:30:01.2193] Plugins::SqueezeScrobbler::Scrobbler::Session::handleSubmitResponse (982) AudioScrobbler submit success! [20:30:01.2200] Plugins::SqueezeScrobbler::Scrobbler::Session::handleSubmitResponse (996) Clearing pending file [20:30:01.2217] Plugins::SqueezeScrobbler::Scrobbler::Session::handleTagSubmit (1079) Requesting TAG POST on URL: "http://ws.audioscrobbler.com/1.0/rw/xmlrpc.php" [20:30:01.2225] Plugins::SqueezeScrobbler::Scrobbler::Session::handleTagSubmit (1080) Posting data: <?xml version="1.0" encoding="UTF-8"?><methodCall><methodName>tagTrack</methodName><params><param><value><string>kweller</string></value></param><param><value><string>adc25bc0f12f2d1ecde7696382e8ad44</string></value></param><param><value><string>79e005b1a728748b4b283116ce4141af</string></value></param><param><value><string>Marillion</string></value></param> <param><value><string>Incubus</string></value></param> <param><value><array><data><value><string>Progressive Rock</string></value></data> </array></value></param> <param><value><string>set</string></value></param> </params></methodCall> [20:30:01.2639] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (174) Session status for kweller: [20:30:01.2653] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (178) Pending submissions / Max : 0 / 1 [20:30:01.2660] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (180) Background Submit Status: 0 [20:30:01.2669] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (185) Interval Countdown remaining / elapsed / original : 0 / 120 / 120 [20:30:03.2207] Plugins::SqueezeScrobbler::Scrobbler::Session::handleTagSubmitResponse (1124) AudioScrobbler tag submit success! [20:31:41.4736] Slim::Utils::Misc::findbin (159) Didn't find binary for lame.exe [20:34:20.3676] Slim::Player::Source::decoderUnderrun (579) 00:04:20:06:30:69: Decoder underrun while this mode: playout-play [20:34:20.3687] Slim::Player::Source::nextsong (1551) The next song is number 6, was 5 [20:34:20.3702] Slim::Player::Source::nextsong (1551) The next song is number 6, was 5 [20:34:20.3804] Slim::Player::Source::decoderUnderrun (579) 00:04:20:05:a8:71: Decoder underrun while this mode: playout-play [20:34:20.3814] Slim::Player::Source::nextsong (1551) The next song is number 6, was 5 [20:34:20.3827] Slim::Player::Source::nextsong (1551) The next song is number 6, was 5 [20:34:30.3466] Slim::Player::Source::underrun (676) 00:04:20:06:30:69: Underrun while this mode: playout-play [20:34:30.3520] Slim::Player::Source::underrun (676) 00:04:20:05:a8:71: Underrun while this mode: playout-play [20:34:30.3570] Slim::Player::Sync::checkSync (547) 00:04:20:05:a8:71 has run out of data, checking to see if we can push on... [20:34:30.3578] Slim::Player::Sync::checkSync (563) everybody's run out of data. Let's start them up... [20:34:30.3588] Slim::Player::Source::nextsong (1551) The next song is number 6, was 5 [20:34:30.3613] Slim::Player::Source::playmode (298) 00:04:20:05:a8:71: Switching to mode stop from playout-play [20:34:30.3625] Slim::Player::Source::playmode (397) 00:04:20:05:a8:71 New play mode: stop [20:34:30.3634] Slim::Player::Source::playmode (442) 00:04:20:05:a8:71: Stopping and clearing out old chunks [20:34:30.3658] Slim::Player::Source::resetSong (1590) Resetting song buffer. [20:34:30.3668] Slim::Player::Source::resetSongQueue (1424) Resetting song queue [20:34:30.3677] Slim::Player::Source::resetSongQueue (1434) Song queue is now 5 [20:34:30.3693] Slim::Player::Source::playmode (397) 00:04:20:06:30:69 New play mode: stop [20:34:30.3702] Slim::Player::Source::playmode (442) 00:04:20:06:30:69: Stopping and clearing out old chunks [20:34:30.3726] Slim::Player::Source::resetSong (1590) Resetting song buffer. [20:34:30.3735] Slim::Player::Source::resetSongQueue (1424) Resetting song queue [20:34:30.3743] Slim::Player::Source::resetSongQueue (1434) Song queue is now 5 [20:34:30.3759] Slim::Player::Source::playmode (553) 00:04:20:05:a8:71: Current playmode: stop [20:34:30.3767] Slim::Player::Source::jumpto (1162) Jumping to 6 [20:34:30.3775] Slim::Player::Source::streamingSongIndex (1350) Adding song index 6 to song queue [20:34:30.3783] Slim::Player::Source::streamingSongIndex (1354) Clearing out song queue first [20:34:30.3791] Slim::Player::Source::streamingSongIndex (1371) Song queue is now 6 [20:34:30.3805] Slim::Player::Source::playmode (298) 00:04:20:05:a8:71: Switching to mode play from stop [20:34:30.3817] Slim::Player::Source::resetSong (1590) Resetting song buffer. [20:34:30.4082] Slim::Player::Source::openSong (1685) Trying to open: file:///M:/Music/Play/T/T.%20Rex/Bolan%20Boogie/08%20-%20T.%20Rex%20-%20Ride%20a%20White%20Swan.mp3 [20:34:30.4113] Slim::Player::Source::openSong (1862) duration: [134.06] size: [2144966] endian [] offset: [14021] for file:///M:/Music/Play/T/T.%20Rex/Bolan%20Boogie/08%20-%20T.%20Rex%20-%20Ride%20a%20White%20Swan.mp3 [20:34:30.4135] Slim::Player::TranscodingHelper::getConvertCommand (203) undermax = 1, type = mp3, squeezebox2 = 00:04:20:05:a8:71 [20:34:30.4144] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wma-squeezebox2-00:04:20:05:a8:71 [20:34:30.4152] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wma-*-00:04:20:05:a8:71 [20:34:30.4160] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wma-squeezebox2-* [20:34:30.4167] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wma-*-* [20:34:30.4175] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-ogg-squeezebox2-00:04:20:05:a8:71 [20:34:30.4183] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-ogg-*-00:04:20:05:a8:71 [20:34:30.4191] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-ogg-squeezebox2-* [20:34:30.4198] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-ogg-*-* [20:34:30.4206] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-flc-squeezebox2-00:04:20:05:a8:71 [20:34:30.4214] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-flc-*-00:04:20:05:a8:71 [20:34:30.4221] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-flc-squeezebox2-* [20:34:30.4229] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-flc-*-* [20:34:30.4237] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-aif-squeezebox2-00:04:20:05:a8:71 [20:34:30.4247] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-aif-*-00:04:20:05:a8:71 [20:34:30.4255] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-aif-squeezebox2-* [20:34:30.4263] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-aif-*-* [20:34:30.4271] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wav-squeezebox2-00:04:20:05:a8:71 [20:34:30.4279] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wav-*-00:04:20:05:a8:71 [20:34:30.4287] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wav-squeezebox2-* [20:34:30.4294] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wav-*-* [20:34:30.4302] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-mp3-squeezebox2-00:04:20:05:a8:71 [20:34:30.4310] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-mp3-*-00:04:20:05:a8:71 [20:34:30.4317] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-mp3-squeezebox2-* [20:34:30.4325] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-mp3-*-* [20:34:30.4333] Slim::Player::TranscodingHelper::enabledFormat (105) Checking to see if mp3-mp3-*-* is enabled [20:34:30.4340] Slim::Player::TranscodingHelper::checkBin (146) enabled [20:34:30.4348] Slim::Player::TranscodingHelper::checkBin (148) Found command: - [20:34:30.4804] Slim::Utils::Misc::findbin (159) Didn't find binary for lame.exe [20:34:30.4813] Slim::Player::TranscodingHelper::getConvertCommand (308) Matched Format: mp3 Type: mp3 Command: - [20:34:30.4821] Slim::Player::Source::openSong (1889) This is an mp3 file: file:///M:/Music/Play/T/T.%20Rex/Bolan%20Boogie/08%20-%20T.%20Rex%20-%20Ride%20a%20White%20Swan.mp3 [20:34:30.4829] Slim::Player::Source::openSong (1890) file type: mp3 format: mp3 inrate: 128 maxRate: 0 [20:34:30.4836] Slim::Player::Source::openSong (1891) command: - [20:34:30.4848] Slim::Player::Source::openSong (1914) Opening file M:\Music\Play\T\T. Rex\Bolan Boogie\08 - T. Rex - Ride a White Swan.mp3 [20:34:30.4858] Slim::Player::Source::openSong (1918) Seeking in 14021 into M:\Music\Play\T\T. Rex\Bolan Boogie\08 - T. Rex - Ride a White Swan.mp3 [20:34:30.5156] Slim::Player::Source::openSong (1959) MP3 wasn't encoded with LAME, won't play back gapless [20:34:30.5170] Slim::Player::Source::openSong (2053) Streaming with format: mp3 [20:34:30.5588] Slim::Player::Source::playmode (397) 00:04:20:05:a8:71 New play mode: play [20:34:30.5637] Slim::Player::Source::playmode (397) 00:04:20:06:30:69 New play mode: play [20:34:30.5685] Slim::Player::Source::playmode (553) 00:04:20:05:a8:71: Current playmode: play [20:34:30.5927] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:34:30.5956] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:34:30.5982] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6007] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6033] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6058] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6084] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6109] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6135] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6191] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6217] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6243] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6269] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6295] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6321] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6347] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:34:30.6374] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:34:30.7395] Plugins::SqueezeScrobbler::Scrobbler::openCommand (900) Open command [Study (00:04:20:05:a8:71)] [20:34:30.7662] Plugins::SqueezeScrobbler::Scrobbler::noteNewTrack (1570) Noting new track Marillion - Incubus [20:34:30.7672] Plugins::SqueezeScrobbler::Scrobbler::startTimingNewSong (1333) Starting to time: Ride a White Swan by T. Rex from Bolan Boogie (Adult Contemporary) [20:34:30.7681] Plugins::SqueezeScrobbler::Scrobbler::Track::new (123) Track length is: 134.06 seconds [20:34:30.7688] Plugins::SqueezeScrobbler::Scrobbler::Track::new (134) checking for excluded genres... [20:34:30.7704] Plugins::SqueezeScrobbler::Scrobbler::Track::new (163) Track will be submitted after 67.03 seconds of play [20:34:30.7713] Plugins::SqueezeScrobbler::Scrobbler::Track::play (185) Restarting track countdown: 67.03 seconds remaining [20:34:30.7724] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (442) Artist: T. Rex [20:34:30.7731] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (443) Track: Ride a White Swan [20:34:30.7739] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (444) Album: Bolan Boogie [20:34:30.7748] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (446) Original Filename: file:///M:/Music/Play/T/T.%20Rex/Bolan%20Boogie/08%20-%20T.%20Rex%20-%20Ride%20a%20White%20Swan.mp3 [20:34:30.7755] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (448) Duration in seconds: 134.06 [20:34:30.7764] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (460) Time showing on stopwatch: 0.004193 [20:34:30.7772] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (461) Remaining time: 67.025765 [20:34:30.7779] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (468) Current state of Track object: PLAYING [20:34:30.7787] Plugins::SqueezeScrobbler::Scrobbler::showCurrentVariables (1563) Is power on? : true [20:34:30.9752] Slim::Player::Source::readNextChunk (2163) Sending 0 bytes of silence. [20:34:30.9789] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:34:30.9816] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 4380 (threshold: 4096) [20:34:30.9821] Slim::Player::Sync::checkSync (503) 00:04:20:05:a8:71 is ready to sync [20:34:30.9837] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:34:30.9901] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 4380 (threshold: 4096) [20:34:30.9906] Slim::Player::Sync::checkSync (503) 00:04:20:06:30:69 is ready to sync [20:34:30.9910] Slim::Player::Sync::checkSync (528) all clients ready to sync now. unpausing them. [20:34:31.1237] Slim::Player::Source::trackStartEvent (1461) Got a track starting event [20:34:31.1242] Slim::Player::Source::trackStartEvent (1477) Song 6 has now started playing [20:34:31.1264] Slim::Player::Source::trackStartEvent (1500) Song queue is now 6 [20:34:31.1837] Slim::Player::Source::trackStartEvent (1461) Got a track starting event [20:34:31.1840] Slim::Player::Source::trackStartEvent (1477) Song 6 has now started playing [20:34:31.1856] Slim::Player::Source::trackStartEvent (1500) Song queue is now 6 [20:34:31.1866] Slim::Player::Source::trackStartEvent (1461) Got a track starting event [20:34:31.1869] Slim::Player::Source::trackStartEvent (1477) Song 6 has now started playing [20:34:31.1881] Slim::Player::Source::trackStartEvent (1500) Song queue is now 6 [20:34:32.6261] Slim::Player::Source::readNextChunk (2268) Reduced chunksize to 15046 at end of file (2144966 - 2129920) [20:34:32.6391] Slim::Player::Source::readNextChunk (2268) Reduced chunksize to 289 at end of file (2144966 - 2144677) [20:34:32.6395] Slim::Player::Source::readNextChunk (2312) Read to end of file or pipe [20:34:32.6885] Slim::Player::Source::readNextChunk (2335) end of file or error on socket, opening next song, (song pos: 2144677(tell says: . 2159115), totalbytes: 2144966) [20:34:32.7000] Slim::Player::Source::gotoNext (1206) Opening next song... [20:34:32.7006] Slim::Player::Source::nextsong (1551) The next song is number 6, was 5 [20:34:32.7015] Slim::Player::TranscodingHelper::getConvertCommand (203) undermax = 1, type = mp3, squeezebox2 = 00:04:20:05:a8:71 [20:34:32.7018] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wma-squeezebox2-00:04:20:05:a8:71 [20:34:32.7021] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wma-*-00:04:20:05:a8:71 [20:34:32.7024] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wma-squeezebox2-* [20:34:32.7027] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wma-*-* [20:34:32.7030] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-ogg-squeezebox2-00:04:20:05:a8:71 [20:34:32.7033] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-ogg-*-00:04:20:05:a8:71 [20:34:32.7036] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-ogg-squeezebox2-* [20:34:32.7039] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-ogg-*-* [20:34:32.7042] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-flc-squeezebox2-00:04:20:05:a8:71 [20:34:32.7044] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-flc-*-00:04:20:05:a8:71 [20:34:32.7047] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-flc-squeezebox2-* [20:34:32.7050] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-flc-*-* [20:34:32.7053] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-aif-squeezebox2-00:04:20:05:a8:71 [20:34:32.7056] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-aif-*-00:04:20:05:a8:71 [20:34:32.7059] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-aif-squeezebox2-* [20:34:32.7062] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-aif-*-* [20:34:32.7065] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wav-squeezebox2-00:04:20:05:a8:71 [20:34:32.7068] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wav-*-00:04:20:05:a8:71 [20:34:32.7070] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wav-squeezebox2-* [20:34:32.7073] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wav-*-* [20:34:32.7076] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-mp3-squeezebox2-00:04:20:05:a8:71 [20:34:32.7079] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-mp3-*-00:04:20:05:a8:71 [20:34:32.7082] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-mp3-squeezebox2-* [20:34:32.7085] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-mp3-*-* [20:34:32.7088] Slim::Player::TranscodingHelper::enabledFormat (105) Checking to see if mp3-mp3-*-* is enabled [20:34:32.7091] Slim::Player::TranscodingHelper::checkBin (146) enabled [20:34:32.7094] Slim::Player::TranscodingHelper::checkBin (148) Found command: - [20:34:32.7267] Slim::Utils::Misc::findbin (159) Didn't find binary for lame.exe [20:34:32.7272] Slim::Player::TranscodingHelper::getConvertCommand (308) Matched Format: mp3 Type: mp3 Command: - [20:34:32.7275] Slim::Player::Source::gotoNext (1271) Playing out before starting next song. (old format: mp3, new: mp3) [20:34:32.7279] Slim::Player::Source::playmode (298) 00:04:20:05:a8:71: Switching to mode playout-play from play [20:34:32.7284] Slim::Player::Source::playmode (397) 00:04:20:05:a8:71 New play mode: playout-play [20:34:32.7298] Slim::Player::Source::playmode (397) 00:04:20:06:30:69 New play mode: playout-play [20:34:32.7311] Slim::Player::Source::playmode (553) 00:04:20:05:a8:71: Current playmode: playout-play [20:34:32.7316] Slim::Player::Source::dropStreamingConnection (1315) No pending chunks - we're dropping the streaming connection [20:34:32.7327] Slim::Player::Source::readNextChunk (2393) 00:04:20:05:a8:71: Can't opennext, returning no chunk. [20:34:32.7465] Slim::Player::Source::nextChunk (897) Found an empty chunk on the queue - dropping the streaming connection. [20:35:42.3358] Plugins::SqueezeScrobbler::Scrobbler::Track::catchup (299) Track Ride a White Swan has reached its play threshold [20:35:42.3366] Plugins::SqueezeScrobbler::Scrobbler::submitter (1448) Following track is ready to submit: [20:35:42.3374] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (442) Artist: T. Rex [20:35:42.3382] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (443) Track: Ride a White Swan [20:35:42.3389] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (444) Album: Bolan Boogie [20:35:42.3397] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (446) Original Filename: file:///M:/Music/Play/T/T.%20Rex/Bolan%20Boogie/08%20-%20T.%20Rex%20-%20Ride%20a%20White%20Swan.mp3 [20:35:42.3405] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (448) Duration in seconds: 134.06 [20:35:42.3413] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (460) Time showing on stopwatch: 67.03 [20:35:42.3421] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (461) Remaining time: 0 [20:35:42.3429] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (468) Current state of Track object: READY [20:35:42.3438] Plugins::SqueezeScrobbler::Scrobbler::getSessionForClient (695) User ID: kweller [20:35:42.3445] Plugins::SqueezeScrobbler::Scrobbler::getSessionForUserIDPassword (669) Found existing Session for kweller [20:35:42.3464] Plugins::SqueezeScrobbler::Scrobbler::Session::addSongRecordToPendingFile (408) Writing song entry to "C:\WINDOWS\TEMP\PendingSongListV1.2_kweller.txt"... [20:35:42.3480] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (174) Session status for kweller: [20:35:42.3496] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (178) Pending submissions / Max : 1 / 1 [20:35:42.3505] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (180) Background Submit Status: 0 [20:35:42.3514] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (185) Interval Countdown remaining / elapsed / original : 0 / 120 / 120 [20:35:42.3530] Plugins::SqueezeScrobbler::Scrobbler::Session::shouldTryToSubmitToAudioscrobbler (343) It IS time to submit! [20:35:42.3538] Plugins::SqueezeScrobbler::Scrobbler::Session::tryToBackgroundSubmitToAudioscrobblerIfNeeded (302) About to attempt submit to Audioscrobbler.. [20:35:42.3550] Plugins::SqueezeScrobbler::Scrobbler::Session::doBackgroundSubmit (924) Requesting POST on URL: "http://87.117.229.205:80/protocol_1.2" [20:35:42.3558] Plugins::SqueezeScrobbler::Scrobbler::Session::doBackgroundSubmit (925) Posting data: s=adc25bc0f12f2d1ecde7696382e8ad44&a[0]=T.%20Rex&t[0]=Ride%20a%20White%20Swan&i[0]=1194899670&l[0]=134&b[0]=Bolan%20Boogie&m[0]=&n[0]=&r[0]=&o[0]=P& [20:35:42.4278] Plugins::SqueezeScrobbler::Scrobbler::Session::handleSubmitResponse (962) OK [20:35:42.4286] Plugins::SqueezeScrobbler::Scrobbler::Session::handleSubmitResponse (982) AudioScrobbler submit success! [20:35:42.4294] Plugins::SqueezeScrobbler::Scrobbler::Session::handleSubmitResponse (996) Clearing pending file [20:35:42.4310] Plugins::SqueezeScrobbler::Scrobbler::Session::handleTagSubmit (1079) Requesting TAG POST on URL: "http://ws.audioscrobbler.com/1.0/rw/xmlrpc.php" [20:35:42.4318] Plugins::SqueezeScrobbler::Scrobbler::Session::handleTagSubmit (1080) Posting data: <?xml version="1.0" encoding="UTF-8"?><methodCall><methodName>tagTrack</methodName><params><param><value><string>kweller</string></value></param><param><value><string>adc25bc0f12f2d1ecde7696382e8ad44</string></value></param><param><value><string>79e005b1a728748b4b283116ce4141af</string></value></param><param><value><string>T. Rex</string></value></param> <param><value><string>Ride a White Swan</string></value></param> <param><value><array><data><value><string>Adult Contemporary</string></value></data> </array></value></param> <param><value><string>set</string></value></param> </params></methodCall> [20:35:42.4516] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (174) Session status for kweller: [20:35:42.4529] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (178) Pending submissions / Max : 0 / 1 [20:35:42.4537] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (180) Background Submit Status: 0 [20:35:42.4546] Plugins::SqueezeScrobbler::Scrobbler::Session::showCurrentVariables (185) Interval Countdown remaining / elapsed / original : 0 / 120 / 120 [20:35:46.6211] Plugins::SqueezeScrobbler::Scrobbler::Session::handleTagSubmitResponse (1124) AudioScrobbler tag submit success! [20:36:35.1050] Slim::Player::Source::decoderUnderrun (579) 00:04:20:06:30:69: Decoder underrun while this mode: playout-play [20:36:35.1060] Slim::Player::Source::nextsong (1551) The next song is number 6, was 5 [20:36:35.1074] Slim::Player::Source::nextsong (1551) The next song is number 6, was 5 [20:36:35.1112] Slim::Player::Source::decoderUnderrun (579) 00:04:20:05:a8:71: Decoder underrun while this mode: playout-play [20:36:35.1122] Slim::Player::Source::nextsong (1551) The next song is number 6, was 5 [20:36:35.1135] Slim::Player::Source::nextsong (1551) The next song is number 6, was 5 [20:36:45.0768] Slim::Player::Source::underrun (676) 00:04:20:06:30:69: Underrun while this mode: playout-play [20:36:45.0825] Slim::Player::Source::underrun (676) 00:04:20:05:a8:71: Underrun while this mode: playout-play [20:36:45.0872] Slim::Player::Sync::checkSync (547) 00:04:20:06:30:69 has run out of data, checking to see if we can push on... [20:36:45.0881] Slim::Player::Sync::checkSync (563) everybody's run out of data. Let's start them up... [20:36:45.0890] Slim::Player::Source::nextsong (1551) The next song is number 6, was 5 [20:36:45.0915] Slim::Player::Source::playmode (298) 00:04:20:05:a8:71: Switching to mode stop from playout-play [20:36:45.0927] Slim::Player::Source::playmode (397) 00:04:20:05:a8:71 New play mode: stop [20:36:45.0936] Slim::Player::Source::playmode (442) 00:04:20:05:a8:71: Stopping and clearing out old chunks [20:36:45.0962] Slim::Player::Source::resetSong (1590) Resetting song buffer. [20:36:45.0971] Slim::Player::Source::resetSongQueue (1424) Resetting song queue [20:36:45.0979] Slim::Player::Source::resetSongQueue (1434) Song queue is now 5 [20:36:45.0995] Slim::Player::Source::playmode (397) 00:04:20:06:30:69 New play mode: stop [20:36:45.1004] Slim::Player::Source::playmode (442) 00:04:20:06:30:69: Stopping and clearing out old chunks [20:36:45.1026] Slim::Player::Source::resetSong (1590) Resetting song buffer. [20:36:45.1034] Slim::Player::Source::resetSongQueue (1424) Resetting song queue [20:36:45.1042] Slim::Player::Source::resetSongQueue (1434) Song queue is now 5 [20:36:45.1059] Slim::Player::Source::playmode (553) 00:04:20:05:a8:71: Current playmode: stop [20:36:45.1066] Slim::Player::Source::jumpto (1162) Jumping to 6 [20:36:45.1076] Slim::Player::Source::streamingSongIndex (1350) Adding song index 6 to song queue [20:36:45.1084] Slim::Player::Source::streamingSongIndex (1354) Clearing out song queue first [20:36:45.1092] Slim::Player::Source::streamingSongIndex (1371) Song queue is now 6 [20:36:45.1106] Slim::Player::Source::playmode (298) 00:04:20:05:a8:71: Switching to mode play from stop [20:36:45.1119] Slim::Player::Source::resetSong (1590) Resetting song buffer. [20:36:45.1221] Slim::Player::Source::openSong (1685) Trying to open: file:///M:/Music/Play/D/David%20Gilmour/About%20Face/09%20-%20David%20Gilmour%20-%20Let's%20Get%20Metaphysical.mp3 [20:36:45.1253] Slim::Player::Source::openSong (1862) duration: [241.345] size: [6209967] endian [] offset: [35193] for file:///M:/Music/Play/D/David%20Gilmour/About%20Face/09%20-%20David%20Gilmour%20-%20Let's%20Get%20Metaphysical.mp3 [20:36:45.1276] Slim::Player::TranscodingHelper::getConvertCommand (203) undermax = 1, type = mp3, squeezebox2 = 00:04:20:05:a8:71 [20:36:45.1286] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wma-squeezebox2-00:04:20:05:a8:71 [20:36:45.1294] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wma-*-00:04:20:05:a8:71 [20:36:45.1301] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wma-squeezebox2-* [20:36:45.1309] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wma-*-* [20:36:45.1317] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-ogg-squeezebox2-00:04:20:05:a8:71 [20:36:45.1325] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-ogg-*-00:04:20:05:a8:71 [20:36:45.1332] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-ogg-squeezebox2-* [20:36:45.1340] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-ogg-*-* [20:36:45.1348] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-flc-squeezebox2-00:04:20:05:a8:71 [20:36:45.1355] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-flc-*-00:04:20:05:a8:71 [20:36:45.1363] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-flc-squeezebox2-* [20:36:45.1371] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-flc-*-* [20:36:45.1379] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-aif-squeezebox2-00:04:20:05:a8:71 [20:36:45.1387] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-aif-*-00:04:20:05:a8:71 [20:36:45.1395] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-aif-squeezebox2-* [20:36:45.1403] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-aif-*-* [20:36:45.1411] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wav-squeezebox2-00:04:20:05:a8:71 [20:36:45.1418] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wav-*-00:04:20:05:a8:71 [20:36:45.1426] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wav-squeezebox2-* [20:36:45.1434] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-wav-*-* [20:36:45.1441] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-mp3-squeezebox2-00:04:20:05:a8:71 [20:36:45.1449] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-mp3-*-00:04:20:05:a8:71 [20:36:45.1457] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-mp3-squeezebox2-* [20:36:45.1464] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: mp3-mp3-*-* [20:36:45.1472] Slim::Player::TranscodingHelper::enabledFormat (105) Checking to see if mp3-mp3-*-* is enabled [20:36:45.1479] Slim::Player::TranscodingHelper::checkBin (146) enabled [20:36:45.1487] Slim::Player::TranscodingHelper::checkBin (148) Found command: - [20:36:45.1942] Slim::Utils::Misc::findbin (159) Didn't find binary for lame.exe [20:36:45.1950] Slim::Player::TranscodingHelper::getConvertCommand (308) Matched Format: mp3 Type: mp3 Command: - [20:36:45.1958] Slim::Player::Source::openSong (1889) This is an mp3 file: file:///M:/Music/Play/D/David%20Gilmour/About%20Face/09%20-%20David%20Gilmour%20-%20Let's%20Get%20Metaphysical.mp3 [20:36:45.1966] Slim::Player::Source::openSong (1890) file type: mp3 format: mp3 inrate: 205 maxRate: 0 [20:36:45.1974] Slim::Player::Source::openSong (1891) command: - [20:36:45.1985] Slim::Player::Source::openSong (1914) Opening file M:\Music\Play\D\David Gilmour\About Face\09 - David Gilmour - Let's Get Metaphysical.mp3 [20:36:45.1996] Slim::Player::Source::openSong (1918) Seeking in 35193 into M:\Music\Play\D\David Gilmour\About Face\09 - David Gilmour - Let's Get Metaphysical.mp3 [20:36:45.2213] Slim::Player::Source::openSong (1945) MP3 file was encoded with LAME3.92 [20:36:45.2221] Slim::Player::Source::openSong (1947) MP3 contains encoder delay information (576/1592), will be played gapless [20:36:45.2437] Slim::Player::Source::openSong (2053) Streaming with format: mp3 [20:36:45.2989] Slim::Player::Source::playmode (397) 00:04:20:05:a8:71 New play mode: play [20:36:45.3037] Slim::Player::Source::playmode (397) 00:04:20:06:30:69 New play mode: play [20:36:45.3085] Slim::Player::Source::playmode (553) 00:04:20:05:a8:71: Current playmode: play [20:36:45.3121] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3148] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3174] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3200] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3226] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3257] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3284] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3310] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3337] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3642] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3669] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3696] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3722] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3749] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3774] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3800] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3826] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3852] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:36:45.3905] Plugins::SqueezeScrobbler::Scrobbler::openCommand (900) Open command [Study (00:04:20:05:a8:71)] [20:36:45.4196] Plugins::SqueezeScrobbler::Scrobbler::noteNewTrack (1570) Noting new track T. Rex - Ride a White Swan [20:36:45.4209] Plugins::SqueezeScrobbler::Scrobbler::startTimingNewSong (1333) Starting to time: Let's Get Metaphysical by David Gilmour from About Face (Progressive Rock) [20:36:45.4218] Plugins::SqueezeScrobbler::Scrobbler::Track::new (123) Track length is: 241.345 seconds [20:36:45.4225] Plugins::SqueezeScrobbler::Scrobbler::Track::new (134) checking for excluded genres... [20:36:45.4234] Plugins::SqueezeScrobbler::Scrobbler::Track::new (163) Track will be submitted after 120.6725 seconds of play [20:36:45.4244] Plugins::SqueezeScrobbler::Scrobbler::Track::play (185) Restarting track countdown: 120.6725 seconds remaining [20:36:45.4254] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (442) Artist: David Gilmour [20:36:45.4262] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (443) Track: Let's Get Metaphysical [20:36:45.4269] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (444) Album: About Face [20:36:45.4277] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (446) Original Filename: file:///M:/Music/Play/D/David%20Gilmour/About%20Face/09%20-%20David%20Gilmour%20-%20Let's%20Get%20Metaphysical.mp3 [20:36:45.4285] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (448) Duration in seconds: 241.345 [20:36:45.4293] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (460) Time showing on stopwatch: 0.004126 [20:36:45.4302] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (461) Remaining time: 120.668331 [20:36:45.4309] Plugins::SqueezeScrobbler::Scrobbler::Track::showCurrentVariables (468) Current state of Track object: PLAYING [20:36:45.4317] Plugins::SqueezeScrobbler::Scrobbler::showCurrentVariables (1563) Is power on? : true [20:36:45.6040] Slim::Player::Source::readNextChunk (2163) Sending 0 bytes of silence. [20:36:45.6075] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 0 (threshold: 4096) [20:36:45.6094] Slim::Player::Sync::checkSync (494) 00:04:20:05:a8:71 checking buffer fullness: 4380 (threshold: 4096) [20:36:45.6098] Slim::Player::Sync::checkSync (503) 00:04:20:05:a8:71 is ready to sync [20:36:45.6113] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 0 (threshold: 4096) [20:36:45.6193] Slim::Player::Sync::checkSync (494) 00:04:20:06:30:69 checking buffer fullness: 4380 (threshold: 4096) [20:36:45.6198] Slim::Player::Sync::checkSync (503) 00:04:20:06:30:69 is ready to sync [20:36:45.6203] Slim::Player::Sync::checkSync (528) all clients ready to sync now. unpausing them. [20:36:45.7658] Slim::Player::Source::trackStartEvent (1461) Got a track starting event [20:36:45.7662] Slim::Player::Source::trackStartEvent (1477) Song 6 has now started playing [20:36:45.7686] Slim::Player::Source::trackStartEvent (1500) Song queue is now 6 [20:36:45.8468] Slim::Player::Source::trackStartEvent (1461) Got a track starting event [20:36:45.8472] Slim::Player::Source::trackStartEvent (1477) Song 5 has now started playing [20:36:45.8484] Slim::Player::Source::trackStartEvent (1500) Song queue is now 5 [20:36:45.8495] Slim::Player::Source::trackStartEvent (1461) Got a track starting event [20:36:45.8498] Slim::Player::Source::trackStartEvent (1477) Song 5 has now started playing [20:36:45.8509] Slim::Player::Source::trackStartEvent (1500) Song queue is now 5