First Last Prev Next    This bug is not in your last search results.
Bug 17090 - WMA seeking fails if file does not contain an ASF_Index object
: WMA seeking fails if file does not contain an ASF_Index object
Status: RESOLVED FIXED
Product: Logitech Media Server
Classification: Unclassified
Component: Streaming From SlimServer
: 7.5.x
: All All
: P2 major with 1 vote (vote)
: 7.7.0
Assigned To: Andy Grundman
: Audio::Scan
Depends on:
Blocks:
  Show dependency tree / graph
 
Reported: 2011-03-24 14:22 UTC by Christian Spieles
Modified: 2011-09-14 11:43 UTC (History)
5 users (show)

See Also:
Category: Bug

Attachments
Add an attachment (proposed patch, testcase, etc.)

Note You need to log in before you can comment on or make changes to this bug.
Description Christian Spieles 2011-03-24 14:22:29 UTC 
I have some issues with my Squeezebox Radio.
Since the release of SBS 7.5.1 holding the ffwd button to ffwd to a position in a song doesn't work. This issue only happens when playing .wma files... mp3 files work fine. Also its the same when i try to use the webinterface of the SBS and do a click to the middle of the songs timeline.
Then a moment nothing happens and the song begins to play from the beginning and doesn't jump to for example 01:50min. (same by pressing and holding the ffwd button on the radio)
I tested different plattforms (win7 64bit, sbs for qnap nas...), reseted everything to factory defaults... same issues.
I can tell that the problem was introduced in the 7.5.1 release because when i try to ffwd with 7.5.0 it works fine even with the same wma files.

Hope you can fix this soon

Regards
Christian
Comment 1 Christian Spieles 2011-03-28 12:06:55 UTC 
Player-Modell: Squeezebox Radio

Firmware: 7.5.3-r9283
Comment 2 Christian Spieles 2011-03-29 14:53:17 UTC 
updated to Firmware: 7.5.3-r9377
still the same problem
Comment 3 Christian Spieles 2011-03-29 15:20:40 UTC 
Here is a copy from the log file from the server... it contains the moment when i wanted to jump to a position in the middle of the song... hope it will help!

[11-03-30 00:16:35.0816] Slim::Player::Protocols::File::open (95) Opening file /share/Multimedia/Musik/Squeezebox/Adam Lambert - If I Had You.wma
[11-03-30 00:16:35.0861] Slim::Player::Protocols::File::_timeToOffset (294) seeking using Slim::Formats::WMA findFrameBoundaries(2233514, 91.4077448747153)
[11-03-30 00:16:35.0906] Slim::Player::Protocols::File::_timeToOffset (306) 91.4077448747153 -> 0 (align: 1 size: 5578645 duration: 228.309)
[11-03-30 00:16:35.0930] Slim::Player::Protocols::File::open (178) Seeking in 0 into /share/Multimedia/Musik/Squeezebox/Adam Lambert - If I Had You.wma
[11-03-30 00:16:35.0962] Slim::Player::Song::open (476) URL is a song (audio): file:///share/Multimedia/Musik/Squeezebox/Adam%20Lambert%20-%20If%20I%20Had%20You.wma, type=wma
[11-03-30 00:16:35.1805] Slim::Player::SongStreamController::new (32) live=1
[11-03-30 00:16:35.1852] Slim::Player::StreamingController::_Stream (1228) 00:04:20:26:54:3e: stream
[11-03-30 00:16:35.1955] Slim::Player::StreamingController::_Stream (1263) Song queue is now 9
[11-03-30 00:16:35.2019] Slim::Player::StreamingController::_setPlayingState (2244) new playing state BUFFERING
[11-03-30 00:16:35.2041] Slim::Player::StreamingController::_setStreamingState (2257) new streaming state STREAMING
[11-03-30 00:16:35.2063] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: JumpToTime - new state BUFFERING-STREAMING
[11-03-30 00:16:35.2544] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-03-30 00:16:35.2780] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-03-30 00:16:35.2804] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-03-30 00:16:35.2827] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-03-30 00:16:35.2848] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-03-30 00:16:35.2870] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-03-30 00:16:35.2891] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-03-30 00:16:35.2913] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-03-30 00:16:35.2934] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-03-30 00:16:35.2955] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-03-30 00:16:35.2976] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-03-30 00:16:35.2997] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-03-30 00:16:35.3120] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-03-30 00:16:35.3146] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-03-30 00:16:36.2276] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-03-30 00:16:37.2800] Slim::Player::StreamingController::playerTrackStarted (2056) 00:04:20:26:54:3e
[11-03-30 00:16:37.2826] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: Started in BUFFERING-STREAMING -> Slim::Player::StreamingController::_Playing
[11-03-30 00:16:37.2848] Slim::Player::StreamingController::_setPlayingState (2244) new playing state PLAYING
[11-03-30 00:16:37.2876] Slim::Player::StreamingController::_Playing (361) Song 9 has now started playing
[11-03-30 00:16:37.2923] Slim::Player::StreamingController::_Playing (389) Song queue is now 9
[11-03-30 00:16:37.2951] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: Started - new state PLAYING-STREAMING
[11-03-30 00:16:37.6153] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-03-30 00:16:37.6178] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-03-30 00:16:37.6199] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-03-30 00:16:37.6221] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-03-30 00:16:37.6242] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-03-30 00:16:37.6263] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-03-30 00:16:37.6284] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-03-30 00:16:37.6305] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-03-30 00:16:37.6327] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-03-30 00:16:37.6348] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-03-30 00:16:37.6369] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-03-30 00:16:37.6391] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-03-30 00:16:37.6417] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-03-30 00:16:38.3782] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-03-30 00:16:39.2055] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-03-30 00:16:39.4404] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
Comment 4 Christian Spieles 2011-04-09 03:08:28 UTC 
Hey,

even tested my problem with the latest 7.5.4 nightly build...
Version: 7.5.4 - r32224 @ Tue Apr 5 02:07:33 PDT 2011

It seams like the Slim::Player::StreamingController::jumpToTime causes the problem. Here is a part of the log from the server.

