search

manio / vdr-plugin-dvbapi

VDR dvbapi plugin for use with OSCam
http://www.streamboard.tv/wbb2/thread.php?threadid=40060
GNU General Public License v2.0
57 stars 25 forks source link

High CPU-Load when record a view HD-Streams #43

Closed MegaV0lt closed 10 years ago

MegaV0lt commented 10 years ago

I set up 2.1.4 and had a viuew recordings in hd. Then i got vdsb and i was lloking at the log. there is many device buffer overflows and htop shows 100% of vdr cpu usage. short log: https://dl.dropboxusercontent.com/u/1490505/VDR/G2V_V4/info.txt Full package with more informations: https://dl.dropboxusercontent.com/u/1490505/VDR/G2V_V4/VDSB_1391022845.tar.xz I was using dvbapi 2.0 latest git with libdvbcsa enabled.

Christian-MLD commented 10 years ago

Yes all Recordings are ok . I can start a Recording without errors in the stream Only in liveview are the problems

imperia777 commented 10 years ago

sure. brb.

imperia777 commented 10 years ago

Jan 31 21:01:10 eeepc vdr: [9836] VDR version 2.1.4 started Jan 31 21:01:10 eeepc vdr: [9836] switched to user 'vdr' Jan 31 21:01:10 eeepc vdr: [9836] codeset is 'UTF-8' - known Jan 31 21:01:10 eeepc vdr: [9836] found 0 locales in /usr/share/locale Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'deu,ger' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'slv,slo' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'ita' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'dut,nla,nld' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'prt' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'fra,fre' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'nor' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'fin,suo' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'pol' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'esl,spa' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'ell,gre' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'sve,swe' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'rom,rum' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'hun' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'cat,cln' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'rus' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'srb,srp,scr,scc' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'hrv' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'est' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'dan' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'cze,ces' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'tur' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'ukr' Jan 31 21:01:10 eeepc vdr: [9836] no locale for language code 'ara' Jan 31 21:01:10 eeepc vdr: [9836] loading plugin: /usr/lib/vdr/plugins/libvdr-dvbapi.so.2.1.4 Jan 31 21:01:10 eeepc vdr: [9836] loading /var/lib/vdr/setup.conf Jan 31 21:01:10 eeepc vdr: [9836] ERROR: unknown config parameter: dvbapi.DeCsaTsBuffSize = 4 Jan 31 21:01:10 eeepc vdr: [9836] loading /var/lib/vdr/sources.conf Jan 31 21:01:10 eeepc vdr: [9836] loading /var/lib/vdr/diseqc.conf Jan 31 21:01:10 eeepc vdr: [9836] loading /var/lib/vdr/scr.conf Jan 31 21:01:10 eeepc vdr: [9836] loading /var/lib/vdr/channels.conf Jan 31 21:01:10 eeepc vdr: [9836] loading /var/lib/vdr/timers.conf Jan 31 21:01:10 eeepc vdr: [9836] loading /var/lib/vdr/commands.conf Jan 31 21:01:10 eeepc vdr: [9836] loading /var/lib/vdr/reccmds.conf Jan 31 21:01:10 eeepc vdr: [9836] loading /var/lib/vdr/svdrphosts.conf Jan 31 21:01:10 eeepc vdr: [9836] loading /var/lib/vdr/keymacros.conf Jan 31 21:01:10 eeepc vdr: [9836] registered source parameters for 'A - ATSC' Jan 31 21:01:10 eeepc vdr: [9836] registered source parameters for 'C - DVB-C' Jan 31 21:01:10 eeepc vdr: [9836] registered source parameters for 'S - DVB-S' Jan 31 21:01:10 eeepc vdr: [9836] registered source parameters for 'T - DVB-T' Jan 31 21:01:10 eeepc vdr: [9836] probing /dev/dvb/adapter0/frontend0 Jan 31 21:01:10 eeepc vdr: [9836] creating cDvbDevice Jan 31 21:01:10 eeepc vdr: [9836] new device number 1 Jan 31 21:01:10 eeepc vdr: [9839] epg data reader thread started (pid=9836, tid=9839, prio=high) Jan 31 21:01:10 eeepc vdr: [9839] reading EPG data from /var/cache/vdr/epg.data Jan 31 21:01:10 eeepc vdr: [9838] video directory scanner thread started (pid=9836, tid=9838, prio=high) Jan 31 21:01:10 eeepc vdr: [9838] video directory scanner thread ended (pid=9836, tid=9838) Jan 31 21:01:10 eeepc vdr: [9837] video directory scanner thread started (pid=9836, tid=9837, prio=high) Jan 31 21:01:10 eeepc vdr: [9837] video directory scanner thread ended (pid=9836, tid=9837) Jan 31 21:01:11 eeepc vdr: [9836] DVB API version is 0x0503 (VDR was built with 0x050A) Jan 31 21:01:11 eeepc vdr: [9836] frontend 0/0 provides DVB-S,DVB-S2 with QPSK ("TurboSight TBS 5922 DVBS/S2 frontend") Jan 31 21:01:11 eeepc vdr: [9836] found 1 DVB device Jan 31 21:01:11 eeepc vdr: [9836] initializing plugin: dvbapi (2.0.0): DVBAPI type SOFTCAM Jan 31 21:01:11 eeepc vdr: [9836] setting primary device to 1 Jan 31 21:01:11 eeepc vdr: [9836] device 1 has no MPEG decoder Jan 31 21:01:11 eeepc vdr: [9836] assuming manual start of VDR Jan 31 21:01:11 eeepc vdr: [9836] SVDRP listening on port 6419 Jan 31 21:01:11 eeepc vdr: [9836] setting current skin to "lcars" Jan 31 21:01:11 eeepc vdr: [9836] loading /var/lib/vdr/themes/lcars-default.theme Jan 31 21:01:11 eeepc vdr: [9836] starting plugin: dvbapi Jan 31 21:01:11 eeepc vdr: [9836] DVBAPI: plugin version 2.0.0 initializing (VDR 2.1.4) Jan 31 21:01:11 eeepc vdr: [9836] cTimeMs: using monotonic clock (resolution is 1 ns) Jan 31 21:01:11 eeepc vdr: [9836] DVBAPI: SocketHandler Jan 31 21:01:11 eeepc vdr: [9836] DVBAPI: 0: clustersize=140 rangesize=285 Jan 31 21:01:11 eeepc vdr: [9836] DVBAPI: 0: reset state Jan 31 21:01:11 eeepc vdr: [9836] DVBAPI: Creating sCCIAdapter for device 0 Jan 31 21:01:11 eeepc vdr: [9836] DVBAPI: ResetSlot: log=0 Jan 31 21:01:11 eeepc vdr: [9836] DVBAPI: plugin started Jan 31 21:01:11 eeepc lircd-0.9.0-pre1[2398]: accepted new client on /var/run/lirc/lircd Jan 31 21:01:11 eeepc lircd-0.9.0-pre1[2398]: initializing '/dev/input/tbs-ir' Jan 31 21:01:11 eeepc vdr: [9836] remote control LIRC - learning keys Jan 31 21:01:11 eeepc vdr: [9845] LIRC remote control thread started (pid=9836, tid=9845, prio=high) Jan 31 21:01:11 eeepc vdr: [9844] SC-CI adapter on device 0 thread started (pid=9836, tid=9844, prio=high) Jan 31 21:01:11 eeepc vdr: [9842] section handler thread started (pid=9836, tid=9842, prio=low) Jan 31 21:01:11 eeepc vdr: [9843] Socket Handler thread started (pid=9836, tid=9843, prio=high) Jan 31 21:01:11 eeepc vdr: [9843] DVBAPI: Action Jan 31 21:01:11 eeepc vdr: [9841] tuner on frontend 0/0 thread started (pid=9836, tid=9841, prio=high) Jan 31 21:01:11 eeepc vdr: [9836] ERROR: no OSD provider available - using dummy OSD! Jan 31 21:01:11 eeepc vdr: [9844] DVBAPI: 0.0: doReply changed, reset triggered Jan 31 21:01:11 eeepc vdr: [9844] DVBAPI: ResetSlot: log=0 Jan 31 21:01:11 eeepc vdr: [9844] DVBAPI: 0.0: now using CAIDs version 1 Jan 31 21:01:11 eeepc vdr: [9844] DVBAPI: 0.0: status 'present' Jan 31 21:01:11 eeepc vdr: [9844] CAM 1: module present Jan 31 21:01:12 eeepc vdr: [9844] DVBAPI: 0.0: status 'reset' Jan 31 21:01:12 eeepc vdr: [9844] CAM 1: module reset Jan 31 21:01:12 eeepc vdr: [9844] DVBAPI: 0.0: status 'ready' Jan 31 21:01:12 eeepc vdr: [9844] CAM 1: module ready Jan 31 21:01:12 eeepc vdr: [9844] DVBAPI: CaInfo: 0.0 sending CA info Jan 31 21:01:12 eeepc vdr: [9844] CAM 1: system ids: FFFF Jan 31 21:01:13 eeepc vdr: [9844] DVBAPI: 0.0 CA_PMT decoding len=7 lm=3 prg=0 len=1 Jan 31 21:01:13 eeepc vdr: [9844] DVBAPI: ci_cmd(G)=03 Jan 31 21:01:13 eeepc vdr: [9844] DVBAPI: 0.0 got CA pmt ciCmd=3 caLm=3 Jan 31 21:01:13 eeepc vdr: [9844] DVBAPI: 0.0 answer to query Jan 31 21:01:13 eeepc vdr: [9844] DVBAPI: 0.0 no action taken Jan 31 21:01:13 eeepc vdr: [9844] CAM 1: replies to QUERY - multi channel decryption possible Jan 31 21:01:15 eeepc vdr: [9839] epg data reader thread ended (pid=9836, tid=9839) Jan 31 21:01:21 eeepc vdr: [9836] switching to channel 1 Jan 31 21:01:21 eeepc vdr: [9836] setting watchdog timer to 60 seconds Jan 31 21:01:21 eeepc vdr: [9836] OSD size changed to 720x480 @ 1 Jan 31 21:01:21 eeepc vdr: [9836] ERROR: no OSD provider available - using dummy OSD! Jan 31 21:01:22 eeepc vdr: [9836] max. latency time 1 seconds Jan 31 21:01:27 eeepc vdr: [9836] connect from 127.0.0.1, port 58431 - accepted Jan 31 21:02:47 eeepc vdr: [9836] timer 1 (2998 2103-2105 'test4.ts') added Jan 31 21:02:49 eeepc vdr: [9836] switching device 1 to channel 2998 Jan 31 21:02:51 eeepc vdr: [9836] timer 1 (2998 2103-2105 'test4.ts') set to event Fri 31.01.2014 21:00-21:20 'NBA LIVE' Jan 31 21:03:00 eeepc vdr: [9836] CAM 1: assigned to device 1 Jan 31 21:03:00 eeepc vdr: [9836] switching device 1 to channel 2998 Jan 31 21:03:00 eeepc vdr: [9836] timer 1 (2998 2103-2105 'test4.ts') start Jan 31 21:03:00 eeepc vdr: [9836] Title: 'NBA LIVE' Subtitle: '' Jan 31 21:03:00 eeepc vdr: [9836] executing '/usr/lib/vdr/vdr-recordingaction before "/var/lib/video.00/test4.ts/2014-01-31.21.03.2998-0.rec"' Jan 31 21:03:00 eeepc recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom before recording /var/lib/video.00/test4.ts/2014-01-31.21.03.2998-0.rec as shell script Jan 31 21:03:00 eeepc vdr: [9836] record /var/lib/video.00/test4.ts/2014-01-31.21.03.2998-0.rec Jan 31 21:03:00 eeepc vdr: [9836] creating directory /var/lib/video.00/test4.ts Jan 31 21:03:00 eeepc vdr: [9836] creating directory /var/lib/video.00/test4.ts/2014-01-31.21.03.2998-0.rec Jan 31 21:03:00 eeepc vdr: [9836] recording to '/var/lib/video.00/test4.ts/2014-01-31.21.03.2998-0.rec/00001.ts' Jan 31 21:03:00 eeepc vdr: [9836] DVBAPI: 0.0 CA_PMT decoding len=2a lm=4 prg=30760 len=0 Jan 31 21:03:00 eeepc vdr: [9836] DVBAPI: pid=2,00a1 len=7 (0x7) Jan 31 21:03:00 eeepc vdr: [9836] DVBAPI: ci_cmd(S)=01 Jan 31 21:03:00 eeepc vdr: [9836] DVBAPI: pid=6,0056 len=7 (0x7) Jan 31 21:03:00 eeepc vdr: [9836] DVBAPI: ci_cmd(S)=01 Jan 31 21:03:00 eeepc vdr: [9836] DVBAPI: pid=6,0057 len=7 (0x7) Jan 31 21:03:00 eeepc vdr: [9836] DVBAPI: ci_cmd(S)=01 Jan 31 21:03:00 eeepc vdr: [9836] DVBAPI: 0.0 got CA pmt ciCmd=1 caLm=4 Jan 31 21:03:00 eeepc vdr: [9836] DVBAPI: 0.0 answer to query surpressed Jan 31 21:03:00 eeepc vdr: [9836] DVBAPI: 0.0 set CAM decrypt (SID 30760, caLm 4, HasCaDescriptors 1) Jan 31 21:03:00 eeepc vdr: [9836] DVBAPI: send: channelSid=0x7828 (30760) Jan 31 21:03:00 eeepc vdr: [9836] DVBAPI: created socket with socket_fd=18 Jan 31 21:03:00 eeepc vdr: [9836] DVBAPI: socket_fd=18 toWrite=53 wrote=53 Jan 31 21:03:00 eeepc vdr: [9858] recording thread started (pid=9836, tid=9858, prio=high) Jan 31 21:03:00 eeepc vdr: [9859] receiver on device 1 thread started (pid=9836, tid=9859, prio=high) Jan 31 21:03:00 eeepc vdr: [9860] TS buffer on device 1 thread started (pid=9836, tid=9860, prio=high) Jan 31 21:03:00 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_PID request, adapter_index=0 Jan 31 21:03:00 eeepc vdr: [9843] DVBAPI: 0.0: set pid 00a1 Jan 31 21:03:00 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_PID request, adapter_index=0 Jan 31 21:03:00 eeepc vdr: [9843] DVBAPI: 0.0: set pid 0056 Jan 31 21:03:00 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_PID request, adapter_index=0 Jan 31 21:03:00 eeepc vdr: [9843] DVBAPI: 0.0: set pid 0057 Jan 31 21:03:00 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:03:00 eeepc vdr: [9843] DVBAPI: SetDescr Jan 31 21:03:00 eeepc vdr: [9843] DVBAPI: 0.0: even key set Jan 31 21:03:00 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:03:00 eeepc vdr: [9843] DVBAPI: SetDescr Jan 31 21:03:00 eeepc vdr: [9843] DVBAPI: 0.0: odd key set Jan 31 21:03:01 eeepc vdr: [9860] i/o throttle activated, count = 1 (tid=9860) Jan 31 21:03:02 eeepc vdr: [9860] buffer usage: 70% (tid=9859) Jan 31 21:03:02 eeepc vdr: [9860] buffer usage: 80% (tid=9859) Jan 31 21:03:02 eeepc vdr: [9860] buffer usage: 90% (tid=9859) Jan 31 21:03:03 eeepc vdr: [9860] buffer usage: 100% (tid=9859) Jan 31 21:03:04 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:05 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:06 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:07 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:08 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:03:08 eeepc vdr: [9843] DVBAPI: SetDescr Jan 31 21:03:08 eeepc vdr: [9843] DVBAPI: 0.0: odd key set Jan 31 21:03:08 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:09 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:11 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:12 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:13 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:15 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:16 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:17 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:18 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:18 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:03:18 eeepc vdr: [9843] DVBAPI: SetDescr Jan 31 21:03:18 eeepc vdr: [9843] DVBAPI: 0.0: even key set Jan 31 21:03:19 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:20 eeepc vdr: [9858] executing '/usr/lib/vdr/vdr-recordingaction started "/var/lib/video.00/test4.ts/2014-01-31.21.03.2998-0.rec"' Jan 31 21:03:20 eeepc recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom as shell script Jan 31 21:03:21 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:22 eeepc vdr: [9859] ERROR: skipped 123 bytes to sync on TS packet on device 1 Jan 31 21:03:23 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:24 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:26 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:27 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:28 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:03:28 eeepc vdr: [9843] DVBAPI: SetDescr Jan 31 21:03:28 eeepc vdr: [9843] DVBAPI: 0.0: odd key set Jan 31 21:03:28 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:30 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:31 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:33 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:34 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:35 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:37 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:38 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:38 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:03:38 eeepc vdr: [9843] DVBAPI: SetDescr Jan 31 21:03:38 eeepc vdr: [9843] DVBAPI: 0.0: even key set Jan 31 21:03:39 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:40 eeepc vdr: [9858] ERROR: skipped 188 bytes to sync on start of TS packet Jan 31 21:03:41 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:41 eeepc vdr: [9859] ERROR: skipped 123 bytes to sync on TS packet on device 1 Jan 31 21:03:43 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:45 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:46 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:48 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:48 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:03:48 eeepc vdr: [9843] DVBAPI: SetDescr Jan 31 21:03:48 eeepc vdr: [9843] DVBAPI: 0.0: odd key set Jan 31 21:03:49 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:51 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:53 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:54 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:55 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:56 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:58 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:03:58 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:03:58 eeepc vdr: [9843] DVBAPI: SetDescr Jan 31 21:03:58 eeepc vdr: [9843] DVBAPI: 0.0: even key set Jan 31 21:04:00 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:00 eeepc vdr: [9859] ERROR: skipped 123 bytes to sync on TS packet on device 1 Jan 31 21:04:02 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:04 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:05 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:07 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:08 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:04:08 eeepc vdr: [9843] DVBAPI: SetDescr Jan 31 21:04:08 eeepc vdr: [9843] DVBAPI: 0.0: odd key set Jan 31 21:04:09 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:10 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:12 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:13 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:15 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:16 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:18 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:04:18 eeepc vdr: [9843] DVBAPI: SetDescr Jan 31 21:04:18 eeepc vdr: [9843] DVBAPI: 0.0: even key set Jan 31 21:04:18 eeepc vdr: [9859] ERROR: skipped 123 bytes to sync on TS packet on device 1 Jan 31 21:04:19 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:20 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:22 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:23 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:25 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:26 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:28 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:28 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:04:28 eeepc vdr: [9843] DVBAPI: SetDescr Jan 31 21:04:28 eeepc vdr: [9843] DVBAPI: 0.0: odd key set Jan 31 21:04:29 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:31 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:34 eeepc vdr: [9859] ERROR: skipped 106 bytes to sync on TS packet on device 1 Jan 31 21:04:34 eeepc vdr: [9859] ERROR: skipped 17 bytes to sync on TS packet on device 1 Jan 31 21:04:34 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:36 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:38 eeepc vdr: [9860] ERROR: driver buffer overflow on device 1 Jan 31 21:04:38 eeepc vdr: [9843] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:04:38 eeepc vdr: [9843] DVBAPI: SetDescr Jan 31 21:04:38 eeepc vdr: [9843] DVBAPI: 0.0: even key set

