softhddev "speed up video, droping frame"

horchi · 23. Juni 2015

Hi,

ich habe seit geraumer Zeit 'droping frame' Meldungen:

Code

Jun 23 00:59:07 vdr vdr: video: speed up video, droping frame:
Jun 23 00:59:07 vdr vdr: video: speed up video, droping frame
Jun 23 00:59:07 vdr vdr: video:  4:27:49.463  -10  568   0/\ms  52+1 v-buf
Jun 23 00:59:07 vdr vdr: video: speed up video, droping frame
Jun 23 00:59:07 vdr vdr: video:  4:27:49.523  +19  633   0/\ms  54+1 v-buf
Jun 23 00:59:39 vdr vdr: video:  4:28:21.483  +81  608   0/\ms  41+2 v-buf
Jun 23 01:00:39 vdr vdr: video:  4:29:21.483  +81  576   0/\ms  39+2 v-buf
Jun 23 14:04:25 vdr vdr: video: speed up video, droping frame
Jun 23 14:04:25 vdr vdr: video: 17:33:07.023 -507  462   0/\ms  60+2 v-buf
Jun 23 14:05:23 vdr vdr: video: speed up video, droping frame
Jun 23 14:05:23 vdr vdr: video: 17:34:06.263  +52  374   0/\ms  31+2 v-buf

Alles anzeigen

und 'duping frame' Meldungen im Log:

Code

Jun 22 21:42:06 vdr vdr: video: decoder buffer empty, duping frame (22368/240) 0 v-buf
Jun 22 21:42:06 vdr vdr: video: slow down video, duping frame
Jun 22 21:42:06 vdr vdr: video: 17:44:46.348 +164  369   0/\ms  32+8 v-buf
Jun 22 21:42:08 vdr vdr: video: slow down video, duping frame
Jun 22 21:42:08 vdr vdr: video: decoder buffer empty, duping frame (22373/108) 0 v-buf

Ich kann leider nicht genau sagen seit wann. Sie kommen beim Umschalten, beim Live TV und auch (gefühlt seltener) bei der Wiedergabe von Aufzeichnungen, auch wenn ich alle Plugins bis auf dbus2vdr und softhddev weg lasse.
Mir sind sie die ganze Zeit nicht aufgefallen nur häufen sich inzwischen die Bildruckler von Zeit zu Zeit.

Auch nach Umstellen des Deinterlacer von temporal_spatial auf bob werden die Meldungen nicht weniger.

Das ist meine Graka:

Code

root@vdr:~# nvidia-smi 
Tue Jun 23 14:19:15 2015       
+------------------------------------------------------+                       
| NVIDIA-SMI 331.113    Driver Version: 331.113        |                       
|-------------------------------+----------------------+----------------------+
| GPU  Name        Persistence-M| Bus-Id        Disp.A | Volatile Uncorr. ECC |
| Fan  Temp  Perf  Pwr:Usage/Cap|         Memory-Usage | GPU-Util  Compute M. |
|===============================+======================+======================|
|   0  GeForce GT 430      Off  | 0000:01:00.0     N/A |                  N/A |
| 52%   47C  N/A     N/A /  N/A |    196MiB /  1023MiB |     N/A      Default |
+-------------------------------+----------------------+----------------------+

+-----------------------------------------------------------------------------+
| Compute processes:                                               GPU Memory |
|  GPU       PID  Process name                                     Usage      |
|=============================================================================|
|    0            Not Supported                                               |
+-----------------------------------------------------------------------------+

Alles anzeigen

softhddev läuft mit diesen Parametern:

Code

-Psofthddevice -D -a hw:NVidia,9 -p hw:NVidia,9

und diesen Einstellungen:

Code