[11-04-09 11:32:26.3611] Slim::Player::StreamingController::jumpToTime (2022) 00:04:20:26:54:3e
[11-04-09 11:32:26.3636] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: JumpToTime in PLAYING-STREAMING -> Slim::Player::StreamingController::_JumpToTime
[11-04-09 11:32:26.3653] Slim::Player::StreamingController::_eventAction (284) params: restartIfNoSeek => undef newtime => 84
[11-04-09 11:32:26.3833] Slim::Player::StreamingController::_Stop (604) Song queue is now 0
[11-04-09 11:32:26.3854] Slim::Player::SongStreamController::DESTROY (45) DESTROY(Slim::Player::SongStreamController=HASH(0x89e8e3c)) live=0
[11-04-09 11:32:26.3866] Slim::Player::StreamingController::_setPlayingState (2244) new playing state STOPPED



Here is the complete log from the Server:

[11-04-09 11:31:55.8336] Slim::Player::StreamingController::stop (1973) 00:04:20:26:54:3e
[11-04-09 11:31:55.8353] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: Stop in STOPPED-IDLE -> Slim::Player::StreamingController::_NoOp
[11-04-09 11:31:55.8578] Slim::Player::StreamingController::resetSongqueue (1652) Song queue is now 
[11-04-09 11:31:56.0306] Slim::Player::StreamingController::play (1976) 00:04:20:26:54:3e
[11-04-09 11:31:56.0319] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: Play in STOPPED-IDLE -> Slim::Player::StreamingController::_StopGetNext
[11-04-09 11:31:56.0345] Slim::Player::StreamingController::_eventAction (284) params: index => 0 seekdata => undef
[11-04-09 11:31:56.1955] Slim::Player::StreamingController::_setPlayingState (2244) new playing state STOPPED
[11-04-09 11:31:56.1967] Slim::Player::StreamingController::_setStreamingState (2257) new streaming state IDLE
[11-04-09 11:31:56.2684] Slim::Player::Song::new (107) index 0 -> file:///D:/Musik/Madness%20-%20Our%20House%20(1999%20Digital%20Remaster).wma
[11-04-09 11:31:56.5194] Slim::Player::Song::new (149) live=1
[11-04-09 11:31:56.5206] Slim::Player::StreamingController::_setStreamingState (2257) new streaming state TRACKWAIT
[11-04-09 11:31:56.5222] Slim::Player::Song::getNextSong (228) file:///D:/Musik/Madness%20-%20Our%20House%20(1999%20Digital%20Remaster).wma
[11-04-09 11:31:56.5298] Slim::Player::StreamingController::_nextTrackReady (730) 00:04:20:26:54:3e: nextTrack will be index 0
[11-04-09 11:31:56.5339] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: NextTrackReady in STOPPED-TRACKWAIT -> Slim::Player::StreamingController::_Stream
[11-04-09 11:31:56.5586] Slim::Player::StreamingController::_Stream (1170) Song queue is now 0
[11-04-09 11:31:56.5725] Slim::Player::StreamingController::_Stream (1173) 00:04:20:26:54:3e: preparing to stream song index 0
[11-04-09 11:31:56.6029] Slim::Player::Song::open (362) file:///D:/Musik/Madness%20-%20Our%20House%20(1999%20Digital%20Remaster).wma
[11-04-09 11:31:56.8246] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:31:56.8263] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 11:31:56.8274] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 11:31:56.8286] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-04-09 11:31:56.8296] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-04-09 11:31:56.8310] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 11:31:56.8322] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 11:31:56.8332] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-04-09 11:31:56.8341] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-04-09 11:31:56.8351] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:31:56.8360] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-04-09 11:31:56.8370] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-04-09 11:31:56.8550] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-04-09 11:31:56.8563] Slim::Player::Song::open (386) seek=false time=0 canSeek=1
[11-04-09 11:31:56.8592] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:31:56.8609] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 11:31:56.8620] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 11:31:56.8629] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-04-09 11:31:56.8638] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-04-09 11:31:56.8648] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 11:31:56.8658] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 11:31:56.8667] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-04-09 11:31:56.8676] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-04-09 11:31:56.8686] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:31:56.8699] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-04-09 11:31:56.8709] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-04-09 11:31:56.8724] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-04-09 11:31:56.8737] Slim::Player::Song::open (407) Transcoder: streamMode=I, streamformat=wma
[11-04-09 11:31:56.8751] Slim::Player::Song::open (455) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///D:/Musik/Madness%20-%20Our%20House%20(1999%20Digital%20Remaster).wma]
[11-04-09 11:31:56.8792] Slim::Player::Protocols::File::open (78) duration: [201.266] size: [4854837] endian [] offset: [0] for file:///D:/Musik/Madness%20-%20Our%20House%20(1999%20Digital%20Remaster).wma
[11-04-09 11:31:56.8803] Slim::Player::Protocols::File::open (95) Opening file D:\Musik\Madness - Our House (1999 Digital Remaster).wma
[11-04-09 11:31:56.8833] Slim::Player::Protocols::File::open (178) Seeking in 0 into D:\Musik\Madness - Our House (1999 Digital Remaster).wma
[11-04-09 11:31:56.8854] Slim::Player::Song::open (476) URL is a song (audio): file:///D:/Musik/Madness%20-%20Our%20House%20(1999%20Digital%20Remaster).wma, type=wma
[11-04-09 11:31:57.1145] Slim::Player::SongStreamController::new (32) live=1
[11-04-09 11:31:57.1631] Slim::Player::StreamingController::_Stream (1228) 00:04:20:26:54:3e: stream
[11-04-09 11:31:57.2980] Slim::Player::StreamingController::_Stream (1263) Song queue is now 0
[11-04-09 11:31:57.2998] Slim::Player::StreamingController::_setPlayingState (2244) new playing state BUFFERING
[11-04-09 11:31:57.3008] Slim::Player::StreamingController::_setStreamingState (2257) new streaming state STREAMING
[11-04-09 11:31:57.3019] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: NextTrackReady - new state BUFFERING-STREAMING
[11-04-09 11:31:57.3033] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: Play - new state BUFFERING-STREAMING
[11-04-09 11:31:57.6118] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-04-09 11:31:58.1067] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:31:58.1084] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 11:31:58.1096] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 11:31:58.1108] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-04-09 11:31:58.1120] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-04-09 11:31:58.1140] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 11:31:58.1155] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 11:31:58.1174] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-04-09 11:31:58.1185] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-04-09 11:31:58.1196] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:31:58.1207] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-04-09 11:31:58.1222] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-04-09 11:31:58.1240] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-04-09 11:31:58.9668] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-04-09 11:31:59.4526] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-04-09 11:31:59.7755] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-04-09 11:32:03.1738] Slim::Player::StreamingController::playerTrackStarted (2056) 00:04:20:26:54:3e
[11-04-09 11:32:03.1822] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: Started in BUFFERING-STREAMING -> Slim::Player::StreamingController::_Playing
[11-04-09 11:32:03.1835] Slim::Player::StreamingController::_setPlayingState (2244) new playing state PLAYING
[11-04-09 11:32:03.1845] Slim::Player::StreamingController::_Playing (361) Song 0 has now started playing
[11-04-09 11:32:03.1871] Slim::Player::StreamingController::_Playing (389) Song queue is now 0
[11-04-09 11:32:03.1883] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: Started - new state PLAYING-STREAMING
[11-04-09 11:32:03.1902] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:03.1921] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:05.3024] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:05.7335] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:32:05.7348] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 11:32:05.7358] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 11:32:05.7367] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-04-09 11:32:05.7376] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-04-09 11:32:05.7385] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 11:32:05.7395] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 11:32:05.7404] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-04-09 11:32:05.7414] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-04-09 11:32:05.7423] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:32:05.7433] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-04-09 11:32:05.7443] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-04-09 11:32:05.7456] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-04-09 11:32:07.8206] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:08.2092] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:09.7567] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:10.4674] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:11.1888] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:11.5284] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:12.6368] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:13.6668] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:14.8579] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:15.8984] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:16.3217] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:17.0393] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:18.1364] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:19.1118] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:20.3552] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:21.2830] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:21.2854] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:22.5366] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:23.5464] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:25.1165] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:25.7838] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:26.2316] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:26.3611] Slim::Player::StreamingController::jumpToTime (2022) 00:04:20:26:54:3e
[11-04-09 11:32:26.3636] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: JumpToTime in PLAYING-STREAMING -> Slim::Player::StreamingController::_JumpToTime
[11-04-09 11:32:26.3653] Slim::Player::StreamingController::_eventAction (284) params: restartIfNoSeek => undef newtime => 84
[11-04-09 11:32:26.3833] Slim::Player::StreamingController::_Stop (604) Song queue is now 0
[11-04-09 11:32:26.3854] Slim::Player::SongStreamController::DESTROY (45) DESTROY(Slim::Player::SongStreamController=HASH(0x89e8e3c)) live=0
[11-04-09 11:32:26.3866] Slim::Player::StreamingController::_setPlayingState (2244) new playing state STOPPED
[11-04-09 11:32:26.3876] Slim::Player::StreamingController::_setStreamingState (2257) new streaming state IDLE
[11-04-09 11:32:26.3891] Slim::Player::StreamingController::_Stream (1096) 00:04:20:26:54:3e: got song from params, song index 0
[11-04-09 11:32:26.3914] Slim::Player::StreamingController::_Stream (1170) Song queue is now 0
[11-04-09 11:32:26.3934] Slim::Player::StreamingController::_Stream (1173) 00:04:20:26:54:3e: preparing to stream song index 0
[11-04-09 11:32:26.3952] Slim::Player::Song::open (362) file:///D:/Musik/Madness%20-%20Our%20House%20(1999%20Digital%20Remaster).wma
[11-04-09 11:32:26.3983] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:32:26.3996] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 11:32:26.4007] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 11:32:26.4016] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-04-09 11:32:26.4026] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-04-09 11:32:26.4036] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 11:32:26.4046] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 11:32:26.4056] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-04-09 11:32:26.4066] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-04-09 11:32:26.4084] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:32:26.4100] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-04-09 11:32:26.4111] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-04-09 11:32:26.4124] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-04-09 11:32:26.4138] Slim::Player::Song::open (386) seek=true time=84 canSeek=1
[11-04-09 11:32:26.4161] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:32:26.4174] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 11:32:26.4184] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 11:32:26.4194] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-04-09 11:32:26.4204] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-04-09 11:32:26.4221] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 11:32:26.4233] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 11:32:26.4248] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-04-09 11:32:26.4260] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-04-09 11:32:26.4272] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:32:26.4288] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-04-09 11:32:26.4300] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-04-09 11:32:26.4313] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-04-09 11:32:26.4324] Slim::Player::Song::open (407) Transcoder: streamMode=I, streamformat=wma
[11-04-09 11:32:26.4337] Slim::Player::Song::open (455) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///D:/Musik/Madness%20-%20Our%20House%20(1999%20Digital%20Remaster).wma]
[11-04-09 11:32:26.4369] Slim::Player::Protocols::File::open (78) duration: [201.266] size: [4854837] endian [] offset: [0] for file:///D:/Musik/Madness%20-%20Our%20House%20(1999%20Digital%20Remaster).wma
[11-04-09 11:32:26.4381] Slim::Player::Protocols::File::open (95) Opening file D:\Musik\Madness - Our House (1999 Digital Remaster).wma
[11-04-09 11:32:26.4411] Slim::Player::Protocols::File::_timeToOffset (294) seeking using Slim::Formats::WMA findFrameBoundaries(2026205, 84)
[11-04-09 11:32:26.5100] Slim::Player::Protocols::File::_timeToOffset (306) 84 -> 0 (align: 1 size: 4854837 duration: 201.266)
[11-04-09 11:32:26.5112] Slim::Player::Protocols::File::open (178) Seeking in 0 into D:\Musik\Madness - Our House (1999 Digital Remaster).wma
[11-04-09 11:32:26.5128] Slim::Player::Song::open (476) URL is a song (audio): file:///D:/Musik/Madness%20-%20Our%20House%20(1999%20Digital%20Remaster).wma, type=wma
[11-04-09 11:32:26.5658] Slim::Player::SongStreamController::new (32) live=1
[11-04-09 11:32:26.5688] Slim::Player::StreamingController::_Stream (1228) 00:04:20:26:54:3e: stream
[11-04-09 11:32:26.5925] Slim::Player::StreamingController::_Stream (1263) Song queue is now 0
[11-04-09 11:32:26.5952] Slim::Player::StreamingController::_setPlayingState (2244) new playing state BUFFERING
[11-04-09 11:32:26.5964] Slim::Player::StreamingController::_setStreamingState (2257) new streaming state STREAMING
[11-04-09 11:32:26.5975] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: JumpToTime - new state BUFFERING-STREAMING
[11-04-09 11:32:26.9104] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-04-09 11:32:27.4464] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-04-09 11:32:28.1154] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:32:28.1167] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 11:32:28.1177] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 11:32:28.1186] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-04-09 11:32:28.1196] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-04-09 11:32:28.1208] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 11:32:28.1225] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 11:32:28.1239] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-04-09 11:32:28.1250] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-04-09 11:32:28.1260] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:32:28.1270] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-04-09 11:32:28.1280] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-04-09 11:32:28.1293] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-04-09 11:32:31.2974] Slim::Player::StreamingController::playerTrackStarted (2056) 00:04:20:26:54:3e
[11-04-09 11:32:31.2988] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: Started in BUFFERING-STREAMING -> Slim::Player::StreamingController::_Playing
[11-04-09 11:32:31.3001] Slim::Player::StreamingController::_setPlayingState (2244) new playing state PLAYING
[11-04-09 11:32:31.3014] Slim::Player::StreamingController::_Playing (361) Song 0 has now started playing
[11-04-09 11:32:31.3039] Slim::Player::StreamingController::_Playing (389) Song queue is now 0
[11-04-09 11:32:31.3055] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: Started - new state PLAYING-STREAMING
[11-04-09 11:32:31.6165] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:32:31.6180] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 11:32:31.6195] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 11:32:31.6210] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-04-09 11:32:31.6221] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-04-09 11:32:31.6231] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 11:32:31.6241] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 11:32:31.6251] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-04-09 11:32:31.6261] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-04-09 11:32:31.6270] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-09 11:32:31.6280] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-04-09 11:32:31.6289] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-04-09 11:32:31.6302] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-04-09 11:32:31.8335] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:32.1428] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:33.1835] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:34.2364] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:35.4775] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:36.1340] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:36.5449] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 11:32:37.5834] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
Comment 5 Christian Spieles 2011-04-09 03:37:47 UTC 
just tested the nightly 7.6
Version: 7.6.0 - r32248 @ Fri Apr 8 02:07:46 PDT 2011

