Bug 2368 - wma internet radio station problem (wma voice)
: wma internet radio station problem (wma voice)
Status: RESOLVED PATCHWELCOME
Product: Logitech Media Server
Classification: Unclassified
Component: Streaming To SlimServer
: 6.2.0
: Macintosh MacOS X 10
: P2 normal with 3 votes (vote)
: ---
Assigned To: Dan Sully
:
Depends on:
Blocks:
  Show dependency treegraph
 
Reported: 2005-10-25 15:00 UTC by Kevin Pearsall
Modified: 2011-03-16 04:18 UTC (History)
4 users (show)

See Also:
Category: ---


Attachments
2006-04-02 nightly still fails (9.97 KB, text/plain)
2006-04-02 18:46 UTC, Tom Permutt
Details

Note You need to log in before you can comment on or make changes to this bug.
Description Kevin Pearsall 2005-10-25 15:00:09 UTC
mms://ms.radio-canada.ca/liverci_fr?MSWMExt=.asf

error is:
Offset outside string at /Users/kpearsall/trunk/server/Slim/Networking/Select.pm
line 151.


observed in r4774.
Comment 1 Kevin Pearsall 2005-10-26 11:58:11 UTC
2005-10-26 11:57:38.3240 Backtrace:

   frame 0: Slim::Player::Source::playmode
(/Users/kpearsall/trunk/server/Slim/Control/Command.pm line 606)
   frame 1: Slim::Control::Command::execute
(/Users/kpearsall/trunk/server/Slim/Web/HTTP.pm line 672)
   frame 2: Slim::Web::HTTP::processURL
(/Users/kpearsall/trunk/server/Slim/Web/HTTP.pm line 537)
   frame 3: Slim::Web::HTTP::processHTTP
(/Users/kpearsall/trunk/server/Slim/Networking/Select.pm line 111)
   frame 4: Slim::Networking::Select::select (./slimserver.pl line 634)
   frame 5: main::idle (./slimserver.pl line 570)
   frame 6: main::main (./slimserver.pl line 1226)

2005-10-26 11:57:38.3263 00:04:20:81:22:33: Switching to mode stop from stop
2005-10-26 11:57:38.3273  Already in playmode stop : ignoring mode change
2005-10-26 11:57:38.3293 Adding song index 0 to song queue
2005-10-26 11:57:38.3303 Clearing out song queue first
2005-10-26 11:57:38.3312 Song queue is now 0
2005-10-26 11:57:38.3414 Backtrace:

   frame 0: Slim::Player::Source::playmode
(/Users/kpearsall/trunk/server/Slim/Player/Source.pm line 765)
   frame 1: Slim::Player::Source::jumpto
(/Users/kpearsall/trunk/server/Slim/Control/Command.pm line 1432)
   frame 2: Slim::Control::Command::load_done
(/Users/kpearsall/trunk/server/Slim/Utils/Scan.pm line 122)
   frame 3: Slim::Utils::Scan::addToList
(/Users/kpearsall/trunk/server/Slim/Control/Command.pm line 667)
   frame 4: Slim::Control::Command::execute
(/Users/kpearsall/trunk/server/Slim/Web/HTTP.pm line 672)
   frame 5: Slim::Web::HTTP::processURL
(/Users/kpearsall/trunk/server/Slim/Web/HTTP.pm line 537)
   frame 6: Slim::Web::HTTP::processHTTP
(/Users/kpearsall/trunk/server/Slim/Networking/Select.pm line 111)
   frame 7: Slim::Networking::Select::select (./slimserver.pl line 634)
   frame 8: main::idle (./slimserver.pl line 570)
   frame 9: main::main (./slimserver.pl line 1226)

2005-10-26 11:57:38.3438 00:04:20:81:22:33: Switching to mode stop from stop
2005-10-26 11:57:38.3447  Already in playmode stop : ignoring mode change
2005-10-26 11:57:38.3456 Adding song index 0 to song queue
2005-10-26 11:57:38.3464 Clearing out song queue first
2005-10-26 11:57:38.3621 Song queue is now 0
2005-10-26 11:57:38.3639 Backtrace:

   frame 0: Slim::Player::Source::playmode
(/Users/kpearsall/trunk/server/Slim/Player/Source.pm line 796)
   frame 1: Slim::Player::Source::jumpto
(/Users/kpearsall/trunk/server/Slim/Control/Command.pm line 1432)
   frame 2: Slim::Control::Command::load_done
(/Users/kpearsall/trunk/server/Slim/Utils/Scan.pm line 122)
   frame 3: Slim::Utils::Scan::addToList
