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

nothing happening #54

Closed jteeuw closed 10 years ago

jteeuw commented 10 years ago

Hello,

i have build a new setup , with vdr 2.1.6 and oscam ,

nothing happening in oscam or vdr logs

Apr 24 10:01:13 tvheadend vdr: [12352] VDR version 2.1.6 started Apr 24 10:01:13 tvheadend vdr: [12352] switched to user 'vdr' Apr 24 10:01:13 tvheadend vdr: [12352] codeset is 'UTF-8' - known Apr 24 10:01:13 tvheadend vdr: [12352] found 28 locales in /usr/share/locale Apr 24 10:01:13 tvheadend vdr: [12352] loading plugin: /usr/lib/vdr/plugins/libvdr-live.so.2.1.6 Apr 24 10:01:13 tvheadend vdr: [12352] loading plugin: /usr/lib/vdr/plugins/libvdr-streamdev-server.so.2.1.6 Apr 24 10:01:13 tvheadend vdr: [12352] loading plugin: /usr/lib/vdr/plugins/libvdr-vnsiserver.so.2.1.6 Apr 24 10:01:13 tvheadend vdr: [12352] loading plugin: /usr/lib/vdr/plugins/libvdr-dvbapi.so.2.1.6 Apr 24 10:01:13 tvheadend vdr: [12352] loading /var/lib/vdr/setup.conf Apr 24 10:01:13 tvheadend vdr: [12352] loading /var/lib/vdr/channels.conf Apr 24 10:01:13 tvheadend vdr: [12352] loading /var/lib/vdr/timers.conf Apr 24 10:01:13 tvheadend vdr: [12352] loading /var/lib/vdr/commands.conf Apr 24 10:01:13 tvheadend vdr: [12352] loading /var/lib/vdr/reccmds.conf Apr 24 10:01:13 tvheadend vdr: [12354] video directory scanner thread started (pid=12352, tid=12354, prio=high) Apr 24 10:01:13 tvheadend vdr: [12353] video directory scanner thread started (pid=12352, tid=12353, prio=high) Apr 24 10:01:13 tvheadend vdr: [12352] registered source parameters for 'A - ATSC' Apr 24 10:01:13 tvheadend vdr: [12352] registered source parameters for 'C - DVB-C' Apr 24 10:01:13 tvheadend vdr: [12353] video directory scanner thread ended (pid=12352, tid=12353) Apr 24 10:01:13 tvheadend vdr: [12352] registered source parameters for 'S - DVB-S' Apr 24 10:01:13 tvheadend vdr: [12352] registered source parameters for 'T - DVB-T' Apr 24 10:01:13 tvheadend vdr: [12354] video directory scanner thread ended (pid=12352, tid=12354) Apr 24 10:01:13 tvheadend vdr: [12355] epg data reader thread started (pid=12352, tid=12355, prio=high) Apr 24 10:01:13 tvheadend vdr: [12355] reading EPG data from /var/cache/vdr/epg.data Apr 24 10:01:13 tvheadend vdr: [12352] probing /dev/dvb/adapter0/frontend0 Apr 24 10:01:13 tvheadend vdr: [12352] creating cDvbDevice Apr 24 10:01:13 tvheadend vdr: [12352] new device number 1 Apr 24 10:01:13 tvheadend vdr: [12352] DVB API version is 0x050A (VDR was built with 0x050A) Apr 24 10:01:13 tvheadend vdr: [12352] frontend 0/0 provides DVB-C,DVB-T with QAM16,QAM32,QAM64,QAM128,QAM256 ("Sundtek DVB-C") Apr 24 10:01:13 tvheadend vdr: [12352] cTimeMs: using monotonic clock (resolution is 1 ns) Apr 24 10:01:13 tvheadend vdr: [12357] section handler thread started (pid=12352, tid=12357, prio=low) Apr 24 10:01:13 tvheadend vdr: [12352] found 1 DVB device Apr 24 10:01:13 tvheadend vdr: [12352] initializing plugin: live (0.3.0): Live Interactive VDR Environment Apr 24 10:01:13 tvheadend vdr: [12352] initializing plugin: streamdev-server (0.6.1-git): VDR Streaming Server Apr 24 10:01:13 tvheadend vdr: [12352] initializing plugin: vnsiserver (1.0.0): VDR-Network-Streaming-Interface (VNSI) Server Apr 24 10:01:13 tvheadend vdr: [12352] initializing plugin: dvbapi (2.1.0-GIT-6ee9d62): SoftCAM for OSCam Apr 24 10:01:13 tvheadend vdr: [12352] setting primary device to 1 Apr 24 10:01:13 tvheadend vdr: [12352] device 1 has no MPEG decoder Apr 24 10:01:13 tvheadend vdr: [12352] assuming manual start of VDR Apr 24 10:01:13 tvheadend vdr: [12352] SVDRP listening on port 6419 Apr 24 10:01:13 tvheadend vdr: [12352] setting current skin to "lcars" Apr 24 10:01:13 tvheadend vdr: [12352] loading /var/lib/vdr/themes/lcars-default.theme Apr 24 10:01:13 tvheadend vdr: [12352] starting plugin: live Apr 24 10:01:13 tvheadend vdr: [12356] tuner on frontend 0/0 thread started (pid=12352, tid=12356, prio=high) Apr 24 10:01:13 tvheadend vdr: [12352] LIVE: initial file cache has 82 entries and needs 377394 bytes of data! Apr 24 10:01:13 tvheadend vdr: [12352] starting plugin: streamdev-server Apr 24 10:01:13 tvheadend vdr: [12352] loading /var/lib/vdr/plugins/streamdev-server/streamdevhosts.conf Apr 24 10:01:13 tvheadend vdr: [12352] starting plugin: vnsiserver Apr 24 10:01:13 tvheadend vdr: [12352] VNSI: VNSI Server started Apr 24 10:01:13 tvheadend vdr: [12352] VNSI: Channel streaming timeout: 10 seconds Apr 24 10:01:13 tvheadend vdr: [12352] starting plugin: dvbapi Apr 24 10:01:13 tvheadend vdr: [12352] DVBAPI: plugin version 2.1.0-GIT-6ee9d62 initializing (VDR 2.1.6) Apr 24 10:01:13 tvheadend vdr: [12352] DVBAPI: decryption library: FFdecsa Apr 24 10:01:13 tvheadend vdr: [12359] streamdev server thread started (pid=12352, tid=12359, prio=high) Apr 24 10:01:13 tvheadend vdr: [12359] Streamdev: Listening (VTP) on port 2004 Apr 24 10:01:13 tvheadend vdr: [12359] Streamdev: Listening (HTTP) on port 3000 Apr 24 10:01:13 tvheadend vdr: [12360] VDR VNSI Server thread started (pid=12352, tid=12360, prio=high) Apr 24 10:01:13 tvheadend vdr: [12352] DVBAPI: Creating sCCIAdapter for device 0 Apr 24 10:01:13 tvheadend vdr: [12352] DVBAPI: plugin started Apr 24 10:01:13 tvheadend vdr: [12352] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:01:13 tvheadend vdr: [12352] ERROR: remote control LIRC not ready! Apr 24 10:01:13 tvheadend vdr: [12361] Socket Handler thread started (pid=12352, tid=12361, prio=high) Apr 24 10:01:13 tvheadend vdr: [12363] LIRC remote control thread started (pid=12352, tid=12363, prio=high) Apr 24 10:01:13 tvheadend vdr: [12363] ERROR: lircd connection broken, trying to reconnect every 3.0 seconds Apr 24 10:01:13 tvheadend vdr: [12362] SC-CI adapter on device 0 thread started (pid=12352, tid=12362, prio=high) Apr 24 10:01:13 tvheadend vdr: [12358] [live] INFO: attempt to listen on ip = '' Apr 24 10:01:13 tvheadend vdr: [12358] [live] ERROR: Unable to load cert/key (/var/lib/vdr/plugins/live/live.pem//var/lib/vdr/plugins/live/live-key.pem): No such file or directory Apr 24 10:01:13 tvheadend vdr: [12362] DVBAPI: 0.0: doReply changed, reset triggered Apr 24 10:01:13 tvheadend vdr: [12362] DVBAPI: 0.0: now using CAIDs version 1 Apr 24 10:01:13 tvheadend vdr: [12362] DVBAPI: 0.0: status 'present' Apr 24 10:01:13 tvheadend vdr: [12362] CAM 1: module present Apr 24 10:01:13 tvheadend vdr: [12352] DVBAPI: 0.0: status 'reset' Apr 24 10:01:13 tvheadend vdr: [12355] epg data reader thread ended (pid=12352, tid=12355) Apr 24 10:01:13 tvheadend vdr: [12352] DVBAPI: 0.0: status 'ready' Apr 24 10:01:14 tvheadend vdr: [12362] CAM 1: module ready Apr 24 10:01:14 tvheadend vdr: [12362] DVBAPI: CaInfo: 0.0 sending CA info Apr 24 10:01:14 tvheadend vdr: [12362] CAM 1: system ids: FFFF Apr 24 10:01:15 tvheadend vdr: [12362] CAM 1: replies to QUERY - multi channel decryption possible Apr 24 10:01:15 tvheadend vdr: [12352] switching to channel 1 Apr 24 10:01:15 tvheadend vdr: [12352] setting watchdog timer to 60 seconds Apr 24 10:01:15 tvheadend vdr: [12352] OSD size changed to 720x480 @ 1 Apr 24 10:01:15 tvheadend vdr: [12352] ERROR: no OSD provider available - using dummy OSD! Apr 24 10:01:16 tvheadend vdr: [12352] ERROR: Channel locked (recording)! Apr 24 10:01:16 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:01:18 tvheadend vdr: [12352] max. latency time 3 seconds Apr 24 10:01:19 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:01:37 tvheadend vdr: message repeated 6 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:01:38 tvheadend vdr: [12352] connect from 127.0.0.1, port 57217 - DENIED Apr 24 10:01:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:02:25 tvheadend vdr: message repeated 15 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:02:27 tvheadend vdr: [12359] Streamdev: Accepted new client (HTTP) 192.168.1.19:3583 Apr 24 10:02:27 tvheadend vdr: [12379] streamdev-writer thread started (pid=12352, tid=12379, prio=high) Apr 24 10:02:27 tvheadend vdr: [12380] streamdev-livestreaming thread started (pid=12352, tid=12380, prio=high) Apr 24 10:02:28 tvheadend vdr: [12382] receiver on device 1 thread started (pid=12352, tid=12382, prio=high) Apr 24 10:02:28 tvheadend vdr: [12383] TS buffer on device 1 thread started (pid=12352, tid=12383, prio=high) Apr 24 10:02:28 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:02:31 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:02:33 tvheadend vdr: [12359] ERROR: read from client (HTTP) 192.168.1.19:3583 failed: Connection reset by peer Apr 24 10:02:33 tvheadend vdr: [12359] streamdev-server: closing HTTP connection to 192.168.1.19:3583 Apr 24 10:02:33 tvheadend vdr: [12383] TS buffer on device 1 thread ended (pid=12352, tid=12383) Apr 24 10:02:33 tvheadend vdr: [12382] buffer stats: 121824 (2%) used Apr 24 10:02:33 tvheadend vdr: [12382] receiver on device 1 thread ended (pid=12352, tid=12382) Apr 24 10:02:33 tvheadend vdr: [12380] streamdev-livestreaming thread ended (pid=12352, tid=12380) Apr 24 10:02:33 tvheadend vdr: [12379] streamdev-writer thread ended (pid=12352, tid=12379) Apr 24 10:02:33 tvheadend vdr: [12359] buffer stats: 120508 (3%) used Apr 24 10:02:34 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:02:37 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:02:37 tvheadend vdr: [12359] Streamdev: Accepted new client (HTTP) 192.168.1.19:3586 Apr 24 10:02:37 tvheadend vdr: [12359] CAM 1: assigned to device 1 Apr 24 10:02:37 tvheadend vdr: [12385] streamdev-writer thread started (pid=12352, tid=12385, prio=high) Apr 24 10:02:37 tvheadend vdr: [12386] streamdev-livestreaming thread started (pid=12352, tid=12386, prio=high) Apr 24 10:02:38 tvheadend vdr: [12352] connect from 127.0.0.1, port 57218 - DENIED Apr 24 10:02:38 tvheadend vdr: [12359] DVBAPI: 0.0 set CAM decrypt (SID 19561, caLm 4, HasCaDescriptors 0) Apr 24 10:02:38 tvheadend vdr: [12388] receiver on device 1 thread started (pid=12352, tid=12388, prio=high) Apr 24 10:02:38 tvheadend vdr: [12389] TS buffer on device 1 thread started (pid=12352, tid=12389, prio=high) Apr 24 10:02:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:02:43 tvheadend vdr: [12388] detaching receiver - won't decrypt channel C-1536-2106-19561 with CAM 1 Apr 24 10:02:43 tvheadend vdr: [12388] DVBAPI: 0.0 set CAM decrypt (SID 19561, caLm 5, HasCaDescriptors 1) Apr 24 10:02:43 tvheadend vdr: [12388] CAM 1: unassigned Apr 24 10:02:43 tvheadend vdr: [12389] TS buffer on device 1 thread ended (pid=12352, tid=12389) Apr 24 10:02:43 tvheadend vdr: [12388] buffer stats: 204544 (3%) used Apr 24 10:02:43 tvheadend vdr: [12388] receiver on device 1 thread ended (pid=12352, tid=12388) Apr 24 10:02:43 tvheadend vdr: [12357] ERROR: 1 ring buffer overflow (188 bytes dropped) Apr 24 10:02:43 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:02:45 tvheadend vdr: [12385] streamdev-server: streamer done - writer exiting Apr 24 10:02:45 tvheadend vdr: [12385] streamdev-server: closing HTTP connection to 192.168.1.19:3586 Apr 24 10:02:45 tvheadend vdr: [12385] streamdev-writer thread ended (pid=12352, tid=12385) Apr 24 10:02:45 tvheadend vdr: [12386] streamdev-livestreaming thread ended (pid=12352, tid=12386) Apr 24 10:02:45 tvheadend vdr: [12359] buffer stats: 191760 (5%) used Apr 24 10:02:46 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:03:37 tvheadend vdr: message repeated 17 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:03:38 tvheadend vdr: [12352] connect from 127.0.0.1, port 57219 - DENIED Apr 24 10:03:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:04:37 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:04:38 tvheadend vdr: [12352] connect from 127.0.0.1, port 57220 - DENIED Apr 24 10:04:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:05:37 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:05:38 tvheadend vdr: [12352] connect from 127.0.0.1, port 57221 - DENIED Apr 24 10:05:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:06:37 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:06:38 tvheadend vdr: [12352] connect from 127.0.0.1, port 57222 - DENIED Apr 24 10:06:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:07:37 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:07:39 tvheadend vdr: [12352] connect from 127.0.0.1, port 57223 - DENIED Apr 24 10:07:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:08:37 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:08:39 tvheadend vdr: [12352] connect from 127.0.0.1, port 57224 - DENIED Apr 24 10:08:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:09:37 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:09:39 tvheadend vdr: [12352] connect from 127.0.0.1, port 57225 - DENIED Apr 24 10:09:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:10:37 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:10:39 tvheadend vdr: [12352] connect from 127.0.0.1, port 57226 - DENIED Apr 24 10:10:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:11:13 tvheadend vdr: message repeated 11 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:11:14 tvheadend vdr: [12460] epg data writer thread started (pid=12352, tid=12460, prio=low) Apr 24 10:11:14 tvheadend vdr: [12460] epg data writer thread ended (pid=12352, tid=12460) Apr 24 10:11:16 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:11:37 tvheadend vdr: message repeated 7 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:11:39 tvheadend vdr: [12352] connect from 127.0.0.1, port 57227 - DENIED Apr 24 10:11:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:12:37 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:12:39 tvheadend vdr: [12352] connect from 127.0.0.1, port 57228 - DENIED Apr 24 10:12:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:13:37 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:13:40 tvheadend vdr: [12352] connect from 127.0.0.1, port 57229 - DENIED Apr 24 10:13:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:14:37 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:14:40 tvheadend vdr: [12352] connect from 127.0.0.1, port 57230 - DENIED Apr 24 10:14:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:15:37 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:15:40 tvheadend vdr: [12352] connect from 127.0.0.1, port 57231 - DENIED Apr 24 10:15:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:16:37 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:16:40 tvheadend vdr: [12352] connect from 127.0.0.1, port 57232 - DENIED Apr 24 10:16:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:17:01 tvheadend CRON[12502]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly) Apr 24 10:17:37 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:17:40 tvheadend vdr: [12352] connect from 127.0.0.1, port 57233 - DENIED Apr 24 10:17:40 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:18:40 tvheadend vdr: message repeated 20 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:18:40 tvheadend vdr: [12352] connect from 127.0.0.1, port 57234 - DENIED Apr 24 10:18:43 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:19:40 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:19:41 tvheadend vdr: [12352] connect from 127.0.0.1, port 57235 - DENIED Apr 24 10:19:43 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:20:16 tvheadend vdr: message repeated 11 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:20:18 tvheadend vdr: [12356] frontend 0/0 timed out while tuning to channel 0, tp 482 Apr 24 10:20:19 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:20:40 tvheadend vdr: message repeated 7 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:20:41 tvheadend vdr: [12352] connect from 127.0.0.1, port 57236 - DENIED Apr 24 10:20:43 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:21:08 tvheadend dhclient: DHCPREQUEST of 192.168.1.18 on eth0 to 192.168.1.1 port 67 (xid=0xec88259) Apr 24 10:21:08 tvheadend dhclient: DHCPACK of 192.168.1.18 from 192.168.1.1 Apr 24 10:21:08 tvheadend dhclient: bound to 192.168.1.18 -- renewal in 1571 seconds. Apr 24 10:21:13 tvheadend vdr: message repeated 10 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:21:15 tvheadend vdr: [12549] epg data writer thread started (pid=12352, tid=12549, prio=low) Apr 24 10:21:15 tvheadend vdr: [12549] epg data writer thread ended (pid=12352, tid=12549) Apr 24 10:21:16 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:21:40 tvheadend vdr: message repeated 8 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:21:41 tvheadend vdr: [12352] connect from 127.0.0.1, port 57237 - DENIED Apr 24 10:21:43 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:22:01 tvheadend vdr: message repeated 6 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:22:03 tvheadend vdr: [12356] frontend 0/0 timed out while tuning to channel 0, tp 530 Apr 24 10:22:04 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:22:22 tvheadend vdr: message repeated 6 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:22:24 tvheadend vdr: [12356] frontend 0/0 timed out while tuning to channel 0, tp 554 Apr 24 10:22:25 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:22:40 tvheadend vdr: message repeated 5 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:22:42 tvheadend vdr: [12352] connect from 127.0.0.1, port 57238 - DENIED Apr 24 10:22:43 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:23:40 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:23:42 tvheadend vdr: [12352] connect from 127.0.0.1, port 57239 - DENIED Apr 24 10:23:43 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:24:40 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:24:42 tvheadend vdr: [12352] connect from 127.0.0.1, port 57240 - DENIED Apr 24 10:24:43 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory Apr 24 10:25:40 tvheadend vdr: message repeated 19 times: [ [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory] Apr 24 10:25:42 tvheadend vdr: [12352] connect from 127.0.0.1, port 57241 - DENIED Apr 24 10:25:43 tvheadend vdr: [12363] ERROR (lirc.c,43): /var/run/lirc/lircd: No such file or directory

2014/04/24 09:33:43 0 s init for all local cards done 2014/04/24 09:33:43 0 s anti cascading disabled 2014/04/24 09:33:43 16666D0 c plain dvbapi-client granted (vdr, au=off) 2014/04/24 09:33:43 16666D0 c [DVBAPI] Using TCP listen socket, API forced to DVBAPIv3 (0), userconfig boxtype: 11

manio commented 10 years ago

First of all - disable lirc. You have a big mess in the logs. Second: I can see you're using dvbapi in network mode - what about the config in vdr - you also have it enabled? Did you set host and IP correctly? Please provide VDR log with plugin loglevel=3.

jteeuw commented 10 years ago

Hi Mano, thanks for the quick reply.

I have tested with the normal mode and network mode, this is the log with dvbapi.LogLevel = 3

Apr 24 11:17:32 tvheadend vdr: [13424] VDR version 2.1.6 started Apr 24 11:17:32 tvheadend vdr: [13424] switched to user 'vdr' Apr 24 11:17:32 tvheadend vdr: [13424] codeset is 'UTF-8' - known Apr 24 11:17:32 tvheadend vdr: [13424] found 28 locales in /usr/share/locale Apr 24 11:17:32 tvheadend vdr: [13424] loading plugin: /usr/lib/vdr/plugins/libvdr-live.so.2.1.6 Apr 24 11:17:32 tvheadend vdr: [13424] loading plugin: /usr/lib/vdr/plugins/libvdr-streamdev-server.so.2.1.6 Apr 24 11:17:32 tvheadend vdr: [13424] loading plugin: /usr/lib/vdr/plugins/libvdr-vnsiserver.so.2.1.6 Apr 24 11:17:32 tvheadend vdr: [13424] loading plugin: /usr/lib/vdr/plugins/libvdr-dvbapi.so.2.1.6 Apr 24 11:17:32 tvheadend vdr: [13424] loading /var/lib/vdr/setup.conf Apr 24 11:17:32 tvheadend vdr: [13424] loading /var/lib/vdr/channels.conf Apr 24 11:17:32 tvheadend vdr: [13424] loading /var/lib/vdr/timers.conf Apr 24 11:17:32 tvheadend vdr: [13424] loading /var/lib/vdr/commands.conf Apr 24 11:17:32 tvheadend vdr: [13424] loading /var/lib/vdr/reccmds.conf Apr 24 11:17:32 tvheadend vdr: [13425] video directory scanner thread started (pid=13424, tid=13425, prio=high) Apr 24 11:17:32 tvheadend vdr: [13424] registered source parameters for 'A - ATSC' Apr 24 11:17:32 tvheadend vdr: [13424] registered source parameters for 'C - DVB-C' Apr 24 11:17:32 tvheadend vdr: [13424] registered source parameters for 'S - DVB-S' Apr 24 11:17:32 tvheadend vdr: [13424] registered source parameters for 'T - DVB-T' Apr 24 11:17:32 tvheadend vdr: [13425] video directory scanner thread ended (pid=13424, tid=13425) Apr 24 11:17:32 tvheadend vdr: [13427] epg data reader thread started (pid=13424, tid=13427, prio=high) Apr 24 11:17:32 tvheadend vdr: [13426] video directory scanner thread started (pid=13424, tid=13426, prio=high) Apr 24 11:17:32 tvheadend vdr: [13426] video directory scanner thread ended (pid=13424, tid=13426) Apr 24 11:17:32 tvheadend vdr: [13427] reading EPG data from /var/cache/vdr/epg.data Apr 24 11:17:32 tvheadend vdr: [13424] probing /dev/dvb/adapter0/frontend0 Apr 24 11:17:32 tvheadend vdr: [13424] creating cDvbDevice Apr 24 11:17:32 tvheadend vdr: [13424] new device number 1 Apr 24 11:17:32 tvheadend vdr: [13424] DVB API version is 0x050A (VDR was built with 0x050A) Apr 24 11:17:32 tvheadend vdr: [13424] frontend 0/0 provides DVB-C,DVB-T with QAM16,QAM32,QAM64,QAM128,QAM256 ("Sundtek DVB-C") Apr 24 11:17:32 tvheadend vdr: [13424] cTimeMs: using monotonic clock (resolution is 1 ns) Apr 24 11:17:32 tvheadend vdr: [13424] found 1 DVB device Apr 24 11:17:32 tvheadend vdr: [13424] initializing plugin: live (0.3.0): Live Interactive VDR Environment Apr 24 11:17:32 tvheadend vdr: [13424] initializing plugin: streamdev-server (0.6.1-git): VDR Streaming Server Apr 24 11:17:32 tvheadend vdr: [13424] initializing plugin: vnsiserver (1.0.0): VDR-Network-Streaming-Interface (VNSI) Server Apr 24 11:17:32 tvheadend vdr: [13424] initializing plugin: dvbapi (2.1.0-GIT-6ee9d62): SoftCAM for OSCam Apr 24 11:17:32 tvheadend vdr: [13424] setting primary device to 1 Apr 24 11:17:32 tvheadend vdr: [13424] device 1 has no MPEG decoder Apr 24 11:17:32 tvheadend vdr: [13424] assuming manual start of VDR Apr 24 11:17:32 tvheadend vdr: [13424] SVDRP listening on port 6419 Apr 24 11:17:32 tvheadend vdr: [13424] setting current skin to "lcars" Apr 24 11:17:32 tvheadend vdr: [13424] loading /var/lib/vdr/themes/lcars-default.theme Apr 24 11:17:32 tvheadend vdr: [13428] tuner on frontend 0/0 thread started (pid=13424, tid=13428, prio=high) Apr 24 11:17:32 tvheadend vdr: [13424] starting plugin: live Apr 24 11:17:32 tvheadend vdr: [13429] section handler thread started (pid=13424, tid=13429, prio=low) Apr 24 11:17:32 tvheadend vdr: [13424] LIVE: initial file cache has 82 entries and needs 377394 bytes of data! Apr 24 11:17:32 tvheadend vdr: [13424] starting plugin: streamdev-server Apr 24 11:17:32 tvheadend vdr: [13424] loading /var/lib/vdr/plugins/streamdev-server/streamdevhosts.conf Apr 24 11:17:32 tvheadend vdr: [13424] starting plugin: vnsiserver Apr 24 11:17:32 tvheadend vdr: [13424] VNSI: VNSI Server started Apr 24 11:17:32 tvheadend vdr: [13424] VNSI: Channel streaming timeout: 10 seconds Apr 24 11:17:32 tvheadend vdr: [13424] starting plugin: dvbapi Apr 24 11:17:32 tvheadend vdr: [13424] DVBAPI: plugin version 2.1.0-GIT-6ee9d62 initializing (VDR 2.1.6) Apr 24 11:17:32 tvheadend vdr: [13430] [live] INFO: attempt to listen on ip = '' Apr 24 11:17:32 tvheadend vdr: [13424] DVBAPI: decryption library: FFdecsa Apr 24 11:17:32 tvheadend vdr: [13424] DVBAPI: 0: clustersize=140 rangesize=285 Apr 24 11:17:32 tvheadend vdr: [13432] VDR VNSI Server thread started (pid=13424, tid=13432, prio=high) Apr 24 11:17:32 tvheadend vdr: [13431] streamdev server thread started (pid=13424, tid=13431, prio=high) Apr 24 11:17:32 tvheadend vdr: [13424] DVBAPI: 0: reset state Apr 24 11:17:32 tvheadend vdr: [13431] Streamdev: Listening (VTP) on port 2004 Apr 24 11:17:32 tvheadend vdr: [13431] Streamdev: Listening (HTTP) on port 3000 Apr 24 11:17:32 tvheadend vdr: [13430] [live] ERROR: Unable to load cert/key (/var/lib/vdr/plugins/live/live.pem//var/lib/vdr/plugins/live/live-key.pem): No such file or directory Apr 24 11:17:32 tvheadend vdr: [13424] DVBAPI: SocketHandler Apr 24 11:17:32 tvheadend vdr: [13424] DVBAPI: Creating sCCIAdapter for device 0 Apr 24 11:17:32 tvheadend vdr: [13424] DVBAPI: ResetSlot: log=0 Apr 24 11:17:32 tvheadend vdr: [13435] Socket Handler thread started (pid=13424, tid=13435, prio=high) Apr 24 11:17:32 tvheadend vdr: [13435] DVBAPI: Action Apr 24 11:17:32 tvheadend vdr: [13424] DVBAPI: plugin started Apr 24 11:17:32 tvheadend vdr: [13424] ERROR (lirc.c,43): /dev/null: Connection refused Apr 24 11:17:32 tvheadend vdr: [13424] ERROR: remote control LIRC not ready! Apr 24 11:17:32 tvheadend vdr: [13445] LIRC remote control thread started (pid=13424, tid=13445, prio=high) Apr 24 11:17:32 tvheadend vdr: [13440] SC-CI adapter on device 0 thread started (pid=13424, tid=13440, prio=high) Apr 24 11:17:32 tvheadend vdr: [13445] ERROR: lircd connection broken, trying to reconnect every 3.0 seconds Apr 24 11:17:32 tvheadend vdr: [13440] DVBAPI: 0.0: doReply changed, reset triggered Apr 24 11:17:32 tvheadend vdr: [13440] DVBAPI: ResetSlot: log=0 Apr 24 11:17:32 tvheadend vdr: [13440] DVBAPI: 0.0: now using CAIDs version 1 Apr 24 11:17:32 tvheadend vdr: [13440] DVBAPI: 0.0: status 'present' Apr 24 11:17:32 tvheadend vdr: [13440] CAM 1: module present Apr 24 11:17:32 tvheadend vdr: [13427] epg data reader thread ended (pid=13424, tid=13427) Apr 24 11:17:32 tvheadend vdr: [13424] DVBAPI: 0.0: status 'reset' Apr 24 11:17:32 tvheadend vdr: [13424] DVBAPI: 0.0: status 'ready' Apr 24 11:17:32 tvheadend vdr: [13440] CAM 1: module ready Apr 24 11:17:32 tvheadend vdr: [13440] DVBAPI: CaInfo: 0.0 sending CA info Apr 24 11:17:32 tvheadend vdr: [13440] CAM 1: system ids: FFFF Apr 24 11:17:33 tvheadend vdr: [13440] DVBAPI: 0.0 CA_PMT decoding len=7 lm=3 prg=0 len=1 Apr 24 11:17:33 tvheadend vdr: [13440] DVBAPI: ci_cmd(G)=03 Apr 24 11:17:33 tvheadend vdr: [13440] DVBAPI: 0.0 got CA pmt ciCmd=3 caLm=3 Apr 24 11:17:33 tvheadend vdr: [13440] DVBAPI: 0.0 answer to query Apr 24 11:17:33 tvheadend vdr: [13440] DVBAPI: 0.0 no action taken Apr 24 11:17:33 tvheadend vdr: [13440] CAM 1: replies to QUERY - multi channel decryption possible Apr 24 11:17:33 tvheadend vdr: [13424] switching to channel 1 Apr 24 11:17:33 tvheadend vdr: [13424] setting watchdog timer to 60 seconds Apr 24 11:17:34 tvheadend vdr: [13424] OSD size changed to 720x480 @ 1 Apr 24 11:17:34 tvheadend vdr: [13424] ERROR: no OSD provider available - using dummy OSD! Apr 24 11:17:35 tvheadend vdr: [13424] ERROR: Channel locked (recording)! Apr 24 11:17:35 tvheadend vdr: [13445] ERROR (lirc.c,43): /dev/null: Connection refused Apr 24 11:17:37 tvheadend vdr: [13424] max. latency time 3 seconds Apr 24 11:17:38 tvheadend vdr: [13445] ERROR (lirc.c,43): /dev/null: Connection refused Apr 24 11:17:50 tvheadend vdr: message repeated 4 times: [ [13445] ERROR (lirc.c,43): /dev/null: Connection refused] Apr 24 11:17:51 tvheadend vdr: [13431] Streamdev: Accepted new client (HTTP) 192.168.1.19:3741 Apr 24 11:17:51 tvheadend vdr: [13431] CAM 1: assigned to device 1 Apr 24 11:17:51 tvheadend vdr: [13448] streamdev-writer thread started (pid=13424, tid=13448, prio=high) Apr 24 11:17:51 tvheadend vdr: [13449] streamdev-livestreaming thread started (pid=13424, tid=13449, prio=high) Apr 24 11:17:52 tvheadend vdr: [13431] DVBAPI: 0.0 CA_PMT decoding len=15 lm=4 prg=19645 len=0 Apr 24 11:17:52 tvheadend vdr: [13431] DVBAPI: pid=2,125d len=0 (0x0) Apr 24 11:17:52 tvheadend vdr: [13431] DVBAPI: pid=4,1266 len=0 (0x0) Apr 24 11:17:52 tvheadend vdr: [13431] DVBAPI: pid=6,1267 len=0 (0x0) Apr 24 11:17:52 tvheadend vdr: [13431] DVBAPI: 0.0 got CA pmt ciCmd=-1 caLm=4 Apr 24 11:17:52 tvheadend vdr: [13431] DVBAPI: 0.0 answer to query suppressed Apr 24 11:17:52 tvheadend vdr: [13431] DVBAPI: 0.0 set CAM decrypt (SID 19645, caLm 4, HasCaDescriptors 0) Apr 24 11:17:52 tvheadend vdr: [13431] DVBAPI: CA_PMT doesn't contain CA desriptors Apr 24 11:17:52 tvheadend vdr: [13451] receiver on device 1 thread started (pid=13424, tid=13451, prio=high) Apr 24 11:17:52 tvheadend vdr: [13452] TS buffer on device 1 thread started (pid=13424, tid=13452, prio=high) Apr 24 11:17:52 tvheadend vdr: [13431] Streamdev: Accepted new client (HTTP) 192.168.1.19:3744 Apr 24 11:17:53 tvheadend vdr: [13448] ERROR: streamdev-server: couldn't send 58744 bytes: Broken pipe Apr 24 11:17:53 tvheadend vdr: [13448] streamdev-server: closing HTTP connection to 192.168.1.19:3741 Apr 24 11:17:53 tvheadend vdr: [13448] streamdev-writer thread ended (pid=13424, tid=13448) Apr 24 11:17:53 tvheadend vdr: [13431] DVBAPI: 0.0 CA_PMT decoding len=13 lm=5 prg=19645 len=d Apr 24 11:17:53 tvheadend vdr: [13431] DVBAPI: ci_cmd(G)=01 Apr 24 11:17:53 tvheadend vdr: [13431] DVBAPI: 0.0 got CA pmt ciCmd=1 caLm=5 Apr 24 11:17:53 tvheadend vdr: [13431] DVBAPI: 0.0 answer to query suppressed Apr 24 11:17:53 tvheadend vdr: [13431] DVBAPI: 0.0 set CAM decrypt (SID 19645, caLm 5, HasCaDescriptors 1) Apr 24 11:17:53 tvheadend vdr: [13431] DVBAPI: 0.0 CA_PMT decoding len=6 lm=3 prg=0 len=0 Apr 24 11:17:53 tvheadend vdr: [13431] DVBAPI: 0.0 got CA pmt ciCmd=-1 caLm=3 Apr 24 11:17:53 tvheadend vdr: [13431] DVBAPI: 0.0 answer to query suppressed Apr 24 11:17:53 tvheadend vdr: [13431] DVBAPI: 0.0 stop decrypt Apr 24 11:17:53 tvheadend vdr: [13431] CAM 1: unassigned Apr 24 11:17:53 tvheadend vdr: [13445] ERROR (lirc.c,43): /dev/null: Connection refused Apr 24 11:17:53 tvheadend vdr: [13449] streamdev-livestreaming thread ended (pid=13424, tid=13449) Apr 24 11:17:53 tvheadend vdr: [13431] buffer stats: 209432 (5%) used Apr 24 11:17:53 tvheadend vdr: [13453] streamdev-writer thread started (pid=13424, tid=13453, prio=high) Apr 24 11:17:53 tvheadend vdr: [13454] streamdev-livestreaming thread started (pid=13424, tid=13454, prio=high) Apr 24 11:17:53 tvheadend vdr: [13452] TS buffer on device 1 thread ended (pid=13424, tid=13452) Apr 24 11:17:53 tvheadend vdr: [13451] buffer stats: 211876 (4%) used Apr 24 11:17:53 tvheadend vdr: [13451] receiver on device 1 thread ended (pid=13424, tid=13451) Apr 24 11:17:53 tvheadend vdr: [13455] receiver on device 1 thread started (pid=13424, tid=13455, prio=high) Apr 24 11:17:53 tvheadend vdr: [13456] TS buffer on device 1 thread started (pid=13424, tid=13456, prio=high) Apr 24 11:17:54 tvheadend vdr: [13429] ERROR: 1 ring buffer overflow (188 bytes dropped) Apr 24 11:17:54 tvheadend vdr: [13424] connect from 127.0.0.1, port 57293 - DENIED Apr 24 11:17:56 tvheadend vdr: [13445] ERROR (lirc.c,43): /dev/null: Connection refused

manio commented 10 years ago

Your logs ends when it is most interesting. From your part I can only see that VDR doesn't provide CA descriptors to my plugin. It's normal when first zap, then it has to automatically tune again to the channel and I don't see it in the log.

ps. please use the pastebin next time ps2. You are sure that you have a working hardware? I have bad experience with this crappy hardware and it's "drivers" (Sundtek). I can also see some strange ring buffer overflow errors.

jteeuw commented 10 years ago

If have installed a new driver and its working now, witch hardware do you recommend , ( usb dvb-c)

manio commented 10 years ago

Great :) Sorry - you need to ask on some good linux forum about good device with good drivers. I cannot recommend you something because I am not using dvb-c at all.

If it is working - closing. Thank you.