Squeezebox Radio 
Player-Modell: Squeezebox Radio 
Firmware: 7.6.0-r9405

even this version has the wma bug. Here the logfile:

Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:27.0589] Slim::Player::StreamingController::jumpToTime (2113) 00:04:20:26:54:3e
[11-04-09 12:30:27.0602] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: JumpToTime in PLAYING-STREAMING -> Slim::Player::StreamingController::_JumpToTime
[11-04-09 12:30:27.0613] Slim::Player::StreamingController::_eventAction (284) params: restartIfNoSeek => undef newtime => 102.813211845103
[11-04-09 12:30:27.0642] Slim::Player::StreamingController::_Stop (603) Song queue is now 1
[11-04-09 12:30:27.0663] Slim::Player::SongStreamController::DESTROY (44) DESTROY(Slim::Player::SongStreamController=HASH(0x940bcf4)) live=0
[11-04-09 12:30:27.0675] Slim::Player::StreamingController::_setPlayingState (2335) new playing state STOPPED
[11-04-09 12:30:27.0685] Slim::Player::StreamingController::_setStreamingState (2348) new streaming state IDLE
[11-04-09 12:30:27.0701] Slim::Player::StreamingController::_Stream (1122) 00:04:20:26:54:3e: got song from params, song index 1
[11-04-09 12:30:27.0716] Slim::Player::StreamingController::_Stream (1196) Song queue is now 1
[11-04-09 12:30:27.0729] Slim::Player::StreamingController::_Stream (1199) 00:04:20:26:54:3e: preparing to stream song index 1
[11-04-09 12:30:27.0744] Slim::Player::Song::open (363) file:///D:/Musik/Agnes%20-%20Release%20Me%20[long%20version].wma
[11-04-09 12:30:27.0779] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:27.0792] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 12:30:27.0807] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 12:30:27.0817] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-*
[11-04-09 12:30:27.0830] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-*
[11-04-09 12:30:27.0844] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 12:30:27.0855] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 12:30:27.0865] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-*
[11-04-09 12:30:27.0874] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-*
[11-04-09 12:30:27.0885] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:27.0914] Slim::Player::TranscodingHelper::checkBin (239)    enabled
[11-04-09 12:30:27.0928] Slim::Player::TranscodingHelper::checkBin (241)   Found command: -
[11-04-09 12:30:27.0943] Slim::Player::TranscodingHelper::getConvertCommand2 (428) Matched: wma->wma via: -
[11-04-09 12:30:27.0955] Slim::Player::Song::open (387) seek=true time=102.813211845103 canSeek=1
[11-04-09 12:30:27.0977] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:27.0990] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 12:30:27.1000] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 12:30:27.1010] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-*
[11-04-09 12:30:27.1020] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-*
[11-04-09 12:30:27.1030] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 12:30:27.1040] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 12:30:27.1053] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-*
[11-04-09 12:30:27.1064] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-*
[11-04-09 12:30:27.1074] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:27.1084] Slim::Player::TranscodingHelper::checkBin (239)    enabled
[11-04-09 12:30:27.1093] Slim::Player::TranscodingHelper::checkBin (241)   Found command: -
[11-04-09 12:30:27.1106] Slim::Player::TranscodingHelper::getConvertCommand2 (428) Matched: wma->wma via: -
[11-04-09 12:30:27.1119] Slim::Player::Song::open (408) Transcoder: streamMode=I, streamformat=wma
[11-04-09 12:30:27.1134] Slim::Player::Song::open (461) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///D:/Musik/Agnes%20-%20Release%20Me%20[long%20version].wma]
[11-04-09 12:30:27.1191] Slim::Player::Protocols::File::open (81) duration: [255.586] size: [6172399] endian [] offset: [0] for file:///D:/Musik/Agnes%20-%20Release%20Me%20[long%20version].wma
[11-04-09 12:30:27.1203] Slim::Player::Protocols::File::open (98) Opening file D:\Musik\Agnes - Release Me [long version].wma
[11-04-09 12:30:27.1232] Slim::Player::Protocols::File::_timeToOffset (350) seeking using Slim::Formats::WMA findFrameBoundaries(2482937, 102.813211845103)
[11-04-09 12:30:27.1253] Slim::Player::Protocols::File::_timeToOffset (362) 102.813211845103 -> 0 (align: 1 size: 6172399 duration: 255.586)
[11-04-09 12:30:27.1265] Slim::Player::Protocols::File::open (192) Seeking in 0 into D:\Musik\Agnes - Release Me [long version].wma
[11-04-09 12:30:27.1286] Slim::Player::Song::open (482) URL is a song (audio): file:///D:/Musik/Agnes%20-%20Release%20Me%20[long%20version].wma, type=wma
[11-04-09 12:30:27.5145] Slim::Player::SongStreamController::new (31) live=1
[11-04-09 12:30:27.5177] Slim::Player::StreamingController::_Stream (1258) 00:04:20:26:54:3e: stream
[11-04-09 12:30:27.5257] Slim::Player::StreamingController::_Stream (1293) Song queue is now 1
[11-04-09 12:30:27.5275] Slim::Player::StreamingController::_setPlayingState (2335) new playing state BUFFERING
[11-04-09 12:30:27.5290] Slim::Player::StreamingController::_setStreamingState (2348) new streaming state STREAMING
[11-04-09 12:30:27.5302] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: JumpToTime - new state BUFFERING-STREAMING
[11-04-09 12:30:27.6136] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:27.6159] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 12:30:27.6203] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 12:30:27.6216] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-*
[11-04-09 12:30:27.6226] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-*
[11-04-09 12:30:27.6235] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 12:30:27.6248] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 12:30:27.6260] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-*
[11-04-09 12:30:27.6270] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-*
[11-04-09 12:30:27.6280] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:27.6292] Slim::Player::TranscodingHelper::checkBin (239)    enabled
[11-04-09 12:30:27.6302] Slim::Player::TranscodingHelper::checkBin (241)   Found command: -
[11-04-09 12:30:27.6319] Slim::Player::TranscodingHelper::getConvertCommand2 (428) Matched: wma->wma via: -
[11-04-09 12:30:27.7568] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-04-09 12:30:28.0916] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-04-09 12:30:28.2985] Slim::Player::StreamingController::playerTrackStarted (2147) 00:04:20:26:54:3e
[11-04-09 12:30:28.2998] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: Started in BUFFERING-STREAMING -> Slim::Player::StreamingController::_Playing
[11-04-09 12:30:28.3009] Slim::Player::StreamingController::_setPlayingState (2335) new playing state PLAYING
[11-04-09 12:30:28.3019] Slim::Player::StreamingController::_Playing (361) Song 1 has now started playing
[11-04-09 12:30:28.3043] Slim::Player::StreamingController::_Playing (390) Song queue is now 1
[11-04-09 12:30:28.3055] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: Started - new state PLAYING-STREAMING
[11-04-09 12:30:28.6125] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:28.6149] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 12:30:28.6178] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 12:30:28.6195] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-*
[11-04-09 12:30:28.6206] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-*
[11-04-09 12:30:28.6215] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 12:30:28.6228] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 12:30:28.6251] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-*
[11-04-09 12:30:28.6271] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-*
[11-04-09 12:30:28.6283] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:28.6293] Slim::Player::TranscodingHelper::checkBin (239)    enabled
[11-04-09 12:30:28.6303] Slim::Player::TranscodingHelper::checkBin (241)   Found command: -
[11-04-09 12:30:28.6320] Slim::Player::TranscodingHelper::getConvertCommand2 (428) Matched: wma->wma via: -
[11-04-09 12:30:29.3973] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:29.9753] Slim::Player::StreamingController::jumpToTime (2113) 00:04:20:26:54:3e
[11-04-09 12:30:29.9768] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: JumpToTime in PLAYING-STREAMING -> Slim::Player::StreamingController::_JumpToTime
[11-04-09 12:30:29.9781] Slim::Player::StreamingController::_eventAction (284) params: restartIfNoSeek => undef newtime => 107.46013667426
[11-04-09 12:30:29.9820] Slim::Player::StreamingController::_Stop (603) Song queue is now 1
[11-04-09 12:30:29.9840] Slim::Player::SongStreamController::DESTROY (44) DESTROY(Slim::Player::SongStreamController=HASH(0x7b34574)) live=0
[11-04-09 12:30:29.9858] Slim::Player::StreamingController::_setPlayingState (2335) new playing state STOPPED
[11-04-09 12:30:29.9870] Slim::Player::StreamingController::_setStreamingState (2348) new streaming state IDLE
[11-04-09 12:30:29.9881] Slim::Player::StreamingController::_Stream (1122) 00:04:20:26:54:3e: got song from params, song index 1
[11-04-09 12:30:29.9892] Slim::Player::StreamingController::_Stream (1196) Song queue is now 1
[11-04-09 12:30:29.9902] Slim::Player::StreamingController::_Stream (1199) 00:04:20:26:54:3e: preparing to stream song index 1
[11-04-09 12:30:29.9916] Slim::Player::Song::open (363) file:///D:/Musik/Agnes%20-%20Release%20Me%20[long%20version].wma
[11-04-09 12:30:29.9947] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:29.9959] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 12:30:29.9969] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 12:30:29.9986] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-*
[11-04-09 12:30:30.0004] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-*
[11-04-09 12:30:30.0019] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 12:30:30.0034] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 12:30:30.0052] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-*
[11-04-09 12:30:30.0064] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-*
[11-04-09 12:30:30.0074] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:30.0084] Slim::Player::TranscodingHelper::checkBin (239)    enabled
[11-04-09 12:30:30.0093] Slim::Player::TranscodingHelper::checkBin (241)   Found command: -
[11-04-09 12:30:30.0115] Slim::Player::TranscodingHelper::getConvertCommand2 (428) Matched: wma->wma via: -
[11-04-09 12:30:30.0134] Slim::Player::Song::open (387) seek=true time=107.46013667426 canSeek=1
[11-04-09 12:30:30.0171] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:30.0192] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 12:30:30.0210] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 12:30:30.0228] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-*
[11-04-09 12:30:30.0245] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-*
[11-04-09 12:30:30.0259] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 12:30:30.0272] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 12:30:30.0283] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-*
[11-04-09 12:30:30.0293] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-*
[11-04-09 12:30:30.0302] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:30.0316] Slim::Player::TranscodingHelper::checkBin (239)    enabled
[11-04-09 12:30:30.0328] Slim::Player::TranscodingHelper::checkBin (241)   Found command: -
[11-04-09 12:30:30.0342] Slim::Player::TranscodingHelper::getConvertCommand2 (428) Matched: wma->wma via: -
[11-04-09 12:30:30.0358] Slim::Player::Song::open (408) Transcoder: streamMode=I, streamformat=wma
[11-04-09 12:30:30.0371] Slim::Player::Song::open (461) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///D:/Musik/Agnes%20-%20Release%20Me%20[long%20version].wma]
[11-04-09 12:30:30.0398] Slim::Player::Protocols::File::open (81) duration: [255.586] size: [6172399] endian [] offset: [0] for file:///D:/Musik/Agnes%20-%20Release%20Me%20[long%20version].wma
[11-04-09 12:30:30.0409] Slim::Player::Protocols::File::open (98) Opening file D:\Musik\Agnes - Release Me [long version].wma
[11-04-09 12:30:30.0436] Slim::Player::Protocols::File::_timeToOffset (350) seeking using Slim::Formats::WMA findFrameBoundaries(2595161, 107.46013667426)
[11-04-09 12:30:30.0458] Slim::Player::Protocols::File::_timeToOffset (362) 107.46013667426 -> 0 (align: 1 size: 6172399 duration: 255.586)
[11-04-09 12:30:30.0475] Slim::Player::Protocols::File::open (192) Seeking in 0 into D:\Musik\Agnes - Release Me [long version].wma
[11-04-09 12:30:30.0494] Slim::Player::Song::open (482) URL is a song (audio): file:///D:/Musik/Agnes%20-%20Release%20Me%20[long%20version].wma, type=wma
[11-04-09 12:30:30.1812] Slim::Player::SongStreamController::new (31) live=1
[11-04-09 12:30:30.1853] Slim::Player::StreamingController::_Stream (1258) 00:04:20:26:54:3e: stream
[11-04-09 12:30:30.1945] Slim::Player::StreamingController::_Stream (1293) Song queue is now 1
[11-04-09 12:30:30.1962] Slim::Player::StreamingController::_setPlayingState (2335) new playing state BUFFERING
[11-04-09 12:30:30.1978] Slim::Player::StreamingController::_setStreamingState (2348) new streaming state STREAMING
[11-04-09 12:30:30.1989] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: JumpToTime - new state BUFFERING-STREAMING
[11-04-09 12:30:30.2905] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:30.2930] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 12:30:30.2943] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 12:30:30.2954] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-*
[11-04-09 12:30:30.2964] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-*
[11-04-09 12:30:30.2974] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 12:30:30.2983] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 12:30:30.2993] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-*
[11-04-09 12:30:30.3004] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-*
[11-04-09 12:30:30.3034] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:30.3050] Slim::Player::TranscodingHelper::checkBin (239)    enabled
[11-04-09 12:30:30.3066] Slim::Player::TranscodingHelper::checkBin (241)   Found command: -
[11-04-09 12:30:30.3081] Slim::Player::TranscodingHelper::getConvertCommand2 (428) Matched: wma->wma via: -
[11-04-09 12:30:30.5756] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-04-09 12:30:30.5777] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-04-09 12:30:30.7882] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-04-09 12:30:31.0785] Slim::Player::StreamingController::playerTrackStarted (2147) 00:04:20:26:54:3e
[11-04-09 12:30:31.0815] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: Started in BUFFERING-STREAMING -> Slim::Player::StreamingController::_Playing
[11-04-09 12:30:31.0826] Slim::Player::StreamingController::_setPlayingState (2335) new playing state PLAYING
[11-04-09 12:30:31.0836] Slim::Player::StreamingController::_Playing (361) Song 1 has now started playing
[11-04-09 12:30:31.0861] Slim::Player::StreamingController::_Playing (390) Song queue is now 1
[11-04-09 12:30:31.0872] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: Started - new state PLAYING-STREAMING
[11-04-09 12:30:31.3950] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:31.3972] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-09 12:30:31.3985] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-09 12:30:31.4127] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-baby-*
[11-04-09 12:30:31.4172] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-alc-*-*
[11-04-09 12:30:31.4281] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-09 12:30:31.4305] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-09 12:30:31.4316] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-baby-*
[11-04-09 12:30:31.4329] Slim::Player::TranscodingHelper::checkBin (231) Checking formats for: wma-wma-*-*
[11-04-09 12:30:31.4355] Slim::Player::TranscodingHelper::enabledFormat (198) Checking to see if wma-wma-*-* is enabled
[11-04-09 12:30:31.4367] Slim::Player::TranscodingHelper::checkBin (239)    enabled
[11-04-09 12:30:31.4376] Slim::Player::TranscodingHelper::checkBin (241)   Found command: -
[11-04-09 12:30:31.4398] Slim::Player::TranscodingHelper::getConvertCommand2 (428) Matched: wma->wma via: -
[11-04-09 12:30:32.1619] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:33.2242] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:34.2707] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:35.1221] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:35.3364] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:36.3632] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:37.4906] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:38.5465] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:39.5763] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:40.0599] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:40.6660] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:41.7885] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-09 12:30:42.9434] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
Comment 6 Christian Spieles 2011-04-14 14:48:52 UTC 
Hello,

