060809 20:22:01 InnoDB: Started; log sequence number 0 15697666
060809 20:22:01 [Note] /usr/local/slimserver/Bin/i386-linux/mysqld: ready for connections.
Version: '5.0.21-standard' socket: '/home/mjpine/Cache/slimserver-mysql.sock' port: 9092 MySQL Community Edition - Standard (GPL)
2006-08-09 20:22:03.7124 Squeezebox protocol listening on port 3483
2006-08-09 20:22:04.1122 loading conversion config files...
2006-08-09 20:22:04.1546 input: 'mov' output: 'mp3' clienttype: '*': clientid: '*': '[mov123] $FILE$ | [lame] --resample 44100 --silent -q $QUALITY$ -b $BITRATE$ -r - -'
2006-08-09 20:22:04.1550 input: 'ogg' output: 'mp3' clienttype: '*': clientid: '*': '[sox] -t ogg $FILE$ -t raw -r 44100 -c 2 -w -s $-x$ - | [lame] --resample 44100 --silent -q $QUALITY$ --abr $BITRATE$ -r - -'
2006-08-09 20:22:04.1552 input: 'wav' output: 'mp3' clienttype: '*': clientid: '*': '[lame] --resample 44100 --silent -q $QUALITY$ --abr $BITRATE$ $FILE$ -'
2006-08-09 20:22:04.1555 input: 'aif' output: 'mp3' clienttype: '*': clientid: '*': '[lame] --resample 44100 --silent -q $QUALITY$ --abr $BITRATE$ $FILE$ -'
2006-08-09 20:22:04.1557 input: 'shn' output: 'mp3' clienttype: '*': clientid: '*': '[shorten] -x $FILE$ - | [lame] --resample 44100 --silent -q $QUALITY$ --abr $BITRATE$ - -'
2006-08-09 20:22:04.1560 input: 'flc' output: 'mp3' clienttype: '*': clientid: '*': '[flac] -dcs --skip=$START$ --until=$END$ -- $FILE$ | [lame] --resample 44100 --silent -q $QUALITY$ --abr $BITRATE$ - -'
2006-08-09 20:22:04.1562 input: 'wma' output: 'mp3' clienttype: '*': clientid: '*': '[wmadec] -r 44100 -b 16 -n 2 $FILE$ | [lame] -x --resample 44100 --silent -q $QUALITY$ --abr $BITRATE$ - -'
2006-08-09 20:22:04.1565 input: 'mpc' output: 'mp3' clienttype: '*': clientid: '*': '[mppdec] --raw-le --silent --prev --gain 3 $FILE$ - | [lame] -x --resample 44100 --silent -q $QUALITY$ --abr $BITRATE$ - -'
2006-08-09 20:22:04.1568 input: 'ape' output: 'mp3' clienttype: '*': clientid: '*': '[mac] $FILE$ - -d | [lame] --resample 44100 -x --silent -q 9 --abr $BITRATE$ - -'
2006-08-09 20:22:04.1570 input: 'mp3' output: 'mp3' clienttype: '*': clientid: '*': '-'
2006-08-09 20:22:04.1572 input: 'aif' output: 'aif' clienttype: '*': clientid: '*': '-'
2006-08-09 20:22:04.1575 input: 'wav' output: 'wav' clienttype: '*': clientid: '*': '-'
2006-08-09 20:22:04.1577 input: 'shn' output: 'wav' clienttype: '*': clientid: '*': '[shorten] -x $FILE$ -'
2006-08-09 20:22:04.1579 input: 'flc' output: 'wav' clienttype: '*': clientid: '*': '[flac] -dcs --force-raw-format --endian=little --sign=signed --skip=$START$ --until=$END$ -- $FILE$'
2006-08-09 20:22:04.1581 input: 'ogg' output: 'ogg' clienttype: '*': clientid: '*': '-'
2006-08-09 20:22:04.1584 input: 'ogg' output: 'aif' clienttype: '*': clientid: '*': '[sox] -t ogg $FILE$ -t raw -r 44100 -c 2 -w -s $-x$ -'
2006-08-09 20:22:04.1586 input: 'wma' output: 'wav' clienttype: '*': clientid: '*': '[wmadec] -r 44100 -b 16 -n 2 $FILE$'
2006-08-09 20:22:04.1588 input: 'mpc' output: 'wav' clienttype: '*': clientid: '*': '[mppdec] --raw-le --silent --prev --gain 2 $FILE$ -'
2006-08-09 20:22:04.1590 input: 'ape' output: 'wav' clienttype: '*': clientid: '*': '[mac] $FILE$ - -d'
2006-08-09 20:22:04.1593 input: 'mpc' output: 'aif' clienttype: '*': clientid: '*': '[mppdec] --raw-be --silent --prev --gain 2 $FILE$ -'
2006-08-09 20:22:04.1595 input: 'mov' output: 'aif' clienttype: '*': clientid: '*': '[mov123] $FILE$'
2006-08-09 20:22:04.1597 input: 'wma' output: 'wma' clienttype: 'squeezebox2': clientid: '*': '-'
2006-08-09 20:22:04.1600 input: 'flc' output: 'flc' clienttype: '*': clientid: '*': '-'
2006-08-09 20:22:04.1602 input: 'aif' output: 'flc' clienttype: '*': clientid: '*': '[flac] -cs --totally-silent --compression-level-0 --skip=$START$ --until=$END$ -- $FILE$'
2006-08-09 20:22:04.1605 input: 'wav' output: 'flc' clienttype: '*': clientid: '*': '[flac] -cs --totally-silent --compression-level-0 --skip=$START$ --until=$END$ -- $FILE$'
2006-08-09 20:22:04.1609 input: 'shn' output: 'flc' clienttype: '*': clientid: '*': '[shorten] -x $FILE$ - | [flac] -cs --totally-silent --compression-level-0 --endian little --sign signed --channels 2 --bps 16 --sample-rate 44100 -'
2006-08-09 20:22:04.1613 input: 'ogg' output: 'flc' clienttype: '*': clientid: '*': '[sox] -t ogg $FILE$ -t raw -r 44100 -c 2 -w -s $-x$ - | [flac] -cs --compression-level-0 --totally-silent --endian big --channel 2 --bps 16 --sample-rate 44100 --sign signed -'
2006-08-09 20:22:04.1616 input: 'wma' output: 'flc' clienttype: '*': clientid: '*': '[wmadec] -r 44100 -b 16 -n 2 $FILE$ | [flac] -cs --totally-silent --compression-level-0 --endian little --sign signed --channels 2 --bps 16 --sample-rate 44100 -'
2006-08-09 20:22:04.1619 input: 'mpc' output: 'flc' clienttype: '*': clientid: '*': '[mppdec] --silent --prev --gain 2 $FILE$ - | [flac] -cs --totally-silent --compression-level-0 -'
2006-08-09 20:22:04.1621 input: 'ape' output: 'flc' clienttype: '*': clientid: '*': '[mac] $FILE$ - -d | [flac] -cs --totally-silent --compression-level-0 -'
2006-08-09 20:22:04.1624 input: 'mov' output: 'flc' clienttype: '*': clientid: '*': '[mov123] $FILE$ | [flac] -cs --totally-silent --compression-level-0 --endian big --sign signed --channels 2 --bps 16 --sample-rate 44100 -'
2006-08-09 20:22:04.1626 input: 'mp3' output: 'mp3' clienttype: 'transcode': clientid: '*': '[lame] --resample 44100 --silent -q $QUALITY$ --abr $BITRATE$ $FILE$ -'
2006-08-09 20:22:04.1629 input: 'flc' output: 'flc' clienttype: 'transcode': clientid: '*': '[flac] -dcs --skip=$START$ --until=$END$ -- $FILE$ | [flac] -cs --totally-silent --compression-level-0 -'
2006-08-09 20:22:04.1921 input: 'mov' output: 'mp3' clienttype: '*': clientid: '*': '[mplayer] -novideo -nortc -vc dummy -vo null -cache 128 -af volume=0,resample=44100:0:1,channels=2 -ao pcm:file=/dev/fd/4 $FILE$ 4>&1 1>&2 1>/dev/null | [lame] --silent -q $QUALITY$ -b $BITRATE$ -'
2006-08-09 20:22:04.1930 input: 'rtsp' output: 'wav' clienttype: '*': clientid: '*': '[mplayer.sh] -really-quiet -vc null -vo null -bandwidth 10000000 -cache 128 -af volume=0,resample=44100:0:1,channels=2 -ao pcm:nowaveheader:file=/dev/fd/3 $FILE$'
2006-08-09 20:22:04.1933 input: 'rtsp' output: 'mp3' clienttype: '*': clientid: '*': '[mplayer.sh] -really-quiet -vc null -vo null -bandwidth 10000000 -cache 128 -af volume=0,resample=44100:0:1,channels=2 -ao pcm:nowaveheader:file=/dev/fd/3 $FILE$ | [lame] --silent -r -x -q $QUALITY$ -b $BITRATE$ - -'
2006-08-09 20:22:04.1936 input: 'rtsp' output: 'flc' clienttype: '*': clientid: '*': '[mplayer.sh] -really-quiet -vc null -vo null -bandwidth 10000000 -cache 128 -af volume=0,resample=44100:0:1,channels=2 -ao pcm:nowaveheader:file=/dev/fd/3 $FILE$ | [flac] -cs --totally-silent --endian=little --channels=2 --sign=signed --bps=16 --sample-rate=44100 --compression-level-0 -'
2006-08-09 20:22:04.1939 input: 'wma' output: 'wav' clienttype: '*': clientid: '*': '[mplayer.sh] -really-quiet -vc null -vo null -cache 128 -af volume=0,resample=44100:0:1,channels=2 -ao pcm:nowaveheader:file=/dev/fd/3 $FILE$'
2006-08-09 20:22:04.1942 input: 'wma' output: 'mp3' clienttype: '*': clientid: '*': '[mplayer.sh] -really-quiet -vc null -vo null -cache 128 -af volume=0,resample=44100:0:1,channels=2 -ao pcm:nowaveheader:file=/dev/fd/3 $FILE$ | [lame] --silent -r -x -q $QUALITY$ -b $BITRATE$ - -'
2006-08-09 20:22:04.1945 input: 'wma' output: 'flc' clienttype: '*': clientid: '*': '[mplayer.sh] -really-quiet -vc null -vo null -cache 128 -af volume=0,resample=44100:0:1,channels=2 -ao pcm:nowaveheader:file=/dev/fd/3 $FILE$ | [flac] -cs --totally-silent --endian=little --channels=2 --sign=signed --bps=16 --sample-rate=44100 --compression-level-0 -'
2006-08-09 20:22:06.6914 Slimproto accepted connection from: [192.168.2.4:47995]
2006-08-09 20:22:06.7161 Setting timer in 5 seconds to close bogus connection
2006-08-09 20:22:06.7172 _hello_handler: Killing bogus player timer.
2006-08-09 20:22:06.7177 Squeezebox says hello.
Deviceid: 4
revision: 59
mac: 00:04:20:06:7f:7f
bitmapped: 32768
reconnect: 0
wlan_channellist: 0000
2006-08-09 20:22:06.7178 Squeezebox also says.
bytes_received: 0
2006-08-09 20:22:06.7181 creating new client, id:00:04:20:06:7f:7f ipport: 192.168.2.4:47995
2006-08-09 20:22:07.0574 Adding song index 0 to song queue
2006-08-09 20:22:07.0577 Clearing out song queue first
2006-08-09 20:22:07.0579 Song queue is now 0
2006-08-09 20:22:07.0617 *************stream called: q paused: format: url:
2006-08-09 20:22:07.0621 Backtrace:
frame 0: Slim::Player::Squeezebox::stream (/usr/local/slimserver/Slim/Player/Squeezebox.pm line 202)
frame 1: Slim::Player::Squeezebox::stop (/usr/local/slimserver/Slim/Player/Squeezebox2.pm line 203)
frame 2: Slim::Player::Squeezebox2::stop (/usr/local/slimserver/Slim/Player/Squeezebox.pm line 87)
frame 3: Slim::Player::Squeezebox::reconnect (/usr/local/slimserver/Slim/Networking/Slimproto.pm line 812)
frame 4: Slim::Networking::Slimproto::_hello_handler (/usr/local/slimserver/Slim/Networking/Slimproto.pm line 360)
frame 5: Slim::Networking::Slimproto::client_readable (/usr/local/slimserver/Slim/Networking/Select.pm line 170)
frame 6: Slim::Networking::Select::select (/usr/local/slimserver/slimserver.pl line 493)
frame 7: main::idle (/usr/local/slimserver/slimserver.pl line 446)
frame 8: main::main (/usr/local/slimserver/slimserver.pl line 1043)
2006-08-09 20:22:07.0624 starting with decoder with format: m autostart: 0 threshold: 255 samplesize: ? samplerate: ? endian: ? channels: ?
2006-08-09 20:22:07.0626 flags: 0
2006-08-09 20:22:07.0628 sending strm frame of length: 24 request string:
2006-08-09 20:22:07.0694 00:04:20:06:7f:7f Squeezebox stream status:
event_code: ����
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354703528
2006-08-09 20:22:07.0697 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:07.0706 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMf
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354703900
2006-08-09 20:22:07.0708 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:07.0717 00:04:20:06:7f:7f Squeezebox stream status:
event_code: strm
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354703901
2006-08-09 20:22:07.0719 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:07.0727 00:04:20:06:7f:7f Squeezebox stream status:
event_code: aude
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354703905
2006-08-09 20:22:07.0730 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:07.0738 00:04:20:06:7f:7f Squeezebox stream status:
event_code: audg
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354703906
2006-08-09 20:22:07.0740 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:13.0048 00:04:20:06:7f:7f Squeezebox stream status:
event_code: stat
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354709838
2006-08-09 20:22:13.0051 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:18.0050 00:04:20:06:7f:7f Squeezebox stream status:
event_code: stat
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354714837
2006-08-09 20:22:18.0053 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:21.8554 00:04:20:06:7f:7f: Switching to mode stop from stop
2006-08-09 20:22:21.8557 Already in playmode stop : ignoring mode change
2006-08-09 20:22:21.8560 jumping to 0
2006-08-09 20:22:21.8563 Adding song index 0 to song queue
2006-08-09 20:22:21.8564 Clearing out song queue first
2006-08-09 20:22:21.8566 Song queue is now 0
2006-08-09 20:22:21.8584 00:04:20:06:7f:7f Squeezebox stream status:
event_code: aude
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354718680
2006-08-09 20:22:21.8587 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:28.0045 00:04:20:06:7f:7f Squeezebox stream status:
event_code: stat
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354724836
2006-08-09 20:22:28.0047 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:33.0048 00:04:20:06:7f:7f Squeezebox stream status:
event_code: stat
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354729836
2006-08-09 20:22:33.0051 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:38.0051 00:04:20:06:7f:7f Squeezebox stream status:
event_code: stat
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354734835
2006-08-09 20:22:38.0054 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:43.0054 00:04:20:06:7f:7f Squeezebox stream status:
event_code: stat
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354739834
2006-08-09 20:22:43.0058 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:47.2019 Adding song index 0 to song queue
2006-08-09 20:22:47.2022 Clearing out song queue first
2006-08-09 20:22:47.2024 Song queue is now 0
2006-08-09 20:22:47.2028 00:04:20:06:7f:7f: Switching to mode stop from stop
2006-08-09 20:22:47.2030 Already in playmode stop : ignoring mode change
2006-08-09 20:22:47.3493 00:04:20:06:7f:7f: Switching to mode stop from stop
2006-08-09 20:22:47.3496 Already in playmode stop : ignoring mode change
2006-08-09 20:22:47.3498 jumping to 0
2006-08-09 20:22:47.3500 Adding song index 0 to song queue
2006-08-09 20:22:47.3501 Clearing out song queue first
2006-08-09 20:22:47.3503 Song queue is now 0
2006-08-09 20:22:47.3508 00:04:20:06:7f:7f: Switching to mode play from stop
2006-08-09 20:22:47.3580 openSong on: file:///home/slim%20music/Bananarama/Greatest%20Hits%20Collection/02%20I%20Heard%20A%20Rumour.m4a
2006-08-09 20:22:47.3595 openSong: duration: [207] size: [3293112] endian [] offset: [0] for file:///home/slim%20music/Bananarama/Greatest%20Hits%20Collection/02%20I%20Heard%20A%20Rumour.m4a
2006-08-09 20:22:47.3600 Setting maxBitRate for squeezhome to: 0
2006-08-09 20:22:47.3604 Setting maxBitRate for squeezhome to: 0
2006-08-09 20:22:47.3612 Setting maxBitRate for squeezhome to: 0
2006-08-09 20:22:47.3616 Setting maxBitRate for squeezhome to: 0
2006-08-09 20:22:47.3618 undermax = 1, type = mov, squeezebox2 = 00:04:20:06:7f:7f
2006-08-09 20:22:47.3620 checking formats for: mov-wma-squeezebox2-00:04:20:06:7f:7f
2006-08-09 20:22:47.3622 checking formats for: mov-wma-*-00:04:20:06:7f:7f
2006-08-09 20:22:47.3624 checking formats for: mov-wma-squeezebox2-*
2006-08-09 20:22:47.3625 checking formats for: mov-wma-*-*
2006-08-09 20:22:47.3627 checking formats for: mov-ogg-squeezebox2-00:04:20:06:7f:7f
2006-08-09 20:22:47.3629 checking formats for: mov-ogg-*-00:04:20:06:7f:7f
2006-08-09 20:22:47.3630 checking formats for: mov-ogg-squeezebox2-*
2006-08-09 20:22:47.3632 checking formats for: mov-ogg-*-*
2006-08-09 20:22:47.3633 checking formats for: mov-flc-squeezebox2-00:04:20:06:7f:7f
2006-08-09 20:22:47.3638 checking formats for: mov-flc-*-00:04:20:06:7f:7f
2006-08-09 20:22:47.3639 checking formats for: mov-flc-squeezebox2-*
2006-08-09 20:22:47.3641 checking formats for: mov-flc-*-*
2006-08-09 20:22:47.3643 Checking to see if mov-flc-*-* is enabled
2006-08-09 20:22:47.3645 There are 1 disabled formats...
2006-08-09 20:22:47.3646 Testing rtsp-wav-*-* vs mov-flc-*-*
2006-08-09 20:22:47.3648 Testing rtsp-flc-*-* vs mov-flc-*-*
2006-08-09 20:22:47.3649 enabled
2006-08-09 20:22:47.3651 Found command: [mov123] $FILE$ | [flac] -cs --totally-silent --compression-level-0 --endian big --sign signed --channels 2 --bps 16 --sample-rate 44100 -
2006-08-09 20:22:47.5979 drat, missing binary mov123
2006-08-09 20:22:47.5981 checking formats for: mov-aif-squeezebox2-00:04:20:06:7f:7f
2006-08-09 20:22:47.5983 checking formats for: mov-aif-*-00:04:20:06:7f:7f
2006-08-09 20:22:47.5984 checking formats for: mov-aif-squeezebox2-*
2006-08-09 20:22:47.5986 checking formats for: mov-aif-*-*
2006-08-09 20:22:47.5987 Checking to see if mov-aif-*-* is enabled
2006-08-09 20:22:47.5989 There are 1 disabled formats...
2006-08-09 20:22:47.5991 Testing rtsp-wav-*-* vs mov-aif-*-*
2006-08-09 20:22:47.5993 Testing rtsp-flc-*-* vs mov-aif-*-*
2006-08-09 20:22:47.5997 enabled
2006-08-09 20:22:47.5999 Found command: [mov123] $FILE$
2006-08-09 20:22:47.6010 drat, missing binary mov123
2006-08-09 20:22:47.6013 checking formats for: mov-wav-squeezebox2-00:04:20:06:7f:7f
2006-08-09 20:22:47.6014 checking formats for: mov-wav-*-00:04:20:06:7f:7f
2006-08-09 20:22:47.6016 checking formats for: mov-wav-squeezebox2-*
2006-08-09 20:22:47.6017 checking formats for: mov-wav-*-*
2006-08-09 20:22:47.6019 checking formats for: mov-mp3-squeezebox2-00:04:20:06:7f:7f
2006-08-09 20:22:47.6021 checking formats for: mov-mp3-*-00:04:20:06:7f:7f
2006-08-09 20:22:47.6022 checking formats for: mov-mp3-squeezebox2-*
2006-08-09 20:22:47.6024 checking formats for: mov-mp3-*-*
2006-08-09 20:22:47.6025 Checking to see if mov-mp3-*-* is enabled
2006-08-09 20:22:47.6027 There are 1 disabled formats...
2006-08-09 20:22:47.6029 Testing rtsp-wav-*-* vs mov-mp3-*-*
2006-08-09 20:22:47.6031 Testing rtsp-flc-*-* vs mov-mp3-*-*
2006-08-09 20:22:47.6032 enabled
2006-08-09 20:22:47.6035 Found command: [mplayer] -novideo -nortc -vc dummy -vo null -cache 128 -af volume=0,resample=44100:0:1,channels=2 -ao pcm:file=/dev/fd/4 $FILE$ 4>&1 1>&2 1>/dev/null | [lame] --silent -q $QUALITY$ -b $BITRATE$ -
2006-08-09 20:22:47.6553 Setting maxBitRate for squeezhome to: 0
2006-08-09 20:22:47.6561 Setting maxBitRate for squeezhome to: 0
2006-08-09 20:22:47.6563 Matched Format: mp3 Type: mov Command: [mplayer] -novideo -nortc -vc dummy -vo null -cache 128 -af volume=0,resample=44100:0:1,channels=2 -ao pcm:file=/dev/fd/4 $FILE$ 4>&1 1>&2 1>/dev/null | [lame] --silent -q $QUALITY$ -b $BITRATE$ -
2006-08-09 20:22:47.6565 openSong: this is an mov file: file:///home/slim%20music/Bananarama/Greatest%20Hits%20Collection/02%20I%20Heard%20A%20Rumour.m4a
2006-08-09 20:22:47.6567 file type: mov format: mp3 inrate: 124 maxRate: 0
2006-08-09 20:22:47.6568 command: [mplayer] -novideo -nortc -vc dummy -vo null -cache 128 -af volume=0,resample=44100:0:1,channels=2 -ao pcm:file=/dev/fd/4 $FILE$ 4>&1 1>&2 1>/dev/null | [lame] --silent -q $QUALITY$ -b $BITRATE$ -
2006-08-09 20:22:47.6581 Using command for conversion: "/usr/local/bin/mplayer" -novideo -nortc -vc dummy -vo null -cache 128 -af volume=0,resample=44100:0:1,channels=2 -ao pcm:file=/dev/fd/4 "/home/slim music/Bananarama/Greatest Hits Collection/02 I Heard A Rumour.m4a" 4>&1 1>&2 1>/dev/null | "/usr/bin/lame" --silent -q 2 -b 0 - & |
2006-08-09 20:22:47.7020 openSong: Streaming with format: mp3
2006-08-09 20:22:47.7921 00:04:20:06:7f:7f New play mode: play
2006-08-09 20:22:48.1976 *************stream called: s paused: 0 format: mp3 url: file:///home/slim%20music/Bananarama/Greatest%20Hits%20Collection/02%20I%20Heard%20A%20Rumour.m4a
2006-08-09 20:22:48.1984 Backtrace:
frame 0: Slim::Player::Squeezebox::stream (/usr/local/slimserver/Slim/Player/Squeezebox.pm line 152)
frame 1: Slim::Player::Squeezebox::play (/usr/local/slimserver/Slim/Player/Source.pm line 486)
frame 2: Slim::Player::Source::playmode (/usr/local/slimserver/Slim/Player/Source.pm line 856)
frame 3: Slim::Player::Source::jumpto (/usr/local/slimserver/Slim/Control/Commands.pm line 579)
frame 4: Slim::Control::Commands::playlistJumpCommand (/usr/local/slimserver/Slim/Control/Request.pm line 1405)
frame 5: (eval) (/usr/local/slimserver/Slim/Control/Request.pm line 1405)
frame 6: Slim::Control::Request::execute (/usr/local/slimserver/Slim/Control/Request.pm line 731)
frame 7: Slim::Control::Request::executeRequest (/usr/local/slimserver/Slim/Player/Client.pm line 1015)
frame 8: Slim::Player::Client::execute (/usr/local/slimserver/Slim/Buttons/BrowseTree.pm line 129)
frame 9: Slim::Buttons::BrowseTree::__ANON__ (/usr/local/slimserver/Slim/Hardware/IR.pm line 737)
frame 10: Slim::Hardware::IR::executeButton (/usr/local/slimserver/Slim/Buttons/Input/List.pm line 74)
frame 11: Slim::Buttons::Input::List::__ANON__ (/usr/local/slimserver/Slim/Hardware/IR.pm line 737)
frame 12: Slim::Hardware::IR::executeButton (/usr/local/slimserver/Slim/Control/Commands.pm line 141)
frame 13: Slim::Control::Commands::buttonCommand (/usr/local/slimserver/Slim/Control/Request.pm line 1405)
frame 14: (eval) (/usr/local/slimserver/Slim/Control/Request.pm line 1405)
frame 15: Slim::Control::Request::execute (/usr/local/slimserver/Slim/Control/Request.pm line 731)
frame 16: Slim::Control::Request::executeRequest (/usr/local/slimserver/Slim/Player/Client.pm line 1015)
frame 17: Slim::Player::Client::execute (/usr/local/slimserver/Slim/Hardware/IR.pm line 750)
frame 18: Slim::Hardware::IR::processCode (/usr/local/slimserver/Slim/Hardware/IR.pm line 613)
frame 19: Slim::Hardware::IR::releaseCode (/usr/local/slimserver/Slim/Hardware/IR.pm line 501)
frame 20: Slim::Hardware::IR::checkRelease (/usr/local/slimserver/Slim/Utils/Timers.pm line 171)
frame 21: Slim::Utils::Timers::checkTimers (/usr/local/slimserver/slimserver.pl line 496)
frame 22: main::idle (/usr/local/slimserver/slimserver.pl line 446)
frame 23: main::main (/usr/local/slimserver/slimserver.pl line 1043)
2006-08-09 20:22:48.1991 starting with decoder with format: m autostart: 1 threshold: 255 samplesize: ? samplerate: ? endian: ? channels: ?
2006-08-09 20:22:48.1993 flags: 0
2006-08-09 20:22:48.1997 sending strm frame of length: 76 request string:
GET /stream.mp3?player=00:04:20:06:7f:7f HTTP/1.0
2006-08-09 20:22:48.2012 00:04:20:06:7f:7f: Current playmode: play
2006-08-09 20:22:48.2044 00:04:20:06:7f:7f Squeezebox stream status:
event_code: audg
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354744625
2006-08-09 20:22:48.2047 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:48.2056 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMf
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354745031
2006-08-09 20:22:48.2058 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:48.2067 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMc
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354745032
2006-08-09 20:22:48.2070 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:48.9459 00:04:20:06:7f:7f Squeezebox stream status:
event_code: strm
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354745033
2006-08-09 20:22:48.9464 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:48.9480 00:04:20:06:7f:7f Squeezebox stream status:
event_code: audg
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354745034
2006-08-09 20:22:48.9487 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:48.9500 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMe
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354745036
2006-08-09 20:22:48.9502 output size: 3528000
output fullness: 3048896
elapsed seconds: 0
2006-08-09 20:22:49.2995 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMh
bytes_rec_H 0
bytes_rec_L 0
fullness: 0 (0%)
bufferSize 3145728
fullness 0
bytes_received 0
jiffies: 354746127
2006-08-09 20:22:49.2998 output size: 3528000
output fullness: 0
elapsed seconds: 0
2006-08-09 20:22:49.3004 Squeezebox got HTTP response:
HTTP/1.0 200 OK
Date: Wed, 09 Aug 2006 12:22:49 GMT
Server: SlimServer (6.5b1 - 8806)
Connection: close
Content-Type: audio/mpeg
Set-Cookie: SlimServer-player=00%3A04%3A20%3A06%3A7f%3A7f; path=/; expires=Thu, 09-Aug-2007 12:22:49 GMT
2006-08-09 20:22:49.3012 We need to send 0 seconds of silence...
2006-08-09 20:22:49.3014 sending 0 bytes of silence
2006-08-09 20:22:54.0653 00:04:20:06:7f:7f Squeezebox stream status:
event_code: stat
bytes_rec_H 0
bytes_rec_L 196608
fullness: 196608 (6%)
bufferSize 3145728
fullness 196608
bytes_received 196608
jiffies: 354750839
2006-08-09 20:22:54.0656 output size: 3528000
output fullness: 0
elapsed seconds: 0
2006-08-09 20:22:54.9027 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMs
bytes_rec_H 0
bytes_rec_L 262144
fullness: 259254 (8%)
bufferSize 3145728
fullness 259254
bytes_received 262144
jiffies: 354751706
2006-08-09 20:22:54.9030 output size: 3528000
output fullness: 11648
elapsed seconds: 0
2006-08-09 20:22:54.9033 Got a track starting event
2006-08-09 20:22:54.9036 Song 0 has now started playing
2006-08-09 20:22:54.9044 Song queue is now 0
2006-08-09 20:22:55.5237 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 307200
fullness: 286756 (9%)
bufferSize 3145728
fullness 286756
bytes_received 307200
jiffies: 354752312
2006-08-09 20:22:55.5240 output size: 3528000
output fullness: 194176
elapsed seconds: 0
2006-08-09 20:22:56.5068 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 385024
fullness: 336995 (10%)
bufferSize 3145728
fullness 336995
bytes_received 385024
jiffies: 354753312
2006-08-09 20:22:56.5071 output size: 3528000
output fullness: 468096
elapsed seconds: 1
2006-08-09 20:22:57.4864 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 462848
fullness: 384726 (12%)
bufferSize 3145728
fullness 384726
bytes_received 462848
jiffies: 354754312
2006-08-09 20:22:57.4867 output size: 3528000
output fullness: 741888
elapsed seconds: 2
2006-08-09 20:22:58.5184 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 544768
fullness: 439061 (13%)
bufferSize 3145728
fullness 439061
bytes_received 544768
jiffies: 354755312
2006-08-09 20:22:58.5186 output size: 3528000
output fullness: 1023872
elapsed seconds: 3
2006-08-09 20:22:59.5340 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 622592
fullness: 489299 (15%)
bufferSize 3145728
fullness 489299
bytes_received 622592
jiffies: 354756312
2006-08-09 20:22:59.5344 output size: 3528000
output fullness: 1297792
elapsed seconds: 4
2006-08-09 20:23:00.4884 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 696320
fullness: 532934 (16%)
bufferSize 3145728
fullness 532934
bytes_received 696320
jiffies: 354757312
2006-08-09 20:23:00.4887 output size: 3528000
output fullness: 1572736
elapsed seconds: 5
2006-08-09 20:23:01.5269 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 774144
fullness: 583173 (18%)
bufferSize 3145728
fullness 583173
bytes_received 774144
jiffies: 354758312
2006-08-09 20:23:01.5272 output size: 3528000
output fullness: 1846656
elapsed seconds: 6
2006-08-09 20:23:02.5336 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 851968
fullness: 630904 (20%)
bufferSize 3145728
fullness 630904
bytes_received 851968
jiffies: 354759312
2006-08-09 20:23:02.5339 output size: 3528000
output fullness: 2120576
elapsed seconds: 7
2006-08-09 20:23:03.5195 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 925696
fullness: 677046 (21%)
bufferSize 3145728
fullness 677046
bytes_received 925696
jiffies: 354760312
2006-08-09 20:23:03.5198 output size: 3528000
output fullness: 2394368
elapsed seconds: 8
2006-08-09 20:23:04.4935 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 999424
fullness: 723189 (22%)
bufferSize 3145728
fullness 723189
bytes_received 999424
jiffies: 354761312
2006-08-09 20:23:04.4938 output size: 3528000
output fullness: 2677504
elapsed seconds: 9
2006-08-09 20:23:05.5125 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 1081344
fullness: 775016 (24%)
bufferSize 3145728
fullness 775016
bytes_received 1081344
jiffies: 354762312
2006-08-09 20:23:05.5128 output size: 3528000
output fullness: 2947904
elapsed seconds: 10
2006-08-09 20:23:06.4921 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 1159168
fullness: 825255 (26%)
bufferSize 3145728
fullness 825255
bytes_received 1159168
jiffies: 354763312
2006-08-09 20:23:06.4923 output size: 3528000
output fullness: 3225280
elapsed seconds: 11
2006-08-09 20:23:07.5111 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 1241088
fullness: 879589 (27%)
bufferSize 3145728
fullness 879589
bytes_received 1241088
jiffies: 354764312
2006-08-09 20:23:07.5114 output size: 3528000
output fullness: 3499200
elapsed seconds: 12
2006-08-09 20:23:08.5150 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 1318912
fullness: 939859 (29%)
bufferSize 3145728
fullness 939859
bytes_received 1318912
jiffies: 354765312
2006-08-09 20:23:08.5153 output size: 3528000
output fullness: 3514944
elapsed seconds: 13
2006-08-09 20:23:09.5276 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 1396736
fullness: 1002637 (31%)
bufferSize 3145728
fullness 1002637
bytes_received 1396736
jiffies: 354766312
2006-08-09 20:23:09.5279 output size: 3528000
output fullness: 3521600
elapsed seconds: 14
2006-08-09 20:23:10.5074 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 1470464
fullness: 1058810 (33%)
bufferSize 3145728
fullness 1058810
bytes_received 1470464
jiffies: 354767312
2006-08-09 20:23:10.5077 output size: 3528000
output fullness: 3519040
elapsed seconds: 15
2006-08-09 20:23:11.5229 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 1548288
fullness: 1121588 (35%)
bufferSize 3145728
fullness 1121588
bytes_received 1548288
jiffies: 354768312
2006-08-09 20:23:11.5232 output size: 3528000
output fullness: 3516480
elapsed seconds: 16
2006-08-09 20:23:12.5218 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 1626112
fullness: 1181858 (37%)
bufferSize 3145728
fullness 1181858
bytes_received 1626112
jiffies: 354769312
2006-08-09 20:23:12.5221 output size: 3528000
output fullness: 3521856
elapsed seconds: 17
2006-08-09 20:23:13.5310 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 1703936
fullness: 1244635 (39%)
bufferSize 3145728
fullness 1244635
bytes_received 1703936
jiffies: 354770312
2006-08-09 20:23:13.5313 output size: 3528000
output fullness: 3520448
elapsed seconds: 18
2006-08-09 20:23:14.4914 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 1777664
fullness: 1303317 (41%)
bufferSize 3145728
fullness 1303317
bytes_received 1777664
jiffies: 354771312
2006-08-09 20:23:14.4917 output size: 3528000
output fullness: 3517888
elapsed seconds: 19
2006-08-09 20:23:15.5390 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 1855488
fullness: 1363586 (43%)
bufferSize 3145728
fullness 1363586
bytes_received 1855488
jiffies: 354772312
2006-08-09 20:23:15.5393 output size: 3528000
output fullness: 3515264
elapsed seconds: 20
2006-08-09 20:23:16.5130 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 1933312
fullness: 1426364 (45%)
bufferSize 3145728
fullness 1426364
bytes_received 1933312
jiffies: 354773312
2006-08-09 20:23:16.5134 output size: 3528000
output fullness: 3521920
elapsed seconds: 21
2006-08-09 20:23:17.4888 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2007040
fullness: 1485045 (47%)
bufferSize 3145728
fullness 1485045
bytes_received 2007040
jiffies: 354774312
2006-08-09 20:23:17.4891 output size: 3528000
output fullness: 3519232
elapsed seconds: 22
2006-08-09 20:23:18.5257 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2088960
fullness: 1549411 (49%)
bufferSize 3145728
fullness 1549411
bytes_received 2088960
jiffies: 354775312
2006-08-09 20:23:18.5260 output size: 3528000
output fullness: 3516672
elapsed seconds: 23
2006-08-09 20:23:19.5277 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2166784
fullness: 1612188 (51%)
bufferSize 3145728
fullness 1612188
bytes_received 2166784
jiffies: 354776312
2006-08-09 20:23:19.5280 output size: 3528000
output fullness: 3523328
elapsed seconds: 24
2006-08-09 20:23:20.5226 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2244608
fullness: 1672458 (53%)
bufferSize 3145728
fullness 1672458
bytes_received 2244608
jiffies: 354777312
2006-08-09 20:23:20.5229 output size: 3528000
output fullness: 3520640
elapsed seconds: 25
2006-08-09 20:23:21.5277 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2322432
fullness: 1735236 (55%)
bufferSize 3145728
fullness 1735236
bytes_received 2322432
jiffies: 354778312
2006-08-09 20:23:21.5280 output size: 3528000
output fullness: 3518080
elapsed seconds: 26
2006-08-09 20:23:22.5201 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2396160
fullness: 1793917 (57%)
bufferSize 3145728
fullness 1793917
bytes_received 2396160
jiffies: 354779312
2006-08-09 20:23:22.5204 output size: 3528000
output fullness: 3515520
elapsed seconds: 27
2006-08-09 20:23:23.5119 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2469888
fullness: 1850091 (58%)
bufferSize 3145728
fullness 1850091
bytes_received 2469888
jiffies: 354780312
2006-08-09 20:23:23.5122 output size: 3528000
output fullness: 3522048
elapsed seconds: 28
2006-08-09 20:23:24.5425 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2547712
fullness: 1912868 (60%)
bufferSize 3145728
fullness 1912868
bytes_received 2547712
jiffies: 354781312
2006-08-09 20:23:24.5428 output size: 3528000
output fullness: 3519488
elapsed seconds: 29
2006-08-09 20:23:25.5436 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2622900
fullness: 1970502 (62%)
bufferSize 3145728
fullness 1970502
bytes_received 2622900
jiffies: 354782312
2006-08-09 20:23:25.5440 output size: 3528000
output fullness: 3516736
elapsed seconds: 30
2006-08-09 20:23:26.5348 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2699264
fullness: 2031819 (64%)
bufferSize 3145728
fullness 2031819
bytes_received 2699264
jiffies: 354783312
2006-08-09 20:23:26.5351 output size: 3528000
output fullness: 3521216
elapsed seconds: 31
2006-08-09 20:23:27.5121 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2772992
fullness: 2090501 (66%)
bufferSize 3145728
fullness 2090501
bytes_received 2772992
jiffies: 354784312
2006-08-09 20:23:27.5125 output size: 3528000
output fullness: 3520960
elapsed seconds: 32
2006-08-09 20:23:28.5223 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2850816
fullness: 2150771 (68%)
bufferSize 3145728
fullness 2150771
bytes_received 2850816
jiffies: 354785312
2006-08-09 20:23:28.5227 output size: 3528000
output fullness: 3518272
elapsed seconds: 33
2006-08-09 20:23:29.5052 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2924544
fullness: 2209452 (70%)
bufferSize 3145728
fullness 2209452
bytes_received 2924544
jiffies: 354786312
2006-08-09 20:23:29.5056 output size: 3528000
output fullness: 3515712
elapsed seconds: 34
2006-08-09 20:23:30.5094 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 2998272
fullness: 2268133 (72%)
bufferSize 3145728
fullness 2268133
bytes_received 2998272
jiffies: 354787312
2006-08-09 20:23:30.5098 output size: 3528000
output fullness: 3522368
elapsed seconds: 35
2006-08-09 20:23:31.5070 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3076096
fullness: 2328403 (74%)
bufferSize 3145728
fullness 2328403
bytes_received 3076096
jiffies: 354788312
2006-08-09 20:23:31.5074 output size: 3528000
output fullness: 3519808
elapsed seconds: 36
2006-08-09 20:23:32.5260 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3149824
fullness: 2387085 (75%)
bufferSize 3145728
fullness 2387085
bytes_received 3149824
jiffies: 354789312
2006-08-09 20:23:32.5264 output size: 3528000
output fullness: 3517120
elapsed seconds: 37
2006-08-09 20:23:33.4978 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3223552
fullness: 2443258 (77%)
bufferSize 3145728
fullness 2443258
bytes_received 3223552
jiffies: 354790312
2006-08-09 20:23:33.4981 output size: 3528000
output fullness: 3514560
elapsed seconds: 38
2006-08-09 20:23:34.4980 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3297280
fullness: 2501940 (79%)
bufferSize 3145728
fullness 2501940
bytes_received 3297280
jiffies: 354791312
2006-08-09 20:23:34.4984 output size: 3528000
output fullness: 3521216
elapsed seconds: 39
2006-08-09 20:23:34.5915 Read to end of file or pipe
2006-08-09 20:23:34.5920 end of file or error on socket, opening next song, (song pos: 3309818(tell says: . ), totalbytes: 0)
2006-08-09 20:23:34.5923 opening next song...
2006-08-09 20:23:34.5928 the next song is number 1, was 0
2006-08-09 20:23:34.5939 Setting maxBitRate for squeezhome to: 0
2006-08-09 20:23:34.5951 Setting maxBitRate for squeezhome to: 0
2006-08-09 20:23:34.5954 undermax = 1, type = mov, squeezebox2 = 00:04:20:06:7f:7f
2006-08-09 20:23:34.5957 checking formats for: mov-wma-squeezebox2-00:04:20:06:7f:7f
2006-08-09 20:23:34.5960 checking formats for: mov-wma-*-00:04:20:06:7f:7f
2006-08-09 20:23:34.5963 checking formats for: mov-wma-squeezebox2-*
2006-08-09 20:23:34.5965 checking formats for: mov-wma-*-*
2006-08-09 20:23:34.5968 checking formats for: mov-ogg-squeezebox2-00:04:20:06:7f:7f
2006-08-09 20:23:34.5970 checking formats for: mov-ogg-*-00:04:20:06:7f:7f
2006-08-09 20:23:34.5973 checking formats for: mov-ogg-squeezebox2-*
2006-08-09 20:23:34.5975 checking formats for: mov-ogg-*-*
2006-08-09 20:23:34.5977 checking formats for: mov-flc-squeezebox2-00:04:20:06:7f:7f
2006-08-09 20:23:34.5980 checking formats for: mov-flc-*-00:04:20:06:7f:7f
2006-08-09 20:23:34.5982 checking formats for: mov-flc-squeezebox2-*
2006-08-09 20:23:34.5984 checking formats for: mov-flc-*-*
2006-08-09 20:23:34.5987 Checking to see if mov-flc-*-* is enabled
2006-08-09 20:23:34.5990 There are 1 disabled formats...
2006-08-09 20:23:34.5992 Testing rtsp-wav-*-* vs mov-flc-*-*
2006-08-09 20:23:34.5995 Testing rtsp-flc-*-* vs mov-flc-*-*
2006-08-09 20:23:34.5997 enabled
2006-08-09 20:23:34.5999 Found command: [mov123] $FILE$ | [flac] -cs --totally-silent --compression-level-0 --endian big --sign signed --channels 2 --bps 16 --sample-rate 44100 -
2006-08-09 20:23:34.6015 drat, missing binary mov123
2006-08-09 20:23:34.6018 checking formats for: mov-aif-squeezebox2-00:04:20:06:7f:7f
2006-08-09 20:23:34.6021 checking formats for: mov-aif-*-00:04:20:06:7f:7f
2006-08-09 20:23:34.6025 checking formats for: mov-aif-squeezebox2-*
2006-08-09 20:23:34.6027 checking formats for: mov-aif-*-*
2006-08-09 20:23:34.6030 Checking to see if mov-aif-*-* is enabled
2006-08-09 20:23:34.6033 There are 1 disabled formats...
2006-08-09 20:23:34.6035 Testing rtsp-wav-*-* vs mov-aif-*-*
2006-08-09 20:23:34.6038 Testing rtsp-flc-*-* vs mov-aif-*-*
2006-08-09 20:23:34.6040 enabled
2006-08-09 20:23:34.6042 Found command: [mov123] $FILE$
2006-08-09 20:23:34.6054 drat, missing binary mov123
2006-08-09 20:23:34.6057 checking formats for: mov-wav-squeezebox2-00:04:20:06:7f:7f
2006-08-09 20:23:34.6060 checking formats for: mov-wav-*-00:04:20:06:7f:7f
2006-08-09 20:23:34.6063 checking formats for: mov-wav-squeezebox2-*
2006-08-09 20:23:34.6066 checking formats for: mov-wav-*-*
2006-08-09 20:23:34.6069 checking formats for: mov-mp3-squeezebox2-00:04:20:06:7f:7f
2006-08-09 20:23:34.6072 checking formats for: mov-mp3-*-00:04:20:06:7f:7f
2006-08-09 20:23:34.6074 checking formats for: mov-mp3-squeezebox2-*
2006-08-09 20:23:34.6077 checking formats for: mov-mp3-*-*
2006-08-09 20:23:34.6079 Checking to see if mov-mp3-*-* is enabled
2006-08-09 20:23:34.6082 There are 1 disabled formats...
2006-08-09 20:23:34.6084 Testing rtsp-wav-*-* vs mov-mp3-*-*
2006-08-09 20:23:34.6087 Testing rtsp-flc-*-* vs mov-mp3-*-*
2006-08-09 20:23:34.6089 enabled
2006-08-09 20:23:34.6091 Found command: [mplayer] -novideo -nortc -vc dummy -vo null -cache 128 -af volume=0,resample=44100:0:1,channels=2 -ao pcm:file=/dev/fd/4 $FILE$ 4>&1 1>&2 1>/dev/null | [lame] --silent -q $QUALITY$ -b $BITRATE$ -
2006-08-09 20:23:34.6095 Setting maxBitRate for squeezhome to: 0
2006-08-09 20:23:34.6099 Setting maxBitRate for squeezhome to: 0
2006-08-09 20:23:34.6102 Matched Format: mp3 Type: mov Command: [mplayer] -novideo -nortc -vc dummy -vo null -cache 128 -af volume=0,resample=44100:0:1,channels=2 -ao pcm:file=/dev/fd/4 $FILE$ 4>&1 1>&2 1>/dev/null | [lame] --silent -q $QUALITY$ -b $BITRATE$ -
2006-08-09 20:23:34.6108 playing out before starting next song. (old format: mp3, new: mp3)
2006-08-09 20:23:34.6111 00:04:20:06:7f:7f: Switching to mode playout-play from play
2006-08-09 20:23:34.6118 00:04:20:06:7f:7f New play mode: playout-play
2006-08-09 20:23:34.6125 *************stream called: u paused: format: url:
2006-08-09 20:23:34.6130 Backtrace:
frame 0: Slim::Player::Squeezebox::stream (/usr/local/slimserver/Slim/Player/Squeezebox.pm line 179)
frame 1: Slim::Player::Squeezebox::resume (/usr/local/slimserver/Slim/Player/Source.pm line 443)
frame 2: Slim::Player::Source::playmode (/usr/local/slimserver/Slim/Player/Source.pm line 930)
frame 3: Slim::Player::Source::gotoNext (/usr/local/slimserver/Slim/Player/Source.pm line 1789)
frame 4: Slim::Player::Source::readNextChunk (/usr/local/slimserver/Slim/Player/Source.pm line 661)
frame 5: Slim::Player::Source::nextChunk (/usr/local/slimserver/Slim/Web/HTTP.pm line 1672)
frame 6: Slim::Web::HTTP::sendStreamingResponse (/usr/local/slimserver/Slim/Networking/Select.pm line 170)
frame 7: Slim::Networking::Select::select (/usr/local/slimserver/slimserver.pl line 493)
frame 8: main::idle (/usr/local/slimserver/slimserver.pl line 446)
frame 9: main::main (/usr/local/slimserver/slimserver.pl line 1043)
2006-08-09 20:23:34.6134 starting with decoder with format: m autostart: 1 threshold: 255 samplesize: ? samplerate: ? endian: ? channels: ?
2006-08-09 20:23:34.6137 flags: 0
2006-08-09 20:23:34.6140 sending strm frame of length: 24 request string:
2006-08-09 20:23:34.6150 00:04:20:06:7f:7f: Current playmode: playout-play
2006-08-09 20:23:34.6154 No pending chunks - we're dropping the streaming connection
2006-08-09 20:23:34.6165 00:04:20:06:7f:7f: Can't opennext, returning no chunk.
2006-08-09 20:23:34.6183 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMr
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2511970 (79%)
bufferSize 3145728
fullness 2511970
bytes_received 3309818
jiffies: 354791437
2006-08-09 20:23:34.6188 output size: 3528000
output fullness: 3521984
elapsed seconds: 39
2006-08-09 20:23:34.6198 00:04:20:06:7f:7f Squeezebox stream status:
event_code: strm
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2511970 (79%)
bufferSize 3145728
fullness 2511970
bytes_received 3309818
jiffies: 354791437
2006-08-09 20:23:34.6201 output size: 3528000
output fullness: 3522880
elapsed seconds: 39
2006-08-09 20:23:34.6208 Squeezebox got disconnection on the data channel why: Connection closed normally
2006-08-09 20:23:35.4916 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2499431 (79%)
bufferSize 3145728
fullness 2499431
bytes_received 3309818
jiffies: 354792312
2006-08-09 20:23:35.4920 output size: 3528000
output fullness: 3518592
elapsed seconds: 40
2006-08-09 20:23:36.4922 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2481877 (78%)
bufferSize 3145728
fullness 2481877
bytes_received 3309818
jiffies: 354793312
2006-08-09 20:23:36.4926 output size: 3528000
output fullness: 3516032
elapsed seconds: 41
2006-08-09 20:23:37.4919 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2466831 (78%)
bufferSize 3145728
fullness 2466831
bytes_received 3309818
jiffies: 354794312
2006-08-09 20:23:37.4922 output size: 3528000
output fullness: 3522560
elapsed seconds: 42
2006-08-09 20:23:38.4925 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2451784 (77%)
bufferSize 3145728
fullness 2451784
bytes_received 3309818
jiffies: 354795312
2006-08-09 20:23:38.4928 output size: 3528000
output fullness: 3520000
elapsed seconds: 43
2006-08-09 20:23:39.4923 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2434230 (77%)
bufferSize 3145728
fullness 2434230
bytes_received 3309818
jiffies: 354796312
2006-08-09 20:23:39.4927 output size: 3528000
output fullness: 3517440
elapsed seconds: 44
2006-08-09 20:23:40.4924 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2419183 (76%)
bufferSize 3145728
fullness 2419183
bytes_received 3309818
jiffies: 354797312
2006-08-09 20:23:40.4928 output size: 3528000
output fullness: 3514752
elapsed seconds: 45
2006-08-09 20:23:41.4926 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2401629 (76%)
bufferSize 3145728
fullness 2401629
bytes_received 3309818
jiffies: 354798312
2006-08-09 20:23:41.4929 output size: 3528000
output fullness: 3521408
elapsed seconds: 46
2006-08-09 20:23:42.4928 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2386582 (75%)
bufferSize 3145728
fullness 2386582
bytes_received 3309818
jiffies: 354799312
2006-08-09 20:23:42.4931 output size: 3528000
output fullness: 3518848
elapsed seconds: 47
2006-08-09 20:23:43.4929 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2371536 (75%)
bufferSize 3145728
fullness 2371536
bytes_received 3309818
jiffies: 354800312
2006-08-09 20:23:43.4933 output size: 3528000
output fullness: 3516160
elapsed seconds: 48
2006-08-09 20:23:44.4931 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2353982 (74%)
bufferSize 3145728
fullness 2353982
bytes_received 3309818
jiffies: 354801312
2006-08-09 20:23:44.4934 output size: 3528000
output fullness: 3522816
elapsed seconds: 49
2006-08-09 20:23:45.4936 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2338935 (74%)
bufferSize 3145728
fullness 2338935
bytes_received 3309818
jiffies: 354802312
2006-08-09 20:23:45.4940 output size: 3528000
output fullness: 3520192
elapsed seconds: 50
2006-08-09 20:23:46.4935 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2321381 (73%)
bufferSize 3145728
fullness 2321381
bytes_received 3309818
jiffies: 354803312
2006-08-09 20:23:46.4939 output size: 3528000
output fullness: 3517632
elapsed seconds: 51
2006-08-09 20:23:47.4936 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2306334 (73%)
bufferSize 3145728
fullness 2306334
bytes_received 3309818
jiffies: 354804312
2006-08-09 20:23:47.4940 output size: 3528000
output fullness: 3515072
elapsed seconds: 52
2006-08-09 20:23:48.4938 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2291288 (72%)
bufferSize 3145728
fullness 2291288
bytes_received 3309818
jiffies: 354805312
2006-08-09 20:23:48.4941 output size: 3528000
output fullness: 3521600
elapsed seconds: 53
2006-08-09 20:23:49.4942 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2273733 (72%)
bufferSize 3145728
fullness 2273733
bytes_received 3309818
jiffies: 354806312
2006-08-09 20:23:49.4946 output size: 3528000
output fullness: 3519040
elapsed seconds: 54
2006-08-09 20:23:50.4941 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2258687 (71%)
bufferSize 3145728
fullness 2258687
bytes_received 3309818
jiffies: 354807312
2006-08-09 20:23:50.4945 output size: 3528000
output fullness: 3516480
elapsed seconds: 55
2006-08-09 20:23:51.4946 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2243640 (71%)
bufferSize 3145728
fullness 2243640
bytes_received 3309818
jiffies: 354808312
2006-08-09 20:23:51.4949 output size: 3528000
output fullness: 3523008
elapsed seconds: 56
2006-08-09 20:23:52.4944 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2226086 (70%)
bufferSize 3145728
fullness 2226086
bytes_received 3309818
jiffies: 354809312
2006-08-09 20:23:52.4948 output size: 3528000
output fullness: 3520448
elapsed seconds: 57
2006-08-09 20:23:53.4947 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2211039 (70%)
bufferSize 3145728
fullness 2211039
bytes_received 3309818
jiffies: 354810312
2006-08-09 20:23:53.4950 output size: 3528000
output fullness: 3517888
elapsed seconds: 58
2006-08-09 20:23:54.4951 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2193485 (69%)
bufferSize 3145728
fullness 2193485
bytes_received 3309818
jiffies: 354811312
2006-08-09 20:23:54.4954 output size: 3528000
output fullness: 3515200
elapsed seconds: 59
2006-08-09 20:23:55.4951 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMt
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2178439 (69%)
bufferSize 3145728
fullness 2178439
bytes_received 3309818
jiffies: 354812312
2006-08-09 20:23:55.4955 output size: 3528000
output fullness: 3521920
elapsed seconds: 60
2006-08-09 20:23:55.5385 00:04:20:06:7f:7f: Switching to mode pause from playout-play
2006-08-09 20:23:55.5393 00:04:20:06:7f:7f New play mode: pause
2006-08-09 20:23:55.5410 00:04:20:06:7f:7f: Current playmode: pause
2006-08-09 20:23:55.5509 00:04:20:06:7f:7f Squeezebox stream status:
event_code: audg
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2178439 (69%)
bufferSize 3145728
fullness 2178439
bytes_received 3309818
jiffies: 354812360
2006-08-09 20:23:55.5514 output size: 3528000
output fullness: 3517568
elapsed seconds: 60
2006-08-09 20:23:55.5946 00:04:20:06:7f:7f Squeezebox stream status:
event_code: audg
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2175931 (69%)
bufferSize 3145728
fullness 2175931
bytes_received 3309818
jiffies: 354812411
2006-08-09 20:23:55.5949 output size: 3528000
output fullness: 3515520
elapsed seconds: 60
2006-08-09 20:23:55.6468 00:04:20:06:7f:7f Squeezebox stream status:
event_code: audg
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2175931 (69%)
bufferSize 3145728
fullness 2175931
bytes_received 3309818
jiffies: 354812464
2006-08-09 20:23:55.6471 output size: 3528000
output fullness: 3520128
elapsed seconds: 60
2006-08-09 20:23:55.6997 00:04:20:06:7f:7f Squeezebox stream status:
event_code: audg
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2175931 (69%)
bufferSize 3145728
fullness 2175931
bytes_received 3309818
jiffies: 354812516
2006-08-09 20:23:55.7001 output size: 3528000
output fullness: 3520000
elapsed seconds: 60
2006-08-09 20:23:55.7506 00:04:20:06:7f:7f Squeezebox stream status:
event_code: audg
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2173423 (69%)
bufferSize 3145728
fullness 2173423
bytes_received 3309818
jiffies: 354812567
2006-08-09 20:23:55.7510 output size: 3528000
output fullness: 3514624
elapsed seconds: 60
2006-08-09 20:23:55.8007 *************stream called: p paused: format: url:
2006-08-09 20:23:55.8012 Backtrace:
frame 0: Slim::Player::Squeezebox::stream (/usr/local/slimserver/Slim/Player/Squeezebox.pm line 192)
frame 1: Slim::Player::Squeezebox::pause (/usr/local/slimserver/Slim/Player/Source.pm line 1836)
frame 2: Slim::Player::Source::pauseSynced (/usr/local/slimserver/Slim/Player/Player.pm line 465)
frame 3: Slim::Player::Player::fade_volume (/usr/local/slimserver/Slim/Utils/Timers.pm line 171)
frame 4: Slim::Utils::Timers::checkTimers (/usr/local/slimserver/slimserver.pl line 496)
frame 5: main::idle (/usr/local/slimserver/slimserver.pl line 446)
frame 6: main::main (/usr/local/slimserver/slimserver.pl line 1043)
2006-08-09 20:23:55.8016 starting with decoder with format: m autostart: 0 threshold: 255 samplesize: ? samplerate: ? endian: ? channels: ?
2006-08-09 20:23:55.8019 flags: 0
2006-08-09 20:23:55.8023 sending strm frame of length: 24 request string:
2006-08-09 20:23:55.8072 00:04:20:06:7f:7f Squeezebox stream status:
event_code: audg
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2173423 (69%)
bufferSize 3145728
fullness 2173423
bytes_received 3309818
jiffies: 354812624
2006-08-09 20:23:55.8076 output size: 3528000
output fullness: 3522432
elapsed seconds: 60
2006-08-09 20:23:55.8087 00:04:20:06:7f:7f Squeezebox stream status:
event_code: STMp
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2173423 (69%)
bufferSize 3145728
fullness 2173423
bytes_received 3309818
jiffies: 354812625
2006-08-09 20:23:55.8091 output size: 3528000
output fullness: 3522048
elapsed seconds: 60
2006-08-09 20:23:55.8101 00:04:20:06:7f:7f Squeezebox stream status:
event_code: strm
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2173423 (69%)
bufferSize 3145728
fullness 2173423
bytes_received 3309818
jiffies: 354812626
2006-08-09 20:23:55.8105 output size: 3528000
output fullness: 3521792
elapsed seconds: 60
2006-08-09 20:23:55.8115 00:04:20:06:7f:7f Squeezebox stream status:
event_code: audg
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2173423 (69%)
bufferSize 3145728
fullness 2173423
bytes_received 3309818
jiffies: 354812627
2006-08-09 20:23:55.8120 output size: 3528000
output fullness: 3521408
elapsed seconds: 60
2006-08-09 20:23:59.0027 00:04:20:06:7f:7f Squeezebox stream status:
event_code: stat
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2173423 (69%)
bufferSize 3145728
fullness 2173423
bytes_received 3309818
jiffies: 354815819
2006-08-09 20:23:59.0031 output size: 3528000
output fullness: 3521408
elapsed seconds: 60
2006-08-09 20:23:59.6724 00:04:20:06:7f:7f Squeezebox stream status:
event_code: aude
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2173423 (69%)
bufferSize 3145728
fullness 2173423
bytes_received 3309818
jiffies: 354816486
2006-08-09 20:23:59.6728 output size: 3528000
output fullness: 3521408
elapsed seconds: 60
2006-08-09 20:24:04.0037 00:04:20:06:7f:7f Squeezebox stream status:
event_code: stat
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2173423 (69%)
bufferSize 3145728
fullness 2173423
bytes_received 3309818
jiffies: 354820818
2006-08-09 20:24:04.0042 output size: 3528000
output fullness: 3521408
elapsed seconds: 60
2006-08-09 20:24:09.0040 00:04:20:06:7f:7f Squeezebox stream status:
event_code: stat
bytes_rec_H 0
bytes_rec_L 3309818
fullness: 2173423 (69%)
bufferSize 3145728
fullness 2173423
bytes_received 3309818
jiffies: 354825817
2006-08-09 20:24:09.0044 output size: 3528000
output fullness: 3521408
elapsed seconds: 60
060809 20:24:11 [Note] /usr/local/slimserver/Bin/i386-linux/mysqld: Normal shutdown
060809 20:24:11 InnoDB: Starting shutdown...
060809 20:24:13 InnoDB: Shutdown completed; log sequence number 0 15717565
060809 20:24:13 [Note] /usr/local/slimserver/Bin/i386-linux/mysqld: Shutdown complete