imperia777 commented 10 years ago

this is with ci.c original state. also i beleive some of my overflow error are related to the high cpu usage. because my cpu is only 900mhz compared to Christian-MLD.

manio commented 10 years ago

@imperia777 Please revert all VDR changes, use my clean perftest and apply this VDR patch (you didn't test this patch yet, right?): http://skyboo.net/p3.diff

imperia777 commented 10 years ago

stock vdr-2.1.4 with perftest and p3.. ok.. coming.

imperia777 commented 10 years ago

Jan 31 21:26:11 eeepc vdr: [11200] timer 1 (2998 2126-2130 'test4.ts') start Jan 31 21:26:11 eeepc vdr: [11200] Title: 'PANATHINAIKOS - FC... (HD)' Subtitle: '(null)' Jan 31 21:26:11 eeepc vdr: [11200] executing '/usr/lib/vdr/vdr-recordingaction before "/var/lib/video.00/test4.ts/2014-01-31.21.26.2998-0.rec"' Jan 31 21:26:11 eeepc recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom before recording /var/lib/video.00/test4.ts/2014-01-31.21.26.2998-0.rec as shell script Jan 31 21:26:11 eeepc vdr: [11200] record /var/lib/video.00/test4.ts/2014-01-31.21.26.2998-0.rec Jan 31 21:26:11 eeepc vdr: [11200] creating directory /var/lib/video.00/test4.ts/2014-01-31.21.26.2998-0.rec Jan 31 21:26:11 eeepc vdr: [11200] recording to '/var/lib/video.00/test4.ts/2014-01-31.21.26.2998-0.rec/00001.ts' Jan 31 21:26:11 eeepc vdr: [11221] recording thread started (pid=11200, tid=11221, prio=high) Jan 31 21:26:11 eeepc vdr: [11200] DVBAPI: 0.0 CA_PMT decoding len=15 lm=4 prg=30760 len=0 Jan 31 21:26:11 eeepc vdr: [11200] DVBAPI: pid=2,00a1 len=0 (0x0) Jan 31 21:26:11 eeepc vdr: [11200] DVBAPI: pid=6,0056 len=0 (0x0) Jan 31 21:26:11 eeepc vdr: [11200] DVBAPI: pid=6,0057 len=0 (0x0) Jan 31 21:26:11 eeepc vdr: [11200] DVBAPI: 0.0 got CA pmt ciCmd=-1 caLm=4 Jan 31 21:26:11 eeepc vdr: [11200] DVBAPI: 0.0 answer to query surpressed Jan 31 21:26:11 eeepc vdr: [11200] DVBAPI: 0.0 set CAM decrypt (SID 30760, caLm 4, HasCaDescriptors 0) Jan 31 21:26:11 eeepc vdr: [11200] DVBAPI: CA_PMT doesn't contain CA desriptors Jan 31 21:26:11 eeepc vdr: [11222] receiver on device 1 thread started (pid=11200, tid=11222, prio=high) Jan 31 21:26:11 eeepc vdr: [11223] TS buffer on device 1 thread started (pid=11200, tid=11223, prio=high) Jan 31 21:26:14 eeepc vdr: [11200] timer 1 (2998 2126-2130 'test4.ts') set to event Fri 31.01.2014 21:20-23:30 'PANATHINAIKOS - FC... (HD)' Jan 31 21:26:27 eeepc vdr: [11200] stopping recording due to modification of channel 2998 Jan 31 21:26:27 eeepc vdr: [11221] recording thread ended (pid=11200, tid=11221) Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: 0.0 CA_PMT decoding len=6 lm=5 prg=30760 len=0 Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: 0.0 got CA pmt ciCmd=-1 caLm=5 Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: 0.0 answer to query surpressed Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: 0.0 set CAM decrypt (SID 30760, caLm 5, HasCaDescriptors 0) Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: 0.0 CA_PMT decoding len=6 lm=3 prg=0 len=0 Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: 0.0 got CA pmt ciCmd=-1 caLm=3 Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: 0.0 answer to query surpressed Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: 0.0 stop decrypt Jan 31 21:26:27 eeepc vdr: [11200] CAM 1: unassigned Jan 31 21:26:27 eeepc vdr: [11200] buffer stats: 227668 (1%) used Jan 31 21:26:27 eeepc vdr: [11200] timer 1 (2998 2126-2130 'test4.ts') stop Jan 31 21:26:27 eeepc vdr: [11200] executing '/usr/lib/vdr/vdr-recordingaction after "/var/lib/video.00/test4.ts/2014-01-31.21.26.2998-0.rec"' Jan 31 21:26:27 eeepc recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom after recording /var/lib/video.00/test4.ts/2014-01-31.21.26.2998-0.rec as shell script Jan 31 21:26:27 eeepc vdr: [11200] CAM 1: assigned to device 1 Jan 31 21:26:27 eeepc vdr: [11200] switching device 1 to channel 2998 Jan 31 21:26:27 eeepc vdr: [11200] timer 1 (2998 2126-2130 'test4.ts') start Jan 31 21:26:27 eeepc vdr: [11200] Title: 'PANATHINAIKOS - FC... (HD)' Subtitle: '' Jan 31 21:26:27 eeepc vdr: [11200] executing '/usr/lib/vdr/vdr-recordingaction before "/var/lib/video.00/test4.ts/2014-01-31.21.26.2998-0.rec"' Jan 31 21:26:27 eeepc vdr: [11223] TS buffer on device 1 thread ended (pid=11200, tid=11223) Jan 31 21:26:27 eeepc vdr: [11222] buffer stats: 35344 (0%) used Jan 31 21:26:27 eeepc vdr: [11222] receiver on device 1 thread ended (pid=11200, tid=11222) Jan 31 21:26:27 eeepc recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom before recording /var/lib/video.00/test4.ts/2014-01-31.21.26.2998-0.rec as shell script Jan 31 21:26:27 eeepc vdr: [11200] record /var/lib/video.00/test4.ts/2014-01-31.21.26.2998-0.rec Jan 31 21:26:27 eeepc vdr: [11200] cFileName::SetOffset: removing zero-sized file /var/lib/video.00/test4.ts/2014-01-31.21.26.2998-0.rec/00001.ts Jan 31 21:26:27 eeepc vdr: [11200] recording to '/var/lib/video.00/test4.ts/2014-01-31.21.26.2998-0.rec/00001.ts' Jan 31 21:26:27 eeepc vdr: [11238] recording thread started (pid=11200, tid=11238, prio=high) Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: 0.0 CA_PMT decoding len=2a lm=4 prg=30760 len=0 Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: pid=2,00a1 len=7 (0x7) Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: ci_cmd(S)=01 Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: pid=6,0056 len=7 (0x7) Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: ci_cmd(S)=01 Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: pid=6,0057 len=7 (0x7) Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: ci_cmd(S)=01 Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: 0.0 got CA pmt ciCmd=1 caLm=4 Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: 0.0 answer to query surpressed Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: 0.0 set CAM decrypt (SID 30760, caLm 4, HasCaDescriptors 1) Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: send: channelSid=0x7828 (30760) Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: created socket with socket_fd=19 Jan 31 21:26:27 eeepc vdr: [11200] DVBAPI: socket_fd=19 toWrite=53 wrote=53 Jan 31 21:26:27 eeepc vdr: [11239] receiver on device 1 thread started (pid=11200, tid=11239, prio=high) Jan 31 21:26:27 eeepc vdr: [11240] TS buffer on device 1 thread started (pid=11200, tid=11240, prio=high) Jan 31 21:26:27 eeepc vdr: [11207] DVBAPI: Action: Got CA_SET_PID request, adapter_index=0 Jan 31 21:26:27 eeepc vdr: [11207] DVBAPI: 0.0: set pid 00a1 Jan 31 21:26:27 eeepc vdr: [11207] DVBAPI: Action: Got CA_SET_PID request, adapter_index=0 Jan 31 21:26:27 eeepc vdr: [11207] DVBAPI: 0.0: set pid 0056 Jan 31 21:26:27 eeepc vdr: [11207] DVBAPI: Action: Got CA_SET_PID request, adapter_index=0 Jan 31 21:26:27 eeepc vdr: [11207] DVBAPI: 0.0: set pid 0057 Jan 31 21:26:27 eeepc vdr: [11207] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:26:27 eeepc vdr: [11207] DVBAPI: SetDescr Jan 31 21:26:27 eeepc vdr: [11207] DVBAPI: 0.0: even key set Jan 31 21:26:27 eeepc vdr: [11207] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:26:27 eeepc vdr: [11207] DVBAPI: SetDescr Jan 31 21:26:27 eeepc vdr: [11207] DVBAPI: 0.0: odd key set Jan 31 21:26:28 eeepc vdr: [11238] executing '/usr/lib/vdr/vdr-recordingaction started "/var/lib/video.00/test4.ts/2014-01-31.21.26.2998-0.rec"' Jan 31 21:26:28 eeepc recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom as shell script Jan 31 21:26:28 eeepc vdr: [11207] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:26:28 eeepc vdr: [11207] DVBAPI: SetDescr Jan 31 21:26:28 eeepc vdr: [11207] DVBAPI: 0.0: odd key set Jan 31 21:26:38 eeepc vdr: [11207] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:26:38 eeepc vdr: [11207] DVBAPI: SetDescr Jan 31 21:26:38 eeepc vdr: [11207] DVBAPI: 0.0: even key set Jan 31 21:26:48 eeepc vdr: [11207] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:26:48 eeepc vdr: [11207] DVBAPI: SetDescr Jan 31 21:26:48 eeepc vdr: [11207] DVBAPI: 0.0: odd key set Jan 31 21:26:58 eeepc vdr: [11207] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:26:58 eeepc vdr: [11207] DVBAPI: SetDescr Jan 31 21:26:58 eeepc vdr: [11207] DVBAPI: 0.0: even key set Jan 31 21:27:08 eeepc vdr: [11207] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:27:08 eeepc vdr: [11207] DVBAPI: SetDescr Jan 31 21:27:08 eeepc vdr: [11207] DVBAPI: 0.0: odd key set Jan 31 21:27:18 eeepc vdr: [11207] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:27:18 eeepc vdr: [11207] DVBAPI: SetDescr Jan 31 21:27:18 eeepc vdr: [11207] DVBAPI: 0.0: even key set Jan 31 21:27:28 eeepc vdr: [11207] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 21:27:28 eeepc vdr: [11207] DVBAPI: SetDescr Jan 31 21:27:28 eeepc vdr: [11207] DVBAPI: 0.0: odd key set

imperia777 commented 10 years ago

it is recording with this patch.. but the cpu usage remains 100%

manio commented 10 years ago

@imperia777 Still not tired with my patches? :) I've updated the master (and added one fix which may be relevant). You may try it with stock vdr.