would be really nice if someone could have a look at this bug... still got no answer since weeks now... :-(

Update: Just installed the brand new 7.5.4 release of the SBS and updated my Radio to Firmware: 7.5.4-r9408


Here is maybe a more usefull log with debug enabled for network.protocol.slimp3 and formats.audio hope this would help to identify my problem.

Thanks in advance.
Christian


[11-04-14 23:34:19.0492] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_CheckSync
[11-04-14 23:34:19.7060] Slim::Player::StreamingController::jumpToTime (2022) 00:04:20:26:54:3e
[11-04-14 23:34:19.7087] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: JumpToTime in PLAYING-STREAMOUT -> Slim::Player::StreamingController::_JumpToTime
[11-04-14 23:34:19.7112] Slim::Player::StreamingController::_eventAction (284) params: restartIfNoSeek => undef newtime => 76.7927107061503
[11-04-14 23:34:19.7160] Slim::Player::StreamingController::_Stop (604) Song queue is now 2
[11-04-14 23:34:19.7186] Slim::Player::SongStreamController::DESTROY (45) DESTROY(Slim::Player::SongStreamController=HASH(0x3a011c8)) live=0
[11-04-14 23:34:19.7210] Slim::Player::StreamingController::_setPlayingState (2244) new playing state STOPPED
[11-04-14 23:34:19.7234] Slim::Player::StreamingController::_setStreamingState (2257) new streaming state IDLE
[11-04-14 23:34:19.7260] Slim::Player::StreamingController::_Stream (1096) 00:04:20:26:54:3e: got song from params, song index 2
[11-04-14 23:34:19.7287] Slim::Player::StreamingController::_Stream (1170) Song queue is now 2
[11-04-14 23:34:19.7311] Slim::Player::StreamingController::_Stream (1173) 00:04:20:26:54:3e: preparing to stream song index 2
[11-04-14 23:34:19.7340] Slim::Player::Song::open (362) file:///share/Multimedia/Musik/Squeezebox/Natalia%20Kills%20-%20Mirrors.wma
[11-04-14 23:34:19.7415] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-14 23:34:19.7442] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-14 23:34:19.7466] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-14 23:34:19.7491] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-04-14 23:34:19.7515] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-04-14 23:34:19.7539] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-14 23:34:19.7563] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-14 23:34:19.7587] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-04-14 23:34:19.7611] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-04-14 23:34:19.7635] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-14 23:34:19.7659] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-04-14 23:34:19.7682] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-04-14 23:34:19.7711] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-04-14 23:34:19.7737] Slim::Player::Song::open (386) seek=true time=76.7927107061503 canSeek=1
[11-04-14 23:34:19.7783] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-14 23:34:19.7810] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-14 23:34:19.7834] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-14 23:34:19.7857] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-04-14 23:34:19.7880] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-04-14 23:34:19.7904] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-14 23:34:19.7928] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-14 23:34:19.7951] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-04-14 23:34:19.7975] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-04-14 23:34:19.7999] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-14 23:34:19.8022] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-04-14 23:34:19.8046] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-04-14 23:34:19.8074] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-04-14 23:34:19.8100] Slim::Player::Song::open (407) Transcoder: streamMode=I, streamformat=wma
[11-04-14 23:34:19.8128] Slim::Player::Song::open (455) Opening stream (no direct streaming) using Slim::Player::Protocols::File [file:///share/Multimedia/Musik/Squeezebox/Natalia%20Kills%20-%20Mirrors.wma]
[11-04-14 23:34:19.8177] Slim::Player::Protocols::File::open (78) duration: [196.596] size: [4771129] endian [] offset: [0] for file:///share/Multimedia/Musik/Squeezebox/Natalia%20Kills%20-%20Mirrors.wma
[11-04-14 23:34:19.8201] Slim::Player::Protocols::File::open (95) Opening file /share/Multimedia/Musik/Squeezebox/Natalia Kills - Mirrors.wma
[11-04-14 23:34:19.8252] Slim::Player::Protocols::File::_timeToOffset (294) seeking using Slim::Formats::WMA findFrameBoundaries(1863659, 76.7927107061503)
** Unhandled GUID: 1806d474-cadf-4509-a4ba-9aabcb96aae8 size: 1406
** Unhandled GUID: 1806d474-cadf-4509-a4ba-9aabcb96aae8 size: 172
** Unhandled GUID: 1806d474-cadf-4509-a4ba-9aabcb96aae8 size: 400
[11-04-14 23:34:19.8296] Slim::Player::Protocols::File::_timeToOffset (306) 76.7927107061503 -> 0 (align: 1 size: 4771129 duration: 196.596)
[11-04-14 23:34:19.8321] Slim::Player::Protocols::File::open (178) Seeking in 0 into /share/Multimedia/Musik/Squeezebox/Natalia Kills - Mirrors.wma
[11-04-14 23:34:19.8356] Slim::Player::Song::open (476) URL is a song (audio): file:///share/Multimedia/Musik/Squeezebox/Natalia%20Kills%20-%20Mirrors.wma, type=wma
[11-04-14 23:34:19.9539] Slim::Player::SongStreamController::new (32) live=1
[11-04-14 23:34:19.9592] Slim::Player::StreamingController::_Stream (1228) 00:04:20:26:54:3e: stream
[11-04-14 23:34:19.9709] Slim::Player::StreamingController::_Stream (1263) Song queue is now 2
[11-04-14 23:34:19.9738] Slim::Player::StreamingController::_setPlayingState (2244) new playing state BUFFERING
[11-04-14 23:34:19.9763] Slim::Player::StreamingController::_setStreamingState (2257) new streaming state STREAMING
[11-04-14 23:34:19.9789] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: JumpToTime - new state BUFFERING-STREAMING
[11-04-14 23:34:20.0291] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-14 23:34:20.0319] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-14 23:34:20.0343] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-14 23:34:20.0367] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-04-14 23:34:20.0391] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-04-14 23:34:20.0415] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-14 23:34:20.0439] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-14 23:34:20.0462] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-04-14 23:34:20.0487] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-04-14 23:34:20.0511] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-14 23:34:20.0535] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-04-14 23:34:20.0558] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-04-14 23:34:20.0587] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-04-14 23:34:20.4519] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-04-14 23:34:20.7926] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in BUFFERING-STREAMING -> Slim::Player::StreamingController::_NoOp
[11-04-14 23:34:21.8587] Slim::Player::StreamingController::playerTrackStarted (2056) 00:04:20:26:54:3e
[11-04-14 23:34:21.8615] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: Started in BUFFERING-STREAMING -> Slim::Player::StreamingController::_Playing
[11-04-14 23:34:21.8639] Slim::Player::StreamingController::_setPlayingState (2244) new playing state PLAYING
[11-04-14 23:34:21.8664] Slim::Player::StreamingController::_Playing (361) Song 2 has now started playing
[11-04-14 23:34:21.8719] Slim::Player::StreamingController::_Playing (389) Song queue is now 2
[11-04-14 23:34:21.8745] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: Started - new state PLAYING-STREAMING
[11-04-14 23:34:22.1022] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-14 23:34:22.2054] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-14 23:34:22.2082] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-00:04:20:26:54:3e
[11-04-14 23:34:22.2106] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-00:04:20:26:54:3e
[11-04-14 23:34:22.2130] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-baby-*
[11-04-14 23:34:22.2154] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-alc-*-*
[11-04-14 23:34:22.2177] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-00:04:20:26:54:3e
[11-04-14 23:34:22.2202] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-00:04:20:26:54:3e
[11-04-14 23:34:22.2225] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-baby-*
[11-04-14 23:34:22.2249] Slim::Player::TranscodingHelper::checkBin (232) Checking formats for: wma-wma-*-*
[11-04-14 23:34:22.2272] Slim::Player::TranscodingHelper::enabledFormat (199) Checking to see if wma-wma-*-* is enabled
[11-04-14 23:34:22.2298] Slim::Player::TranscodingHelper::checkBin (240)    enabled
[11-04-14 23:34:22.2322] Slim::Player::TranscodingHelper::checkBin (242)   Found command: -
[11-04-14 23:34:22.2351] Slim::Player::TranscodingHelper::getConvertCommand2 (424) Matched: wma->wma via: -
[11-04-14 23:34:22.9649] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-14 23:34:24.0759] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-14 23:34:25.1981] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-14 23:34:25.4681] Slim::Player::StreamingController::playerOutputUnderrun (2095) 00:04:20:26:54:3e: decoder: 2547650 / output: 0
[11-04-14 23:34:25.4708] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: OutputUnderrun in PLAYING-STREAMING -> Slim::Player::StreamingController::_Rebuffer
[11-04-14 23:34:25.4732] Slim::Player::StreamingController::_setPlayingState (2244) new playing state BUFFERING
[11-04-14 23:34:25.4847] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: OutputUnderrun - new state BUFFERING-STREAMING
[11-04-14 23:34:25.6104] Slim::Player::Player::_buffering (1152) Buffering... 2547650 / 120800
[11-04-14 23:34:25.6129] Slim::Player::StreamingController::playerBufferReady (2145) 00:04:20:26:54:3e
[11-04-14 23:34:25.6155] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: BufferReady in BUFFERING-STREAMING -> Slim::Player::StreamingController::_WaitToSync
[11-04-14 23:34:25.6180] Slim::Player::StreamingController::_setPlayingState (2244) new playing state WAITING_TO_SYNC
[11-04-14 23:34:25.6206] Slim::Player::StreamingController::_setPlayingState (2244) new playing state PLAYING
[11-04-14 23:34:25.6263] Slim::Player::StreamingController::_eventAction (303) 00:04:20:26:54:3e: BufferReady - new state PLAYING-STREAMING
[11-04-14 23:34:25.6987] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-14 23:34:25.7820] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-14 23:34:25.8506] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-14 23:34:26.1778] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
[11-04-14 23:34:26.7495] Slim::Player::StreamingController::_eventAction (271) 00:04:20:26:54:3e: StatusHeartbeat in PLAYING-STREAMING -> Slim::Player::StreamingController::_CheckSync
Comment 7 Andy Grundman 2011-04-25 09:23:22 UTC 
Please send me the file. http://wiki.slimdevices.com/index.php/Large_File_Upload
Comment 8 Christian Spieles 2011-05-04 16:04:39 UTC 
Just sent the file for testing.