softhddevice.1080i.CutLeftRight = 0
softhddevice.1080i.CutTopBottom = 0
softhddevice.1080i.Deinterlace = 3
softhddevice.1080i.Denoise = 0
softhddevice.1080i.InverseTelecine = 0
softhddevice.1080i.Scaling = 0
softhddevice.1080i.Sharpen = 0
softhddevice.1080i.SkipChromaDeinterlace = 0
softhddevice.1080i_fake.CutLeftRight = 0
softhddevice.1080i_fake.CutTopBottom = 0
softhddevice.1080i_fake.Deinterlace = 3
softhddevice.1080i_fake.Denoise = 0
softhddevice.1080i_fake.InverseTelecine = 0
softhddevice.1080i_fake.Scaling = 0
softhddevice.1080i_fake.Sharpen = 0
softhddevice.1080i_fake.SkipChromaDeinterlace = 0
softhddevice.576i.CutLeftRight = 0
softhddevice.576i.CutTopBottom = 0
softhddevice.576i.Deinterlace = 3
softhddevice.576i.Denoise = 0
softhddevice.576i.InverseTelecine = 0
softhddevice.576i.Scaling = 0
softhddevice.576i.Sharpen = 0
softhddevice.576i.SkipChromaDeinterlace = 0
softhddevice.60HzMode = 0
softhddevice.720p.CutLeftRight = 0
softhddevice.720p.CutTopBottom = 0
softhddevice.720p.Deinterlace = 3
softhddevice.720p.Denoise = 0
softhddevice.720p.InverseTelecine = 0
softhddevice.720p.Scaling = 0
softhddevice.720p.Sharpen = 0
softhddevice.720p.SkipChromaDeinterlace = 0
softhddevice.AudioAutoAES = 0
softhddevice.AudioBufferTime = 0
softhddevice.AudioCompression = 0
softhddevice.AudioDelay = 50
softhddevice.AudioDownmix = 0
softhddevice.AudioDrift = 0
softhddevice.AudioMaxCompression = 0
softhddevice.AudioMaxNormalize = 0
softhddevice.AudioNormalize = 0
softhddevice.AudioPassthrough = 4
softhddevice.AudioSoftvol = 0
softhddevice.AudioStereoDescent = 0
softhddevice.AutoCrop.Delay = 10
softhddevice.AutoCrop.Interval = 10
softhddevice.AutoCrop.Tolerance = 10
softhddevice.Background = 0
softhddevice.BlackPicture = 0
softhddevice.Brightness = 0
softhddevice.ClearOnSwitch = 0
softhddevice.Contrast = 1000
softhddevice.DetachFromMainMenu = 0
softhddevice.HideMainMenuEntry = 1
softhddevice.Hue = 0
softhddevice.MakePrimary = 0
softhddevice.Osd.Height = 1080
softhddevice.Osd.Width = 1920
softhddevice.pip.Alt.Height = 50
softhddevice.pip.Alt.VideoHeight = 50
softhddevice.pip.Alt.VideoWidth = 0
softhddevice.pip.Alt.VideoX = 0
softhddevice.pip.Alt.VideoY = 0
softhddevice.pip.Alt.Width = 0
softhddevice.pip.Alt.X = 0
softhddevice.pip.Alt.Y = 50
softhddevice.pip.Height = 18
softhddevice.pip.VideoHeight = 0
softhddevice.pip.VideoWidth = 0
softhddevice.pip.VideoX = 0
softhddevice.pip.VideoY = 0
softhddevice.pip.Width = 18
softhddevice.pip.X = 79
softhddevice.pip.Y = 78
softhddevice.Saturation = 1000
softhddevice.SoftStartSync = 0
softhddevice.StudioLevels = 0
softhddevice.Suspend.Close = 1
softhddevice.Suspend.X11 = 0
softhddevice.Video4to3DisplayFormat = 1
softhddevice.VideoOtherDisplayFormat = 1

Alles anzeigen

Der TV wird laut xrandr und auch laut der Anzeige am TV mit 50Hz angesteuert

Code

root@vdr:~# DISPLAY=:1.0  xrandr -q
Screen 0: minimum 8 x 8, current 1920 x 1080, maximum 16384 x 16384
DVI-I-0 disconnected (normal left inverted right x axis y axis)
VGA-0 disconnected (normal left inverted right x axis y axis)
HDMI-0 connected 1920x1080+0+0 (normal left inverted right x axis y axis) 1020mm x 570mm
   1920x1080      60.0 +   59.9     59.9     50.0*    30.0     25.0     24.0     30.0     30.0     25.0

Woran können die buffer Probleme liegen bzw. wie kann ich das Problem am besten weiter analysieren?

Danke, Grüße
Jörg

horchi · 23. Juni 2015

BTW: Habe zum Test auf den Nvidia Treiber 331 gewechselt, vorher hatte ich 304

johns · 23. Juni 2015

Normal ist es nicht. Sieht so aus als ob deine Karte mit dem Dekodieren nicht nachkommt.
Erstmal den Test auf einen Sender beschränken.
SDTV sollte am zuverlässigsten gehen, dann 720p (Öffentlich rechtlichen)

Code

softhddevice.720p.Deinterlace = 3

Sollte nicht stören, aber für 720p ist "Weave/None" genug.

Dann prüfe die Temperatur, ob nicht durch zu hohe Temperatur heruntergetaktet wird.
Du kannst das SoftHdDevice Menu aufrufen, da werden die Zahlen live gezählt.

Johns

horchi · 23. Juni 2015

Hi Johns,

sehe ich mir morgen Abend an, bin heute nicht zuhause. Mal sehen ob ich die Zahlen interpretieren kann. Ich trage mir mal ARD SD in die Kanal-liste ein.

softhddevice.720p.Deinterlace spielt bei mir vermutlich keine Rolle schaue zu 99% nur HD Sender.

Die Temperatur ist laut nvidia-smi immer zwischen 50 und 58°C, sollte okay sein, oder?

Kann man den Empfang (habe DVB-S2) ausschließen oder könnte es auch damit zu tun haben?
Sollten die Meldungen grundsätzlich auch beim zappen unterleiben?

Sorry ... viele Fragen :o

/EDIT, dabei fällt mir ein ich kann es ja mal schnell von Remote testen
/EDIT2 sorry 50 und 58 war der Fan in %, die Temperatur liegt zwischen 45 und 52°C

johns · 23. Juni 2015

Ein paar Meldungen nach dem Umschalten sind normal, aber nach ca. 1 Minute sollte Ruhe sein.