(/Users/kpearsall/trunk/server/Slim/Control/Command.pm line 667)
   frame 4: Slim::Control::Command::execute
(/Users/kpearsall/trunk/server/Slim/Web/HTTP.pm line 672)
   frame 5: Slim::Web::HTTP::processURL
(/Users/kpearsall/trunk/server/Slim/Web/HTTP.pm line 537)
   frame 6: Slim::Web::HTTP::processHTTP
(/Users/kpearsall/trunk/server/Slim/Networking/Select.pm line 111)
   frame 7: Slim::Networking::Select::select (./slimserver.pl line 634)
   frame 8: main::idle (./slimserver.pl line 570)
   frame 9: main::main (./slimserver.pl line 1226)

2005-10-26 11:57:38.3659 00:04:20:81:22:33: Switching to mode play from stop
2005-10-26 11:57:38.3707 openSong on:
mms://ms.radio-canada.ca/liverci_fr?MSWMExt=.asf
2005-10-26 11:57:39.0263 00:04:20:81:22:33 New play mode: play
2005-10-26 11:57:39.0432 This player supports direct streaming for
mms://ms.radio-canada.ca/liverci_fr?MSWMExt=.asf as
mms://ms.radio-canada.ca/liverci_fr?MSWMExt=.asf, let's do it.
2005-10-26 11:57:39.0467 setting up direct stream (2669756784:80) autostart: 3.
2005-10-26 11:57:39.0478 request string: GET /liverci_fr?MSWMExt=.asf HTTP/1.0
Accept: */*
User-Agent: NSPlayer/4.1.0.3856
Host: ms.radio-canada.ca
Pragma: xClientGUID={350d9096-7db8-a823-b381-ecac38bfb064}
Pragma:
no-cache,rate=1.0000000,stream-time=0,stream-offset=0:0,request-context=1,max-duration=0
Connection: Close


2005-10-26 11:57:39.0542 00:04:20:81:22:33: Current playmode: play
2005-10-26 11:57:39.8700 Setting maxBitRate for scratched to: 0
2005-10-26 11:57:39.8716 Setting maxBitRate for scratched to: 0
2005-10-26 11:57:46.0388 processing headers for direct streaming
2005-10-26 11:57:46.0413 $VAR1 = 'HTTP/1.0 200 OK
Content-Type: application/vnd.ms.wms-hdr.asfv1
Server: Cougar/9.00.00.3372
Content-Length: 2541
Date: Wed, 26 Oct 2005 18:57:45 GMT
Pragma: no-cache, client-id=3958030000, xResetStrm=1, features="broadcast"
Cache-Control: no-cache, x-wms-stream-type="broadcast"
Last-Modified: Sat, 30 Dec 1899 00:00:00 GMT
Supported: com.microsoft.wm.srvppair, com.microsoft.wm.sswitch,
com.microsoft.wm.predstrm, com.microsoft.wm.fastcache

';
2005-10-26 11:57:46.0430 Backtrace:

   frame 0: Slim::Player::Squeezebox2::directHeaders
(/Users/kpearsall/trunk/server/Slim/Networking/Slimproto.pm line 405)
   frame 1: Slim::Networking::Slimproto::process_slimproto_frame
(/Users/kpearsall/trunk/server/Slim/Networking/Slimproto.pm line 236)
   frame 2: Slim::Networking::Slimproto::client_readable
(/Users/kpearsall/trunk/server/Slim/Networking/Select.pm line 111)
   frame 3: Slim::Networking::Select::select (./slimserver.pl line 634)
   frame 4: main::idle (./slimserver.pl line 570)
   frame 5: main::main (./slimserver.pl line 1226)

2005-10-26 11:57:46.0456 processing 8 headers
2005-10-26 11:57:46.0468 header: Content-Type: application/vnd.ms.wms-hdr.asfv1
2005-10-26 11:57:46.0483 header: Server: Cougar/9.00.00.3372
2005-10-26 11:57:46.0492 header: Content-Length: 2541
2005-10-26 11:57:46.0501 header: Date: Wed, 26 Oct 2005 18:57:45 GMT
2005-10-26 11:57:46.0509 header: Pragma: no-cache, client-id=3958030000,
xResetStrm=1, features="broadcast"
2005-10-26 11:57:46.0517 header: Cache-Control: no-cache,
x-wms-stream-type="broadcast"
2005-10-26 11:57:46.0525 header: Last-Modified: Sat, 30 Dec 1899 00:00:00 GMT
2005-10-26 11:57:46.0533 header: Supported: com.microsoft.wm.srvppair,
com.microsoft.wm.sswitch, com.microsoft.wm.predstrm, com.microsoft.wm.fastcache
2005-10-26 11:57:46.0541 it looks like a WMA file
Can't call method "can" on unblessed reference at
/Users/kpearsall/trunk/server/Slim/DataStores/DBI/DBIStore.pm line 1664.
2005-10-26 11:57:46.8415 Slim::DataStores::DBI::Track
Slim::DataStores::DBI::Track=HASH(0xe6630c) destroyed without saving changes to
ct, remote at ./slimserver.pl line 0
Comment 2 Kevin Pearsall 2005-10-26 12:12:16 UTC
different error in r4843:
Can't call method "isa" on unblessed reference at
/Users/kpearsall/trunk/server/CPAN/Class/DBI/Relationship/HasA.pm line 41.
Comment 3 KDF 2005-10-27 14:40:40 UTC
*** Bug 2397 has been marked as a duplicate of this bug. ***
Comment 4 Shawn Rutledge 2005-10-27 23:01:21 UTC
With the nightly build from 10/26, I also see this:

Can't call method "isa" on unblessed reference at
/opt/SlimServer_v2005-10-26/CPAN/Class/DBI/Relationship/HasA.pm line 41.
2005-10-27 22:55:38.8380 Got to the END.
2005-10-27 22:55:38.8394 Got sigint.
2005-10-27 22:55:38.8404 SlimServer cleaning up.

for some radio stations, for example "Jazz & Blues: Mostly Bop" does it every time.
Comment 5 jean-guillaume 2005-10-28 02:51:30 UTC
Same crash using this radio:
http://213.246.39.108:8000/

Comment 6 Dan Sully 2005-10-28 17:16:55 UTC
Please try with the 10-28-2005 nightly, or the latest subversion update.

Thanks
Comment 7 Tom Permutt 2005-10-30 05:59:56 UTC
(It was I that called this problem to Kevin's attention.)  The same stream and 
some others fail for me, but differently.  Squeezebox2 (firmware 26) 
says "Problem:  Can't connect to server for:"  The server (Windows XP home, 
official 6.2 release) doesn't crash, though.  Indeed, it plays this stream 
just fine through SoftSqueeze.  I've tried the 10/30 nightly, and the behavior 
is unchanged.

The same stream on SqueezeNetwork gives "WMA convert error:  check file 
types."  I don't know if that is a related problem, or just that WMA is not 
supposed to work on SqueezeNetwork quite yet.
Comment 8 Shawn Rutledge 2005-10-30 22:43:31 UTC
As far as I can tell the "unblessed reference" bug is now gone as of the 10/30
nightly.  Thanks!
Comment 9 Kevin Pearsall 2005-10-31 10:54:26 UTC
i'm still having problems here, various crashes.  all i do is try to play this
stream:
mms://media3.abc.net.au/localradio
...using the internet radio tune in page.  using that page at all seems to crash
the server very frequently these days...

Can't call method "replay_gain" on unblessed reference at
/Users/kpearsall/trunk/server/Slim/Player/Source.pm line 1010.

Can't call method "isa" on unblessed reference at
/Users/kpearsall/trunk/server/CPAN/Class/DBI/Relationship/HasA.pm line 41.

observed in r4965
Comment 10 Tom Permutt 2005-10-31 19:21:24 UTC
We may have distinct bugs.  Both Jean-Guillaume's and Kevin's streams
http://213.246.39.108:8000/ and mms://media3.abc.net.au/localradio play fine for
me.  Mine is still as I reported.

SlimServer Version: 6.2.1 - 4941 - Windows XP - EN - cp1252
Comment 11 Shawn Rutledge 2005-10-31 20:04:51 UTC
http://213.246.39.108:8000/ and mms://media3.abc.net.au/localradio are playing
fine for me too, with the 10/30 nightly.
Comment 12 jean-guillaume 2005-11-01 02:12:11 UTC
http://213.246.39.108:8000/ 
mms://media3.abc.net.au/localradio
http://64.236.34.4:80/stream/1010 
http://64.236.34.4:80/stream/1014

 are still crashing slimserver (11-01 release)

Can't call method "isa" on unblessed reference at C:\program files\slimserver6.5
\server\CPAN/Class/DBI/Relationship/HasA.pm line 41

SlimServer Version: 6.5b1 - 4979 - Windows Server 2003 - EN - cp1252 

Idea: may be it's a problem with lame transcoding, as webradios works fine if I 
set "no limit" to lame, then restart slimserver, then use a NEW radio url. (all 
steps are required)
Comment 13 Nestor 2005-11-01 12:59:38 UTC
It fails for me with 

Can't call method "isa" on unblessed reference at
D:\soft\Slimserver\server\CPAN/Class/DBI/Relationship/HasA.pm line 41, <GEN22>
line 1.

for this stream   http://www.continental.com.ar/ra/am.ram

but only after applying SVN Revision 4971 , if it helps in any way.

Comment 14 Nestor 2005-11-01 13:00:53 UTC
Sorry , forgot to add Im using AlienBBC to listen to that ram stream.
Comment 15 Dan Sully 2005-11-01 15:45:19 UTC
Fixed in change 4986
Comment 16 Dan Sully 2005-11-01 16:01:28 UTC
*** Bug 2455 has been marked as a duplicate of this bug. ***
Comment 17 Tom Permutt 2005-11-02 04:11:42 UTC
SlimServer Version: 6.2.1 - 4990 - Windows XP - EN - cp1252

Behavior is unchanged.  Squeezebox2 still says "problem: can't connect to server
for:"

mms://ms.radio-canada.ca/liverci_fr?MSWMExt=.asf
Comment 18 Will Irace 2005-11-02 06:59:12 UTC
SlimServer Version: 6.5b1 - 4996 - Linux - EN - utf8

Fixed for me. In particular, the attachments to Bug 2455 no longer cause a crash.
Comment 19 Nestor 2005-11-02 07:12:17 UTC
Fixed for me too.
Thanks!
Comment 20 KDF 2005-11-02 09:42:02 UTC
Tom,
Since it is not crashign any more, I've lowered severity.

Would you be able to provide log output using d_source and d_remotestream when
trying to connect to this station?

as for my test, I'm seeing this in there:
Opening stream failed with error code 0xc00d0006

but I'm also behind a firewall, so I can't say if that is the cause.
Comment 21 Kevin Pearsall 2005-11-02 12:00:29 UTC
No crash here, but this stream indeed still does not play.  Here's the log KDF
wanted...

2005-11-02 11:59:21.7299 Setting maxBitRate for 10.0.3.196 to: 0
2005-11-02 11:59:21.7317 Setting maxBitRate for 10.0.3.196 to: 0
2005-11-02 11:59:21.7693 00:04:20:81:22:33: Switching to mode stop from playout-play
2005-11-02 11:59:21.7708 00:04:20:81:22:33 New play mode: stop
2005-11-02 11:59:21.7719 Stopping and clearing out old chunks for client
00:04:20:81:22:33
2005-11-02 11:59:21.7740 Resetting song queue
2005-11-02 11:59:21.7754 Song queue is now 0
2005-11-02 11:59:21.7771 00:04:20:81:22:33: Current playmode: stop
2005-11-02 11:59:21.7879 Adding song index 0 to song queue
2005-11-02 11:59:21.7892 Clearing out song queue first
2005-11-02 11:59:21.7902 Song queue is now 0
2005-11-02 11:59:21.8015 Trying to open protocol stream for
http://ms.radio-canada.ca/liverci_fr
2005-11-02 11:59:21.8029 Looking for handler for protocol http
2005-11-02 11:59:21.8040 Found handler for protocol http
2005-11-02 11:59:23.2716 00:04:20:81:22:33: Switching to mode stop from stop
2005-11-02 11:59:23.2731  Already in playmode stop : ignoring mode change
2005-11-02 11:59:23.2742 jumping to 0
2005-11-02 11:59:23.2754 Adding song index 0 to song queue
2005-11-02 11:59:23.2766 Clearing out song queue first
2005-11-02 11:59:23.2776 Song queue is now 0
2005-11-02 11:59:23.2821 00:04:20:81:22:33: Switching to mode play from stop
2005-11-02 11:59:23.2842 openSong on:
mms://ms.radio-canada.ca/liverci_fr?MSWMExt=.asf
2005-11-02 11:59:23.6038 00:04:20:81:22:33 New play mode: play
2005-11-02 11:59:23.6125 This player supports direct streaming for
mms://ms.radio-canada.ca/liverci_fr?MSWMExt=.asf as
mms://ms.radio-canada.ca/liverci_fr?MSWMExt=.asf, let's do it.
2005-11-02 11:59:23.6152 setting up direct stream (2669756784:80) autostart: 3.
2005-11-02 11:59:23.6163 request string: GET /liverci_fr?MSWMExt=.asf HTTP/1.0
Accept: */*
User-Agent: NSPlayer/4.1.0.3856
Host: ms.radio-canada.ca
Pragma: xClientGUID={4a0b6648-74ba-b240-0a0c-4ef4376a799a}
Pragma:
no-cache,rate=1.0000000,stream-time=0,stream-offset=0:0,request-context=1,max-duration=0
Connection: Close


