yaVDR 0.5 headless / ARD & ZDF HD Aufnahmen / ERROR: 1 ring buffer overflow

Alex Maier · 23. Dezember 2013

Hallo,

ich habe ein Problem mit meinem yaVDR-0.5 Server. Die Kiste läuft im Headless-Mode und bedient per Streamdev zwei Clients.

Wenn ich in ARD-HD oder ZDF-HD was aufnehmen möchte, dann hab ich nach ein paar Sekunden Aufnahme nur noch Artefakte in den Aufnahmen.
Das Syslog zeigt folgendes dabei:

Zitat

Dec 22 20:34:26 VDR-Server vdr: [8282] i/o throttle activated, count = 1 (tid=8282)
Dec 22 20:34:32 VDR-Server vdr: [8282] buffer usage: 70% (tid=8874)
Dec 22 20:34:33 VDR-Server vdr: [8282] buffer usage: 60% (tid=8874)
Dec 22 20:34:33 VDR-Server vdr: [8282] buffer usage: 70% (tid=8874)
Dec 22 20:34:36 VDR-Server vdr: [8282] buffer usage: 80% (tid=8874)
Dec 22 20:34:39 VDR-Server vdr: [8282] buffer usage: 90% (tid=8874)
Dec 22 20:34:44 VDR-Server vdr: [8282] buffer usage: 100% (tid=8874)
Dec 22 20:34:44 VDR-Server vdr: [8282] ERROR: 1 ring buffer overflow (1 bytes dropped)
Dec 22 20:34:50 VDR-Server vdr: [8282] ERROR: 17950 ring buffer overflows (3374600 bytes dropped)
Dec 22 20:34:56 VDR-Server vdr: [8282] ERROR: 22877 ring buffer overflows (4300876 bytes dropped)
Dec 22 20:35:02 VDR-Server vdr: [8282] ERROR: 19806 ring buffer overflows (3723528 bytes dropped)
Dec 22 20:35:08 VDR-Server vdr: [8282] ERROR: 31896 ring buffer overflows (5996448 bytes dropped)
Dec 22 20:35:10 VDR-Server vdr: [8874] ERROR: skipped 187 bytes to sync on start of TS packet
Dec 22 20:35:14 VDR-Server vdr: [8282] ERROR: 24222 ring buffer overflows (4553549 bytes dropped)
Dec 22 20:35:20 VDR-Server vdr: [8282] ERROR: 16724 ring buffer overflows (3144112 bytes dropped)
Dec 22 20:35:26 VDR-Server vdr: [8282] ERROR: 26856 ring buffer overflows (5048928 bytes dropped)
Dec 22 20:35:32 VDR-Server vdr: [8282] ERROR: 25359 ring buffer overflows (4767492 bytes dropped)
Dec 22 20:35:36 VDR-Server vdr: [8874] ERROR: skipped 187 bytes to sync on start of TS packet
...

Alles anzeigen

Aufnahmen auf den anderen Kanälen funktionieren problemlos (auch HD).

Was kann das sein?

Alex Maier · 30. Dezember 2013

Update:

nach stundenlangem suchen & testen bin ich zu fogendem Zwischenergebnis gekommen:

Das Problem besteht zu 100% bei Aufnahmen von ARD-HD & ZDF-HD, d.h hier passiert es ständig!
Bei anderen Kanälen passiert es zwar manchmal auch, aber nur sehr, sehr selten und dann auch nur kurzzeitig und nicht permanent wie bei ARD & ZDF.

Was ich vergssen hatte zu erwähnen, ich nehme direkt auf ein NAS auf!
Dazu habe ich am headless-Server und bei den Clients das Aufnahmeverzeichnis des NAS per fstab direkt nach /srv/vdr/video.00 gemounted (per smb):

Zitat

//IP-NAS/VDR-Aufnahmen /srv/vdr/video.00 cifs user=username,password=passwort,nounix,dir_mode=0777,file_mode=0777 0 0

Das ganze lief unter yaVDR-0.4 in der ansonsten gleichen Konfiguration auch monatelang ohne Probleme.

Bei den Tests habe ich übrigens noch ein seltsames Phänomen entdeckt:
Wenn eine Aufnahme läuft, dann habe ich am NAS einen Eingangs-Traffic von ~10MB/Sek., was ja viel zu hoch ist für eine einzelne Aufnahme. Ich hab dann mal kurz umgestellt auf NFS Mount (headless-Server zum NAS) und siehe da, keine Fehler in den Aufnahmen und nur noch einen Eingangs-Traffic von ~1,5MB/Sek., so wie es sein soll.
Zu guter letzt hab ich dann noch meinen alten yaVDR-0.4 restored und und in der gleichen Konfiguration aufs NAS aufgenommen, Ergebnis: Alles ohne Probleme, sowohl per SMB als auch auch per NFS, Eingangs-Traffic am NAS jeweils ~1,5MB/Sek bei einer Aufnahme. Auch Tests mit 2 Aufnahmen gleichzeitig klappten problemlos.