Code

Jun 23 15:08:56 i3-2100 vdr: video:  3:43:14.279  +30  412 240/\ms   9+7 v-buf
Jun 23 15:09:56 i3-2100 vdr: video:  3:44:14.279  +30  388 240/\ms   7+7 v-buf
Jun 23 15:10:56 i3-2100 vdr: video:  3:45:14.279  +30  268 240/\ms   6+7 v-buf
Jun 23 15:11:56 i3-2100 vdr: video:  3:46:14.279  +30  364 240/\ms  10+7 v-buf
Jun 23 15:12:56 i3-2100 vdr: video:  3:47:14.279  +30  316 240/\ms  12+7 v-buf
Jun 23 15:13:56 i3-2100 vdr: video:  3:48:14.279  +30  292 240/\ms   3+7 v-buf
Jun 23 15:14:56 i3-2100 vdr: video:  3:49:14.279  +30  460 240/\ms  14+7 v-buf

So sollte es aussehen. In deinem.Log fallen die "1 v-buf" auf. 60 Hz hast schon geprüft.
Kannst auch die AudioBufferTime erhöhen, das sollte auch die 'Video Buffer erhöhen.

Wenn die v-buf 0 sind, dann gibts "dups", wenn Audio/Video nicht im Sync sind gibts drop.
Wenn das Ganze nie in Sync kommt, dann gibts dup/drop für immer.

Johns

horchi · 23. Juni 2015

läuft nun seit 10 Minuten aut ARTE SD:

Code

Jun 23 15:14:51 vdr vdr: video: decoder buffer empty, duping frame (1/914) 0 v-buf
Jun 23 15:14:53 vdr vdr: video: decoder buffer empty, duping frame (35/914) 0 v-buf
Jun 23 15:14:53 vdr vdr: video: slow down video, duping frame
Jun 23 15:15:52 vdr vdr: video: slow down video, duping frame

Die ersten drei Meldungen kamen beim Umschalten, dann noch die eine ca 60 Sekunden später seit dem ist Ruhe.

Auf ARTE SD habe ich 6-7:

Code

Jun 23 15:14:53 vdr vdr: video: 10:35:14.503 +161  465   0/\ms  11+7 v-buf
Jun 23 15:15:52 vdr vdr: video: 10:36:13.623  +81  497   0/\ms  15+6 v-buf
Jun 23 15:16:52 vdr vdr: video: 10:37:13.623  +81  545   0/\ms  13+6 v-buf
Jun 23 15:17:52 vdr vdr: video: 10:38:13.623  +81  521   0/\ms   9+6 v-buf
Jun 23 15:18:52 vdr vdr: video: 10:39:13.623  +81  473   0/\ms  14+6 v-buf
Jun 23 15:19:52 vdr vdr: video: 10:40:13.623  +81  521   0/\ms  12+6 v-buf
Jun 23 15:20:52 vdr vdr: video: 10:41:13.623  +81  569   0/\ms  12+6 v-buf
Jun 23 15:21:35 vdr vdr: video: 10:41:56.703  -21  538   0/\ms  14+5 v-buf
Jun 23 15:21:35 vdr vdr: video: 10:41:56.823  +37  476   0/\ms  11+5 v-buf
Jun 23 15:21:52 vdr vdr: video: 10:42:13.683  +81  557   0/\ms  13+7 v-buf
Jun 23 15:22:52 vdr vdr: video: 10:43:13.683  +81  533   0/\ms  11+7 v-buf
Jun 23 15:23:52 vdr vdr: video: 10:44:13.683  +81  509   0/\ms  13+7 v-buf
Jun 23 15:24:52 vdr vdr: video: 10:45:13.683  +81  533   0/\ms  12+7 v-buf
Jun 23 15:25:52 vdr vdr: video: 10:46:13.683  +61  489   0/\ms  10+7 v-buf

Alles anzeigen

Auf ARD HD sind es gleich wieder nur 2:

Code

Jun 23 15:27:37 vdr vdr: video: 11:43:30.600  +86  521   0/\ms  67+2 v-buf
Jun 23 15:28:37 vdr vdr: video: 11:44:30.600  +86  553   0/\ms  74+2 v-buf

horchi · 23. Juni 2015

Habe nun die Audio Buffer Größe von 0 auf 50ms umgestellt. ist bei +2 v-buf geblieben (ARD HD):

Code

Jun 23 15:31:37 vdr vdr: video: 11:47:30.600  +86  553   0/\ms  74+2 v-buf
Jun 23 15:32:37 vdr vdr: video: 11:48:30.600  +86  521   0/\ms  71+2 v-buf

Code

softhddevice.AudioBufferTime = 50

johns · 23. Juni 2015

720p hat maximal 4 Buffer, normal sind 3.
Bei SDTV gehts bei dir schon runter auf 5.

Eigentlich war die GT 430 eine der Leistungsstärksten Karten. Mal verschiedene NVidia Treiber ausprobieren.
Kannst auch den Energiesparmodus der Karte deaktivieren.

Code

softhddevice.AudioBufferTime = 1000