2005-11-02 11:59:23.6191 00:04:20:81:22:33: Current playmode: play
2005-11-02 11:59:24.3988 processing headers for direct streaming
2005-11-02 11:59:24.4004 $VAR1 = 'HTTP/1.0 200 OK
Content-Type: application/vnd.ms.wms-hdr.asfv1
Server: Cougar/9.00.00.3372
Content-Length: 2541
Date: Wed, 02 Nov 2005 19:59:22 GMT
Pragma: no-cache, client-id=2914954825, xResetStrm=1, features="broadcast"
Cache-Control: no-cache, x-wms-stream-type="broadcast"
Last-Modified: Sat, 30 Dec 1899 00:00:00 GMT
Supported: com.microsoft.wm.srvppair, com.microsoft.wm.sswitch,
com.microsoft.wm.predstrm, com.microsoft.wm.fastcache

';
2005-11-02 11:59:24.4021 Backtrace:

   frame 0: Slim::Player::Squeezebox2::directHeaders
(/Users/kpearsall/BRANCH_6_2_x/Slim/Networking/Slimproto.pm line 405)
   frame 1: Slim::Networking::Slimproto::process_slimproto_frame
(/Users/kpearsall/BRANCH_6_2_x/Slim/Networking/Slimproto.pm line 236)
   frame 2: Slim::Networking::Slimproto::client_readable