imperia777 commented 10 years ago

who? me? no! i hope you are just getting started :) stock vdr 2.1.4 + master

imperia777 commented 10 years ago

Jan 31 22:10:04 eeepc vdr: [4636] timer 1 (2998 2210-2215 'test6.ts') start Jan 31 22:10:04 eeepc vdr: [4636] Title: 'PANATHINAIKOS - FC... (HD)' Subtitle: '' Jan 31 22:10:04 eeepc vdr: [4636] executing '/usr/lib/vdr/vdr-recordingaction before "/var/lib/video.00/test6.ts/2014-01-31.22.10.2998-0.rec"' Jan 31 22:10:04 eeepc recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom before recording /var/lib/video.00/test6.ts/2014-01-31.22.10.2998-0.rec as shell script Jan 31 22:10:04 eeepc vdr: [4636] record /var/lib/video.00/test6.ts/2014-01-31.22.10.2998-0.rec Jan 31 22:10:04 eeepc vdr: [4636] creating directory /var/lib/video.00/test6.ts Jan 31 22:10:04 eeepc vdr: [4636] creating directory /var/lib/video.00/test6.ts/2014-01-31.22.10.2998-0.rec Jan 31 22:10:04 eeepc vdr: [4636] recording to '/var/lib/video.00/test6.ts/2014-01-31.22.10.2998-0.rec/00001.ts' Jan 31 22:10:04 eeepc vdr: [4747] recording thread started (pid=4636, tid=4747, prio=high) Jan 31 22:10:04 eeepc vdr: [4636] DVBAPI: 0.0 CA_PMT decoding len=2a lm=4 prg=30760 len=0 Jan 31 22:10:04 eeepc vdr: [4636] DVBAPI: pid=2,00a1 len=7 (0x7) Jan 31 22:10:04 eeepc vdr: [4636] DVBAPI: ci_cmd(S)=01 Jan 31 22:10:04 eeepc vdr: [4636] DVBAPI: pid=6,0056 len=7 (0x7) Jan 31 22:10:04 eeepc vdr: [4636] DVBAPI: ci_cmd(S)=01 Jan 31 22:10:04 eeepc vdr: [4636] DVBAPI: pid=6,0057 len=7 (0x7) Jan 31 22:10:04 eeepc vdr: [4636] DVBAPI: ci_cmd(S)=01 Jan 31 22:10:04 eeepc vdr: [4636] DVBAPI: 0.0 got CA pmt ciCmd=1 caLm=4 Jan 31 22:10:04 eeepc vdr: [4636] DVBAPI: 0.0 answer to query surpressed Jan 31 22:10:04 eeepc vdr: [4636] DVBAPI: 0.0 set CAM decrypt (SID 30760, caLm 4, HasCaDescriptors 1) Jan 31 22:10:04 eeepc vdr: [4636] DVBAPI: send: channelSid=0x7828 (30760) Jan 31 22:10:04 eeepc vdr: [4636] DVBAPI: created socket with socket_fd=19 Jan 31 22:10:04 eeepc vdr: [4636] DVBAPI: socket_fd=19 toWrite=53 wrote=53 Jan 31 22:10:04 eeepc vdr: [4748] receiver on device 1 thread started (pid=4636, tid=4748, prio=high) Jan 31 22:10:04 eeepc vdr: [4749] TS buffer on device 1 thread started (pid=4636, tid=4749, prio=high) Jan 31 22:10:04 eeepc vdr: [4636] ERROR: no OSD provider available - using dummy OSD! Jan 31 22:10:04 eeepc vdr: [4644] DVBAPI: Action: Got CA_SET_PID request, adapter_index=0 Jan 31 22:10:04 eeepc vdr: [4644] DVBAPI: 0.0: set pid 00a1 Jan 31 22:10:04 eeepc vdr: [4644] DVBAPI: Action: Got CA_SET_PID request, adapter_index=0 Jan 31 22:10:04 eeepc vdr: [4644] DVBAPI: 0.0: set pid 0056 Jan 31 22:10:04 eeepc vdr: [4644] DVBAPI: Action: Got CA_SET_PID request, adapter_index=0 Jan 31 22:10:04 eeepc vdr: [4644] DVBAPI: 0.0: set pid 0057 Jan 31 22:10:04 eeepc vdr: [4644] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 22:10:04 eeepc vdr: [4644] DVBAPI: SetDescr Jan 31 22:10:04 eeepc vdr: [4644] DVBAPI: 0.0: even key set Jan 31 22:10:04 eeepc vdr: [4644] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 22:10:04 eeepc vdr: [4644] DVBAPI: SetDescr Jan 31 22:10:04 eeepc vdr: [4644] DVBAPI: 0.0: odd key set Jan 31 22:10:06 eeepc vdr: [4747] executing '/usr/lib/vdr/vdr-recordingaction started "/var/lib/video.00/test6.ts/2014-01-31.22.10.2998-0.rec"' Jan 31 22:10:06 eeepc recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom as shell script Jan 31 22:10:08 eeepc vdr: [4644] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 22:10:08 eeepc vdr: [4644] DVBAPI: SetDescr Jan 31 22:10:08 eeepc vdr: [4644] DVBAPI: 0.0: odd key set Jan 31 22:10:10 eeepc vdr: [4636] max. latency time 5 seconds Jan 31 22:10:18 eeepc vdr: [4644] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 22:10:18 eeepc vdr: [4644] DVBAPI: SetDescr Jan 31 22:10:18 eeepc vdr: [4644] DVBAPI: 0.0: even key set Jan 31 22:10:28 eeepc vdr: [4644] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 22:10:28 eeepc vdr: [4644] DVBAPI: SetDescr Jan 31 22:10:28 eeepc vdr: [4644] DVBAPI: 0.0: odd key set Jan 31 22:10:38 eeepc vdr: [4644] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 22:10:38 eeepc vdr: [4644] DVBAPI: SetDescr Jan 31 22:10:38 eeepc vdr: [4644] DVBAPI: 0.0: even key set Jan 31 22:10:40 eeepc vdr: [4636] timer 1 (2998 2210-2215 'test6.ts') set to event Fri 31.01.2014 21:20-23:30 'PANATHINAIKOS - FC... (HD)' Jan 31 22:10:48 eeepc vdr: [4644] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 22:10:48 eeepc vdr: [4644] DVBAPI: SetDescr Jan 31 22:10:48 eeepc vdr: [4644] DVBAPI: 0.0: odd key set