Edit: deine 50 sind weniger als 0, 0 = 300ms.

Sollte die DVB Seite auschliessen.

Johns

horchi · 23. Juni 2015

habe nun die AudioBufferTime auf 1000, hat nichts geändert .... nach dem Restart auf ARD HD:

Code

Jun 23 15:40:32 vdr vdr: video: 11:56:24.980 +169  431   0/\ms  64+4 v-buf
Jun 23 15:41:30 vdr vdr: video: 11:57:23.340  +89  456   0/\ms  66+2 v-buf
Jun 23 15:42:30 vdr vdr: video: 11:58:23.340  +88  423   0/\ms  66+2 v-buf
Jun 23 15:43:30 vdr vdr: video: 11:59:23.340  +89  488   0/\ms  71+2 v-buf
Jun 23 15:44:30 vdr vdr: video: 12:00:23.340  +89  456   0/\ms  66+2 v-buf
Jun 23 15:45:21 vdr vdr: video: 12:01:14.540   -4  455   0/\ms  72+1 v-buf
Jun 23 15:45:30 vdr vdr: video: 12:01:23.380  +89  448   0/\ms  66+2 v-buf
Jun 23 15:46:30 vdr vdr: video: 12:02:23.380  +89  416   0/\ms  68+2 v-buf
Jun 23 15:47:30 vdr vdr: video: 12:03:23.380  +89  448   0/\ms  64+2 v-buf
Jun 23 15:48:30 vdr vdr: video: 12:04:23.380  +89  416   0/\ms  66+2 v-buf

Wobei ich noch keine Fehlermeldung im Log hatte, aber sofern ich dich richtig verstehe sollten die Buffer nicht immer zw. 1 und 2 pendeln.

Hast du eine Tipp wie ich den Energiesparmodus der Nvidia Karte ausschalten kann, google hat mir nix geliefert ;).

Treiber habe ich bis jetzt den 304 und den 331 getestet, mit beiden das selbe.

Danke Grüße
Jörg

seahawk1986 · 23. Juni 2015

Zitat von horchi

Hast du eine Tipp wie ich den Energiesparmodus der Nvidia Karte ausschalten kann, google hat mir nix geliefert .

Versuch mal das: https://wiki.archlinux.org/ind…kes_with_400_series_cards

horchi · 23. Juni 2015

Danke, hab's übernommen:

Code

Section "Device"


    Identifier     "Device0"
    Driver         "nvidia"
    VendorName     "NVIDIA Corporation"
    Screen          0
    Option         "DPI" "100x100"
    BusID          "PCI:1:0:0"
    Option         "NoLogo" "True"
    Option         "UseEvents" "True"
    Option         "TripleBuffer" "False"
    Option         "AddARGBGLXVisuals" "True"
    Option         "TwinView" "0"
    Option         "DynamicTwinView" "0"
    Option         "OnDemandVBlankinterrupts" "on"
    Option         "FlatPanelProperties" "Scaling = Native"
    Option         "RegistryDwords" "PowerMizerEnable=0x1; PerfLevelSrc=0x3322; PowerMizerDefaultAC=0x1"
EndSection




Section "Device"


    Identifier     "Device1"
    Driver         "nvidia"
    VendorName     "NVIDIA Corporation"
    Screen          1
    BusID          "PCI:1:0:0"
    Option         "NoLogo" "True"
    Option         "UseEvents" "True"
    Option         "TripleBuffer" "False"
    Option         "AddARGBGLXVisuals" "True"
    Option         "TwinView" "0"
    Option         "DynamicTwinView" "0"
    Option         "RegistryDwords" "PowerMizerEnable=0x1; PerfLevelSrc=0x3322; PowerMizerDefaultAC=0x1"
EndSection

Alles anzeigen

An den Puffer Werten hat sich nichts getan:

Code

Jun 23 16:02:28 vdr vdr: video: 12:18:20.920  +55  378   0/\ms  63+2 v-buf
Jun 23 16:03:28 vdr vdr: video: 12:19:20.920  +55  442   0/\ms  63+2 v-buf
Jun 23 16:04:28 vdr vdr: video: 12:20:20.920  +55  378   0/\ms  67+2 v-buf

Wie viele sollte ich dort bei ARD HD ca. angezeigt bekommen?

horchi · 23. Juni 2015

keine Ahnung ob das ggf. noch etwas Licht ins Dunkel bringt:

Code

