[09-01-15 17:02:22.1878] main::init (270) Starting SqueezeCenter (v7.3.2, r24656, Thu Jan 15 03:02:49 PST 2009) [09-01-15 17:02:29.7032] Slim::Schema::init (154) Warning: Creating new database - empty database or database from 6.3.x found [09-01-15 17:02:37.7501] Slim::Plugin::MusicMagic::Plugin::initPlugin (150) Can't connect to port 10002 - MusicIP disabled. [09-01-15 17:02:38.4220] main::checkDataSource (904) Warning: Schema updated or no tracks in the database, initiating scan. [09-01-15 17:03:42.2127] Slim::Networking::SqueezeNetwork::_error (455) Unable to login to SN: Invalid SqueezeNetwork username or password. [09-01-15 17:03:49.7957] Slim::Networking::SqueezeNetwork::_error (455) Unable to login to SN: Invalid SqueezeNetwork username or password. [09-01-15 17:07:27.8187] Slim::Utils::Misc::msg (1139) Warning: [17:07:27.8184] Use of uninitialized value in array element at /Slim/Buttons/Input/List.pm line 250. [09-01-15 17:07:27.8191] Slim::Utils::Misc::msg (1139) Warning: [17:07:27.8189] Use of uninitialized value in array element at /Slim/Buttons/Input/List.pm line 261. [09-01-15 17:07:27.8194] Slim::Utils::Misc::msg (1139) Warning: [17:07:27.8193] Use of uninitialized value in array element at /Slim/Buttons/Input/List.pm line 268. [09-01-15 17:26:38.0764] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:26:55.1013] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:26:55.3809] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:26:55.3914] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:26:55.4016] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:26:55.4119] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:26:55.4296] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:26:55.6810] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:26:55.9601] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:28:15.8752] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:28:15.9074] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:28:15.9192] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:28:15.9299] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:28:15.9490] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:29:23.4601] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:29:24.2074] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:29:24.8307] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:29:24.8451] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:29:24.8724] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:29:40.9094] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:30:12.4987] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 17:53:35.0528] Slim::Networking::SqueezeNetwork::Players::_players_error (146) Unable to get players from SN: Timed out waiting for data, retrying in 300 seconds [09-01-15 18:09:48.5490] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:09:48.7296] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:10:00.4454] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:10:00.8038] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:10:15.7238] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:10:15.7422] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:10:15.9019] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:10:15.9129] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:10:15.9357] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:10:55.1917] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:10:55.5923] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:11:03.0797] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:11:15.5300] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:11:15.7927] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:11:30.6683] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:11:30.7179] Slim::Web::JSONRPC::requestMethod (383) request not dispatchable! [09-01-15 18:14:44.2543] Slim::Player::StreamingController::playerEndOfStream (1718) 00:04:20:06:5c:41 [09-01-15 18:14:44.2547] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart [09-01-15 18:14:44.2551] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:14:44.2553] Slim::Player::StreamingController::_AutoStart (1184) autostart possibly short track [09-01-15 18:14:44.2607] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:44.2613] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:44.9931] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:45.2610] Slim::Player::StreamingController::playerReadyToStream (1652) 00:04:20:06:5c:41 [09-01-15 18:14:45.2615] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore [09-01-15 18:14:45.2618] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state IDLE [09-01-15 18:14:45.2622] Slim::Player::StreamingController::nextsong (754) The next song is number 9, was 8 [09-01-15 18:14:45.2672] Slim::Player::Song::new (64) index 9 -> file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/01%20-%20Marching%20Bands%20Of%20Manhattan.mpc [09-01-15 18:14:45.2676] Slim::Player::Song::new (101) live=3 [09-01-15 18:14:45.2679] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state TRACKWAIT [09-01-15 18:14:45.2683] Slim::Player::Song::getNextSong (178) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/01%20-%20Marching%20Bands%20Of%20Manhattan.mpc [09-01-15 18:14:45.2687] Slim::Player::StreamingController::_nextTrackReady (646) 00:04:20:06:5c:41: nextTrack will be index 9 [09-01-15 18:14:45.2690] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady [09-01-15 18:14:45.2694] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: ReadyToStream - new state PLAYING-TRACKWAIT [09-01-15 18:14:45.9928] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:46.9932] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:47.0210] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:47.0219] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:47.9850] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:48.9926] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:49.9850] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:50.9928] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:51.9850] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:52.0102] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:52.0110] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:52.9926] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:53.1405] Slim::Player::StreamingController::playerTrackStarted (1634) 00:04:20:06:5c:41 [09-01-15 18:14:53.1410] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: Started in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_PlayAndStream [09-01-15 18:14:53.1414] Slim::Player::StreamingController::_setPlayingState (1809) new playing state PLAYING [09-01-15 18:14:53.1417] Slim::Player::StreamingController::_Playing (353) Song 7 is not longer in the queue [09-01-15 18:14:53.1421] Slim::Player::Song::DESTROY (111) DESTROY(Slim::Player::Song=HASH(0x667ae50)) live=2: index=7, url=file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/Copy%20of%2008%20-%20Crooked%20Teeth.mp3 [09-01-15 18:14:53.1431] Slim::Player::StreamingController::_Playing (359) Song 8 has now started playing [09-01-15 18:14:53.1441] Slim::Player::StreamingController::_Playing (388) Song queue is now 8 [09-01-15 18:14:53.1445] Slim::Player::StreamingController::_Stream (920) 00:04:20:06:5c:41: preparing to stream song index 9 [09-01-15 18:14:53.1448] Slim::Player::StreamingController::_Stream (935) Song queue is now 9,8 [09-01-15 18:14:53.1452] Slim::Player::Song::open (302) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/01%20-%20Marching%20Bands%20Of%20Manhattan.mpc [09-01-15 18:14:53.1466] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:14:53.1470] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:53.1473] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:14:53.1476] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:14:53.1478] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:14:53.1482] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:53.1484] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:14:53.1487] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:14:53.1490] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:14:53.1493] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:53.1496] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:14:53.1499] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:14:53.1502] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:14:53.1505] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:14:53.1508] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:53.1511] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:14:53.1514] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - because no available stream mode supported: F [09-01-15 18:14:53.1517] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:53.1520] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-00:04:20:06:5c:41 [09-01-15 18:14:53.1522] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-* [09-01-15 18:14:53.1525] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-* [09-01-15 18:14:53.1528] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-aif-*-* is enabled [09-01-15 18:14:53.1531] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:53.1534] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-be --silent --prev --gain 2 - - [09-01-15 18:14:53.1537] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-be --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:14:53.1539] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:53.1542] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-00:04:20:06:5c:41 [09-01-15 18:14:53.1545] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-* [09-01-15 18:14:53.1548] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-* [09-01-15 18:14:53.1551] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-wav-*-* is enabled [09-01-15 18:14:53.1554] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:53.1556] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-le --silent --prev --gain 2 - - [09-01-15 18:14:53.1559] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-le --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:14:53.1574] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:53.1577] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-00:04:20:06:5c:41 [09-01-15 18:14:53.1580] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-* [09-01-15 18:14:53.1583] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-* [09-01-15 18:14:53.1586] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-mp3-*-* is enabled [09-01-15 18:14:53.1588] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:53.1591] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 3 - - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - - [09-01-15 18:14:53.2194] Slim::Player::TranscodingHelper::checkBin (260) couldn't find binary for: lame [09-01-15 18:14:53.2198] Slim::Player::TranscodingHelper::getConvertCommand2 (451) Error: Didn't find any command matches for type: mpc [09-01-15 18:14:53.2201] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmpc [09-01-15 18:14:53.2207] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:14:53.2211] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:53.2226] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:14:53.2230] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:14:53.2233] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:14:53.2235] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:53.2239] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:14:53.2241] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:14:53.2244] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:14:53.2247] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:53.2250] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:14:53.2253] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:14:53.2256] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:14:53.2258] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:14:53.2261] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:53.2264] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:14:53.2268] Slim::Player::TranscodingHelper::getConvertCommand2 (454) Matched: mpc->flc via: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:14:53.2271] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc [09-01-15 18:14:53.2274] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/01%20-%20Marching%20Bands%20Of%20Manhattan.mpc] [09-01-15 18:14:53.2287] Slim::Player::Protocols::File::open (79) duration: [252.56] size: [7235694] endian [] offset: [0] for file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/01%20-%20Marching%20Bands%20Of%20Manhattan.mpc [09-01-15 18:14:53.2290] Slim::Player::Protocols::File::open (96) Opening file F:\Music\A-Z\A-F\D\Death Cab For Cutie\Plans (2005)\01 - Marching Bands Of Manhattan.mpc [09-01-15 18:14:53.2298] Slim::Player::Song::open (385) URL is a song (audio): file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/01%20-%20Marching%20Bands%20Of%20Manhattan.mpc, type=mpc [09-01-15 18:14:53.2311] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (557) Using command for conversion: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:14:53.2314] Slim::Player::Song::open (457) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:14:53.2378] Slim::Player::Pipeline::new (93) Launching process with command: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\socketwrapper.exe" -D -i 2108 -o 2107 -c "\"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe\" --silent --prev --gain 2 - - | \"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe\" -cs --totally-silent --compression-level-0 -" [09-01-15 18:14:53.2542] Slim::Player::SongStreamController::new (32) live=2 [09-01-15 18:14:53.2548] Slim::Player::SongStreamController::DESTROY (45) DESTROY(Slim::Player::SongStreamController=HASH(0x5b63910)) live=1 [09-01-15 18:14:53.2551] Slim::Player::StreamingController::_Stream (976) 00:04:20:06:5c:41: stream [09-01-15 18:14:53.2584] Slim::Player::StreamingController::_Stream (1005) Song queue is now 9,8 [09-01-15 18:14:53.2588] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMING [09-01-15 18:14:53.2591] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: Started - new state PLAYING-STREAMING [09-01-15 18:14:53.3656] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:53.3663] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:53.3668] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:53.3888] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:53.4456] Slim::Player::Pipeline::acceptWriter (230) Pipeline writer connected [09-01-15 18:14:53.4484] Slim::Player::Pipeline::acceptReader (199) Pipeline reader connected [09-01-15 18:14:53.9219] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:53.9224] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:53.9237] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:53.9240] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:53.9244] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:53.9251] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:53.9254] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:53.9257] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:53.9264] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:53.9267] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:53.9270] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:53.9277] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:53.9280] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:53.9283] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:53.9289] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:53.9292] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:53.9295] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:53.9946] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:53.9952] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:53.9962] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:53.9965] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:53.9968] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:53.9975] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:53.9978] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:53.9981] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:53.9988] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:53.9991] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:53.9994] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:54.0000] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:54.0002] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:54.0006] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:54.0191] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:54.0353] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:54.0512] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:54.0671] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:54.0829] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:54.0991] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:54.0996] Slim::Player::Source::_readNextChunk (476) Read to end of file or pipe [09-01-15 18:14:54.0999] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 8646745 [09-01-15 18:14:54.1002] Slim::Player::Source::_readNextChunk (515) 00:04:20:06:5c:41 mark end of stream [09-01-15 18:14:54.1022] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout [09-01-15 18:14:54.1025] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:14:54.1028] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: LocalEndOfStream - new state PLAYING-STREAMOUT [09-01-15 18:14:54.5146] Slim::Player::StreamingController::playerEndOfStream (1718) 00:04:20:06:5c:41 [09-01-15 18:14:54.5151] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart [09-01-15 18:14:54.5153] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:14:54.5156] Slim::Player::StreamingController::_AutoStart (1184) autostart possibly short track [09-01-15 18:14:54.5186] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:54.5194] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:54.9381] Slim::Player::StreamingController::playerReadyToStream (1652) 00:04:20:06:5c:41 [09-01-15 18:14:54.9385] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore [09-01-15 18:14:54.9388] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state IDLE [09-01-15 18:14:54.9392] Slim::Player::StreamingController::nextsong (754) The next song is number 10, was 9 [09-01-15 18:14:54.9455] Slim::Player::Song::new (64) index 10 -> file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/09%20-%20What%20Sarah%20Said.mpc [09-01-15 18:14:54.9460] Slim::Player::Song::new (101) live=3 [09-01-15 18:14:54.9463] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state TRACKWAIT [09-01-15 18:14:54.9467] Slim::Player::Song::getNextSong (178) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/09%20-%20What%20Sarah%20Said.mpc [09-01-15 18:14:54.9471] Slim::Player::StreamingController::_nextTrackReady (646) 00:04:20:06:5c:41: nextTrack will be index 10 [09-01-15 18:14:54.9474] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady [09-01-15 18:14:54.9490] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: ReadyToStream - new state PLAYING-TRACKWAIT [09-01-15 18:14:54.9833] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:55.1462] Slim::Player::StreamingController::playerTrackStarted (1634) 00:04:20:06:5c:41 [09-01-15 18:14:55.1466] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: Started in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_PlayAndStream [09-01-15 18:14:55.1469] Slim::Player::StreamingController::_setPlayingState (1809) new playing state PLAYING [09-01-15 18:14:55.1472] Slim::Player::StreamingController::_Playing (353) Song 8 is not longer in the queue [09-01-15 18:14:55.1493] Slim::Player::Song::DESTROY (111) DESTROY(Slim::Player::Song=HASH(0x5de4498)) live=2: index=8, url=file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/02%20-%20Soul%20Meets%20Body.mpc [09-01-15 18:14:55.1504] Slim::Player::StreamingController::_Playing (359) Song 9 has now started playing [09-01-15 18:14:55.1515] Slim::Player::StreamingController::_Playing (388) Song queue is now 9 [09-01-15 18:14:55.1518] Slim::Player::StreamingController::_Stream (920) 00:04:20:06:5c:41: preparing to stream song index 10 [09-01-15 18:14:55.1521] Slim::Player::StreamingController::_Stream (935) Song queue is now 10,9 [09-01-15 18:14:55.1525] Slim::Player::Song::open (302) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/09%20-%20What%20Sarah%20Said.mpc [09-01-15 18:14:55.1540] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:14:55.1543] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:55.1546] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:14:55.1549] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:14:55.1552] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:14:55.1555] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:55.1570] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:14:55.1574] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:14:55.1576] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:14:55.1579] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:55.1582] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:14:55.1585] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:14:55.1588] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:14:55.1591] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:14:55.1594] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:55.1597] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:14:55.1600] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - because no available stream mode supported: F [09-01-15 18:14:55.1603] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:55.1606] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-00:04:20:06:5c:41 [09-01-15 18:14:55.1608] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-* [09-01-15 18:14:55.1611] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-* [09-01-15 18:14:55.1614] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-aif-*-* is enabled [09-01-15 18:14:55.1617] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:55.1620] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-be --silent --prev --gain 2 - - [09-01-15 18:14:55.1623] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-be --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:14:55.1626] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:55.1629] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-00:04:20:06:5c:41 [09-01-15 18:14:55.1632] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-* [09-01-15 18:14:55.1635] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-* [09-01-15 18:14:55.1653] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-wav-*-* is enabled [09-01-15 18:14:55.1657] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:55.1659] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-le --silent --prev --gain 2 - - [09-01-15 18:14:55.1663] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-le --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:14:55.1665] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:55.1668] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-00:04:20:06:5c:41 [09-01-15 18:14:55.1671] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-* [09-01-15 18:14:55.1674] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-* [09-01-15 18:14:55.1677] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-mp3-*-* is enabled [09-01-15 18:14:55.1679] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:55.1682] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 3 - - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - - [09-01-15 18:14:55.2304] Slim::Player::TranscodingHelper::checkBin (260) couldn't find binary for: lame [09-01-15 18:14:55.2307] Slim::Player::TranscodingHelper::getConvertCommand2 (451) Error: Didn't find any command matches for type: mpc [09-01-15 18:14:55.2310] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmpc [09-01-15 18:14:55.2316] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:14:55.2320] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:55.2323] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:14:55.2325] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:14:55.2328] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:14:55.2331] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:55.2334] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:14:55.2337] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:14:55.2340] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:14:55.2343] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:55.2345] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:14:55.2348] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:14:55.2351] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:14:55.2354] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:14:55.2375] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:55.2378] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:14:55.2382] Slim::Player::TranscodingHelper::getConvertCommand2 (454) Matched: mpc->flc via: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:14:55.2385] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc [09-01-15 18:14:55.2388] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/09%20-%20What%20Sarah%20Said.mpc] [09-01-15 18:14:55.2402] Slim::Player::Protocols::File::open (79) duration: [380.867] size: [11633022] endian [] offset: [0] for file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/09%20-%20What%20Sarah%20Said.mpc [09-01-15 18:14:55.2408] Slim::Player::Protocols::File::open (96) Opening file F:\Music\A-Z\A-F\D\Death Cab For Cutie\Plans (2005)\09 - What Sarah Said.mpc [09-01-15 18:14:55.2417] Slim::Player::Song::open (385) URL is a song (audio): file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/09%20-%20What%20Sarah%20Said.mpc, type=mpc [09-01-15 18:14:55.2429] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (557) Using command for conversion: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:14:55.2432] Slim::Player::Song::open (457) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:14:55.2637] Slim::Player::Pipeline::new (93) Launching process with command: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\socketwrapper.exe" -D -i 2112 -o 2111 -c "\"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe\" --silent --prev --gain 2 - - | \"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe\" -cs --totally-silent --compression-level-0 -" [09-01-15 18:14:55.2801] Slim::Player::SongStreamController::new (32) live=2 [09-01-15 18:14:55.2807] Slim::Player::SongStreamController::DESTROY (45) DESTROY(Slim::Player::SongStreamController=HASH(0x5de50b0)) live=1 [09-01-15 18:14:55.2810] Slim::Player::StreamingController::_Stream (976) 00:04:20:06:5c:41: stream [09-01-15 18:14:55.2845] Slim::Player::StreamingController::_Stream (1005) Song queue is now 10,9 [09-01-15 18:14:55.2850] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMING [09-01-15 18:14:55.2853] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: Started - new state PLAYING-STREAMING [09-01-15 18:14:55.2892] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:55.2901] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:55.2930] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:55.3063] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:55.3394] Slim::Player::Pipeline::acceptWriter (230) Pipeline writer connected [09-01-15 18:14:55.3414] Slim::Player::Pipeline::acceptReader (199) Pipeline reader connected [09-01-15 18:14:55.7198] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:55.7203] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.7220] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:55.7224] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:55.7227] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.7234] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:55.7237] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:55.7240] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.7247] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:55.7250] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:55.7255] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.7262] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:55.7265] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:55.7268] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.7275] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:55.7278] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:55.7281] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.7284] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:55.7287] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:55.7291] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.7303] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.7537] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.7546] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:55.7549] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:55.7553] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.7560] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:55.7563] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:55.7566] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.7575] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:55.7579] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:55.7582] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.7777] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.7788] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.8114] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.8277] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.8289] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.8299] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:55.8303] Slim::Player::Source::_readNextChunk (476) Read to end of file or pipe [09-01-15 18:14:55.8306] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 8868956 [09-01-15 18:14:55.8309] Slim::Player::Source::_readNextChunk (515) 00:04:20:06:5c:41 mark end of stream [09-01-15 18:14:55.8342] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout [09-01-15 18:14:55.8346] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:14:55.8349] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: LocalEndOfStream - new state PLAYING-STREAMOUT [09-01-15 18:14:55.9927] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:56.2533] Slim::Player::StreamingController::playerEndOfStream (1718) 00:04:20:06:5c:41 [09-01-15 18:14:56.2539] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart [09-01-15 18:14:56.2542] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:14:56.2545] Slim::Player::StreamingController::_AutoStart (1184) autostart possibly short track [09-01-15 18:14:56.2651] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:56.2658] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:56.6408] Slim::Player::StreamingController::playerReadyToStream (1652) 00:04:20:06:5c:41 [09-01-15 18:14:56.6413] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore [09-01-15 18:14:56.6416] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state IDLE [09-01-15 18:14:56.6420] Slim::Player::StreamingController::nextsong (754) The next song is number 11, was 10 [09-01-15 18:14:56.6468] Slim::Player::Song::new (64) index 11 -> file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/10%20-%20Brothers%20On%20A%20Hotel%20Bed.mpc [09-01-15 18:14:56.6473] Slim::Player::Song::new (101) live=3 [09-01-15 18:14:56.6476] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state TRACKWAIT [09-01-15 18:14:56.6480] Slim::Player::Song::getNextSong (178) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/10%20-%20Brothers%20On%20A%20Hotel%20Bed.mpc [09-01-15 18:14:56.6484] Slim::Player::StreamingController::_nextTrackReady (646) 00:04:20:06:5c:41: nextTrack will be index 11 [09-01-15 18:14:56.6488] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady [09-01-15 18:14:56.6491] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: ReadyToStream - new state PLAYING-TRACKWAIT [09-01-15 18:14:56.9850] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:57.0112] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:57.0121] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:57.8614] Slim::Player::StreamingController::playerTrackStarted (1634) 00:04:20:06:5c:41 [09-01-15 18:14:57.8618] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: Started in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_PlayAndStream [09-01-15 18:14:57.8621] Slim::Player::StreamingController::_setPlayingState (1809) new playing state PLAYING [09-01-15 18:14:57.8624] Slim::Player::StreamingController::_Playing (353) Song 9 is not longer in the queue [09-01-15 18:14:57.8628] Slim::Player::Song::DESTROY (111) DESTROY(Slim::Player::Song=HASH(0x6689f28)) live=2: index=9, url=file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/01%20-%20Marching%20Bands%20Of%20Manhattan.mpc [09-01-15 18:14:57.8639] Slim::Player::StreamingController::_Playing (359) Song 10 has now started playing [09-01-15 18:14:57.8649] Slim::Player::StreamingController::_Playing (388) Song queue is now 10 [09-01-15 18:14:57.8652] Slim::Player::StreamingController::_Stream (920) 00:04:20:06:5c:41: preparing to stream song index 11 [09-01-15 18:14:57.8655] Slim::Player::StreamingController::_Stream (935) Song queue is now 11,10 [09-01-15 18:14:57.8659] Slim::Player::Song::open (302) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/10%20-%20Brothers%20On%20A%20Hotel%20Bed.mpc [09-01-15 18:14:57.8674] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:14:57.8678] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:57.8681] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:14:57.8683] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:14:57.8686] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:14:57.8689] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:57.8692] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:14:57.8695] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:14:57.8698] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:14:57.8701] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:57.8703] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:14:57.8706] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:14:57.8709] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:14:57.8712] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:14:57.8715] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:57.8718] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:14:57.8721] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - because no available stream mode supported: F [09-01-15 18:14:57.8724] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:57.8727] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-00:04:20:06:5c:41 [09-01-15 18:14:57.8729] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-* [09-01-15 18:14:57.8732] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-* [09-01-15 18:14:57.8735] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-aif-*-* is enabled [09-01-15 18:14:57.8738] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:57.8741] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-be --silent --prev --gain 2 - - [09-01-15 18:14:57.8744] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-be --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:14:57.8747] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:57.8750] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-00:04:20:06:5c:41 [09-01-15 18:14:57.8752] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-* [09-01-15 18:14:57.8755] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-* [09-01-15 18:14:57.8758] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-wav-*-* is enabled [09-01-15 18:14:57.8761] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:57.8764] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-le --silent --prev --gain 2 - - [09-01-15 18:14:57.8767] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-le --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:14:57.8770] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:57.8773] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-00:04:20:06:5c:41 [09-01-15 18:14:57.8775] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-* [09-01-15 18:14:57.8778] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-* [09-01-15 18:14:57.8781] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-mp3-*-* is enabled [09-01-15 18:14:57.8784] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:57.8787] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 3 - - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - - [09-01-15 18:14:57.9311] Slim::Player::TranscodingHelper::checkBin (260) couldn't find binary for: lame [09-01-15 18:14:57.9314] Slim::Player::TranscodingHelper::getConvertCommand2 (451) Error: Didn't find any command matches for type: mpc [09-01-15 18:14:57.9318] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmpc [09-01-15 18:14:57.9323] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:14:57.9327] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:57.9330] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:14:57.9333] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:14:57.9335] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:14:57.9338] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:57.9341] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:14:57.9344] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:14:57.9347] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:14:57.9350] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:57.9352] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:14:57.9355] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:14:57.9358] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:14:57.9361] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:14:57.9364] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:57.9367] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:14:57.9370] Slim::Player::TranscodingHelper::getConvertCommand2 (454) Matched: mpc->flc via: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:14:57.9373] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc [09-01-15 18:14:57.9376] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/10%20-%20Brothers%20On%20A%20Hotel%20Bed.mpc] [09-01-15 18:14:57.9388] Slim::Player::Protocols::File::open (79) duration: [271.133] size: [7867179] endian [] offset: [0] for file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/10%20-%20Brothers%20On%20A%20Hotel%20Bed.mpc [09-01-15 18:14:57.9404] Slim::Player::Protocols::File::open (96) Opening file F:\Music\A-Z\A-F\D\Death Cab For Cutie\Plans (2005)\10 - Brothers On A Hotel Bed.mpc [09-01-15 18:14:57.9415] Slim::Player::Song::open (385) URL is a song (audio): file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/10%20-%20Brothers%20On%20A%20Hotel%20Bed.mpc, type=mpc [09-01-15 18:14:57.9427] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (557) Using command for conversion: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:14:57.9430] Slim::Player::Song::open (457) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:14:57.9529] Slim::Player::Pipeline::new (93) Launching process with command: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\socketwrapper.exe" -D -i 2116 -o 2115 -c "\"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe\" --silent --prev --gain 2 - - | \"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe\" -cs --totally-silent --compression-level-0 -" [09-01-15 18:14:58.0001] Slim::Player::SongStreamController::new (32) live=2 [09-01-15 18:14:58.0007] Slim::Player::SongStreamController::DESTROY (45) DESTROY(Slim::Player::SongStreamController=HASH(0x5aaa918)) live=1 [09-01-15 18:14:58.0011] Slim::Player::StreamingController::_Stream (976) 00:04:20:06:5c:41: stream [09-01-15 18:14:58.0038] Slim::Player::StreamingController::_Stream (1005) Song queue is now 11,10 [09-01-15 18:14:58.0043] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMING [09-01-15 18:14:58.0046] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: Started - new state PLAYING-STREAMING [09-01-15 18:14:58.0614] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:58.0621] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:58.0627] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:58.0735] Slim::Player::Pipeline::acceptWriter (230) Pipeline writer connected [09-01-15 18:14:58.0758] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:58.0769] Slim::Player::Pipeline::acceptReader (199) Pipeline reader connected [09-01-15 18:14:58.4797] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:58.4801] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.4822] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:58.4826] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:58.4829] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.4842] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:58.4845] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:58.4848] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.4855] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:58.4858] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:58.4861] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.4868] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:58.4871] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:58.4874] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.4881] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:58.4884] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:58.4887] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.4893] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:58.4896] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:58.4899] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.4912] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.5470] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.5479] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:58.5482] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:58.5486] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.5493] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:58.5496] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:58.5500] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.5507] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:58.5510] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:58.5513] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.5520] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:14:58.5523] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:14:58.5526] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.5634] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.5774] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.5902] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.6067] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.6081] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.6195] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.6205] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:14:58.6209] Slim::Player::Source::_readNextChunk (476) Read to end of file or pipe [09-01-15 18:14:58.6212] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 9116197 [09-01-15 18:14:58.6217] Slim::Player::Source::_readNextChunk (515) 00:04:20:06:5c:41 mark end of stream [09-01-15 18:14:58.6236] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout [09-01-15 18:14:58.6239] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:14:58.6242] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: LocalEndOfStream - new state PLAYING-STREAMOUT [09-01-15 18:14:58.9854] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:59.0423] Slim::Player::StreamingController::playerEndOfStream (1718) 00:04:20:06:5c:41 [09-01-15 18:14:59.0427] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart [09-01-15 18:14:59.0430] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:14:59.0433] Slim::Player::StreamingController::_AutoStart (1184) autostart possibly short track [09-01-15 18:14:59.0463] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:59.0469] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:14:59.4441] Slim::Player::StreamingController::playerReadyToStream (1652) 00:04:20:06:5c:41 [09-01-15 18:14:59.4446] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore [09-01-15 18:14:59.4449] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state IDLE [09-01-15 18:14:59.4454] Slim::Player::StreamingController::nextsong (754) The next song is number 12, was 11 [09-01-15 18:14:59.4502] Slim::Player::Song::new (64) index 12 -> file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/Copy%20of%2008%20-%20Crooked%20Teeth.mpc [09-01-15 18:14:59.4507] Slim::Player::Song::new (101) live=3 [09-01-15 18:14:59.4510] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state TRACKWAIT [09-01-15 18:14:59.4514] Slim::Player::Song::getNextSong (178) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/Copy%20of%2008%20-%20Crooked%20Teeth.mpc [09-01-15 18:14:59.4518] Slim::Player::StreamingController::_nextTrackReady (646) 00:04:20:06:5c:41: nextTrack will be index 12 [09-01-15 18:14:59.4521] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady [09-01-15 18:14:59.4524] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: ReadyToStream - new state PLAYING-TRACKWAIT [09-01-15 18:14:59.9895] Slim::Player::StreamingController::playerTrackStarted (1634) 00:04:20:06:5c:41 [09-01-15 18:14:59.9899] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: Started in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_PlayAndStream [09-01-15 18:14:59.9902] Slim::Player::StreamingController::_setPlayingState (1809) new playing state PLAYING [09-01-15 18:14:59.9905] Slim::Player::StreamingController::_Playing (353) Song 10 is not longer in the queue [09-01-15 18:14:59.9909] Slim::Player::Song::DESTROY (111) DESTROY(Slim::Player::Song=HASH(0x65d5538)) live=2: index=10, url=file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/09%20-%20What%20Sarah%20Said.mpc [09-01-15 18:14:59.9919] Slim::Player::StreamingController::_Playing (359) Song 11 has now started playing [09-01-15 18:14:59.9930] Slim::Player::StreamingController::_Playing (388) Song queue is now 11 [09-01-15 18:14:59.9933] Slim::Player::StreamingController::_Stream (920) 00:04:20:06:5c:41: preparing to stream song index 12 [09-01-15 18:14:59.9936] Slim::Player::StreamingController::_Stream (935) Song queue is now 12,11 [09-01-15 18:14:59.9940] Slim::Player::Song::open (302) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/Copy%20of%2008%20-%20Crooked%20Teeth.mpc [09-01-15 18:14:59.9955] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:14:59.9959] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:59.9962] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:14:59.9965] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:14:59.9968] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:14:59.9971] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:59.9974] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:14:59.9977] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:14:59.9979] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:14:59.9982] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:14:59.9985] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:14:59.9988] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:14:59.9991] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:14:59.9994] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:14:59.9997] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:14:59.9999] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:00.0003] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - because no available stream mode supported: F [09-01-15 18:15:00.0006] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:00.0009] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-00:04:20:06:5c:41 [09-01-15 18:15:00.0011] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-* [09-01-15 18:15:00.0014] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-* [09-01-15 18:15:00.0017] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-aif-*-* is enabled [09-01-15 18:15:00.0020] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:00.0023] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-be --silent --prev --gain 2 - - [09-01-15 18:15:00.0026] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-be --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:15:00.0029] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:00.0032] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-00:04:20:06:5c:41 [09-01-15 18:15:00.0034] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-* [09-01-15 18:15:00.0037] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-* [09-01-15 18:15:00.0040] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-wav-*-* is enabled [09-01-15 18:15:00.0043] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:00.0046] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-le --silent --prev --gain 2 - - [09-01-15 18:15:00.0049] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-le --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:15:00.0052] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:00.0054] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-00:04:20:06:5c:41 [09-01-15 18:15:00.0057] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-* [09-01-15 18:15:00.0060] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-* [09-01-15 18:15:00.0063] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-mp3-*-* is enabled [09-01-15 18:15:00.0066] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:00.0069] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 3 - - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - - [09-01-15 18:15:00.0572] Slim::Player::TranscodingHelper::checkBin (260) couldn't find binary for: lame [09-01-15 18:15:00.0576] Slim::Player::TranscodingHelper::getConvertCommand2 (451) Error: Didn't find any command matches for type: mpc [09-01-15 18:15:00.0579] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmpc [09-01-15 18:15:00.0585] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:15:00.0588] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:00.0591] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:15:00.0594] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:15:00.0597] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:15:00.0600] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:00.0603] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:15:00.0606] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:15:00.0609] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:15:00.0612] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:00.0614] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:15:00.0617] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:15:00.0620] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:15:00.0623] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:15:00.0626] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:00.0629] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:00.0632] Slim::Player::TranscodingHelper::getConvertCommand2 (454) Matched: mpc->flc via: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:00.0635] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc [09-01-15 18:15:00.0638] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/Copy%20of%2008%20-%20Crooked%20Teeth.mpc] [09-01-15 18:15:00.0650] Slim::Player::Protocols::File::open (79) duration: [203.733] size: [5824644] endian [] offset: [0] for file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/Copy%20of%2008%20-%20Crooked%20Teeth.mpc [09-01-15 18:15:00.0653] Slim::Player::Protocols::File::open (96) Opening file F:\Music\A-Z\A-F\D\Death Cab For Cutie\Plans (2005)\Copy of 08 - Crooked Teeth.mpc [09-01-15 18:15:00.0662] Slim::Player::Song::open (385) URL is a song (audio): file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/Copy%20of%2008%20-%20Crooked%20Teeth.mpc, type=mpc [09-01-15 18:15:00.0674] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (557) Using command for conversion: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:15:00.0677] Slim::Player::Song::open (457) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:15:00.0734] Slim::Player::Pipeline::new (93) Launching process with command: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\socketwrapper.exe" -D -i 2120 -o 2119 -c "\"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe\" --silent --prev --gain 2 - - | \"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe\" -cs --totally-silent --compression-level-0 -" [09-01-15 18:15:00.0889] Slim::Player::SongStreamController::new (32) live=2 [09-01-15 18:15:00.0896] Slim::Player::SongStreamController::DESTROY (45) DESTROY(Slim::Player::SongStreamController=HASH(0x5de3c04)) live=1 [09-01-15 18:15:00.0899] Slim::Player::StreamingController::_Stream (976) 00:04:20:06:5c:41: stream [09-01-15 18:15:00.0932] Slim::Player::StreamingController::_Stream (1005) Song queue is now 12,11 [09-01-15 18:15:00.0937] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMING [09-01-15 18:15:00.0940] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: Started - new state PLAYING-STREAMING [09-01-15 18:15:00.0980] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:00.0999] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:00.1054] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:00.1189] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:00.1407] Slim::Player::Pipeline::acceptWriter (230) Pipeline writer connected [09-01-15 18:15:00.1427] Slim::Player::Pipeline::acceptReader (199) Pipeline reader connected [09-01-15 18:15:00.5087] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:00.5092] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5110] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:00.5113] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:00.5116] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5124] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:00.5126] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:00.5130] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5137] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:00.5140] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:00.5143] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5150] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:00.5153] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:00.5156] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5163] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:00.5166] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:00.5169] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5173] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:00.5176] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:00.5179] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5191] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5428] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5437] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:00.5440] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:00.5444] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5451] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:00.5454] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:00.5458] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5465] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:00.5468] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:00.5472] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5616] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5669] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.5805] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.6050] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.6178] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.6314] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.6564] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.6719] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.6729] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:00.6733] Slim::Player::Source::_readNextChunk (476) Read to end of file or pipe [09-01-15 18:15:00.6736] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 9448468 [09-01-15 18:15:00.6740] Slim::Player::Source::_readNextChunk (515) 00:04:20:06:5c:41 mark end of stream [09-01-15 18:15:00.6759] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout [09-01-15 18:15:00.6762] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:15:00.6766] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: LocalEndOfStream - new state PLAYING-STREAMOUT [09-01-15 18:15:00.9797] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:01.0839] Slim::Player::StreamingController::playerEndOfStream (1718) 00:04:20:06:5c:41 [09-01-15 18:15:01.0843] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart [09-01-15 18:15:01.0846] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:15:01.0849] Slim::Player::StreamingController::_AutoStart (1184) autostart possibly short track [09-01-15 18:15:01.0878] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:01.0886] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:01.1724] Slim::Player::StreamingController::playerReadyToStream (1652) 00:04:20:06:5c:41 [09-01-15 18:15:01.1728] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore [09-01-15 18:15:01.1731] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state IDLE [09-01-15 18:15:01.1735] Slim::Player::StreamingController::nextsong (754) The next song is number 0, was 12 [09-01-15 18:15:01.1784] Slim::Player::Song::new (64) index 0 -> file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/03%20-%20Summer%20Skin.mpc [09-01-15 18:15:01.1789] Slim::Player::Song::new (101) live=3 [09-01-15 18:15:01.1792] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state TRACKWAIT [09-01-15 18:15:01.1795] Slim::Player::Song::getNextSong (178) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/03%20-%20Summer%20Skin.mpc [09-01-15 18:15:01.1799] Slim::Player::StreamingController::_nextTrackReady (646) 00:04:20:06:5c:41: nextTrack will be index 0 [09-01-15 18:15:01.1803] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady [09-01-15 18:15:01.1806] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: ReadyToStream - new state PLAYING-TRACKWAIT [09-01-15 18:15:01.9850] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:02.0111] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:02.0119] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:02.2063] Slim::Player::StreamingController::playerTrackStarted (1634) 00:04:20:06:5c:41 [09-01-15 18:15:02.2067] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: Started in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_PlayAndStream [09-01-15 18:15:02.2070] Slim::Player::StreamingController::_setPlayingState (1809) new playing state PLAYING [09-01-15 18:15:02.2073] Slim::Player::StreamingController::_Playing (353) Song 11 is not longer in the queue [09-01-15 18:15:02.2077] Slim::Player::Song::DESTROY (111) DESTROY(Slim::Player::Song=HASH(0x5b96ce8)) live=2: index=11, url=file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/10%20-%20Brothers%20On%20A%20Hotel%20Bed.mpc [09-01-15 18:15:02.2087] Slim::Player::StreamingController::_Playing (359) Song 12 has now started playing [09-01-15 18:15:02.2097] Slim::Player::StreamingController::_Playing (388) Song queue is now 12 [09-01-15 18:15:02.2101] Slim::Player::StreamingController::_Stream (920) 00:04:20:06:5c:41: preparing to stream song index 0 [09-01-15 18:15:02.2103] Slim::Player::StreamingController::_Stream (935) Song queue is now 0,12 [09-01-15 18:15:02.2107] Slim::Player::Song::open (302) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/03%20-%20Summer%20Skin.mpc [09-01-15 18:15:02.2134] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:15:02.2143] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:02.2153] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:15:02.2156] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:15:02.2159] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:15:02.2161] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:02.2167] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:15:02.2171] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:15:02.2174] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:15:02.2178] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:02.2181] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:15:02.2183] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:15:02.2189] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:15:02.2192] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:15:02.2195] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:02.2198] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:02.2201] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - because no available stream mode supported: F [09-01-15 18:15:02.2204] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:02.2207] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-00:04:20:06:5c:41 [09-01-15 18:15:02.2210] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-* [09-01-15 18:15:02.2213] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-* [09-01-15 18:15:02.2215] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-aif-*-* is enabled [09-01-15 18:15:02.2218] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:02.2221] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-be --silent --prev --gain 2 - - [09-01-15 18:15:02.2224] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-be --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:15:02.2227] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:02.2230] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-00:04:20:06:5c:41 [09-01-15 18:15:02.2233] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-* [09-01-15 18:15:02.2235] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-* [09-01-15 18:15:02.2238] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-wav-*-* is enabled [09-01-15 18:15:02.2241] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:02.2244] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-le --silent --prev --gain 2 - - [09-01-15 18:15:02.2247] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-le --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:15:02.2250] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:02.2253] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-00:04:20:06:5c:41 [09-01-15 18:15:02.2255] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-* [09-01-15 18:15:02.2258] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-* [09-01-15 18:15:02.2261] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-mp3-*-* is enabled [09-01-15 18:15:02.2264] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:02.2269] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 3 - - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - - [09-01-15 18:15:02.2770] Slim::Player::TranscodingHelper::checkBin (260) couldn't find binary for: lame [09-01-15 18:15:02.2774] Slim::Player::TranscodingHelper::getConvertCommand2 (451) Error: Didn't find any command matches for type: mpc [09-01-15 18:15:02.2778] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmpc [09-01-15 18:15:02.2783] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:15:02.2787] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:02.2790] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:15:02.2793] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:15:02.2795] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:15:02.2798] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:02.2801] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:15:02.2804] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:15:02.2807] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:15:02.2810] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:02.2813] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:15:02.2815] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:15:02.2818] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:15:02.2821] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:15:02.2824] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:02.2827] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:02.2830] Slim::Player::TranscodingHelper::getConvertCommand2 (454) Matched: mpc->flc via: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:02.2833] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc [09-01-15 18:15:02.2836] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/03%20-%20Summer%20Skin.mpc] [09-01-15 18:15:02.2848] Slim::Player::Protocols::File::open (79) duration: [194.227] size: [5264626] endian [] offset: [0] for file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/03%20-%20Summer%20Skin.mpc [09-01-15 18:15:02.2851] Slim::Player::Protocols::File::open (96) Opening file F:\Music\A-Z\A-F\D\Death Cab For Cutie\Plans (2005)\03 - Summer Skin.mpc [09-01-15 18:15:02.2859] Slim::Player::Song::open (385) URL is a song (audio): file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/03%20-%20Summer%20Skin.mpc, type=mpc [09-01-15 18:15:02.2871] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (557) Using command for conversion: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:15:02.2875] Slim::Player::Song::open (457) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:15:02.2934] Slim::Player::Pipeline::new (93) Launching process with command: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\socketwrapper.exe" -D -i 2126 -o 2125 -c "\"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe\" --silent --prev --gain 2 - - | \"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe\" -cs --totally-silent --compression-level-0 -" [09-01-15 18:15:02.3081] Slim::Player::SongStreamController::new (32) live=2 [09-01-15 18:15:02.3087] Slim::Player::SongStreamController::DESTROY (45) DESTROY(Slim::Player::SongStreamController=HASH(0x5aa9ec8)) live=1 [09-01-15 18:15:02.3090] Slim::Player::StreamingController::_Stream (976) 00:04:20:06:5c:41: stream [09-01-15 18:15:02.3124] Slim::Player::StreamingController::_Stream (1005) Song queue is now 0,12 [09-01-15 18:15:02.3128] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMING [09-01-15 18:15:02.3131] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: Started - new state PLAYING-STREAMING [09-01-15 18:15:02.3197] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:02.3219] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:02.3275] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:02.3310] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:02.3660] Slim::Player::Pipeline::acceptWriter (230) Pipeline writer connected [09-01-15 18:15:02.3679] Slim::Player::Pipeline::acceptReader (199) Pipeline reader connected [09-01-15 18:15:02.7646] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:02.7651] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.7672] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:02.7675] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:02.7678] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.7692] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:02.7695] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:02.7698] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.7705] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:02.7708] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:02.7711] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.7718] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:02.7721] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:02.7724] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.7731] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:02.7734] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:02.7738] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.7743] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:02.7746] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:02.7749] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.8174] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.8183] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:02.8186] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:02.8189] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.8196] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:02.8199] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:02.8202] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.8209] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:02.8212] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:02.8215] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.8221] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:02.8224] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:02.8227] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.8445] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.8602] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.8760] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.8914] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.9069] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.9227] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:02.9231] Slim::Player::Source::_readNextChunk (476) Read to end of file or pipe [09-01-15 18:15:02.9235] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 9667922 [09-01-15 18:15:02.9238] Slim::Player::Source::_readNextChunk (515) 00:04:20:06:5c:41 mark end of stream [09-01-15 18:15:02.9258] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout [09-01-15 18:15:02.9262] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:15:02.9264] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: LocalEndOfStream - new state PLAYING-STREAMOUT [09-01-15 18:15:02.9860] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:03.3334] Slim::Player::StreamingController::playerEndOfStream (1718) 00:04:20:06:5c:41 [09-01-15 18:15:03.3338] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart [09-01-15 18:15:03.3341] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:15:03.3344] Slim::Player::StreamingController::_AutoStart (1184) autostart possibly short track [09-01-15 18:15:03.3382] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:03.3388] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:03.7194] Slim::Player::StreamingController::playerReadyToStream (1652) 00:04:20:06:5c:41 [09-01-15 18:15:03.7198] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore [09-01-15 18:15:03.7201] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state IDLE [09-01-15 18:15:03.7205] Slim::Player::StreamingController::nextsong (754) The next song is number 1, was 0 [09-01-15 18:15:03.7254] Slim::Player::Song::new (64) index 1 -> file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/11%20-%20Stable%20Song.mpc [09-01-15 18:15:03.7259] Slim::Player::Song::new (101) live=3 [09-01-15 18:15:03.7262] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state TRACKWAIT [09-01-15 18:15:03.7266] Slim::Player::Song::getNextSong (178) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/11%20-%20Stable%20Song.mpc [09-01-15 18:15:03.7270] Slim::Player::StreamingController::_nextTrackReady (646) 00:04:20:06:5c:41: nextTrack will be index 1 [09-01-15 18:15:03.7273] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady [09-01-15 18:15:03.7276] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: ReadyToStream - new state PLAYING-TRACKWAIT [09-01-15 18:15:03.9773] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:04.6149] Slim::Player::StreamingController::playerTrackStarted (1634) 00:04:20:06:5c:41 [09-01-15 18:15:04.6154] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: Started in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_PlayAndStream [09-01-15 18:15:04.6157] Slim::Player::StreamingController::_setPlayingState (1809) new playing state PLAYING [09-01-15 18:15:04.6160] Slim::Player::StreamingController::_Playing (353) Song 12 is not longer in the queue [09-01-15 18:15:04.6164] Slim::Player::Song::DESTROY (111) DESTROY(Slim::Player::Song=HASH(0x59ae130)) live=2: index=12, url=file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/Copy%20of%2008%20-%20Crooked%20Teeth.mpc [09-01-15 18:15:04.6174] Slim::Player::StreamingController::_Playing (359) Song 0 has now started playing [09-01-15 18:15:04.6184] Slim::Player::StreamingController::_Playing (388) Song queue is now 0 [09-01-15 18:15:04.6187] Slim::Player::StreamingController::_Stream (920) 00:04:20:06:5c:41: preparing to stream song index 1 [09-01-15 18:15:04.6190] Slim::Player::StreamingController::_Stream (935) Song queue is now 1,0 [09-01-15 18:15:04.6194] Slim::Player::Song::open (302) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/11%20-%20Stable%20Song.mpc [09-01-15 18:15:04.6210] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:15:04.6213] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:04.6216] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:15:04.6219] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:15:04.6222] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:15:04.6225] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:04.6228] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:15:04.6230] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:15:04.6233] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:15:04.6236] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:04.6239] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:15:04.6242] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:15:04.6245] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:15:04.6248] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:15:04.6251] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:04.6254] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:04.6257] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - because no available stream mode supported: F [09-01-15 18:15:04.6260] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:04.6263] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-00:04:20:06:5c:41 [09-01-15 18:15:04.6265] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-* [09-01-15 18:15:04.6268] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-* [09-01-15 18:15:04.6271] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-aif-*-* is enabled [09-01-15 18:15:04.6274] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:04.6277] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-be --silent --prev --gain 2 - - [09-01-15 18:15:04.6280] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-be --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:15:04.6282] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:04.6286] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-00:04:20:06:5c:41 [09-01-15 18:15:04.6288] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-* [09-01-15 18:15:04.6291] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-* [09-01-15 18:15:04.6294] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-wav-*-* is enabled [09-01-15 18:15:04.6297] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:04.6300] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-le --silent --prev --gain 2 - - [09-01-15 18:15:04.6303] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-le --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:15:04.6305] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:04.6308] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-00:04:20:06:5c:41 [09-01-15 18:15:04.6311] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-* [09-01-15 18:15:04.6314] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-* [09-01-15 18:15:04.6317] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-mp3-*-* is enabled [09-01-15 18:15:04.6320] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:04.6322] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 3 - - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - - [09-01-15 18:15:04.6860] Slim::Player::TranscodingHelper::checkBin (260) couldn't find binary for: lame [09-01-15 18:15:04.6863] Slim::Player::TranscodingHelper::getConvertCommand2 (451) Error: Didn't find any command matches for type: mpc [09-01-15 18:15:04.6867] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmpc [09-01-15 18:15:04.6873] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:15:04.6877] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:04.6880] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:15:04.6883] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:15:04.6885] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:15:04.6888] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:04.6891] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:15:04.6894] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:15:04.6897] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:15:04.6900] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:04.6902] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:15:04.6905] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:15:04.6908] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:15:04.6911] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:15:04.6914] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:04.6916] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:04.6920] Slim::Player::TranscodingHelper::getConvertCommand2 (454) Matched: mpc->flc via: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:04.6923] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc [09-01-15 18:15:04.6926] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/11%20-%20Stable%20Song.mpc] [09-01-15 18:15:04.6938] Slim::Player::Protocols::File::open (79) duration: [222.493] size: [6522435] endian [] offset: [0] for file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/11%20-%20Stable%20Song.mpc [09-01-15 18:15:04.6941] Slim::Player::Protocols::File::open (96) Opening file F:\Music\A-Z\A-F\D\Death Cab For Cutie\Plans (2005)\11 - Stable Song.mpc [09-01-15 18:15:04.6949] Slim::Player::Song::open (385) URL is a song (audio): file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/11%20-%20Stable%20Song.mpc, type=mpc [09-01-15 18:15:04.6962] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (557) Using command for conversion: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:15:04.6965] Slim::Player::Song::open (457) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:15:04.7023] Slim::Player::Pipeline::new (93) Launching process with command: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\socketwrapper.exe" -D -i 2130 -o 2129 -c "\"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe\" --silent --prev --gain 2 - - | \"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe\" -cs --totally-silent --compression-level-0 -" [09-01-15 18:15:04.7191] Slim::Player::SongStreamController::new (32) live=2 [09-01-15 18:15:04.7197] Slim::Player::SongStreamController::DESTROY (45) DESTROY(Slim::Player::SongStreamController=HASH(0x5de3c04)) live=1 [09-01-15 18:15:04.7201] Slim::Player::StreamingController::_Stream (976) 00:04:20:06:5c:41: stream [09-01-15 18:15:04.7234] Slim::Player::StreamingController::_Stream (1005) Song queue is now 1,0 [09-01-15 18:15:04.7238] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMING [09-01-15 18:15:04.7241] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: Started - new state PLAYING-STREAMING [09-01-15 18:15:04.7278] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:04.7300] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:04.7358] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:04.7603] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:04.7769] Slim::Player::Pipeline::acceptWriter (230) Pipeline writer connected [09-01-15 18:15:04.7786] Slim::Player::Pipeline::acceptReader (199) Pipeline reader connected [09-01-15 18:15:04.9850] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:05.1488] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:05.1492] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.1513] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:05.1516] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:05.1520] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.1532] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:05.1535] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:05.1538] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.1545] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:05.1548] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:05.1551] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.1558] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:05.1561] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:05.1564] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.1571] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:05.1574] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:05.1577] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.1583] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:05.1586] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:05.1589] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.1602] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.1838] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.1847] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:05.1850] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:05.1854] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.1861] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:05.1864] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:05.1867] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.1874] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:05.1877] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:05.1880] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.1886] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:05.1889] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:05.1892] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.2101] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.2616] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.3168] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.3180] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.3338] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.3346] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:05.3350] Slim::Player::Source::_readNextChunk (476) Read to end of file or pipe [09-01-15 18:15:05.3353] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 9891312 [09-01-15 18:15:05.3357] Slim::Player::Source::_readNextChunk (515) 00:04:20:06:5c:41 mark end of stream [09-01-15 18:15:05.3375] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout [09-01-15 18:15:05.3378] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:15:05.3382] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: LocalEndOfStream - new state PLAYING-STREAMOUT [09-01-15 18:15:05.7534] Slim::Player::StreamingController::playerEndOfStream (1718) 00:04:20:06:5c:41 [09-01-15 18:15:05.7539] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart [09-01-15 18:15:05.7541] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:15:05.7544] Slim::Player::StreamingController::_AutoStart (1184) autostart possibly short track [09-01-15 18:15:05.7573] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:05.7586] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:05.9928] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:06.1394] Slim::Player::StreamingController::playerReadyToStream (1652) 00:04:20:06:5c:41 [09-01-15 18:15:06.1398] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore [09-01-15 18:15:06.1401] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state IDLE [09-01-15 18:15:06.1405] Slim::Player::StreamingController::nextsong (754) The next song is number 2, was 1 [09-01-15 18:15:06.1454] Slim::Player::Song::new (64) index 2 -> file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/08%20-%20Crooked%20Teeth.mpc [09-01-15 18:15:06.1459] Slim::Player::Song::new (101) live=3 [09-01-15 18:15:06.1462] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state TRACKWAIT [09-01-15 18:15:06.1466] Slim::Player::Song::getNextSong (178) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/08%20-%20Crooked%20Teeth.mpc [09-01-15 18:15:06.1470] Slim::Player::StreamingController::_nextTrackReady (646) 00:04:20:06:5c:41: nextTrack will be index 2 [09-01-15 18:15:06.1473] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady [09-01-15 18:15:06.1476] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: ReadyToStream - new state PLAYING-TRACKWAIT [09-01-15 18:15:06.7662] Slim::Player::StreamingController::playerTrackStarted (1634) 00:04:20:06:5c:41 [09-01-15 18:15:06.7666] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: Started in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_PlayAndStream [09-01-15 18:15:06.7669] Slim::Player::StreamingController::_setPlayingState (1809) new playing state PLAYING [09-01-15 18:15:06.7673] Slim::Player::StreamingController::_Playing (353) Song 0 is not longer in the queue [09-01-15 18:15:06.7677] Slim::Player::Song::DESTROY (111) DESTROY(Slim::Player::Song=HASH(0x66c553c)) live=2: index=0, url=file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/03%20-%20Summer%20Skin.mpc [09-01-15 18:15:06.7687] Slim::Player::StreamingController::_Playing (359) Song 1 has now started playing [09-01-15 18:15:06.7697] Slim::Player::StreamingController::_Playing (388) Song queue is now 1 [09-01-15 18:15:06.7700] Slim::Player::StreamingController::_Stream (920) 00:04:20:06:5c:41: preparing to stream song index 2 [09-01-15 18:15:06.7703] Slim::Player::StreamingController::_Stream (935) Song queue is now 2,1 [09-01-15 18:15:06.7707] Slim::Player::Song::open (302) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/08%20-%20Crooked%20Teeth.mpc [09-01-15 18:15:06.7722] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:15:06.7726] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:06.7729] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:15:06.7732] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:15:06.7734] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:15:06.7737] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:06.7740] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:15:06.7743] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:15:06.7746] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:15:06.7748] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:06.7751] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:15:06.7754] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:15:06.7757] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:15:06.7760] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:15:06.7762] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:06.7765] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:06.7768] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - because no available stream mode supported: F [09-01-15 18:15:06.7771] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:06.7774] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-00:04:20:06:5c:41 [09-01-15 18:15:06.7777] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-* [09-01-15 18:15:06.7779] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-* [09-01-15 18:15:06.7782] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-aif-*-* is enabled [09-01-15 18:15:06.7785] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:06.7788] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-be --silent --prev --gain 2 - - [09-01-15 18:15:06.7791] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-be --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:15:06.7793] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:06.7796] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-00:04:20:06:5c:41 [09-01-15 18:15:06.7799] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-* [09-01-15 18:15:06.7802] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-* [09-01-15 18:15:06.7805] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-wav-*-* is enabled [09-01-15 18:15:06.7807] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:06.7810] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-le --silent --prev --gain 2 - - [09-01-15 18:15:06.7813] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-le --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:15:06.7816] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:06.7819] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-00:04:20:06:5c:41 [09-01-15 18:15:06.7822] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-* [09-01-15 18:15:06.7824] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-* [09-01-15 18:15:06.7827] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-mp3-*-* is enabled [09-01-15 18:15:06.7831] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:06.7834] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 3 - - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - - [09-01-15 18:15:06.8331] Slim::Player::TranscodingHelper::checkBin (260) couldn't find binary for: lame [09-01-15 18:15:06.8335] Slim::Player::TranscodingHelper::getConvertCommand2 (451) Error: Didn't find any command matches for type: mpc [09-01-15 18:15:06.8338] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmpc [09-01-15 18:15:06.8344] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:15:06.8347] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:06.8350] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:15:06.8353] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:15:06.8356] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:15:06.8359] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:06.8361] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:15:06.8364] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:15:06.8367] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:15:06.8370] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:06.8373] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:15:06.8376] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:15:06.8378] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:15:06.8381] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:15:06.8384] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:06.8387] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:06.8390] Slim::Player::TranscodingHelper::getConvertCommand2 (454) Matched: mpc->flc via: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:06.8393] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc [09-01-15 18:15:06.8396] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/08%20-%20Crooked%20Teeth.mpc] [09-01-15 18:15:06.8408] Slim::Player::Protocols::File::open (79) duration: [203.733] size: [5824644] endian [] offset: [0] for file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/08%20-%20Crooked%20Teeth.mpc [09-01-15 18:15:06.8411] Slim::Player::Protocols::File::open (96) Opening file F:\Music\A-Z\A-F\D\Death Cab For Cutie\Plans (2005)\08 - Crooked Teeth.mpc [09-01-15 18:15:06.8419] Slim::Player::Song::open (385) URL is a song (audio): file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/08%20-%20Crooked%20Teeth.mpc, type=mpc [09-01-15 18:15:06.8431] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (557) Using command for conversion: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:15:06.8434] Slim::Player::Song::open (457) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:15:06.8494] Slim::Player::Pipeline::new (93) Launching process with command: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\socketwrapper.exe" -D -i 2134 -o 2133 -c "\"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe\" --silent --prev --gain 2 - - | \"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe\" -cs --totally-silent --compression-level-0 -" [09-01-15 18:15:06.8639] Slim::Player::SongStreamController::new (32) live=2 [09-01-15 18:15:06.8645] Slim::Player::SongStreamController::DESTROY (45) DESTROY(Slim::Player::SongStreamController=HASH(0x5b60c70)) live=1 [09-01-15 18:15:06.8649] Slim::Player::StreamingController::_Stream (976) 00:04:20:06:5c:41: stream [09-01-15 18:15:06.8681] Slim::Player::StreamingController::_Stream (1005) Song queue is now 2,1 [09-01-15 18:15:06.8686] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMING [09-01-15 18:15:06.8689] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: Started - new state PLAYING-STREAMING [09-01-15 18:15:06.8745] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:06.8751] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:06.8816] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:06.8851] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:06.9168] Slim::Player::Pipeline::acceptWriter (230) Pipeline writer connected [09-01-15 18:15:06.9186] Slim::Player::Pipeline::acceptReader (199) Pipeline reader connected [09-01-15 18:15:06.9789] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:07.0049] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:07.0058] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:07.2975] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:07.2979] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.2997] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:07.3000] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:07.3003] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.3010] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:07.3013] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:07.3017] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.3023] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:07.3026] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:07.3029] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.3036] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:07.3039] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:07.3042] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.3049] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:07.3052] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:07.3055] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.3059] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:07.3062] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:07.3065] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.3077] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.3456] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.3464] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:07.3467] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:07.3471] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.3478] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:07.3481] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:07.3484] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.3491] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:07.3494] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:07.3497] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.3830] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.4143] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.4475] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.4747] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.4956] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.5172] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.5422] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.5639] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.5648] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:07.5652] Slim::Player::Source::_readNextChunk (476) Read to end of file or pipe [09-01-15 18:15:07.5655] Slim::Player::Source::_readNextChunk (499) end of file or error on socket, song pos: 10223583 [09-01-15 18:15:07.5658] Slim::Player::Source::_readNextChunk (515) 00:04:20:06:5c:41 mark end of stream [09-01-15 18:15:07.5678] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: LocalEndOfStream in PLAYING-STREAMING -> Slim::Player::StreamingController::_Streamout [09-01-15 18:15:07.5682] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:15:07.5685] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: LocalEndOfStream - new state PLAYING-STREAMOUT [09-01-15 18:15:07.9886] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:08.0092] Slim::Player::StreamingController::playerEndOfStream (1718) 00:04:20:06:5c:41 [09-01-15 18:15:08.0096] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: EndOfStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_AutoStart [09-01-15 18:15:08.0099] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMOUT [09-01-15 18:15:08.0102] Slim::Player::StreamingController::_AutoStart (1184) autostart possibly short track [09-01-15 18:15:08.0142] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:08.0148] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:08.0646] Slim::Player::StreamingController::playerReadyToStream (1652) 00:04:20:06:5c:41 [09-01-15 18:15:08.0652] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: ReadyToStream in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_NextIfMore [09-01-15 18:15:08.0655] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state IDLE [09-01-15 18:15:08.0658] Slim::Player::StreamingController::nextsong (754) The next song is number 3, was 2 [09-01-15 18:15:08.0707] Slim::Player::Song::new (64) index 3 -> file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/04%20-%20Different%20Names%20For%20The%20Same%20Thing.mpc [09-01-15 18:15:08.0712] Slim::Player::Song::new (101) live=3 [09-01-15 18:15:08.0715] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state TRACKWAIT [09-01-15 18:15:08.0719] Slim::Player::Song::getNextSong (178) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/04%20-%20Different%20Names%20For%20The%20Same%20Thing.mpc [09-01-15 18:15:08.0723] Slim::Player::StreamingController::_nextTrackReady (646) 00:04:20:06:5c:41: nextTrack will be index 3 [09-01-15 18:15:08.0726] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: NextTrackReady in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_StreamIfReady [09-01-15 18:15:08.0729] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: ReadyToStream - new state PLAYING-TRACKWAIT [09-01-15 18:15:08.9381] Slim::Player::StreamingController::playerTrackStarted (1634) 00:04:20:06:5c:41 [09-01-15 18:15:08.9385] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: Started in PLAYING-TRACKWAIT -> Slim::Player::StreamingController::_PlayAndStream [09-01-15 18:15:08.9388] Slim::Player::StreamingController::_setPlayingState (1809) new playing state PLAYING [09-01-15 18:15:08.9391] Slim::Player::StreamingController::_Playing (353) Song 1 is not longer in the queue [09-01-15 18:15:08.9395] Slim::Player::Song::DESTROY (111) DESTROY(Slim::Player::Song=HASH(0x5e08348)) live=2: index=1, url=file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/11%20-%20Stable%20Song.mpc [09-01-15 18:15:08.9405] Slim::Player::StreamingController::_Playing (359) Song 2 has now started playing [09-01-15 18:15:08.9415] Slim::Player::StreamingController::_Playing (388) Song queue is now 2 [09-01-15 18:15:08.9418] Slim::Player::StreamingController::_Stream (920) 00:04:20:06:5c:41: preparing to stream song index 3 [09-01-15 18:15:08.9421] Slim::Player::StreamingController::_Stream (935) Song queue is now 3,2 [09-01-15 18:15:08.9425] Slim::Player::Song::open (302) file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/04%20-%20Different%20Names%20For%20The%20Same%20Thing.mpc [09-01-15 18:15:08.9442] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:15:08.9446] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:08.9448] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:15:08.9451] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:15:08.9454] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:15:08.9457] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:08.9460] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:15:08.9463] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:15:08.9466] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:15:08.9468] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:08.9471] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:15:08.9474] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:15:08.9477] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:15:08.9480] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:15:08.9483] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:08.9486] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:08.9489] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - because no available stream mode supported: F [09-01-15 18:15:08.9492] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:08.9494] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-00:04:20:06:5c:41 [09-01-15 18:15:08.9497] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-squeezebox2-* [09-01-15 18:15:08.9500] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-aif-*-* [09-01-15 18:15:08.9503] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-aif-*-* is enabled [09-01-15 18:15:08.9506] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:08.9509] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-be --silent --prev --gain 2 - - [09-01-15 18:15:08.9512] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-be --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:15:08.9515] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:08.9517] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-00:04:20:06:5c:41 [09-01-15 18:15:08.9520] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-squeezebox2-* [09-01-15 18:15:08.9523] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wav-*-* [09-01-15 18:15:08.9526] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-wav-*-* is enabled [09-01-15 18:15:08.9529] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:08.9532] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --raw-le --silent --prev --gain 2 - - [09-01-15 18:15:08.9535] Slim::Player::TranscodingHelper::getConvertCommand2 (390) Rejecting [mppdec] --raw-le --silent --prev --gain 2 - - because no available stream mode supported: F [09-01-15 18:15:08.9537] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:08.9540] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-00:04:20:06:5c:41 [09-01-15 18:15:08.9543] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-squeezebox2-* [09-01-15 18:15:08.9546] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-mp3-*-* [09-01-15 18:15:08.9549] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-mp3-*-* is enabled [09-01-15 18:15:08.9552] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:08.9554] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 3 - - | [lame] --silent -q $QUALITY$ $RESAMPLE$ -v $BITRATE$ - - [09-01-15 18:15:09.0056] Slim::Player::TranscodingHelper::checkBin (260) couldn't find binary for: lame [09-01-15 18:15:09.0059] Slim::Player::TranscodingHelper::getConvertCommand2 (451) Error: Didn't find any command matches for type: mpc [09-01-15 18:15:09.0066] Slim::Player::Song::open (323) seek=false time=0 canSeek=0SEEK_ERROR_TYPE_NOT_SUPPORTEDmpc [09-01-15 18:15:09.0072] Slim::Player::TranscodingHelper::getConvertCommand2 (323) rateLimit = 0, type = mpc, squeezebox2 = 00:04:20:06:5c:41 [09-01-15 18:15:09.0076] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:09.0078] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-00:04:20:06:5c:41 [09-01-15 18:15:09.0082] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-squeezebox2-* [09-01-15 18:15:09.0084] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-wma-*-* [09-01-15 18:15:09.0087] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:09.0090] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-00:04:20:06:5c:41 [09-01-15 18:15:09.0093] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-squeezebox2-* [09-01-15 18:15:09.0096] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-ogg-*-* [09-01-15 18:15:09.0099] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-00:04:20:06:5c:41 [09-01-15 18:15:09.0101] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-00:04:20:06:5c:41 [09-01-15 18:15:09.0104] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-squeezebox2-* [09-01-15 18:15:09.0107] Slim::Player::TranscodingHelper::checkBin (227) Checking formats for: mpc-flc-*-* [09-01-15 18:15:09.0110] Slim::Player::TranscodingHelper::enabledFormat (194) Checking to see if mpc-flc-*-* is enabled [09-01-15 18:15:09.0113] Slim::Player::TranscodingHelper::checkBin (235) enabled [09-01-15 18:15:09.0116] Slim::Player::TranscodingHelper::checkBin (237) Found command: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:09.0119] Slim::Player::TranscodingHelper::getConvertCommand2 (454) Matched: mpc->flc via: [mppdec] --silent --prev --gain 2 - - | [flac] -cs --totally-silent --compression-level-0 - [09-01-15 18:15:09.0122] Slim::Player::Song::open (340) Transcoder: streamMode=I, streamformat=flc [09-01-15 18:15:09.0125] Slim::Player::Song::open (364) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/04%20-%20Different%20Names%20For%20The%20Same%20Thing.mpc] [09-01-15 18:15:09.0138] Slim::Player::Protocols::File::open (79) duration: [308.507] size: [9228089] endian [] offset: [0] for file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/04%20-%20Different%20Names%20For%20The%20Same%20Thing.mpc [09-01-15 18:15:09.0141] Slim::Player::Protocols::File::open (96) Opening file F:\Music\A-Z\A-F\D\Death Cab For Cutie\Plans (2005)\04 - Different Names For The Same Thing.mpc [09-01-15 18:15:09.0149] Slim::Player::Song::open (385) URL is a song (audio): file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/04%20-%20Different%20Names%20For%20The%20Same%20Thing.mpc, type=mpc [09-01-15 18:15:09.0161] Slim::Player::TranscodingHelper::tokenizeConvertCommand2 (557) Using command for conversion: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:15:09.0165] Slim::Player::Song::open (457) Tokenized command "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe" --silent --prev --gain 2 - - | "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe" -cs --totally-silent --compression-level-0 - [09-01-15 18:15:09.0224] Slim::Player::Pipeline::new (93) Launching process with command: "C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\socketwrapper.exe" -D -i 2138 -o 2137 -c "\"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\mppdec.exe\" --silent --prev --gain 2 - - | \"C:\PROGRA~1\SQUEEZ~1\server\Bin\MSWin32-x86-multi-thread\flac.exe\" -cs --totally-silent --compression-level-0 -" [09-01-15 18:15:09.0669] Slim::Player::SongStreamController::new (32) live=2 [09-01-15 18:15:09.0675] Slim::Player::SongStreamController::DESTROY (45) DESTROY(Slim::Player::SongStreamController=HASH(0x5af07f0)) live=1 [09-01-15 18:15:09.0679] Slim::Player::StreamingController::_Stream (976) 00:04:20:06:5c:41: stream [09-01-15 18:15:09.0713] Slim::Player::StreamingController::_Stream (1005) Song queue is now 3,2 [09-01-15 18:15:09.0718] Slim::Player::StreamingController::_setStreamingState (1822) new streaming state STREAMING [09-01-15 18:15:09.0721] Slim::Player::StreamingController::_eventAction (301) 00:04:20:06:5c:41: Started - new state PLAYING-STREAMING [09-01-15 18:15:09.0758] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:09.0779] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:09.0835] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:09.0874] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:09.1028] Slim::Player::Pipeline::acceptWriter (230) Pipeline writer connected [09-01-15 18:15:09.1048] Slim::Player::Pipeline::acceptReader (199) Pipeline reader connected [09-01-15 18:15:09.5010] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.5015] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5036] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.5039] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.5042] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5096] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.5100] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.5103] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5113] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.5116] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.5119] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5126] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.5129] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.5132] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5139] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.5142] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.5145] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5152] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.5155] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.5159] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5164] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.5167] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.5170] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5183] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5574] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5582] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.5585] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.5589] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5595] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.5598] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.5601] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5608] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.5612] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.5615] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5620] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.5623] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.5629] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.5858] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.6055] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.6259] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.6425] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.6635] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.6786] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.6967] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.7099] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.7294] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.7304] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.7307] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.7310] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.7318] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.7321] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.7324] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.7331] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.7334] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.7337] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.7344] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.7347] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.7351] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.7431] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.7667] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.7838] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.8030] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.8231] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.8394] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.8691] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.8867] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.9010] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.9018] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.9022] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.9025] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.9032] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.9035] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.9038] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.9045] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.9048] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.9051] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.9055] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:09.9059] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:09.9064] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.9221] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.9370] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.9586] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.9782] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:09.9941] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:09.9986] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.0129] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.0215] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.0358] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.0633] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.0853] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.0862] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.0888] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.0892] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.0900] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.0903] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.0907] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.0914] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.0917] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.0920] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.0924] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.0927] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.0930] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.1063] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.1243] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.1464] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.1655] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.1847] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.2122] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.2273] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.2514] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.2878] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.3006] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.3173] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.3359] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.3511] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.3700] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.3846] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.4026] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.4034] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.4038] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.4041] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.4048] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.4051] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.4055] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.4062] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.4065] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.4069] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.4149] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.4319] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.4689] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.4883] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.5001] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.5173] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.5395] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.5635] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.5788] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.5934] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.6098] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.6281] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.6290] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.6294] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.6297] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.6304] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.6307] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.6310] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.6318] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.6321] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.6324] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.6331] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.6334] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.6338] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.6459] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.7011] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.7155] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.7355] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.7443] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.7690] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.8120] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.8286] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.8425] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.8575] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.8722] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.8912] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.8922] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.8925] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.8928] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.8935] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.8938] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.8942] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.8950] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.8953] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.8956] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.8963] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:10.8966] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:10.8969] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.9243] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.9441] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.9606] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.9780] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:10.9815] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:10.9935] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.0157] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.0361] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.0644] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.0812] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.0963] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.1141] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.1251] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.1260] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.1263] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.1267] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.1273] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.1276] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.1279] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.1286] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.1289] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.1292] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.1298] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.1301] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.1304] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.1913] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.2042] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.2241] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.2373] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.2678] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.2944] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.3112] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.3239] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.3407] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.3462] Slim::Player::StreamingController::playerTrackStarted (1634) 00:04:20:06:5c:41 [09-01-15 18:15:11.3466] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: Started in PLAYING-STREAMING -> Slim::Player::StreamingController::_Playing [09-01-15 18:15:11.3469] Slim::Player::StreamingController::_setPlayingState (1809) new playing state PLAYING [09-01-15 18:15:11.3472] Slim::Player::StreamingController::_Playing (353) Song 2 is not longer in the queue [09-01-15 18:15:11.3476] Slim::Player::Song::DESTROY (111) DESTROY(Slim::Player::Song=HASH(0x5af18f4)) live=1: index=2, url=file:///F:/Music/A-Z/A-F/D/Death%20Cab%20For%20Cutie/Plans%20(2005)/08%20-%20Crooked%20Teeth.mpc [09-01-15 18:15:11.3487] Slim::Player::StreamingController::_Playing (359) Song 3 has now started playing [09-01-15 18:15:11.3498] Slim::Player::StreamingController::_Playing (388) Song queue is now 3 [09-01-15 18:15:11.3625] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.3922] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.4084] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.4227] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.4407] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.4621] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.4629] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.4632] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.4635] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.4644] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.4647] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.4650] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.4657] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.4660] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.4663] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.4669] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.4672] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.4675] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.4745] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.4907] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.5073] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.5315] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.5427] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.5723] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.5974] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.6170] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.6304] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.6450] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.6691] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.6872] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.6881] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.6884] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.6887] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.6895] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.6898] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.6901] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.6908] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.6911] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.6914] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.6920] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.6923] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.6927] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.7028] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.7168] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.7332] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.7480] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.7638] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.7865] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.8060] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.8250] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.8364] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.8527] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.8757] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.8766] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.8769] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.8772] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.8779] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.8782] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.8785] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.8793] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.8796] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.8800] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.8805] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:11.8807] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:11.8811] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.8940] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.9078] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.9228] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.9394] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.9651] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:11.9932] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:12.0003] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:12.0061] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:12.0067] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:12.0223] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:12.0782] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:12.4412] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:12.8129] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:12.9889] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:13.1720] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:13.5369] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:13.8907] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:13.9898] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:14.2611] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:14.6315] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:14.9674] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:14.9683] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:14.9685] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:14.9688] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:14.9695] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:14.9698] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:14.9701] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:14.9708] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:14.9711] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:14.9714] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:14.9719] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:14.9722] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:14.9725] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:14.9928] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:15.3410] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:15.7149] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:15.9923] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:16.0928] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:16.4689] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:16.8177] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:16.9930] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:17.0029] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:17.0036] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:17.1955] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:17.5470] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:17.9534] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:17.9905] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:18.3205] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:18.7129] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:18.9931] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:19.0732] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:19.4466] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:19.4474] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:19.4477] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:19.4481] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:19.4487] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:19.4490] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:19.4494] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:19.4501] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:19.4504] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:19.4507] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:19.4511] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:19.4514] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:19.4517] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:19.8318] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:19.9933] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:20.1892] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:20.5782] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:20.9564] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:20.9840] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:21.3718] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:21.7111] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:21.9926] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:22.0179] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:22.0187] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:22.0879] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:22.3932] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:22.7029] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:22.9919] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:22.9933] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:23.3050] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:23.6199] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:23.6208] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:23.6211] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:23.6214] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:23.6221] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:23.6224] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:23.6227] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:23.6234] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:23.6237] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:23.6240] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:23.6244] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:23.6248] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:23.6251] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:23.9220] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:23.9901] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:24.2179] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:24.4861] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:24.8002] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:24.9849] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:25.1190] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:25.5157] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:25.8810] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:25.9844] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:26.1876] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:26.5122] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:26.8153] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:26.9928] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:27.0220] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:27.0228] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:27.1328] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:27.4159] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:27.6607] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:27.9617] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:27.9934] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:28.3035] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:28.3044] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:28.3047] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:28.3050] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:28.3057] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:28.3060] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:28.3063] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:28.3070] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:28.3073] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:28.3077] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:28.3081] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:28.3084] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:28.3087] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:28.6231] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:28.8943] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:28.9930] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:29.2130] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:29.5515] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:29.8958] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:29.9950] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:30.2374] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:30.5951] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:30.9726] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:30.9925] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:31.3404] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:31.6834] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:31.9930] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:32.0033] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:32.0041] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:32.0501] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:32.4285] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:32.4294] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:32.4297] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:32.4300] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:32.4307] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:32.4310] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:32.4313] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:32.4319] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:32.4322] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:32.4326] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:32.7975] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:32.9908] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:33.1455] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:33.5001] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:33.7981] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:33.9820] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:34.1522] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:34.4573] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:34.7495] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:34.9927] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:35.0419] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:35.3751] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:35.6594] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:35.9845] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:36.0023] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:36.3454] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:36.3463] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:36.3466] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:36.3469] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:36.3476] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:36.3479] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:36.3482] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:36.3489] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:36.3492] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:36.3495] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:36.3501] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:36.3504] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:36.3508] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:36.7032] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:36.9791] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:37.0048] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:37.0056] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:37.0774] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:37.4381] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:37.7302] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:37.9849] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:38.0400] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:38.3400] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:38.6711] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:38.9876] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:38.9929] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:39.2991] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:39.5898] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:39.8986] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:39.9931] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:40.2349] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:40.5475] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:40.9239] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:40.9928] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:41.3151] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:41.3160] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:41.3163] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:41.3166] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:41.3173] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:41.3176] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:41.3179] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:41.3186] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:41.3189] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:41.3192] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:41.3198] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:41.3201] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:41.3204] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:41.6767] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:41.9930] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:42.0198] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:42.0206] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:42.0483] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:42.4103] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:42.7856] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:42.9931] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:43.1572] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:43.5463] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:43.9324] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:43.9926] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:44.2558] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:44.6443] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:44.9611] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:44.9926] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:45.2270] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:45.5217] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:45.5226] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:45.5229] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:45.5232] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:45.5239] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:45.5242] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:45.5245] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:45.5252] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:45.5255] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:45.5259] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:45.5264] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:45.5267] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:45.5271] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:45.7956] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:45.9932] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:46.0868] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:46.3718] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:46.6877] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:46.9689] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:46.9862] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:47.0156] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:47.0163] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:47.2421] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:47.5325] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:47.8494] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:47.9933] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:48.1251] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:48.4277] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:48.7501] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:49.2661] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:49.2668] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:49.3457] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:49.6641] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:49.9701] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:49.9839] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:50.2893] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:50.2902] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:50.2905] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:50.2908] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:50.2915] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:50.2918] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:50.2921] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:50.2928] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:50.2931] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:50.2934] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:50.2939] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:50.2943] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:50.2946] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:50.6118] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:50.8959] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:50.9933] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:51.1983] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:51.5101] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:51.8658] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:51.9961] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:52.0039] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:52.0048] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:52.2320] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:52.6067] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:52.9932] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:53.0012] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:53.3426] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:53.7307] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:54.0707] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:54.0802] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:54.4492] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:54.4502] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:54.4505] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:54.4509] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:54.4516] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:54.4519] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:54.4522] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:54.4528] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:54.4532] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:54.4536] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:54.4541] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:54.4544] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:54.4547] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:54.8237] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:54.9929] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:55.1493] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:55.4977] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:55.8048] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:55.9929] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:56.1720] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:56.4294] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:56.7684] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:56.9940] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:57.0029] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:57.0037] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:57.0665] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:57.3722] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:57.6595] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:57.9938] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:57.9948] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:57.9956] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:57.9959] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:57.9963] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:57.9969] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:57.9973] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:57.9976] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:57.9983] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:57.9986] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:57.9989] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:57.9994] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:15:57.9997] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:15:58.0000] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:58.2755] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:58.5723] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:58.9220] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:58.9897] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:15:59.2217] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:59.5962] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:59.8925] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:15:59.9858] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:00.1878] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:00.4492] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:00.7460] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:00.9932] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:01.0573] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:01.3439] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:01.6617] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:01.9933] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:02.0183] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:02.0191] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:02.0418] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:02.3599] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:02.6719] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:02.9933] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:03.0530] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:03.0539] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:03.0542] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:03.0545] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:03.0552] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:03.0555] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:03.0558] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:03.0565] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:03.0567] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:03.0571] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:03.0577] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:03.0580] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:03.0583] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:03.4028] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:03.8097] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:03.9930] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:04.1991] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:04.5848] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:04.9551] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:04.9927] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:05.3538] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:05.7234] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:05.9933] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:06.1064] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:06.5294] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:06.8959] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:06.9932] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:07.0087] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:07.0162] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:07.2659] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:07.5574] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:07.5583] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:07.5586] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:07.5589] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:07.5596] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:07.5599] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:07.5602] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:07.5609] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:07.5612] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:07.5615] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:07.5620] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:07.5624] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:07.5627] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:07.8696] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:07.9928] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:08.1741] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:08.4484] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:08.7426] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:08.9850] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:09.0166] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:09.3765] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:09.6259] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:09.9191] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:09.9933] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:10.2501] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:10.6221] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:11.0008] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:11.0016] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:11.0025] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:11.0028] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:11.0031] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:11.0038] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:11.0041] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:11.0044] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:11.0051] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:11.0054] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:11.0057] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:11.0061] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:11.0064] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:11.0067] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:11.3297] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:11.6121] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:11.8751] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:11.9884] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:12.0143] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:12.0149] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:12.1565] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:12.4706] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:12.7726] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:12.9850] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:13.0957] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:13.4342] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:13.7708] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:13.9971] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:14.0674] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:14.3422] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:14.6564] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:14.6572] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:14.6575] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:14.6579] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:14.6585] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:14.6588] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:14.6591] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:14.6598] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:14.6601] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:14.6606] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:14.6611] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:14.6615] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:14.6619] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:14.9820] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:15.0374] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:15.4230] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:15.7795] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:15.9943] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:16.1696] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:16.5142] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:16.9116] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:16.9944] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:17.0189] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:17.0195] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:17.2613] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:17.6143] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:17.9745] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:17.9946] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:18.3117] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:18.6363] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:18.9518] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:18.9529] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:18.9532] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:18.9535] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:18.9542] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:18.9545] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:18.9548] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:18.9554] Slim::Player::Pipeline::sysread (303) Wrote 32768 bytes to pipeline writer [09-01-15 18:16:18.9557] Slim::Player::Pipeline::sysread (275) Pipeline doesn't have pending bytes - trying to get some from source [09-01-15 18:16:18.9560] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:18.9929] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:19.2656] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:19.5787] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:19.8613] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:19.9952] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:20.1781] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:20.4453] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:20.7261] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:20.9823] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer [09-01-15 18:16:20.9934] Slim::Player::StreamingController::_eventAction (269) 00:04:20:06:5c:41: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync [09-01-15 18:16:21.2830] Slim::Player::Pipeline::sysread (297) Attempting to write to pipeline writer