100% cpu usage

manio commented 10 years ago

And when you replay this recording, is it ok?

imperia777 commented 10 years ago

recording is ok. i also tried enabling streamdev. i can watch stream but i see some ring errors..

manio commented 10 years ago

Oh, so it seems that the ring errors are only when doing a streaming, but not when you're doing a regular recording?

What is your hardware? You're using FFDeCSA? If yes - what is the result of the benchmark during compile?

imperia777 commented 10 years ago

processor : 0 vendor_id : GenuineIntel cpu family : 6 model : 13 model name : Intel(R) Celeron(R) M processor 900MHz stepping : 8 microcode : 0x20 cpu MHz : 630.052 cache size : 512 KB fdiv_bug : no f00f_bug : no coma_bug : no fpu : yes fpu_exception : yes cpuid level : 2 wp : yes flags : fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov clflush dts acpi mmx fxsr sse sse2 ss tm pbe nx bts bogomips : 1260.10 clflush size : 64 cache_alignment : 64 address sizes : 32 bits physical, 32 bits virtual power management:

benchmark shows: FFdecsa 1.0: testing correctness and speed CORRECT! CORRECT! CORRECT! CORRECT! CORRECT! speed=76.923613 Mbit/s speed=52257.889199 pkts/s CORRECT! CORRECT! CORRECT! CORRECT! CORRECT!

