[08-04-11 00:16:20.1843] Slim::Player::Source::decoderUnderrun (582) 00:04:20:12:3a:6b: Decoder underrun while this mode: playout-play [08-04-11 00:16:20.1846] Slim::Player::Source::nextsong (1586) The next song is number 11, was 10 [08-04-11 00:16:20.1851] Slim::Player::Source::nextsong (1586) The next song is number 11, was 10 [08-04-11 00:16:20.1854] Slim::Player::Source::skipahead (903) **skipahead: opening next song [08-04-11 00:16:20.1857] Slim::Player::Source::gotoNext (1236) Opening next song... [08-04-11 00:16:20.1860] Slim::Player::Source::nextsong (1586) The next song is number 11, was 10 [08-04-11 00:16:20.1865] Slim::Player::TranscodingHelper::getConvertCommand (201) undermax = 1, type = flc, squeezebox2 = 00:04:20:12:3a:6b [08-04-11 00:16:20.1868] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-wma-squeezebox2-00:04:20:12:3a:6b [08-04-11 00:16:20.1870] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-wma-*-00:04:20:12:3a:6b [08-04-11 00:16:20.1872] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-wma-squeezebox2-* [08-04-11 00:16:20.1875] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-wma-*-* [08-04-11 00:16:20.1877] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-ogg-squeezebox2-00:04:20:12:3a:6b [08-04-11 00:16:20.1879] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-ogg-*-00:04:20:12:3a:6b [08-04-11 00:16:20.1881] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-ogg-squeezebox2-* [08-04-11 00:16:20.1884] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-ogg-*-* [08-04-11 00:16:20.1886] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-flc-squeezebox2-00:04:20:12:3a:6b [08-04-11 00:16:20.1888] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-flc-*-00:04:20:12:3a:6b [08-04-11 00:16:20.1890] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-flc-squeezebox2-* [08-04-11 00:16:20.1893] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-flc-*-* [08-04-11 00:16:20.1895] Slim::Player::TranscodingHelper::enabledFormat (105) Checking to see if flc-flc-*-* is enabled [08-04-11 00:16:20.1897] Slim::Player::TranscodingHelper::checkBin (146) enabled [08-04-11 00:16:20.1900] Slim::Player::TranscodingHelper::checkBin (148) Found command: - [08-04-11 00:16:20.1902] Slim::Player::TranscodingHelper::getConvertCommand (302) Matched Format: flc Type: flc Command: - [08-04-11 00:16:20.1905] Slim::Player::Source::gotoNext (1323) opening next song (old format: flc, new: flc) current playmode: playout-play [08-04-11 00:16:20.1907] Slim::Player::Source::streamingSongIndex (1380) Adding song index 11 to song queue [08-04-11 00:16:20.1910] Slim::Player::Source::streamingSongIndex (1401) Song queue is now 11,10 [08-04-11 00:16:20.1912] Slim::Player::Source::skipahead (909) **skipahead: restarting [08-04-11 00:16:20.1914] Slim::Player::Source::playmode (298) 00:04:20:12:3a:6b: Switching to mode play from playout-play [08-04-11 00:16:20.1918] Slim::Player::Source::resetSong (1625) Resetting song buffer. [08-04-11 00:16:20.2363] Slim::Player::Source::openSong (1720) Trying to open: file:///data/Audio/Albums/Cure,%20The%20-%20The%20Cure/08.%20(I%20Don%27t%20Know%20What%27s%20Going)%20On.flac [08-04-11 00:16:20.2371] Slim::Player::Source::openSong (1898) duration: [177.707] size: [22112076] endian [] offset: [0] for file:///data/Audio/Albums/Cure,%20The%20-%20The%20Cure/08.%20(I%20Don%27t%20Know%20What%27s%20Going)%20On.flac [08-04-11 00:16:20.2377] Slim::Player::TranscodingHelper::getConvertCommand (201) undermax = 1, type = flc, squeezebox2 = 00:04:20:12:3a:6b [08-04-11 00:16:20.2380] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-wma-squeezebox2-00:04:20:12:3a:6b [08-04-11 00:16:20.2382] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-wma-*-00:04:20:12:3a:6b [08-04-11 00:16:20.2384] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-wma-squeezebox2-* [08-04-11 00:16:20.2386] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-wma-*-* [08-04-11 00:16:20.2389] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-ogg-squeezebox2-00:04:20:12:3a:6b [08-04-11 00:16:20.2391] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-ogg-*-00:04:20:12:3a:6b [08-04-11 00:16:20.2393] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-ogg-squeezebox2-* [08-04-11 00:16:20.2395] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-ogg-*-* [08-04-11 00:16:20.2398] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-flc-squeezebox2-00:04:20:12:3a:6b [08-04-11 00:16:20.2400] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-flc-*-00:04:20:12:3a:6b [08-04-11 00:16:20.2402] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-flc-squeezebox2-* [08-04-11 00:16:20.2404] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: flc-flc-*-* [08-04-11 00:16:20.2407] Slim::Player::TranscodingHelper::enabledFormat (105) Checking to see if flc-flc-*-* is enabled [08-04-11 00:16:20.2409] Slim::Player::TranscodingHelper::checkBin (146) enabled [08-04-11 00:16:20.2411] Slim::Player::TranscodingHelper::checkBin (148) Found command: - [08-04-11 00:16:20.2414] Slim::Player::TranscodingHelper::getConvertCommand (302) Matched Format: flc Type: flc Command: - [08-04-11 00:16:20.2416] Slim::Player::Source::openSong (1927) This is an flc file: file:///data/Audio/Albums/Cure,%20The%20-%20The%20Cure/08.%20(I%20Don%27t%20Know%20What%27s%20Going)%20On.flac [08-04-11 00:16:20.2419] Slim::Player::Source::openSong (1928) file type: flc format: flc inrate: 995.358 maxRate: 0 [08-04-11 00:16:20.2421] Slim::Player::Source::openSong (1929) command: - [08-04-11 00:16:20.2424] Slim::Player::Source::openSong (1952) Opening file /data/Audio/Albums/Cure, The - The Cure/08. (I Don't Know What's Going) On.flac [08-04-11 00:16:20.2427] Slim::Player::Source::openSong (1956) Seeking in 0 into /data/Audio/Albums/Cure, The - The Cure/08. (I Don't Know What's Going) On.flac [08-04-11 00:16:20.2430] Slim::Player::Source::openSong (2091) Streaming with format: flc [08-04-11 00:16:20.2691] Slim::Player::Source::playmode (401) 00:04:20:12:3a:6b New play mode: play [08-04-11 00:16:20.2789] Slim::Player::Source::playmode (556) 00:04:20:12:3a:6b: Current playmode: play [08-04-11 00:16:30.0803] Slim::Player::Source::trackStartEvent (1491) Got a track starting event [08-04-11 00:16:30.0806] Slim::Player::Source::trackStartEvent (1498) Song 10 had already started, so it's not longer in the queue [08-04-11 00:16:30.0808] Slim::Player::Source::trackStartEvent (1507) Song 11 has now started playing [08-04-11 00:16:30.0853] Slim::Player::Source::trackStartEvent (1535) Song queue is now 11 [08-04-11 00:16:30.0860] Slim::Plugin::RandomPlay::Plugin::commandCallback (1014) Received command playlist newsong [08-04-11 00:16:30.0863] Slim::Plugin::RandomPlay::Plugin::commandCallback (1015) While in mode: track, from Main squeeze [08-04-11 00:16:30.0866] Slim::Plugin::RandomPlay::Plugin::commandCallback (1042) New song detected (11) [08-04-11 00:16:30.0869] Slim::Plugin::RandomPlay::Plugin::commandCallback (1055) Stripping off 1 completed track(s) [08-04-11 00:16:30.0882] Slim::Plugin::RandomPlay::Plugin::playRandom (589) Called with type track [08-04-11 00:16:30.0885] Slim::Plugin::RandomPlay::Plugin::playRandom (614) 9 songs remaining, songIndex = 10 [08-04-11 00:16:30.0999] Slim::Plugin::RandomPlay::Plugin::findAndAdd (355) Starting random selection of 1 items for type: track [08-04-11 00:16:30.1198] Slim::Plugin::RandomPlay::Plugin::findAndAdd (453) Find returned 1 items [08-04-11 00:16:30.1202] Slim::Plugin::RandomPlay::Plugin::findAndAdd (467) Adding track: Every State Line, 110 [08-04-11 00:16:30.1252] Slim::Plugin::RandomPlay::Plugin::playRandom (771) Playing continuous track mode with 21 items [08-04-11 00:16:41.8809] Slim::Player::Source::playmode (298) 00:04:20:12:3a:6b: Switching to mode pause from play [08-04-11 00:16:41.8817] Slim::Player::Source::playmode (401) 00:04:20:12:3a:6b New play mode: pause [08-04-11 00:16:41.8826] Slim::Player::Source::playmode (556) 00:04:20:12:3a:6b: Current playmode: pause [08-04-11 06:34:02.2121] Slim::Player::Source::errorOpening (1639) Error: While opening current track, so mark it as already played! [08-04-11 06:34:02.2128] Slim::Player::Source::errorOpening (1639) Backtrace: frame 0: Slim::Utils::Log::logBacktrace (/usr/share/perl5/Slim/Player/Source.pm line 1639) frame 1: Slim::Player::Source::errorOpening (/usr/share/perl5/Slim/Player/Squeezebox2.pm line 605) frame 2: Slim::Player::Squeezebox2::failedDirectStream (/usr/share/perl5/Slim/Networking/Slimproto.pm line 561) frame 3: Slim::Networking::Slimproto::_disco_handler (/usr/share/perl5/Slim/Networking/Slimproto.pm line 381) frame 4: Slim::Networking::Slimproto::client_readable (/usr/share/perl5/Slim/Networking/Select.pm line 243) frame 5: (eval) (/usr/share/perl5/Slim/Networking/Select.pm line 243) frame 6: Slim::Networking::Select::select (/usr/sbin/squeezecenter-server line 510) frame 7: main::idle (/usr/sbin/squeezecenter-server line 460) frame 8: main::main (/usr/sbin/squeezecenter-server line 1017) [08-04-11 06:34:02.2149] Slim::Player::Source::playmode (298) 00:04:20:12:3a:6b: Switching to mode stop from pause [08-04-11 06:34:02.2158] Slim::Player::Source::playmode (401) 00:04:20:12:3a:6b New play mode: stop [08-04-11 06:34:02.2161] Slim::Player::Source::playmode (444) 00:04:20:12:3a:6b: Stopping and clearing out old chunks [08-04-11 06:34:02.2169] Slim::Player::Source::resetSong (1625) Resetting song buffer. [08-04-11 06:34:02.2172] Slim::Player::Source::resetSongQueue (1454) Resetting song queue [08-04-11 06:34:02.2175] Slim::Player::Source::resetSongQueue (1464) Song queue is now 10 [08-04-11 06:34:02.2180] Slim::Player::Source::playmode (556) 00:04:20:12:3a:6b: Current playmode: stop [08-04-11 06:34:02.2186] Slim::Plugin::RandomPlay::Plugin::commandCallback (1014) Received command playlist cant_open [08-04-11 06:34:02.2189] Slim::Plugin::RandomPlay::Plugin::commandCallback (1015) While in mode: track, from Main squeeze [08-04-11 06:34:02.2191] Slim::Plugin::RandomPlay::Plugin::commandCallback (1021) Warning: Last track failed, restarting. [08-04-11 06:34:02.2194] Slim::Plugin::RandomPlay::Plugin::playRandom (589) Called with type track [08-04-11 06:34:02.2197] Slim::Plugin::RandomPlay::Plugin::playRandom (614) 10 songs remaining, songIndex = 10 [08-04-11 06:34:02.2321] Slim::Plugin::RandomPlay::Plugin::findAndAdd (355) Starting random selection of 10 items for type: track [08-04-11 06:34:02.2398] Slim::Plugin::RandomPlay::Plugin::findAndAdd (453) Find returned 10 items [08-04-11 06:34:02.2402] Slim::Plugin::RandomPlay::Plugin::findAndAdd (467) Playing track: Biscuit, 4643 [08-04-11 06:34:02.2412] Slim::Player::Source::playmode (298) 00:04:20:12:3a:6b: Switching to mode stop from stop [08-04-11 06:34:02.2415] Slim::Player::Source::playmode (305) Already in playmode stop : ignoring mode change [08-04-11 06:34:02.2426] Slim::Player::Source::streamingSongIndex (1380) Adding song index 0 to song queue [08-04-11 06:34:02.2428] Slim::Player::Source::streamingSongIndex (1384) Clearing out song queue first [08-04-11 06:34:02.2431] Slim::Player::Source::streamingSongIndex (1401) Song queue is now 0 [08-04-11 06:34:02.2473] Slim::Player::Source::playmode (298) 00:04:20:12:3a:6b: Switching to mode stop from stop [08-04-11 06:34:02.2476] Slim::Player::Source::playmode (305) Already in playmode stop : ignoring mode change [08-04-11 06:34:02.2479] Slim::Player::Source::streamingSongIndex (1380) Adding song index 0 to song queue [08-04-11 06:34:02.2481] Slim::Player::Source::streamingSongIndex (1384) Clearing out song queue first [08-04-11 06:34:02.2483] Slim::Player::Source::streamingSongIndex (1401) Song queue is now 0 [08-04-11 06:34:02.2488] Slim::Player::Source::playmode (298) 00:04:20:12:3a:6b: Switching to mode play from stop [08-04-11 06:34:02.2491] Slim::Player::Source::resetSong (1625) Resetting song buffer. [08-04-11 06:34:02.2527] Slim::Player::Source::openSong (1720) Trying to open: file:///data/Audio/Albums/Portishead%20-%20Dummy/10%20-%20Biscuit.ogg [08-04-11 06:34:02.2535] Slim::Player::Source::openSong (1898) duration: [302] size: [6149869] endian [] offset: [0] for file:///data/Audio/Albums/Portishead%20-%20Dummy/10%20-%20Biscuit.ogg [08-04-11 06:34:02.2542] Slim::Player::TranscodingHelper::getConvertCommand (201) undermax = 1, type = ogg, squeezebox2 = 00:04:20:12:3a:6b [08-04-11 06:34:02.2545] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: ogg-wma-squeezebox2-00:04:20:12:3a:6b [08-04-11 06:34:02.2547] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: ogg-wma-*-00:04:20:12:3a:6b [08-04-11 06:34:02.2549] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: ogg-wma-squeezebox2-* [08-04-11 06:34:02.2551] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: ogg-wma-*-* [08-04-11 06:34:02.2554] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: ogg-ogg-squeezebox2-00:04:20:12:3a:6b [08-04-11 06:34:02.2556] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: ogg-ogg-*-00:04:20:12:3a:6b [08-04-11 06:34:02.2558] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: ogg-ogg-squeezebox2-* [08-04-11 06:34:02.2561] Slim::Player::TranscodingHelper::checkBin (138) Checking formats for: ogg-ogg-*-* [08-04-11 06:34:02.2563] Slim::Player::TranscodingHelper::enabledFormat (105) Checking to see if ogg-ogg-*-* is enabled [08-04-11 06:34:02.2565] Slim::Player::TranscodingHelper::checkBin (146) enabled [08-04-11 06:34:02.2567] Slim::Player::TranscodingHelper::checkBin (148) Found command: - [08-04-11 06:34:02.2570] Slim::Player::TranscodingHelper::getConvertCommand (302) Matched Format: ogg Type: ogg Command: - [08-04-11 06:34:02.2573] Slim::Player::Source::openSong (1927) This is an ogg file: file:///data/Audio/Albums/Portishead%20-%20Dummy/10%20-%20Biscuit.ogg [08-04-11 06:34:02.2575] Slim::Player::Source::openSong (1928) file type: ogg format: ogg inrate: 162.91 maxRate: 0 [08-04-11 06:34:02.2578] Slim::Player::Source::openSong (1929) command: - [08-04-11 06:34:02.2581] Slim::Player::Source::openSong (1952) Opening file /data/Audio/Albums/Portishead - Dummy/10 - Biscuit.ogg [08-04-11 06:34:02.2584] Slim::Player::Source::openSong (1956) Seeking in 0 into /data/Audio/Albums/Portishead - Dummy/10 - Biscuit.ogg [08-04-11 06:34:02.2587] Slim::Player::Source::openSong (2091) Streaming with format: ogg [08-04-11 06:34:02.2780] Slim::Player::Source::playmode (401) 00:04:20:12:3a:6b New play mode: play [08-04-11 06:34:02.2847] Slim::Player::Source::playmode (556) 00:04:20:12:3a:6b: Current playmode: play [08-04-11 06:34:02.2851] Slim::Plugin::RandomPlay::Plugin::findAndAdd (490) Adding 9 tracks to end of playlist [08-04-11 06:34:02.2876] Slim::Plugin::RandomPlay::Plugin::playRandom (771) Playing continuous track mode with 10 items [08-04-11 06:34:26.3830] Slim::Player::Source::trackStartEvent (1491) Got a track starting event [08-04-11 06:34:26.4115] Slim::Player::Source::trackStartEvent (1507) Song 0 has now started playing [08-04-11 06:34:26.4125] Slim::Player::Source::trackStartEvent (1535) Song queue is now 0 [08-04-11 06:34:26.4132] Slim::Plugin::RandomPlay::Plugin::commandCallback (1014) Received command playlist newsong [08-04-11 06:34:26.4134] Slim::Plugin::RandomPlay::Plugin::commandCallback (1015) While in mode: track, from Main squeeze [08-04-11 06:34:26.4138] Slim::Plugin::RandomPlay::Plugin::commandCallback (1042) New song detected (0) [08-04-11 06:34:26.4140] Slim::Plugin::RandomPlay::Plugin::playRandom (589) Called with type track [08-04-11 06:34:26.4143] Slim::Plugin::RandomPlay::Plugin::playRandom (614) 9 songs remaining, songIndex = 0 [08-04-11 06:34:26.4252] Slim::Plugin::RandomPlay::Plugin::findAndAdd (355) Starting random selection of 1 items for type: track [08-04-11 06:34:26.4283] Slim::Plugin::RandomPlay::Plugin::findAndAdd (453) Find returned 1 items [08-04-11 06:34:26.4287] Slim::Plugin::RandomPlay::Plugin::findAndAdd (467) Adding track: Little Pieces, 2693 [08-04-11 06:34:26.4339] Slim::Plugin::RandomPlay::Plugin::playRandom (771) Playing continuous track mode with 11 items [08-04-11 06:35:00.5926] Slim::Player::Source::playmode (298) 00:04:20:12:3a:6b: Switching to mode pause from play [08-04-11 06:35:00.6245] Slim::Player::Source::playmode (401) 00:04:20:12:3a:6b New play mode: pause [08-04-11 06:35:00.6253] Slim::Player::Source::playmode (556) 00:04:20:12:3a:6b: Current playmode: pause