AlienBBC kills slimserver on Mac Tiger and claims all process resources

[jakey]

Hi,

Any help would be much appreciated.

I'm trying to get AlienBBC to install correctly on Mac OS X 10.4.2 (Tiger). I can see all the AlienBBC menus fine, I get as far as connecting after choosing play, this is where it all goes wrong.

I get no sound, then after a while the slimserver perl process CPU usage increases, on the console you the following message constantly printed:

/Users/userx/Library/PreferencePanes/SlimServer.prefPane/Contents/Resources/Get Slim Server.sh: fork: Resource temporarily unavailable

The slimserver appears to be using up all the process resources when trying to run the AlienBBC plugin, I have to kill the perl slimserver process in the Activity monitor to get my Mac back to normal. This only happens when trying play AlienBBC stations, slimserver is fine with my iTunes library.

I've tried playing through both the Squeezebox 2 and Softsqueeze 2.0b9 and get the same results. I also tried installing slimserver to the preferences pane for all users rather than my own but the same thing happens.

Software versions:

Slimserver: 6.1.1
AlienBBC: 0.98
Mplayer: dev-CVS-0500May-17:40-3.3

mplayer is installed correctly running the following from the terminal works:

mplayer -playlist http://www.bbc.co.uk/radio/aod/shows...paul_jones.rpm

Anybody else been experiencing similar problems?

[Neil Sleightholm]

I am not a Mac expert but there were some recent discussions here http://forums.slimdevices.com/showthread.php?t=15662. There are also some details on how to get a trace file that we can check.

Neil

[jakey]

I turned on 'source' and 'plugin' debug and see the following repeatedly after trying to play an AlienBBC live link:

:22:27.1502 00:04:20:05:bf:5d: Switching to mode play from playout-play
2005-08-21 18:22:27.1519 openSong on: rtsp://rmlivev8.bbc.net.uk/farm/*/ev7/live24/radio4/live/r4_dsat_g2.ra
2005-08-21 18:22:27.1565 URL is remote : rtsp://rmlivev8.bbc.net.uk/farm/*/ev7/live24/radio4/live/r4_dsat_g2.ra
2005-08-21 18:22:27.1572 Trying to open protocol stream for rtsp://rmlivev8.bbc.net.uk/farm/*/ev7/live24/radio4/live/r4_dsat_g2.ra
2005-08-21 18:22:27.1578 Looking for handler for protocol rtsp
2005-08-21 18:22:27.1581 Found handler for protocol rtsp
2005-08-21 18:22:27.4160 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:27.4166 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:27.4169 undermax = 1, type = rtsp, squeezebox2 = 00:04:20:05:bf:5d, lame = /Users/jasonparr/Library/iTunes/Scripts/iTunes-LAME.app/Contents/Resources/lame
2005-08-21 18:22:27.4183 checking formats for: rtsp-flc-squeezebox2-00:04:20:05:bf:5d
2005-08-21 18:22:27.4186 checking formats for: rtsp-flc-*-00:04:20:05:bf:5d
2005-08-21 18:22:27.4188 checking formats for: rtsp-flc-squeezebox2-*
2005-08-21 18:22:27.4190 checking formats for: rtsp-flc-*-*
2005-08-21 18:22:27.4298 Checking to see if rtsp-flc-*-* is enabled
2005-08-21 18:22:27.4305 enabled
2005-08-21 18:22:27.4310 Found command: [mplayer.sh] -really-quiet -vo null -cache 128 -af resample=44100:0:1 -ao pcm -aofile /dev/fd/3 $FILE$ | [flac] -cs --totally-silent --compression-level-0 -
2005-08-21 18:22:27.4319 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:27.4325 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:27.4329 Matched Format: flc Type: rtsp Command: [mplayer.sh] -really-quiet -vo null -cache 128 -af resample=44100:0:1 -ao pcm -aofile /dev/fd/3 $FILE$ | [flac] -cs --totally-silent --compression-level-0 -
2005-08-21 18:22:27.6427 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:27.6432 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:27.6454 Using command for conversion: "/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Bin/darwin/mplayer.sh" -really-quiet -vo null -cache 128 -af resample=44100:0:1 -ao pcm -aofile /dev/fd/3 "rtsp://rmlivev8.bbc.net.uk/farm/*/ev7/live24/radio4/live/r4_dsat_g2.ra" | "/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Bin/darwin/flac" -cs --totally-silent --compression-level-0 -
2005-08-21 18:22:27.7215 remoteURL is a song : rtsp://rmlivev8.bbc.net.uk/farm/*/ev7/live24/radio4/live/r4_dsat_g2.ra
2005-08-21 18:22:27.7278 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:27.7285 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:27.7288 undermax = 1, type = flc, squeezebox2 = 00:04:20:05:bf:5d, lame = /Users/jasonparr/Library/iTunes/Scripts/iTunes-LAME.app/Contents/Resources/lame
2005-08-21 18:22:27.7293 checking formats for: flc-flc-squeezebox2-00:04:20:05:bf:5d
2005-08-21 18:22:27.7296 checking formats for: flc-flc-*-00:04:20:05:bf:5d
2005-08-21 18:22:27.7298 checking formats for: flc-flc-squeezebox2-*
2005-08-21 18:22:27.7300 checking formats for: flc-flc-*-*
2005-08-21 18:22:27.7303 Checking to see if flc-flc-*-* is enabled
2005-08-21 18:22:27.7307 enabled
2005-08-21 18:22:27.7309 Found command: -
2005-08-21 18:22:27.7318 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:27.7324 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:27.7327 Matched Format: flc Type: flc Command: -
2005-08-21 18:22:27.7329 remoteURL command - type flc format flc
2005-08-21 18:22:27.7396 remoteURL stream format : flc
2005-08-21 18:22:27.9827 00:04:20:05:bf:5d New play mode: play
2005-08-21 18:22:28.0150 00:04:20:05:bf:5d: Current playmode: play
2005-08-21 18:22:28.1357 Read to end of file or pipe
2005-08-21 18:22:28.1471 end of file or error on socket, opening next song, (song pos: 0(tell says: . ), totalbytes: )
2005-08-21 18:22:28.1475 Didn't stream any bytes for this song, so just mark it as played
2005-08-21 18:22:28.1479 opening next song...
2005-08-21 18:22:28.1504 the next song is number 0, was 0
2005-08-21 18:22:28.2728 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:28.2733 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:28.2736 undermax = 1, type = flc, squeezebox2 = 00:04:20:05:bf:5d, lame = /Users/jasonparr/Library/iTunes/Scripts/iTunes-LAME.app/Contents/Resources/lame
2005-08-21 18:22:28.2739 checking formats for: flc-flc-squeezebox2-00:04:20:05:bf:5d
2005-08-21 18:22:28.2741 checking formats for: flc-flc-*-00:04:20:05:bf:5d
2005-08-21 18:22:28.2743 checking formats for: flc-flc-squeezebox2-*
2005-08-21 18:22:28.2745 checking formats for: flc-flc-*-*
2005-08-21 18:22:28.2747 Checking to see if flc-flc-*-* is enabled
2005-08-21 18:22:28.2749 enabled
2005-08-21 18:22:28.2752 Found command: -
2005-08-21 18:22:28.2760 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:28.2765 Setting maxBitRate for 10.0.1.3 to: 0
2005-08-21 18:22:28.2768 Matched Format: flc Type: flc Command: -
2005-08-21 18:22:28.2771 playing out before starting next song. (old format: flc, new: flc)
2005-08-21 18:22:28.2779 Backtrace:

frame 0: Slim::Player::Source:laymode (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Player/Source.pm line 869)
frame 1: Slim::Player::Source::gotoNext (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Player/Source.pm line 1951)
frame 2: Slim::Player::Source::readNextChunk (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Player/Source.pm line 609)
frame 3: Slim::Player::Source::nextChunk (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Web/HTTP.pm line 1438)
frame 4: Slim::Web::HTTP::sendStreamingResponse (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Networking/Select.pm line 124)
frame 5: Slim::Networking::Select::select (./slimserver.pl line 636)
frame 6: main::idle (./slimserver.pl line 579)
frame 7: main::main (./slimserver.pl line 1175)

[jakey]

I'm getting a bit further - if I launch from the command line via 'perl slimserver.pl' I get the following. It looks like it not finding the codecs but I installed them as re the Mac OS X instructions.

===========================
Streaming: Launching mplayer -really-quiet -vo null -cache 128 -af resample=44100:0:1 -ao pcm -aofile /dev/fd/3 rtsp://rmlivev8.bbc.net.uk/farm/*/ev7/live24/radio4/live/r4_dsat_g2.ra
MPlayer dev-CVS-041116-19:27-3.3 (C) 2000-2004 MPlayer Team

AltiVec found
CPU: PowerPC
Reading config file /usr/local/etc/mplayer/mplayer.conf: No such file or directory
Reading config file /Users/jasonparr/.mplayer/config
Reading /Users/jasonparr/.mplayer/codecs.conf: Can't open '/Users/jasonparr/.mplayer/codecs.conf': No such file or directory
Reading /usr/local/etc/mplayer/codecs.conf: Can't open '/usr/local/etc/mplayer/codecs.conf': No such file or directory
Using built-in default codecs.conf.
font: can't open file: /Users/jasonparr/.mplayer/font/font.desc
font: can't open file: /usr/local/share/mplayer/font/font.desc
======= WAVE Format =======
Format Tag: 28515 (0x6F63)
Channels: 2
Samplerate: 22050
avg byte/sec: 44100
Block align: 640
bits/sample: 16
cbSize: 18
Unknown extra header dump: [0] [80] [0] [10] [0] [b] [2] [80] [0] [8] [1] [0] [0] [2] [4] [0] [0] [18]
===========================

[danco]

More of your log, please. That part of the log is just indicating that mplayer can't find codecs in certain place where it thinks they might be. Later on it will try somewhere else.

Compare with Scott's log in the thread "AlienBBC and Panther help". That begins much as yours does but continues ok until it says it can't find cook.bundle. In fact look at the whole of that thread to see if it gives you any ideas of what may be wrong.

I'm not sure why Scott is having trouble, or whether you have the same issue as his, but that's the kind of log you might expect if things go wrong.

[jakey]

I have run the rp9codecs-macosx-20041107.pkg - not sure where the installer puts things though.

I have also copied manually

/usr/local/lib/codecs
atrc.bundle cook.bundle drv2.bundle drvc.bundle sipr.bundle

Still no luck.

I ran slimserver.p with -d_source and got the following, it continually tries to fork a mplayer. I'm new to Mac OS X and slimserver! so please stay with me if I'm a bit slow.


2005-08-21 22:21:19.1033 Trying to open protocol stream for http://www.bbc.co.uk/radio/aod/netwo.../live.shtml?lw
2005-08-21 22:21:19.1047 Looking for handler for protocol http
2005-08-21 22:21:19.1062 Found handler for protocol http
2005-08-21 22:21:19.6611 Backtrace:

frame 0: Slim::Player::Source:laymode (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Control/Command.pm line 929)
frame 1: Slim::Control::Command::execute (/Users/jasonparr/Library/SlimDevices/Plugins/Alien/Plugin.pm line 377)
frame 2: Plugins::Alien::Plugin::__ANON__ (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Hardware/IR.pm line 662)
frame 3: Slim::Hardware::IR::executeButton (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Control/Command.pm line 603)
frame 4: Slim::Control::Command::execute (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Player/Client.pm line 999)
frame 5: Slim::Player::Client::execute (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Hardware/IR.pm line 675)
frame 6: Slim::Hardware::IR:rocessCode (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Hardware/IR.pm line 538)
frame 7: Slim::Hardware::IR::releaseCode (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Hardware/IR.pm line 431)
frame 8: Slim::Hardware::IR::checkRelease (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Utils/Timers.pm line 100)
frame 9: Slim::Utils::Timers::checkTimers (slimserver.pl line 641)
frame 10: main::idle (slimserver.pl line 579)
frame 11: main::main (slimserver.pl line 1175)