sometimes i see a bit higher values.

should I try the other option than FFDeCSA for decoding (if yes what is it and how?)

manio commented 10 years ago

What if you run the extra/FFdecsa-benchmark.sh?

imperia777 commented 10 years ago 
### FFdecsa optimization helper/benchmark
### Version 9d
Warning: No valid path specified
Searching...
Found possible FFdecsa source at:
/usr/local/src/vdr/PLUGINS/src/vdr-plugin-dvbapi/FFdecsa
...and source files looks valid.
proceed...
### CPU-INFO ###
System: x86
Auto detected arch: pentium-m
Vendor-ID: GenuineIntel
CPU-Family: 6
CPU-Model: 13
Flags:  fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov clflush dts acpi mmx fxsr sse sse2 ss tm pbe nx bts
gcc version 4.8.2 (Debian 4.8.2-14)
Using compilers "native" flags
### FFdeCSA TEST ###
Using compiler: g++
Flags: -march=native -fexpensive-optimizations -fomit-frame-pointer -funroll-loops
Testing optimization levels 2 and 3
  Level -O2:
    PARALLEL_32_INT
      - 69, 67, 69, 67, 69, 67, 69, 67, 69, 67
      - 69 Mbit/s max.
    PARALLEL_64_2INT
      - 64, 62, 64, 63, 64, 63, 64, 64, 64, 64
      - 64 Mbit/s max.
    PARALLEL_64_LONG
      - 57, 56, 57, 56, 57, 56, 57, 56, 56, 57
      - 57 Mbit/s max.
    PARALLEL_64_MMX
      - 110, 110, 104, 110, 110, 110, 110, 109, 110, 104
      - 110 Mbit/s max.
    PARALLEL_128_2LONG
      - 57, 55, 57, 55, 57, 55, 57, 55, 55, 57
      - 57 Mbit/s max.
    PARALLEL_128_2MMX
      - 98, 94, 98, 98, 98, 98, 98, 98, 98, 94
      - 98 Mbit/s max.
    PARALLEL_128_SSE
      - 112, 106, 112, 112, 106, 112, 112, 106, 111, 112
      - 112 Mbit/s max.
    PARALLEL_128_SSE2
      - 109, 109, 103, 109, 109, 104, 109, 109, 109, 109
      - 109 Mbit/s max.
  Fastest PARALLEL_MODE = PARALLEL_128_SSE (112 Mbit/s)
  Level -O3:
    PARALLEL_32_INT
    ...failed!
    PARALLEL_64_2INT
    ...failed!
    PARALLEL_64_LONG
      - 67, 65, 67, 65, 67, 65, 67, 65, 67, 67
      - 67 Mbit/s max.
    PARALLEL_64_MMX