root@vdr:~# DISPLAY=:1.0 nvidia-settings -q all | grep -i gpucurrent.*clock | grep "[)]:"
  Attribute 'GPUCurrentClockFreqs' (vdr:1.0): 699,597.
  Attribute 'GPUCurrentProcessorClockFreqs' (vdr:1.0): 1399.
  Attribute 'GPUCurrentClockFreqsString' (vdr:1.0): nvclock=699, nvclockmin=700, nvclockmax=700, memclock=597, memclockmin=600, memclockmax=600, memTransferRate=1194, memTransferRatemin=1200, memTransferRatemax=1200, processorclock=1399, processorclockmin=1400, processorclockmax=1400 
  Attribute 'GPUCurrentClockFreqs' (vdr:1.1): 699,597.
  Attribute 'GPUCurrentProcessorClockFreqs' (vdr:1.1): 1399.
  Attribute 'GPUCurrentClockFreqsString' (vdr:1.1): nvclock=699, nvclockmin=700, nvclockmax=700, memclock=597, memclockmin=600, memclockmax=600, memTransferRate=1194, memTransferRatemin=1200, memTransferRatemax=1200, processorclock=1399, processorclockmin=1400, processorclockmax=1400 
  Attribute 'GPUCurrentClockFreqs' (vdr:1[gpu:0]): 699,597.
  Attribute 'GPUCurrentProcessorClockFreqs' (vdr:1[gpu:0]): 1399.
  Attribute 'GPUCurrentClockFreqsString' (vdr:1[gpu:0]): nvclock=699, nvclockmin=700, nvclockmax=700, memclock=597, memclockmin=600, memclockmax=600, memTransferRate=1194, memTransferRatemin=1200, memTransferRatemax=1200, processorclock=1399, processorclockmin=1400, processorclockmax=1400

Code

root@vdr:~# DISPLAY=:1.0 nvidia-settings -q all | grep -i temp | grep "[)]:"
  Attribute 'GPUCoreTemp' (vdr:1.0): 48.
  Attribute 'GPUCoreTemp' (vdr:1.1): 48.
  Attribute 'GPUCoreTemp' (vdr:1[gpu:0]): 48.

horchi · 23. Juni 2015

Auf einem anderen VDR im Haus sieht es so aus:

Code

Jun 23 16:25:07 vdr-andre vdr: video: 14:18:21.296  +37  848   0/\ms  73+7 v-buf
Jun 23 16:26:07 vdr-andre vdr: video: 14:19:21.296  +37  816   0/\ms  73+7 v-buf
Jun 23 16:27:07 vdr-andre vdr: video: 14:20:21.296  +37  880   0/\ms  51+7 v-buf
Jun 23 16:28:07 vdr-andre vdr: video: 14:21:21.296  +37  816   0/\ms  49+7 v-buf

Dieser hat eine "GeForce GT 730" und eine DVB-S2 von TT mit einem Tuner. Im VDR mit dem Buffer Problem ist eine Cine mit 2 Tunern.

Beide VDR hängen an der selben Anlage am selben Multiswitch, die Leitungen zu dem mit dem Buffer Problem sind etwas kürzer.

Sollte ich mir eine neue Graka zulegen :o ?

seahawk1986 · 23. Juni 2015

Das sieht zumindest so aus, als ob die Einstellungen für den PowerMizer greifen und die Karte somit nicht mehr heruntertakten sollte.

Zitat von horchi

Sollte ich mir eine neue Graka zulegen :o ?

Hast du mal ausprobiert was passiert, wenn du die Grafikkarten zwischen den VDRs tauschst?

BTW: Ist das ein yaVDR 0.5 mit dem normalen Stand aus testing (das wäre dann mit ffmpeg 0.10.12) oder spielen da eventuell noch andere Quellen für Pakete mit hinein?

horchi · 23. Juni 2015

ja nur die Quellen:

Code

deb http://192.168.200.101:3142/ppa.launchpad.net/yavdr/main/ubuntu precise main
deb http://192.168.200.101:3142/ppa.launchpad.net/yavdr/testing-vdr/ubuntu precise main
deb http://192.168.200.101:3142/ppa.launchpad.net/yavdr/testing-xbmc/ubuntu precise main
deb http://192.168.200.101:3142/ppa.launchpad.net/yavdr/testing-yavdr/ubuntu precise main


deb-src http://192.168.200.101:3142/ppa.launchpad.net/yavdr/main/ubuntu precise main
deb-src http://192.168.200.101:3142/ppa.launchpad.net/yavdr/testing-vdr/ubuntu precise main
deb-src http://192.168.200.101:3142/ppa.launchpad.net/yavdr/testing-xbmc/ubuntu precise main
deb-src http://192.168.200.101:3142/ppa.launchpad.net/yavdr/testing-yavdr/ubuntu precise main

sonst keine externen eingerichtet.

ja, 0.10.12-7

Code

root@vdr:~# ffmpeg 
ffmpeg version 0.10.12-7:0.10.12-0yavdr0~precise Copyright (c) 2000-2014 the FFmpeg developers
  built on Feb 21 2015 06:38:55 with gcc 4.6.3
  configuration: --arch=amd64 --disable-stripping --enable-pthreads --enable-runtime-cpudetect --extra-version='7:0.10.12-0yavdr0~precise' --libdir=/usr/lib/x86_64-linux-gnu --prefix=/usr --enable-bzlib --enable-libdc1394 --enable-libfreetype --enable-frei0r --enable-gnutls --enable-libgsm --enable-libmp3lame --enable-librtmp --enable-libopencv --enable-libopenjpeg --enable-libpulse --enable-libschroedinger --enable-libspeex --enable-libtheora --enable-vaapi --enable-vdpau --enable-libvorbis --enable-libvpx --enable-zlib --enable-gpl --enable-postproc --enable-libcdio --enable-x11grab --enable-libx264 --shlibdir=/usr/lib/x86_64-linux-gnu --enable-shared --disable-static
  libavutil      51. 35.100 / 51. 35.100
  libavcodec     53. 61.100 / 53. 61.100
  libavformat    53. 32.100 / 53. 32.100
  libavdevice    53.  4.100 / 53.  4.100
  libavfilter     2. 61.100 /  2. 61.100
  libswscale      2.  1.100 /  2.  1.100
  libswresample   0.  6.100 /  0.  6.100
  libpostproc    52.  0.100 / 52.  0.100
