Mailing List archive

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

[vdr] Re: Was: BUG? in mplayer plugin 0.9.7 - Now: BUG: mp3-plugin0.9.8 - Backroundscan runs into endless loop and watchdog restarts VDR



Stefan Huelswitt schrieb:

>On 22 Oct 2004 Tomahawk <Tomahawk@tvcs.de> wrote:
>
>  
>
>>On changing to the added stream by using cursors or digits, it gets 
>>played, until sometime the daemon kicks in,
>>the only visible sign are the permanently written lines
>>
>>mgr: background scan idle
>>mgr: background scan idle wakeup
>>
>>when playing the first stream these lines only appear a few times. The 
>>second time they keep repeating, with some chatter in between i can't 
>>read that fast.
>>    
>>
>
>I can't reproduce this problem (at least not with 0.9.8).
>Is this still a problem there?
>
>Regards.
>
>  
>
Hi Stefan,

the problem is still there with 0.9.8 here.
Not only with streams but also with my mp3s on local drive.
When in the setup the id3 scan is completaly deactivated it works fine.
I upgraded from version 0.9.3, there the id3 scan in backround did work.

How do I produce the (miss)behavior:

I start playing a whole dir by hitting the red button. A playlist is
generated with all the tracks from that dir and subdirs. Doubleklicking
the OK shows the playlist to me. Often only a very few (2-5) tracks a
listed with as id3-tag-string. The rest in the list is shown as
trackname. Test with OK-Button shows me VDR is still "living". Then
hitting UP starts playing the next track and the described error
appears. VDR does not react on pressing keys anymore until the watchdog
(60sec) restarts VDR. Here is the log from stdout:

Starting Digital Videorecorder:
mp3: using MPEG Audio Decoder 0.15.1 (beta)
mp3: compiled with 0.15.1 (beta)
status: volume=255 mute=0
instant: dir e-PUNK's chill
mgr: background scan thread started (pid=6835)
mgr: next -> 0
mgr: scanning (id3) 01_soft_-_slow_beat/01 - Florian Snyder - Alice In
Fashionland.mp3
mgr: scanning (id3) 01_soft_-_slow_beat/02 - Björk - Joga
(SothicBlueMixPt2).mp3
mgr: scanning (id3) 01_soft_-_slow_beat/03 - Isan - phoeb.mp3
mgr: scanning (id3) 01_soft_-_slow_beat/04 - Ulrich Schnaus - Gone
Forever.mp3
mgr: scanning (id3) 01_soft_-_slow_beat/05 - Gescom - Sciew Spoc.mp3
mgr: scanning (id3) 01_soft_-_slow_beat/06 - Nitin Sawhney - Serpents.mp3
mp3: player active true requested...
norm: lim_lev=0,700000 lim_acc=12
norm: table size=13518 start=0b330000 jump=00010000
norm: accuracy 0,000000022352
mp3: play
mp3: player active true done
mp3-oss: using OSS output
mp3: heartbeat buffer=0 now=734
mp3: starting play
mgr: bgr-scan -> throttle (20141)
mgr: playing 01_soft_-_slow_beat/01 - Florian Snyder - Alice In
Fashionland.mp3
mp3: isStream=0 levelgood=1 haslevel=0
mgr: background scan throttled
mad: decode hdr error, frame=0 count=1: lost synchronization
mp3: new input sample rate 44100
oss: DSP samplerate now 44100
mp3-oss: DSP reset done
mp3: heartbeat buffer=0 now=735
mp3: heartbeat buffer=0 now=736
mp3: heartbeat buffer=0 now=737
mp3: heartbeat buffer=0 now=738
mp3: heartbeat buffer=0 now=739
mp3: heartbeat buffer=0 now=740
mp3: heartbeat buffer=0 now=741
mp3: heartbeat buffer=0 now=742
mp3: heartbeat buffer=0 now=743
mp3: heartbeat buffer=0 now=744
mp3: heartbeat buffer=0 now=745
mp3: heartbeat buffer=0 now=746
mp3: heartbeat buffer=0 now=747
mp3: heartbeat buffer=0 now=748
mp3: heartbeat buffer=0 now=749
mp3: heartbeat buffer=0 now=750
mgr: next -> 1
mp3: stale song change, restart.
mp3: stopping play
mp3: scale stats clipped=0 peak_clip=0,000000 peak=0,365144
mp3: starting play
mgr: playing 01_soft_-_slow_beat/02 - Björk - Joga (SothicBlueMixPt2).mp3
mp3: isStream=0 levelgood=1 haslevel=0
mad: decode hdr error, frame=0 count=1: lost synchronization
mgr: background scan throttle wakeup
mgr: background scan throttled
mgr: background scan throttle wakeup
mgr: background scan throttled
mgr: background scan throttle wakeup
mgr: background scan throttled
mgr: background scan throttle wakeup
mgr: background scan throttled
mgr: background scan throttle wakeup
mgr: background scan throttled
mgr: background scan throttle wakeup
mgr: background scan throttled
mgr: background scan throttle wakeup
mgr: background scan throttled
mgr: background scan throttle wakeup
mgr: background scan throttled
...