extra/FFdecsa-benchmark.sh: line 506:  5868 Segmentation fault      "${TMPDIR}/FFdecsa_test" > /dev/null 2> "${TMPOUT}"
    ...failed!
    PARALLEL_128_2LONG
      - 67, 69, 67, 69, 67, 69, 67, 69, 67, 69
      - 69 Mbit/s max.
    PARALLEL_128_2MMX
extra/FFdecsa-benchmark.sh: line 506:  5942 Segmentation fault      "${TMPDIR}/FFdecsa_test" > /dev/null 2> "${TMPOUT}"
    ...failed!
    PARALLEL_128_SSE
      - 118, 118, 118, 118, 111, 118, 118, 118, 118, 118
      - 118 Mbit/s max.
    PARALLEL_128_SSE2
      - 116, 109, 116, 116, 109, 116, 116, 116, 115, 116
      - 116 Mbit/s max.
  Fastest PARALLEL_MODE = PARALLEL_128_SSE (118 Mbit/s)
Best result with -O3 and PARALLEL_128_SSE at 118 Mbit/s
### VDR-SC Makefile FFdeCSA OPTS ###
CPUOPT     ?= native
PARALLEL   ?= PARALLEL_128_SSE
CSAFLAGS   ?= -O3 -fexpensive-optimizations -fomit-frame-pointer -funroll-loops
### GENERIC FFdeCSA make OPTS ###
FLAGS="-O3 -march=native -fexpensive-optimizations -fomit-frame-pointer -funroll-loops" PARALLEL_MODE=PARALLEL_128_SSE
manio commented 10 years ago