2005-08-21 22:21:19.6651 6f:a1:37:59:d3:89: Switching to mode stop from stop
2005-08-21 22:21:19.6666 Already in playmode stop : ignoring mode change
2005-08-21 22:21:19.6681 Adding song index 0 to song queue
2005-08-21 22:21:19.6691 Clearing out song queue first
2005-08-21 22:21:19.6704 Song queue is now 0
2005-08-21 22:21:19.6985 Trying to open protocol stream for http://www.bbc.co.uk/radio4/realplayer/media/lwg2.rpm
2005-08-21 22:21:19.7001 Looking for handler for protocol http
2005-08-21 22:21:19.7012 Found handler for protocol http
2005-08-21 22:21:20.4331 Backtrace:

frame 0: Slim::Player::Source:laymode (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Player/Source.pm line 758)
frame 1: Slim::Player::Source::jumpto (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Control/Command.pm line 1745)
frame 2: Slim::Control::Command::load_done (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Utils/Scan.pm line 124)
frame 3: Slim::Utils::Scan::addToList (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Control/Command.pm line 1000)
frame 4: Slim::Control::Command::execute (/Users/jasonparr/Library/SlimDevices/Plugins/Alien/Plugin.pm line 377)
frame 5: Plugins::Alien::Plugin::__ANON__ (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Hardware/IR.pm line 662)
frame 6: Slim::Hardware::IR::executeButton (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Control/Command.pm line 603)
frame 7: Slim::Control::Command::execute (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Player/Client.pm line 999)
frame 8: Slim::Player::Client::execute (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Hardware/IR.pm line 675)
frame 9: Slim::Hardware::IR:rocessCode (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Hardware/IR.pm line 538)
frame 10: Slim::Hardware::IR::releaseCode (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Hardware/IR.pm line 431)
frame 11: Slim::Hardware::IR::checkRelease (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Utils/Timers.pm line 100)
frame 12: Slim::Utils::Timers::checkTimers (slimserver.pl line 641)
frame 13: main::idle (slimserver.pl line 579)
frame 14: main::main (slimserver.pl line 1175)

2005-08-21 22:21:20.4368 6f:a1:37:59:d3:89: Switching to mode stop from stop
2005-08-21 22:21:20.4378 Already in playmode stop : ignoring mode change
2005-08-21 22:21:20.4396 Adding song index 0 to song queue
2005-08-21 22:21:20.4407 Clearing out song queue first
2005-08-21 22:21:20.4425 Song queue is now 0
2005-08-21 22:21:20.4445 Backtrace:

frame 0: Slim::Player::Source:laymode (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Player/Source.pm line 789)
frame 1: Slim::Player::Source::jumpto (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Control/Command.pm line 1745)
frame 2: Slim::Control::Command::load_done (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Utils/Scan.pm line 124)
frame 3: Slim::Utils::Scan::addToList (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Control/Command.pm line 1000)
frame 4: Slim::Control::Command::execute (/Users/jasonparr/Library/SlimDevices/Plugins/Alien/Plugin.pm line 377)
frame 5: Plugins::Alien::Plugin::__ANON__ (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Hardware/IR.pm line 662)
frame 6: Slim::Hardware::IR::executeButton (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Control/Command.pm line 603)
frame 7: Slim::Control::Command::execute (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Player/Client.pm line 999)
frame 8: Slim::Player::Client::execute (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Hardware/IR.pm line 675)
frame 9: Slim::Hardware::IR:rocessCode (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Hardware/IR.pm line 538)
frame 10: Slim::Hardware::IR::releaseCode (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Hardware/IR.pm line 431)
frame 11: Slim::Hardware::IR::checkRelease (/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Slim/Utils/Timers.pm line 100)
frame 12: Slim::Utils::Timers::checkTimers (slimserver.pl line 641)
frame 13: main::idle (slimserver.pl line 579)
frame 14: main::main (slimserver.pl line 1175)