Also scheint bei yaVDR-05 wohl irgendein Problem im Zusammenspiel mit SMB vor zu liegen oder eben seitens der Distri.

Das gleiche Problem wird auch hier beschrieben: yavdr 0.5 - "ring buffer overflow" nach Updates bei Aufnahmen auf SMB-Share?

Hat jemans eine Idee wo genau das Problem besteht oder was ich noch probieren könnte?

Bax · 6. Januar 2014

Hi!

Mich plagt das selbe Problem: habe am Wochenende upgedatet von 1.7.x auf 2.0.3 (beides yavdr 0.5) und habe seither auf einigen sendern grobe Prpbleme beim Aufnehmen. (insbes HD-Sender).
Auch ich zeichne auf ein NAS auf (Synology, NFS), beim Aufzeihnen habe ich Auslastungen von schwankend ca 12-21 MB/s, wa sja wohl deutlcih zu viel sein dürfte.

Ich merke beim Pausieren und anschließender Wiedergabe, dass die Restzeit, die eigentlich fix bleiben sollte nach und nach runtergeht (mit den ring buffer overflows) und schließlich gegen null geht und dann regieren nur mehr bildstörungen. D.h. Aufnahmen sind nicht mehr möglich...

Bitte daher um Hilfe!!!!

Danke
LG
Bax

PS: Log:

Code

Jan  6 22:44:53 ubuntuVDR vdr: [4090] i/o throttle activated, count = 1 (tid=4090)
Jan  6 22:44:57 ubuntuVDR vdr: [4090] buffer usage: 70% (tid=4103)
Jan  6 22:44:58 ubuntuVDR vdr: [4090] buffer usage: 80% (tid=4103)
Jan  6 22:45:00 ubuntuVDR vdr: [4090] buffer usage: 90% (tid=4103)
Jan  6 22:45:02 ubuntuVDR vdr: [4090] buffer usage: 100% (tid=4103)
Jan  6 22:45:02 ubuntuVDR vdr: [4090] ERROR: 1 ring buffer overflow (1 bytes dropped)
Jan  6 22:45:08 ubuntuVDR vdr: [4090] ERROR: 31125 ring buffer overflows (5851500 bytes dropped)
Jan  6 22:45:13 ubuntuVDR vdr: [3938] [softhddev]Clear:
Jan  6 22:45:13 ubuntuVDR vdr: [3938] [softhddev]Play:
Jan  6 22:45:13 ubuntuVDR vdr: audio/alsa: using device 'default'
Jan  6 22:45:13 ubuntuVDR vdr: audio/alsa: start delay 100ms
Jan  6 22:45:13 ubuntuVDR vdr: audio/alsa: using device 'default'
Jan  6 22:45:13 ubuntuVDR vdr: audio/alsa: start delay 100ms
Jan  6 22:45:13 ubuntuVDR vdr: video: decoder buffer empty, duping frame (1626/4) 6 v-buf
Jan  6 22:45:13 ubuntuVDR vdr: video: slow down video, duping frame
Jan  6 22:45:13 ubuntuVDR vdr: video: 11:48:18.907 +984  910   0/\ms  15+1 v-buf
Jan  6 22:45:14 ubuntuVDR vdr: [4090] ERROR: 33359 ring buffer overflows (6271492 bytes dropped)
Jan  6 22:45:15 ubuntuVDR vdr: video/vdpau: synced after 101 frames
Jan  6 22:45:20 ubuntuVDR vdr: [4090] ERROR: 34553 ring buffer overflows (6495964 bytes dropped)
Jan  6 22:45:26 ubuntuVDR vdr: [4090] ERROR: 37708 ring buffer overflows (7089104 bytes dropped)
Jan  6 22:45:30 ubuntuVDR vdr: audio/alsa: wait underrun error? 'Datenübergabe unterbrochen (broken pipe)'
Jan  6 22:45:30 ubuntuVDR vdr: audio/alsa: wait underrun error? 'Datenübergabe unterbrochen (broken pipe)'
Jan  6 22:45:30 ubuntuVDR vdr: video: slow down video, duping frame
Jan  6 22:45:30 ubuntuVDR vdr: video: decoder buffer empty, duping frame (1681/812) 0 v-buf
Jan  6 22:45:30 ubuntuVDR vdr: video: 11:48:35.147+8888    0   0/\ms   0+0 v-buf
Jan  6 22:45:30 ubuntuVDR vdr: audio/alsa: wait underrun error? 'Datenübergabe unterbrochen (broken pipe)'
Jan  6 22:45:30 ubuntuVDR vdr: video: slow down video, duping frame
Jan  6 22:45:30 ubuntuVDR vdr: video: 11:48:35.147 +450  120   0/\ms   1+0 v-buf
Jan  6 22:45:30 ubuntuVDR vdr: video: decoder buffer empty, duping frame (1683/813) 0 v-buf
Jan  6 22:45:30 ubuntuVDR vdr: video: 11:48:35.167+8888    0   0/\ms   0+0 v-buf
Jan  6 22:45:31 ubuntuVDR vdr: audio/alsa: wait underrun error? 'Datenübergabe unterbrochen (broken pipe)'
Jan  6 22:45:31 ubuntuVDR vdr: video: decoder buffer empty, duping frame (1692/816) 0 v-buf
Jan  6 22:45:31 ubuntuVDR vdr: video: slow down video, duping frame
Jan  6 22:45:31 ubuntuVDR vdr: video: 11:48:35.227 +410  120   0/\ms   4+0 v-buf
Jan  6 22:45:31 ubuntuVDR vdr: video: slow down video, duping frame
Jan  6 22:45:31 ubuntuVDR vdr: video: decoder buffer empty, duping frame (1695/821) 0 v-buf
Jan  6 22:45:31 ubuntuVDR vdr: video: 11:48:35.327+8888    0   0/\ms   0+0 v-buf
Jan  6 22:45:31 ubuntuVDR vdr: audio/alsa: wait underrun error? 'Datenübergabe unterbrochen (broken pipe)'