Hyper fast Audio and Video encoder
usage: ffmpeg [options] [[infile options] -i infile]... {[outfile options] outfile}...

Alles anzeigen

Gute Idee, werde ich meinem Sohn mal die Graka mopsen und schauen ob es was ändert.

Komisch das ich ab und zu duping und ab und zu dropping Meldungen bekomme, gerade hatte ich mal duping:

Code

Jun 23 16:33:28 vdr vdr: video: 12:49:21.200  +75  438   0/\ms  67+2 v-buf
Jun 23 16:34:28 vdr vdr: video: 12:50:21.200  +75  438   0/\ms  59+2 v-buf
Jun 23 16:35:28 vdr vdr: video: 12:51:21.200  +75  502   0/\ms  62+2 v-buf
Jun 23 16:36:04 vdr vdr: video: slow down video, duping frame
Jun 23 16:36:04 vdr vdr: video: 14:29:18.016 +163 1117   0/\ms  69+8 v-buf
Jun 23 16:37:02 vdr vdr: video: slow down video, duping frame
Jun 23 16:37:02 vdr vdr: video: 14:30:16.236  +83 1153   0/\ms  87+6 v-buf
Jun 23 16:37:52 vdr vdr: video: 14:31:06.216   -6 1132   0/\ms  83+6 v-buf
Jun 23 16:38:02 vdr vdr: video: 14:31:16.276  +83 1145   0/\ms  88+6 v-buf

EDIT/ ohne das GTFT Plugin und ohne das dafür nötige Dual-Head das selbe problem

horchi · 23. Juni 2015

Aber irgendwas hat das Ändern der Parameter heute gebracht, auch wenn die v-buf bei den Öffentlich-Rechtlichen HD Sendern immer noch mit 1 oder 2 angezeigt werden habe ich (mal vom zappen abgesehen) sehr viel weniger duping und dropping Meldungen

johns · 24. Juni 2015

Las dich mal mit den mehr als 2 Puffer bei 720p nicht stören. Da ist mein Plugin nicht optimal.

Es scheint einen Leistungseinbruch zugeben, der die Ausgabe durcheinander bringt.
Irgendein Hintergrundprocess?
Du sprichst von einen Display, kann das hängen?

Code

cat /proc/interrupts

Guck mal ob irgendein Interrupt wild läuft.

Kannst noch die CPU Taktung auf "performance" stellen.
Der größere Puffer und die Grafikkarte auf maximalen Takt laufen zulassen, sind nicht die Lösung.
Dies mildet nur die Symtome.

Da fällt mir noch ein auch die CPU Temperatur messen, ob die gedrosselt wird.
Mal mit Aufnahmen prüfen, diese schliessen den Empfangsweg aus.

Johns

horchi · 24. Juni 2015

Läuft gerade seit einer Stunde auf ZDF HD:

Code