2005-08-21 22:21:20.4475 6f:a1:37:59:d3:89: Switching to mode play from stop
2005-08-21 22:21:20.4558 openSong on: rtsp://rmlivev8.bbc.net.uk/farm/*/ev7/live24/radio4/live/r4lw_dsat_g2_1.ra
2005-08-21 22:21:20.5023 URL is remote : rtsp://rmlivev8.bbc.net.uk/farm/*/ev7/live24/radio4/live/r4lw_dsat_g2_1.ra
2005-08-21 22:21:20.5045 Trying to open protocol stream for rtsp://rmlivev8.bbc.net.uk/farm/*/ev7/live24/radio4/live/r4lw_dsat_g2_1.ra
2005-08-21 22:21:20.5055 Looking for handler for protocol rtsp
2005-08-21 22:21:20.5065 Found handler for protocol rtsp
2005-08-21 22:21:20.6913 Setting maxBitRate for 127.0.0.1 to: 0
2005-08-21 22:21:20.6933 Setting maxBitRate for 127.0.0.1 to: 0
2005-08-21 22:21:20.6944 undermax = 1, type = rtsp, softsqueeze = 6f:a1:37:59:d3:89, lame = /Users/jasonparr/Library/iTunes/Scripts/iTunes-LAME.app/Contents/Resources/lame
2005-08-21 22:21:20.6962 checking formats for: rtsp-flc-softsqueeze-6f:a1:37:59:d3:89
2005-08-21 22:21:20.6979 checking formats for: rtsp-flc-*-6f:a1:37:59:d3:89
2005-08-21 22:21:20.6997 checking formats for: rtsp-flc-softsqueeze-*
2005-08-21 22:21:20.7007 checking formats for: rtsp-flc-*-*
2005-08-21 22:21:20.7017 Checking to see if rtsp-flc-*-* is enabled
2005-08-21 22:21:20.7040 enabled
2005-08-21 22:21:20.7050 Found command: [mplayer.sh] -really-quiet -vo null -cache 128 -af resample=44100:0:1 -ao pcm -aofile /dev/fd/3 $FILE$ | [flac] -cs --totally-silent --compression-level-0 -
2005-08-21 22:21:20.7074 Setting maxBitRate for 127.0.0.1 to: 0
2005-08-21 22:21:20.7096 Setting maxBitRate for 127.0.0.1 to: 0
2005-08-21 22:21:20.7107 Matched Format: flc Type: rtsp Command: [mplayer.sh] -really-quiet -vo null -cache 128 -af resample=44100:0:1 -ao pcm -aofile /dev/fd/3 $FILE$ | [flac] -cs --totally-silent --compression-level-0 -
2005-08-21 22:21:20.8981 Setting maxBitRate for 127.0.0.1 to: 0
2005-08-21 22:21:20.9002 Setting maxBitRate for 127.0.0.1 to: 0
2005-08-21 22:21:20.9030 Using command for conversion: "/Users/jasonparr/Library/SlimDevices/bin/mplayer.sh" -really-quiet -vo null -cache 128 -af resample=44100:0:1 -ao pcm -aofile /dev/fd/3 "rtsp://rmlivev8.bbc.net.uk/farm/*/ev7/live24/radio4/live/r4lw_dsat_g2_1.ra" | "/Users/jasonparr/Library/PreferencePanes/SlimServer.prefPane/Contents/server/Bin/darwin/flac" -cs --