Alles anzeigen

mini73 · 6. Januar 2014

Es ist bestimmt auch ein neuer Kernel und damit ein neuer CIFS Treiber beim Update reingekommen.
Welcher war es vorher, welcher ist es jetzt?
Wenn vorher 3.2 und jetzt 3.8, dann vielleicht wieder auf die 3.2er Schiene wechseln.

Der vdr selbst hat gar nichts damit zu tun, weder der 1.7.x noch der 2.0.3.

Lars.

meikelmoeller · 6. Januar 2014

Ich hatte mal ein ähnliches Verhalten und das lag letztendlich daran dass ich auf eine NTFS HDD aufgenommen habe. Erst nachde ich das ganze nach ext4 umgebaut habe ist der Load wieder runter gegangen und alles war wie vorher. Es gab da wohl ein Problem mit der NTFS Unterstützung.
Kannst ja mal schauen was die CPU Auslastung macht wenn die Probleme auftreten.

Bax · 6. Januar 2014

Hi!

Danke für Eure raschen Rückmeldungen!!!

Kernel ist Linux ubuntuVDR 3.2.0-58-generic
vorher 3.2.41 und 3.2.45

TOP zeigt folgendes:

TV ohen Aufnahme:

Code

top - 23:49:25 up 9 min,  2 users,  load average: 1.04, 1.15, 0.70
Tasks: 125 total,   1 running, 124 sleeping,   0 stopped,   0 zombie
Cpu(s):  2.2%us,  1.0%sy,  0.0%ni, 96.3%id,  0.0%wa,  0.0%hi,  0.5%si,  0.0%st
Mem:   2051028k total,   589092k used,  1461936k free,    21912k buffers
Swap:  2094076k total,        0k used,  2094076k free,   216732k cached


  PID USER      PR  NI  VIRT  RES  SHR S %CPU %MEM    TIME+  COMMAND                                          
 2379 vdr       10 -10 1878m 179m  21m S    6  8.9   0:24.71 vdr                                               
 2443 root      20   0     0    0    0 D    1  0.0   0:00.40 kdvb-ad-0-fe-0                                    
 2488 root      20   0     0    0    0 S    1  0.0   0:01.99 cx88[0] dvb                                       
 2450 root      20   0     0    0    0 S    0  0.0   0:01.18 kdvb-ad-2-fe-0                                    
    1 root      20   0 24848 2708 1264 S    0  0.1   0:00.99 init                                              
    2 root      20   0     0    0    0 S    0  0.0   0:00.00 kthreadd

Alles anzeigen

Mit Aufzeichnung

Code