The next time I do the same procedure when VDR is restarted the
id3-cache-file is used to show me some more tracks as id3-string in the
playlist. Mostly the id3-cache got 2 or 3 tracks added.

When doing the procedure without jumping to another track, but just
start playing the dir, wait some time and hitting stop VDR keeps
"living" and this can be repeated several times. The cache-file gets now
bigger and bigger cause a few tracks are added each time one start
playing the dir. The log for on run looks as follows:

Starting Digital Videorecorder:
mp3: using MPEG Audio Decoder 0.15.1 (beta)
mp3: compiled with 0.15.1 (beta)
status: volume=255 mute=0
instant: dir e-PUNK's chill
mgr: background scan thread started (pid=4588)
mgr: next -> 0
mgr: scanning (id3) 01_soft_-_slow_beat/01 - Florian Snyder - Alice In
Fashionland.mp3
mgr: scanning (id3) 01_soft_-_slow_beat/02 - Björk - Joga
(SothicBlueMixPt2).mp3
mgr: scanning (id3) 01_soft_-_slow_beat/03 - Isan - phoeb.mp3
mgr: scanning (id3) 01_soft_-_slow_beat/04 - Ulrich Schnaus - Gone
Forever.mp3
mgr: scanning (id3) 01_soft_-_slow_beat/05 - Gescom - Sciew Spoc.mp3
mgr: scanning (id3) 01_soft_-_slow_beat/06 - Nitin Sawhney - Serpents.mp3
mgr: scanning (id3) 01_soft_-_slow_beat/07 - Bola - Forcasa 3.mp3
mgr: scanning (id3) 01_soft_-_slow_beat/08 - Coldcut - Panopticon
(Irresistable Force Mix).mp3
mgr: scanning (id3) 01_soft_-_slow_beat/09 - Björk - All is full of love
(Plaid mix).mp3
mad: initialy found id3 tag at EOF
mad: id3-scan, decode header error (frame 0): lost synchronization
mad: id3-scan, decode header error (frame 8715): lost synchronization
mad: scanned 8715 frames
mad: vbr detected
cache: caching infos for /video/media/Mukke/lokal/-- my --/[va]/e-PUNK's
chill/01_soft_-_slow_beat/09 - Björk - All is full of love (Plaid mix).mp3
mgr: scanning (id3) 01_soft_-_slow_beat/10 - Lamb - Small.mp3
mad: initialy found id3 tag at EOF
mad: id3-scan, decode header error (frame 0): lost synchronization
mad: id3-scan, decode header error (frame 11106): lost synchronization
mad: scanned 11106 frames
mad: vbr detected
cache: caching infos for /video/media/Mukke/lokal/-- my --/[va]/e-PUNK's
chill/01_soft_-_slow_beat/10 - Lamb - Small.mp3
mgr: scanning (id3) 01_soft_-_slow_beat/11 - Autechre - Basscadet
(seefeelmx).mp3
mad: initialy found id3 tag at EOF
mad: id3-scan, decode header error (frame 0): lost synchronization
mad: id3-scan, decode header error (frame 14297): lost synchronization
mad: scanned 14297 frames
mad: vbr detected
cache: caching infos for /video/media/Mukke/lokal/-- my --/[va]/e-PUNK's
chill/01_soft_-_slow_beat/11 - Autechre - Basscadet (seefeelmx).mp3
mgr: scanning (id3) 01_soft_-_slow_beat/12 - Die Fantastischen Vier -
Krieger.mp3
mad: initialy found id3 tag at EOF
mad: id3-scan, decode header error (frame 0): lost synchronization
mad: id3-scan, decode header error (frame 14411): lost synchronization
mad: scanned 14411 frames
mad: vbr detected
cache: caching infos for /video/media/Mukke/lokal/-- my --/[va]/e-PUNK's
chill/01_soft_-_slow_beat/12 - Die Fantastischen Vier - Krieger.mp3
mgr: scanning (id3) 01_soft_-_slow_beat/13 - Indian Ropeman - 66 Meters
(Feat. Shahin Badar).mp3
mp3: player active true requested...
norm: lim_lev=0,700000 lim_acc=12
norm: table size=13518 start=0b330000 jump=00010000
norm: accuracy 0,000000022352
mp3: play
mp3: player active true done
mp3-oss: using OSS output
mp3: heartbeat buffer=0 now=3332
mp3: starting play
mgr: bgr-scan -> throttle (51322)
mgr: playing 01_soft_-_slow_beat/01 - Florian Snyder - Alice In
Fashionland.mp3
mp3: isStream=0 levelgood=1 haslevel=0
mad: decode hdr error, frame=0 count=1: lost synchronization
mp3: new input sample rate 44100
oss: DSP samplerate now 44100
mp3-oss: DSP reset done
mad: initialy found id3 tag at EOF
mad: id3-scan, decode header error (frame 0): lost synchronization
mad: id3-scan, decode header error (frame 19065): lost synchronization
mad: scanned 19065 frames
mad: vbr detected
cache: caching infos for /video/media/Mukke/lokal/-- my --/[va]/e-PUNK's
chill/01_soft_-_slow_beat/13 - Indian Ropeman - 66 Meters (Feat. Shahin
Badar).mp3
mgr: background scan throttled
mp3: heartbeat buffer=0 now=3333
mp3: heartbeat buffer=0 now=3334
mp3: heartbeat buffer=0 now=3335
mp3: heartbeat buffer=0 now=3336
mp3: heartbeat buffer=0 now=3337
mp3: heartbeat buffer=0 now=3338
mp3: heartbeat buffer=0 now=3339
mp3: heartbeat buffer=0 now=3340
mp3: heartbeat buffer=0 now=3341
mp3: heartbeat buffer=0 now=3342
mp3: heartbeat buffer=0 now=3343
mp3: heartbeat buffer=0 now=3344
mp3: heartbeat buffer=0 now=3345
mp3: heartbeat buffer=0 now=3346
mp3: heartbeat buffer=0 now=3347
mp3: heartbeat buffer=0 now=3348
mp3: heartbeat buffer=0 now=3349
mp3: heartbeat buffer=0 now=3350
mp3: heartbeat buffer=0 now=3351
mp3: heartbeat buffer=0 now=3352
mp3: heartbeat buffer=0 now=3353
mp3: heartbeat buffer=0 now=3354
mp3: player active false requested...
mp3: stopping play
mp3: scale stats clipped=0 peak_clip=0,000000 peak=0,365144
mgr: bgr-scan -> run (73044)
mgr: background scan throttle wakeup
mgr: scanning (id3) 01_soft_-_slow_beat/14 - Plaid - Bo Bootch.mp3
mad: initialy found id3 tag at EOF
mad: id3-scan, decode header error (frame 0): lost synchronization
mad: id3-scan, decode header error (frame 9408): lost synchronization
mad: scanned 9408 frames
mad: vbr detected
cache: caching infos for /video/media/Mukke/lokal/-- my --/[va]/e-PUNK's
chill/01_soft_-_slow_beat/14 - Plaid - Bo Bootch.mp3
mgr: scanning (id3) 01_soft_-_slow_beat/15 - Tosca - Suzuki (Burnt
Friedmannonplace Dub).mp3
mad: initialy found id3 tag at EOF
mad: id3-scan, decode header error (frame 0): lost synchronization
mad: id3-scan, decode header error (frame 11719): lost synchronization
mad: scanned 11719 frames
mad: vbr detected
cache: caching infos for /video/media/Mukke/lokal/-- my --/[va]/e-PUNK's
chill/01_soft_-_slow_beat/15 - Tosca - Suzuki (Burnt Friedmannonplace
Dub).mp3
mgr: scanning (id3) 01_soft_-_slow_beat/16 - Autechre - Rsdio.mp3
mad: initialy found id3 tag at EOF
mad: id3-scan, decode header error (frame 0): lost synchronization
mp3: player active false done
mgr: waiting for bgr release ... (pass2=0 nono=(nil) scan=0x83e9eb8)
mad: id3-scan, decode header error (frame 17990): lost synchronization
mad: scanned 17990 frames
mad: vbr detected
cache: caching infos for /video/media/Mukke/lokal/-- my --/[va]/e-PUNK's
chill/01_soft_-_slow_beat/16 - Autechre - Rsdio.mp3
mgr: background scan idle
cache: saved cache to file
mgr: background scan idle wakeup
mgr: background scan thread ended (pid=4588)

If I wait till the first track is over and the plugin starts playing the
2nd track in the list, the behavior is like one would have hit UP to
start the next track. VDR does not react anymore as described in the
first example.


What can I say to help fixing this important bug:
I have 2 ideas what this prob may be related to.
1. Some libaries like mad on my system used by mp3-plugin did not have
the right version.
   But why did it work with 0.9.3 than?
2. My mp3s have special format and this causes the problem.
   So I want to mention that the folder I use to test the bug contains
mp3s that are
   generated from lame with "vbr-new" and "nogap-feature".
   The tags id3v1 and v2 are manipulated with a
   windows tool called mp3tag v.2.15 (http://www.mp3tag.de)

So hopfully this helps you reproducing and eleminating the bug.

Regards
Marten

-- 
Hi! I'm a signature virus, copy me in your ~/.signature to help me spread.

Attachment: signature.asc
Description: OpenPGP digital signature


Home | Main Index | Thread Index