So you've got the best options. Try it (change the Makefile).

manio commented 10 years ago

You may also try libdvbcsa - maybe it will work better for your hardware.

imperia777 commented 10 years ago

change the makefile of what.. vdr or plugin? and what i have to change?

I have to put: CPUOPT ?= native PARALLEL ?= PARALLEL_128_SSE CSAFLAGS ?= -O3 -fexpensive-optimizations -fomit-frame-pointer -funroll-loops into the Makefile of dvbapi?

imperia777 commented 10 years ago

I never touched these but with 2.0.5 plugin works perfect.

manio commented 10 years ago

Yes, try this patch: http://pastebin.com/raw.php?i=dD9iD4LG This is always a good idea to use the best settings in this case.

manio commented 10 years ago

Still 100% cpu when recording? If yes, run htop and type F5 to see a vdr threads and tell me what thread is eating the cpu at most.

imperia777 commented 10 years ago

2300

manio commented 10 years ago

htop->Setup->Display options->Show custom thread names

imperia777 commented 10 years ago

2310

manio commented 10 years ago

So this is probably the decryption. Last patch for today: Stock VDR + this: http://skyboo.net/p4.diff Please then try the live view, but try harder with channel switching (at least two zaps to the same channel).

imperia777 commented 10 years ago

what is live view? :)

manio commented 10 years ago

streamdev

imperia777 commented 10 years ago

ok. i am watching thru streamdev with this patch.. cpu usage is still 100%. i tried PLAY/STOP button combination few times to restart stream and channel.

manio commented 10 years ago

Does it plays fine?

imperia777 commented 10 years ago

yes - video plays fine.

even while cpu is 100% i still can even run another stream from same transponder and video still plays fine on both. some ring buffer errors appear.

manio commented 10 years ago

This is weird. And on 2.0.5 it works the same but you don't have this ring buffer errors?

imperia777 commented 10 years ago

i posted one screenshot earlier. where htop shows 40% cpu usage. i am with 2 stream HD (encrypted). no errors, no overflows. 2.0.5 + 1.0.6 dvbapi plugin. cpu usage was jumping 20-40%

imperia777 commented 10 years ago

i got small ring buffer errors even with 1 stream right now.. i don't think i saw them while recording to disk. this may be related to streamdev issues with 2.1.4 you mention earlier.

still video runs fine.

imperia777 commented 10 years ago