Regards
Christian
Comment 9 Michael Herger 2011-05-20 00:18:46 UTC 
I can't search inside a track with any of the wma files I've tested today.
Comment 10 Michael Herger 2011-05-20 01:49:17 UTC 
I've traced it back to 

	return Audio::Scan->find_frame_fh( asf => $fh, int($time * 1000) );

always returning -1 for all tested wma files
(Slim::Formats::WMA->findFrameBoundaries())
Comment 11 Andy Grundman 2011-06-15 10:31:33 UTC 
Please leave Audio::Scan bugs with me.
Comment 12 Alan Young 2011-07-27 01:33:40 UTC 
Andy, I confirm this is still a problem with 7.6.

[11-07-27 10:30:02.0218] Slim::Player::Protocols::File::_timeToOffset (350) seeking using Slim::Formats::WMA findFrameBoundaries(2086013, 129.356846473029)
[11-07-27 10:30:02.0257] Slim::Player::Protocols::File::_timeToOffset (362) 129.356846473029 -> 0 (align: 1 size: 3471856 duration: 215.295)
[11-07-27 10:30:02.0278] Slim::Player::Protocols::File::open (192) Seeking in 0 into /UserData/Music/ABBA/ABBA/01 Mamma Mia.wma
Comment 13 Andy Grundman 2011-08-03 09:14:44 UTC 
This particular file is missing an ASF_Index object, so no seeking is possible currently. Can I ask what encoder was used for this file?

I do plan on fixing this at some point, to do a brute force seek.
Comment 14 Andy Grundman 2011-09-14 11:43:19 UTC 
This is fixed in Audio::Scan 0.93, as part of 7.7.
First Last Prev Next    This bug is not in your last search results.