(/Users/kpearsall/BRANCH_6_2_x/Slim/Networking/Select.pm line 111)
   frame 3: Slim::Networking::Select::select (./slimserver.pl line 634)
   frame 4: main::idle (./slimserver.pl line 570)
   frame 5: main::main (./slimserver.pl line 1226)

2005-11-02 11:59:24.4047 processing 8 headers
2005-11-02 11:59:24.4058 header: Content-Type: application/vnd.ms.wms-hdr.asfv1
2005-11-02 11:59:24.4067 header: Server: Cougar/9.00.00.3372
2005-11-02 11:59:24.4076 header: Content-Length: 2541
2005-11-02 11:59:24.4084 header: Date: Wed, 02 Nov 2005 19:59:22 GMT
2005-11-02 11:59:24.4092 header: Pragma: no-cache, client-id=2914954825,
xResetStrm=1, features="broadcast"
2005-11-02 11:59:24.4101 header: Cache-Control: no-cache,
x-wms-stream-type="broadcast"
2005-11-02 11:59:24.4109 header: Last-Modified: Sat, 30 Dec 1899 00:00:00 GMT
2005-11-02 11:59:24.4133 header: Supported: com.microsoft.wm.srvppair,
com.microsoft.wm.sswitch, com.microsoft.wm.predstrm, com.microsoft.wm.fastcache
2005-11-02 11:59:24.4145 it looks like a WMA file2005-11-02 11:59:24.9127 got a
stream type:: wma  bitrate:   title: 
2005-11-02 11:59:24.9142 Direct stream is list, get body to explode
2005-11-02 11:59:25.2396 got some body from the player, length 1009: $H?
                                                                              