Jan 31 23:33:49 eeepc vdr: [7102] DVBAPI: 0.0: odd key set Jan 31 23:33:50 eeepc vdr: [7100] ERROR: 38 ring buffer overflows (7144 bytes dropped) Jan 31 23:33:57 eeepc vdr: [7100] ERROR: 16 ring buffer overflows (3008 bytes dropped) Jan 31 23:33:59 eeepc vdr: [7102] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 23:33:59 eeepc vdr: [7102] DVBAPI: SetDescr Jan 31 23:33:59 eeepc vdr: [7102] DVBAPI: 0.0: even key set Jan 31 23:34:03 eeepc vdr: [7100] ERROR: 26 ring buffer overflows (4888 bytes dropped) Jan 31 23:34:09 eeepc vdr: [7102] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 23:34:09 eeepc vdr: [7102] DVBAPI: SetDescr Jan 31 23:34:09 eeepc vdr: [7102] DVBAPI: 0.0: odd key set Jan 31 23:34:10 eeepc vdr: [7100] ERROR: 24 ring buffer overflows (4512 bytes dropped) Jan 31 23:34:16 eeepc vdr: [7100] ERROR: 19 ring buffer overflows (3572 bytes dropped) Jan 31 23:34:19 eeepc vdr: [7102] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 23:34:19 eeepc vdr: [7102] DVBAPI: SetDescr Jan 31 23:34:19 eeepc vdr: [7102] DVBAPI: 0.0: even key set Jan 31 23:34:23 eeepc vdr: [7100] ERROR: 23 ring buffer overflows (4324 bytes dropped) Jan 31 23:34:29 eeepc vdr: [7102] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 23:34:29 eeepc vdr: [7102] DVBAPI: SetDescr Jan 31 23:34:29 eeepc vdr: [7102] DVBAPI: 0.0: odd key set Jan 31 23:34:29 eeepc vdr: [7100] ERROR: 21 ring buffer overflows (3948 bytes dropped) Jan 31 23:34:36 eeepc vdr: [7100] ERROR: 26 ring buffer overflows (4888 bytes dropped) Jan 31 23:34:39 eeepc vdr: [7102] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 23:34:39 eeepc vdr: [7102] DVBAPI: SetDescr Jan 31 23:34:39 eeepc vdr: [7102] DVBAPI: 0.0: even key set Jan 31 23:34:42 eeepc vdr: [7100] ERROR: 16 ring buffer overflows (3008 bytes dropped) Jan 31 23:34:49 eeepc vdr: [7100] ERROR: 20 ring buffer overflows (3760 bytes dropped) Jan 31 23:34:49 eeepc vdr: [7102] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 23:34:49 eeepc vdr: [7102] DVBAPI: SetDescr Jan 31 23:34:49 eeepc vdr: [7102] DVBAPI: 0.0: odd key set Jan 31 23:34:55 eeepc vdr: [7100] ERROR: 25 ring buffer overflows (4700 bytes dropped) Jan 31 23:34:59 eeepc vdr: [7102] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 23:34:59 eeepc vdr: [7102] DVBAPI: SetDescr

imperia777 commented 10 years ago

or ring buffer errors may be related to the high cpu usage. i saw earlier "i/o throttling activated" message by vdr just after starting stream.

imperia777 commented 10 years ago

as i am continuing to watch same channel. ring buffer error stopped.

Jan 31 23:36:59 eeepc vdr: [7102] DVBAPI: 0.0: even key set Jan 31 23:37:09 eeepc vdr: [7102] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 23:37:09 eeepc vdr: [7102] DVBAPI: SetDescr Jan 31 23:37:09 eeepc vdr: [7102] DVBAPI: 0.0: odd key set Jan 31 23:37:19 eeepc vdr: [7102] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 23:37:19 eeepc vdr: [7102] DVBAPI: SetDescr Jan 31 23:37:19 eeepc vdr: [7102] DVBAPI: 0.0: even key set Jan 31 23:37:29 eeepc vdr: [7102] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 23:37:29 eeepc vdr: [7102] DVBAPI: SetDescr Jan 31 23:37:29 eeepc vdr: [7102] DVBAPI: 0.0: odd key set Jan 31 23:37:39 eeepc vdr: [7102] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 23:37:39 eeepc vdr: [7102] DVBAPI: SetDescr Jan 31 23:37:39 eeepc vdr: [7102] DVBAPI: 0.0: even key set Jan 31 23:37:49 eeepc vdr: [7102] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 23:37:49 eeepc vdr: [7102] DVBAPI: SetDescr Jan 31 23:37:49 eeepc vdr: [7102] DVBAPI: 0.0: odd key set Jan 31 23:37:59 eeepc vdr: [7102] DVBAPI: Action: Got CA_SET_DESCR request, adapter_index=0 Jan 31 23:37:59 eeepc vdr: [7102] DVBAPI: SetDescr Jan 31 23:37:59 eeepc vdr: [7102] DVBAPI: 0.0: even key set

manio commented 10 years ago

Can you maybe try libdvbcsa? Just curious if it changes something...

imperia777 commented 10 years ago

fast instructions how to install it?

imperia777 commented 10 years ago

apt-get install libdvbcsa-dev ?

manio commented 10 years ago

ubuntu/debian: sudo aptitude install libdvbcsa-dev make clean in dvbapi plugin dir cd /usr/src/vdr LIBDVBCSA=1 make install-plugins

imperia777 commented 10 years ago

its the same

manio commented 10 years ago

If you have about 30mins you can wait for one patch, if not you can try it eg tomorrow. I'll try to cook it.

imperia777 commented 10 years ago

i am here on computer anyway. no problem for me to check every 5 minutes for new messages here.

If you think it can help you: I can provide you shell account on my headless vdr server so you can patch and test it, but its compilation speed is not the best :)

manio commented 10 years ago

I'm sorry, I have to sleep on it... It was a hard day. I'll let you know when I have something to test. Thank you for your time.

imperia777 commented 10 years ago

Ok. see ya. I'll be checking around.

manio commented 10 years ago

Oh wait ... I think i found something ;)

imperia777 commented 10 years ago

Nice i am checking again :) so soon

manio commented 10 years ago

Ok. First - revert to stock VDR 2.1.4 and my master plugin. Next apply: VDR -> http://skyboo.net/perf/vdr.diff dvbapi-plugin -> http://skyboo.net/perf/plugin.diff and give it a try