top - 23:50:25 up 10 min,  2 users,  load average: 1.28, 1.23, 0.76
Tasks: 125 total,   2 running, 123 sleeping,   0 stopped,   0 zombie
Cpu(s):  4.2%us, 10.0%sy,  0.3%ni, 38.0%id, 42.4%wa,  0.0%hi,  5.1%si,  0.0%st
Mem:   2051028k total,   623644k used,  1427384k free,    21984k buffers
Swap:  2094076k total,        0k used,  2094076k free,   222624k cached


  PID USER      PR  NI  VIRT  RES  SHR S %CPU %MEM    TIME+  COMMAND                                          
 2379 vdr       10 -10 1917m 207m  21m S   20 10.4   0:32.39 vdr                                               
 2521 root      20   0     0    0    0 S    6  0.0   0:01.91 kworker/0:0                                       
    9 root      20   0     0    0    0 R    6  0.0   0:06.70 kworker/1:0                                       
 2488 root      20   0     0    0    0 S    1  0.0   0:02.48 cx88[0] dvb                                       
 2450 root      20   0     0    0    0 S    1  0.0   0:01.44 kdvb-ad-2-fe-0                                    
   47 root      20   0     0    0    0 S    0  0.0   0:00.17 kworker/u:4                                       
  963 root      20   0     0    0    0 S    0  0.0   0:00.68 rc0

Alles anzeigen

und, jetzt kommts: Aufzeichnung auf ZDF:

Code

top - 23:51:41 up 11 min,  2 users,  load average: 1.19, 1.20, 0.78
Tasks: 125 total,   2 running, 123 sleeping,   0 stopped,   0 zombie
Cpu(s): 20.8%us,  9.3%sy,  0.3%ni, 24.3%id, 41.1%wa,  0.0%hi,  4.2%si,  0.0%st
Mem:   2051028k total,   634892k used,  1416136k free,    22096k buffers
Swap:  2094076k total,        0k used,  2094076k free,   217416k cached


  PID USER      PR  NI  VIRT  RES  SHR S %CPU %MEM    TIME+  COMMAND                                          
 2379 vdr       10 -10 1912m 224m  19m S   54 11.2   0:52.20 vdr                                               
 2521 root      20   0     0    0    0 S    6  0.0   0:05.26 kworker/0:0                                       
 3033 root      20   0     0    0    0 R    6  0.0   0:00.98 kworker/1:2                                       
 2488 root      20   0     0    0    0 S    1  0.0   0:02.99 cx88[0] dvb                                       
 2450 root      20   0     0    0    0 S    0  0.0   0:01.75 kdvb-ad-2-fe-0                                    
 2701 sebastia  20   0 17340 1368 1012 R    0  0.1   0:00.63 top                                               
    1 root      20   0 24848 2708 1264 S    0  0.1   0:01.00 init

Alles anzeigen

CPU klettert bis auf 86 % (Athlon 64 3.000) .....

Platte am NAS ist ext4 (synology 1712 mit 3 platten im Raid)

habe zwischebzeitlich an den NFS Parametern gedreht /async/sync, packetsize), hat aber nichts gebracht ...

lg und danke
Bax

PS: Nachtrag:
auf die lokale Platte gibts keine Probleme,
auf ein cifs Mount am Server: selbiges, er läuft "ins Messer"

(Symptom: Laufendes TV pausieren mit Menü/gelb, und Zeitbalken einblenden, dann zählt er nicht im Sekundentakt hinaus, sondern langsamer; wenn man auf play geht wird die restzeit imme rweniger bis er bei null anlangt und in die Grafikfehler hineinläuft)

Mark · 20. Januar 2014

Hallo zusammen,

bei mir zeigt sich ein ähnliches Verhalten wie bei Bax, das Ganze betrifft aber NUR die Wiedergabe von Sendungen, die ich momentan aufnehme.
Die Aufzeichnung bei mir erfolgt auf ein openmediavault NAS via NFS.

Irgendwann hängt sich das Fronten auf (egal ob xine, xineliboutput oder vnsi). Danach hilft meist nur ein Reboot.

Ich habe tesweise ebenfalls auf die lokale Platte aufgezeichnet und zeitversetzt wiedergegeben - s funktioniert fehlerfrei!

Nehme ich 5 Sendungen gleichzeitig auf und gebe eine ABGESCHLOSSENE Sendung wieder, gibt es keine Probleme.

Für Lösungshinweise wäre ich ebenfalls dankbar.

Gruß,
Mark

Painkilla · 22. Januar 2014

Guten Abend,

ich habe genau das gleich Problem und hoffentlich eine Lösung! Der Buffer ist zu klein, und der kann im VDR in den Folgenden 2 Datein vergrößert werden:

sudo nano recorder.c

----

#define RECORDERBUFSIZE MEGABYTE(100)

----

sudo nano dvbplayer.c

---

#define PLAYERBUFSIZE MEGABYTE(50)

----

make
make install

oder:
[yaVDR 0.5] Gelöst: streamdev ring buffer overflows

lg painkilla

yaVDR 0.5 headless / ARD & ZDF HD Aufnahmen / ERROR: 1 ring buffer overflow

Jetzt mitmachen!

Teilen