Jun 24 10:37:51 vdr vdr: video: 11:35:50.146  +25  363   0/\ms  26+2 v-buf
Jun 24 10:38:08 vdr vdr: video: speed up video, droping frame
Jun 24 10:38:51 vdr vdr: video: 11:36:50.166  +25  407   0/\ms  31+2 v-buf
Jun 24 10:39:18 vdr vdr: video: speed up video, droping frame
Jun 24 10:39:18 vdr vdr: video: 11:37:17.686  -43  370   0/\ms  36+1 v-buf
Jun 24 10:39:51 vdr vdr: video: 11:37:50.186  +25  355   0/\ms  28+2 v-buf
Jun 24 10:40:29 vdr vdr: video: speed up video, droping frame
Jun 24 10:40:29 vdr vdr: video: 11:38:28.326  -62  368   0/\ms  34+1 v-buf
Jun 24 10:40:29 vdr vdr: video: speed up video, droping frame
Jun 24 10:40:29 vdr vdr: video: speed up video, droping frame
Jun 24 10:40:29 vdr vdr: video: 11:38:28.446  -21  384   0/\ms  32+1 v-buf
Jun 24 10:40:51 vdr vdr: video: 11:38:50.246  +45  379   0/\ms  28+2 v-buf
Jun 24 10:41:51 vdr vdr: video: 11:39:50.246  +45  411   0/\ms  31+2 v-buf
Jun 24 10:42:51 vdr vdr: video: 11:40:50.246  +45  379   0/\ms  25+2 v-buf
Jun 24 10:43:51 vdr vdr: video: 11:41:50.246  +45  347   0/\ms  25+2 v-buf
Jun 24 10:44:51 vdr vdr: video: 11:42:50.246  +45  379   0/\ms  30+2 v-buf
Jun 24 10:45:51 vdr vdr: video: 11:43:50.246  +45  347   0/\ms  27+2 v-buf
Jun 24 10:46:51 vdr vdr: video: 11:44:50.246  +25  391   0/\ms  30+2 v-buf
Jun 24 10:47:37 vdr vdr: video: speed up video, droping frame
Jun 24 10:47:37 vdr vdr: video: 11:45:36.146  -58  359   0/\ms  35+1 v-buf
Jun 24 10:47:37 vdr vdr: video: speed up video, droping frame
Jun 24 10:47:51 vdr vdr: video: 11:45:50.286  +25  383   0/\ms  31+2 v-buf
Jun 24 10:48:43 vdr vdr: video: speed up video, droping frame
Jun 24 10:48:43 vdr vdr: video: 11:46:41.886  -32  341   0/\ms  32+1 v-buf
Jun 24 10:48:51 vdr vdr: video: 11:46:50.306  +45  351   0/\ms  25+2 v-buf
Jun 24 10:49:51 vdr vdr: video: 11:47:50.306  +45  415   0/\ms  32+2 v-buf
Jun 24 10:50:51 vdr vdr: video: 11:48:50.306  +45  383   0/\ms  29+2 v-buf
Jun 24 10:51:51 vdr vdr: video: 11:49:50.306  +45  415   0/\ms  30+2 v-buf
Jun 24 10:52:51 vdr vdr: video: 11:50:50.306  +45  383   0/\ms  31+2 v-buf
Jun 24 10:53:25 vdr vdr: video: speed up video, droping frame
Jun 24 10:53:51 vdr vdr: video: 11:51:50.346  +45  375   0/\ms  31+2 v-buf
Jun 24 10:54:51 vdr vdr: video: 11:52:50.346  +25  419   0/\ms  35+2 v-buf
Jun 24 10:55:46 vdr vdr: video: speed up video, droping frame
Jun 24 10:55:46 vdr vdr: video: 11:53:45.606  -37  360   0/\ms  30+1 v-buf
Jun 24 10:55:46 vdr vdr: video: speed up video, droping frame
Jun 24 10:55:51 vdr vdr: video: 11:53:50.386  +45  399   0/\ms  29+2 v-buf
Jun 24 10:56:51 vdr vdr: video: 11:54:50.386  +45  367   0/\ms  30+2 v-buf
Jun 24 10:57:51 vdr vdr: video: 11:55:50.386  +45  431   0/\ms  36+2 v-buf
Jun 24 10:58:51 vdr vdr: video: 11:56:50.386  +45  367   0/\ms  30+2 v-buf
Jun 24 10:59:51 vdr vdr: video: 11:57:50.386  +25  411   0/\ms  32+2 v-buf

Alles anzeigen

wobei ich das Bild dazu nicht sehen kann, sitze im Büro

zur CPU Temperatur, schaut für mich okay aus:

Code

root@vdr:~# sensors
nct6775-isa-0290
Adapter: ISA adapter
Vcore:             +0.98 V  (min =  +0.60 V, max =  +1.60 V)
+12V:             +11.79 V  (min = +11.09 V, max = +12.94 V)
AVCC:              +3.42 V  (min =  +3.01 V, max =  +3.60 V)
+3.3V:             +3.42 V  (min =  +3.01 V, max =  +3.60 V)
+5V:               +5.20 V  (min =  +4.60 V, max =  +5.40 V)
MemV:              +1.57 V  (min =  +0.40 V, max =  +2.00 V)
PCHV:              +1.07 V  (min =  +0.60 V, max =  +1.60 V)
3VSB:              +3.41 V  (min =  +3.01 V, max =  +3.60 V)
Vbat:              +3.34 V  (min =  +0.00 V, max =  +0.00 V)  ALARM
Rear fan:            0 RPM  (min =  251 RPM, div = 128)
CPU fan:           981 RPM  (min =  251 RPM, div = 32)
Front fan:           0 RPM  (min =  251 RPM, div = 128)
VR temp:           +28.0°C  (high = +90.0°C, hyst = +75.0°C)  sensor = diode
CPU temp:          +26.0°C  (high = +93.0°C, hyst = +75.0°C)  sensor = diode
Memory DIMM temp: -128.0°C  (high = +90.0°C, hyst = +75.0°C)  sensor = diode
PCH temp:          +45.0°C  
PECI Agent 0:      +33.5°C  (high = +80.0°C, hyst = +75.0°C)
intrusion0:       OK

Alles anzeigen

Zitat

Las dich mal mit den mehr als 2 Puffer bei 720p nicht stören. Da ist mein Plugin nicht optimal.

Sorry, stehe auf der Leitung, ist es bei HD (ZDF und ARD) okay dass ich zwischen +1 und +2 v-buf angezeigt bekomme?

Code