?0&?u?f????b?l?  3&?u?f????b?l?"@RCI-2 (Fran?ais)2003 Radio Canada
International?u?{?F???`?ɢ? {A?ܫ?G?????
                         Seh???? O??
?K?J?   ww{A??_.?????
                      Se??ӫ??????
                                  Se??FC|???K?)9>?A\?'
X]??&?E?G?_eR????ů[wH?g??D?L?z                        en-us˥?r?2C???iR[ZX?><
                              IsVBR4DeviceConformanceTemplateS1t???     E????˖??p
2005-11-02 11:59:25.2433 saving away that body message until we get an empty body
2005-11-02 11:59:26.4475 got some body from the player, length 1460: ?ܷ??????
                                                                             
Se?@?i?M[????_\D+P?ÿ?a?????? b?l
?>?X.??Z?-H?`XX@?????????^?P?WMFSDKVersion9.00.00.2980WMFSDKNeeded0.0.0.0000
                                                                           
IsVBR@Rц1?????H??ARц1?????H?Windows Media Audio 9 Voice 16 kbps, 16 k
2005-11-02 11:59:26.4687 saving away that body message until we get an empty body
2005-11-02 11:59:26.4711 got some body from the player, length 72: Hz, mono
6&?u?f????b?l2???? O??
?K?J
2005-11-02 11:59:26.4725 saving away that body message until we get an empty body
2005-11-02 11:59:26.4747 MMS protocol handler received response body
2005-11-02 11:59:26.4820 Parsed body as WMA header.
2005-11-02 11:59:26.4844 00:04:20:81:22:33: Switching to mode play from playout-play
2005-11-02 11:59:26.4863 openSong on:
mms://ms.radio-canada.ca/liverci_fr?MSWMExt=.asf
2005-11-02 11:59:26.8214 00:04:20:81:22:33 New play mode: play
2005-11-02 11:59:26.8256 This player supports direct streaming for
mms://ms.radio-canada.ca/liverci_fr?MSWMExt=.asf as
mms://ms.radio-canada.ca/liverci_fr?MSWMExt=.asf, let's do it.
2005-11-02 11:59:26.8284 setting up direct stream (2669756784:80) autostart: 3.
2005-11-02 11:59:26.8296 request string: GET /liverci_fr?MSWMExt=.asf HTTP/1.0
Accept: */*
User-Agent: NSPlayer/4.1.0.3856
Host: ms.radio-canada.ca
Pragma: xClientGUID={93ce5f9e-8579-4293-8f15-227cd269b952}
Pragma:
no-cache,rate=1.0000000,stream-time=0,stream-offset=0:0,request-context=2,max-duration=0
Pragma: xPlayStrm=1
Pragma: stream-switch-count=1
Pragma: stream-switch-entry=ffff:1:0


2005-11-02 11:59:26.8325 00:04:20:81:22:33: Current playmode: play
2005-11-02 11:59:26.8394 got some body from the player, length 0: 
2005-11-02 11:59:26.8411 empty body means we should parse what we have for
mms://ms.radio-canada.ca/liverci_fr?MSWMExt=.asf
2005-11-02 11:59:26.8422 actually, the body was empty.  Got nobody...
2005-11-02 11:59:27.1102 processing headers for direct streaming
2005-11-02 11:59:27.1118 $VAR1 = 'HTTP/1.0 200 OK
Content-Type: application/x-mms-framed
Server: Cougar/9.00.00.3372
Date: Wed, 02 Nov 2005 19:59:26 GMT
Pragma: no-cache, client-id=1544903841, xResetStrm=1, features="broadcast",
AccelBW=0, AccelDuration=0, Speed=1.000
Cache-Control: no-cache
Last-Modified: Wed, 02 Nov 2005 19:59:26 GMT
Supported: com.microsoft.wm.srvppair, com.microsoft.wm.sswitch,
com.microsoft.wm.predstrm, com.microsoft.wm.fastcache

';
2005-11-02 11:59:27.1133 Backtrace:

   frame 0: Slim::Player::Squeezebox2::directHeaders
(/Users/kpearsall/BRANCH_6_2_x/Slim/Networking/Slimproto.pm line 405)
   frame 1: Slim::Networking::Slimproto::process_slimproto_frame
(/Users/kpearsall/BRANCH_6_2_x/Slim/Networking/Slimproto.pm line 236)
   frame 2: Slim::Networking::Slimproto::client_readable
(/Users/kpearsall/BRANCH_6_2_x/Slim/Networking/Select.pm line 111)
   frame 3: Slim::Networking::Select::select (./slimserver.pl line 634)
   frame 4: main::idle (./slimserver.pl line 570)
   frame 5: main::main (./slimserver.pl line 1226)

2005-11-02 11:59:27.1157 processing 7 headers
2005-11-02 11:59:27.1168 header: Content-Type: application/x-mms-framed
2005-11-02 11:59:27.1178 header: Server: Cougar/9.00.00.3372
2005-11-02 11:59:27.1187 header: Date: Wed, 02 Nov 2005 19:59:26 GMT
2005-11-02 11:59:27.1196 header: Pragma: no-cache, client-id=1544903841,
xResetStrm=1, features="broadcast", AccelBW=0, AccelDuration=0, Speed=1.000
2005-11-02 11:59:27.1205 header: Cache-Control: no-cache
2005-11-02 11:59:27.1213 header: Last-Modified: Wed, 02 Nov 2005 19:59:26 GMT
2005-11-02 11:59:27.1374 header: Supported: com.microsoft.wm.srvppair,
com.microsoft.wm.sswitch, com.microsoft.wm.predstrm, com.microsoft.wm.fastcache
2005-11-02 11:59:27.1557 it looks like a WMA file2005-11-02 11:59:27.4759 got a
stream type:: wma  bitrate:   title: 
2005-11-02 11:59:27.4800 Beginning direct stream!
(it repeats this over and over trying to play the stream)
Comment 22 KDF 2005-11-02 12:38:35 UTC
I noticed..."Windows Media Audio 9 Voice 16 kbps"

I don't think the firmware supports this yet. see bug2127

Kev, what debug flag were you using there?  I'm not sure I see something nice
and tidy that we can use to trap wma voice, except for that one segment of
"body" content.  If I can duplicate this later, I'll take a look at ways to trap
and log.  Player will still be stuck with "can't open stream", unfortunately.

Comment 23 Tom Permutt 2005-11-02 12:59:19 UTC
OK, then, we might be done here.  What remains (besides the different, 
crashing bug that Kevin reported and Dan appears to have fixed) is a duplicate 
of 2127.  I suppose that explains why SoftSqueeze _can_ play it, too:  I guess 
other codecs are available to the SoftSqueeze "firmware."
Comment 24 KDF 2005-11-02 13:07:16 UTC
Softsqueeze doesnt' support native WMA, so it never attempts to play that stream
in that format.  It is transcoded to flac, I would expect.

Given that, I'll see what it would take to reroute it...if I can find a way to
detect the stream format before it is too messed up.   It might be a bit out of
my range, but I'll take a crack at it.
Comment 25 Kevin Pearsall 2005-11-02 13:08:25 UTC
kdf--i was using the debug options you recommended (d_directstream and d_source).  

regarding softsqueeze, i don't think softsqueeze does direct streaming for wma,
so it's probably being decoded server side.  you can force this behavior with
squeezeboxen as well by disabling the "Windows Media / Windows Media / built-in"
transcode rule in server settings -> file types...

it might be nice to, in the event of a codec failure like this, fall back to the
legacy wma decoding method if available, yes?  if you think it's a good idea i
can make a separate feature request for that...
Comment 26 Tom Permutt 2005-11-02 13:21:01 UTC
Kevin - I'll try changing the file types setting when I get home.  If that 
works, I'll be pretty happy.

I do think the fallback would be a worthwhile feature, as otherwise this will 
remain rather obscure:  without your help, I might have just shipped the box 
back instead, and somebody else surely will do so.  

It also seems to me that the file types settings need finer grain.  If I 
understand what you're telling me, SoftSqueeze works because it doesn't claim 
to do WMA.  Squeezebox fails because it advertises that it can, but only 
partly truthfully.  There is no way for it to admit what it can play and what 
it needs transcoded.
Comment 27 KDF 2005-11-02 13:30:36 UTC
unfortunately, as the big player insist on burying more and more subformats into
their propretary codecs to enhance their control over media, there will be less
we can do about it.  

A fallback on codec failure might not be possible as I dont know if the hardware
reports back anything useful in time to avoid the hiccups.  It should be
possible to trap the known bad type until we have a working update in firmware
to handle it.  That depends on MS.

Tom, if file types setting corrects this problem for you, please mark this
resolved or let us know so that we can.  

Kev,
I think the idea of a fallback would be good as an enhancement.  
Comment 28 Kevin Pearsall 2005-11-02 13:38:25 UTC
added bug #2469: if trying to play unsupported WMA sub-codec, gracefully fall
back to legacy wma decoding method
Comment 29 Tom Permutt 2005-11-02 16:07:25 UTC
No joy.  Unchecking the Windows Media/(built-in) line in the Server/File Types
screen did nothing.  (Did it work for you, Kevin?)  I also tried commenting out
the lines
   wma wma squeezebox2 *
      -
from .../server/convert.conf with no effect.

KDF: "unfortunately, as the big player insist on burying more and more
subformats into their propretary codecs to enhance their control over media,
there will be less we can do about it."

I don't follow you here.  The server looks at the file or stream and decides
whether to transcode it or not.  It can and did detect this stream as a kind
that you and I know the firmware won't play.  The hardware doesn't need to
report this:  it's a static fact (until the firmware changes).  We need to tell
the server this fact, and then it will transcode.  In fact, I just tried to tell
it that.

My point is, if I had succeeded, I would also have told it the firmware didn't
want any WMA files at all, which isn't true.  Up to now, we have chosen to
decide how to handle the file based on what "the big player" chooses to call
File Type; but this does not reliably distinguish files that can be played in
firmware from those that can't.  (And you imply that it will get less reliable,
not more so.)

It seems clear to me, then, that convert.conf needs to be reworked.  If WMA is
not one kind of file but several, and some work and some don't, we need to
distinguish working WMA from nonworking WMA, not just WMA from OGG, say.  A
pain, maybe, but not at all impossible:  again, if the server can write in the
log that it's an unsupported stream type, it can just as well go and find the
transcoder for it.  And the present algorithm seems to qualify as Broken.

What am I missing?



Comment 30 KDF 2005-11-02 16:17:02 UTC
it comes down to content type and container types.  without a rather significant
rework of how all types are handled, there is going to be a limit.  Right now,
extention = content type.  We can check teh stream for responses, but going by
the log, it looks like there was nothing save for some text buried in what could
be best described as a belch in the log. The trick is whether or not there is
something to detect before that, or the stream will end up being sent to the
hardware as is with no way to know it is wrong until the user notices that it
just isn't working.  

as I have said, I will try to look into it. 
Comment 31 Tom Permutt 2005-11-02 16:47:59 UTC
OK.  From your comments about the "big player," it sounded like that rework was
inevitable later if not sooner.

Meanwhile, I installed server version 6.1.1.  Plays OK.  If somebody can tell me
exactly what to do to the file types in 6.2, I'll try it again (or do any other
tests that would be useful).  Of course, "Used to work and doesn't now" is
pretty much a subset of "Broken."

Thanks, everyone, for the help.  I wouldn't call it "resolved" until the current
version can do it, too, but I'm satisfied for now.
Comment 32 Dan Sully 2005-11-03 13:54:22 UTC
Ok - thanks.

A real fix isn't going to make it in time for 6.2.1
Comment 33 Tom Permutt 2006-02-27 14:35:00 UTC
Since last I griped about this, I have been happily running 6.1.1, but now I want ReplayGain.  So, I've upgraded and am back to complaining.

There seem to me to be a couple of sub-bugs here, which make both diagnosis and workaround of the underlying problem hard.

1.  Uninformative failure.  There have been several "Why doesn't this stream play?" messages on the forums, especially Beginners.  I understand previous comments to the effect that this one is unfixable, but it's likely to scare some people off.

2.  As I've reported before, neither unchecking the relevant line in the File Types dialog nor editing the line out of convert.conf has the expected effect.  It seems that the notion that a Squeezebox >= 2 can play a WMA is hard-coded somewhere.  This seems to me to be a bug in itself:  I ought to be able to transcode it if I want to, even if the hard-coded assertion were true, which it isn't.

Is there any real advantage (yet) to the native WMA feature other than saving a bit of processing time?  If not, I  suggest the world would be a better place if the server didn't claim to be able to do it:  go back to 6.1.1 in this respect until the box truly can play what it says it can.  People using SqueezeNetwork will still have the advantage of playing whatever streams happen to work, but SlimServer will reliably transcode all of them.

But, anyway, I personally would be grateful if someone can point me at the place in the code where it says to play WMA natively regardless of convert.conf.  Then I'll have a go at changing it myself.
Comment 34 Tom Permutt 2006-02-28 19:39:06 UTC
It works.  I made the following three changes to 6.2.1 on Windows XP.  I'm not sure all three are necessary.

1.  In server/slim/player/squeezebox2.pm, changed

	return qw(wma flc aif wav mp3);
to
	return qw(flc aif wav mp3);

2.  In the same file, changed

	if ($handler && $handler->can("canDirectStream")) {
		return $handler->canDirectStream($url);

to

if ($handler && $handler->can("canDirectStream") && !$handler->isa("Slim::Player::Protocols::MMS")) {
		return $handler->canDirectStream($url);

which I stole out of softsqueeze.pm in the same directory, because Softsqueeze plays these streams correctly.

3.  In convert.conf, removed

wma wma squeezebox2 *
	-

After doing this, I also have to start SlimServer by invoking slimserver.pl from the command line (I have ActiveState Perl installed) rather than by slimtray.exe.  Am I correct in guessing that the .exe's are some precompilied version?  It wasn't obvious to me that they would be that, rather than just a wrapper for the interpreter.

I'd still respectfully suggest that some such changes as these should be official until all WMA streams either play or fail gracefully.  But, anyway, here they are for whoever needs them.
Comment 35 Tom Permutt 2006-04-02 18:46:55 UTC
Created attachment 1176 [details]
2006-04-02 nightly still fails

6.2.2 - 6804 - Windows XP
Changelog shows this bug as fixed.

Radio Canada International streams still fail.  Log attached.
Comment 36 Dan Sully 2006-04-29 13:29:12 UTC
Tom - We're working on improving WMA support in the Firmware.

In the meantime, a fix went in for 6.2.2 that allows you to disable the built-in WMA decoding, and it will fall back to using wmadec.exe on Windows. This has made previously unplayable stations work again.

Comment 37 Tom Permutt 2006-05-02 19:17:18 UTC
I think that's best for the time being.  The problem streams seem to play all right for me now.  Well done.