root@vdr:~# cat /proc/interrupts
           CPU0       CPU1       
  0:         55          0   IO-APIC-edge      timer
  1:          3          0   IO-APIC-edge      i8042
  3:          2          0   IO-APIC-edge      nuvoton-cir, nuvoton-cir
  8:          1          0   IO-APIC-edge      rtc0
  9:          0          0   IO-APIC-fasteoi   acpi
 12:          4          0   IO-APIC-edge      i8042
 16:    4356246          0   IO-APIC-fasteoi   ehci_hcd:usb1
 17:     168656          0   IO-APIC-fasteoi   snd_hda_intel
 18:          3          0   IO-APIC-fasteoi 
 23:         32          0   IO-APIC-fasteoi   ehci_hcd:usb2
 40:          0          0   PCI-MSI-edge      PCIe PME
 41:          0          0   PCI-MSI-edge      PCIe PME
 42:          0          0   PCI-MSI-edge      PCIe PME
 43:          0          0   PCI-MSI-edge      PCIe PME
 44:      50796          0   PCI-MSI-edge      ahci
 45:          1          0   PCI-MSI-edge      xhci_hcd
 46:          0          0   PCI-MSI-edge      xhci_hcd
 47:          0          0   PCI-MSI-edge      xhci_hcd
 48:     157019          0   PCI-MSI-edge      eth0
 49:         12          0   PCI-MSI-edge      mei
 50:     506096          0   PCI-MSI-edge      nGene
 51:     614155          0   PCI-MSI-edge      nvidia
NMI:        495        641   Non-maskable interrupts
LOC:    1737330    1337844   Local timer interrupts
SPU:          0          0   Spurious interrupts
PMI:        495        641   Performance monitoring interrupts
IWI:          0          0   IRQ work interrupts
RES:     131562     568386   Rescheduling interrupts
CAL:        232        395   Function call interrupts
TLB:       9330      12903   TLB shootdowns
TRM:          0          0   Thermal event interrupts
THR:          0          0   Threshold APIC interrupts
MCE:          0          0   Machine check exceptions
MCP:         15         15   Machine check polls
ERR:          0

Alles anzeigen

Zitat

Mal mit Aufnahmen prüfen, diese schliessen den Empfangsweg aus.

Bei der Wiedergabe habe ich es auch, wenn auch subjektiv seltener.

Zitat

Du sprichst von einen Display, kann das hängen?

Du meinst was ich zum GTFT geschrieben habe? Ich habe es schon ohne das graphTFT Plugin getestet und dabei auch ohne den xorg Dual-Head Mode, hat nichts geändert

Zitat

Irgendein Hintergrundprocess

habe außer dem VDR nur zwei Skripte laufen welche Daten aus einer Datenbank holen, die hatte ich auch schon mal angehalten.

Ansonsten sieht es CPU Last-seitig so aus:

Code

root@vdr:~# sar 
09:55:44     linux restarts
10:00:01  all   11     4      1     85
            0     8     5      1     87
            1    13     4      0     83
10:10:01  all    9     3      0     88
            0     6     3      0     90
            1    11     3      0     86
10:20:01  all    9     3      0     88
            0     6     3      0     91
            1    12     3      0     86
10:30:01  all    9     3      0     88
            0     7     3      0     90
            1    11     3      0     86
10:40:01  all    9     3      0     88
            0     6     3      0     90
            1    11     3      0     86
10:50:01  all    9     3      0     88
            0     7     3      0     90
            1    12     3      0     86
11:00:01  all    9     3      0     87
            0     7     3      0     89
            1    12     3      0     85

Alles anzeigen

horchi · 24. Juni 2015

habe nun (um 13:40) beide CPU auf 'performance' gestellt:

Code

root@vdr:~# cat /sys/devices/system/cpu/cpu*/cpufreq/scaling_governor
performance
performance

Keine sichtbare Änderung:

Code

Jun 24 13:42:57 vdr vdr: video: 14:40:55.826  +27  446   0/\ms  33+2 v-buf
Jun 24 13:43:57 vdr vdr: video: 14:41:55.826  +27  478   0/\ms  29+2 v-buf
Jun 24 13:44:57 vdr vdr: video: 14:42:55.826  +27  478   0/\ms  34+2 v-buf
Jun 24 13:45:57 vdr vdr: video: 14:43:55.826  +27  478   0/\ms  31+2 v-buf
Jun 24 13:46:10 vdr vdr: video: speed up video, droping frame
Jun 24 13:46:10 vdr vdr: video: 14:44:09.166  -62  519   0/\ms  39+1 v-buf
Jun 24 13:46:10 vdr vdr: video: speed up video, droping frame

johns · 24. Juni 2015

Zitat

Sorry, stehe auf der Leitung, ist es bei HD (ZDF und ARD) okay dass ich zwischen +1 und +2 v-buf angezeigt bekomme?

Das bei ARD und ZDF nur +2 v-buf kommt, ist zwar nicht gut, aber dies liegt an meinem Plugin. +4 wäre besser, aber wird nur unter optimalen Bedingungen erreicht.

Mir fällt dann auch nichts mehr ein.

Einzig der USB Interrupt sieht mir verdächtig aus:

Code

16:    4356246          0   IO-APIC-fasteoi   ehci_hcd:usb1

Johns

softhddev "speed up video, droping frame"

Jetzt mitmachen!

Teilen

Tags