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

After latest commit and oscam 10653 not working #92

Closed posixx closed 9 years ago

posixx commented 9 years ago

After trying new v2 proto with oscam 10653 channel descrambling stops after some ecm:

VDR log:

May 5 17:02:34 DVRServer vdr: [10950] loading /etc/vdr/plugins/vnsiserver/allowed_hosts.conf May 5 17:02:34 DVRServer vdr: [10950] VNSI: Client with ID 1 connected: 10.10.11.60:43819 May 5 17:02:34 DVRServer vdr: [11371] VNSI: Welcome client 'XBMC Media Center' with protocol version '6' May 5 17:02:34 DVRServer vdr: [11371] VNSI: RDS not supported on client 'XBMC Media Center' and stream type disabled May 5 17:02:34 DVRServer vdr: [11371] VNSI: LiveStreamer::Close - close May 5 17:02:34 DVRServer vdr: [11371] VNSI: close video input ... May 5 17:02:34 DVRServer vdr: [11371] CAM 1: assigned to device 1 May 5 17:02:34 DVRServer vdr: [11372] device 1 receiver thread started (pid=10798, tid=11372, prio=high) May 5 17:02:34 DVRServer vdr: [11371] VNSI: Successfully switched to channel 5 - RTL5 HD May 5 17:02:34 DVRServer vdr: [11371] VNSI: Started streaming of channel RTL5 HD (timeout 10 seconds) May 5 17:02:34 DVRServer vdr: [11374] cLiveStreamer stream processor thread started (pid=10798, tid=11374, prio=high) May 5 17:02:34 DVRServer vdr: [11375] device 1 TS buffer thread started (pid=10798, tid=11375, prio=high) May 5 17:02:34 DVRServer vdr: [11373] VNSI: VideoInput: no pat/pmt within timeout, falling back to channel pids May 5 17:02:34 DVRServer vdr: [11373] VNSI: Video Input - new pmt, attaching receiver May 5 17:02:34 DVRServer vdr: [11374] VNSI: Created stream for pid=523 and type=8 May 5 17:02:34 DVRServer vdr: [11374] VNSI: Created stream for pid=83 and type=1 May 5 17:02:34 DVRServer vdr: [11374] VNSI: Created stream for pid=33 and type=11 May 5 17:02:36 DVRServer vdr: [10798] VNSI: re-tune to channel RTL5 HD May 5 17:02:36 DVRServer vdr: [11374] VNSI: close video input ... May 5 17:02:36 DVRServer vdr: [11374] VNSI: call retune ... May 5 17:02:36 DVRServer vdr: [11374] CAM 1: unassigned May 5 17:02:36 DVRServer vdr: [11374] VNSI: call retune ... May 5 17:02:36 DVRServer vdr: [11374] CAM 1: assigned to device 1 May 5 17:02:36 DVRServer vdr: [11375] device 1 TS buffer thread ended (pid=10798, tid=11375) May 5 17:02:36 DVRServer vdr: [11372] buffer stats: 249852 (4%) used May 5 17:02:36 DVRServer vdr: [11372] device 1 receiver thread ended (pid=10798, tid=11372) May 5 17:02:36 DVRServer vdr: [11422] device 1 receiver thread started (pid=10798, tid=11422, prio=high) May 5 17:02:36 DVRServer vdr: [11424] device 1 TS buffer thread started (pid=10798, tid=11424, prio=high) May 5 17:02:36 DVRServer vdr: [11423] VNSI: VideoInput: no pat/pmt within timeout, falling back to channel pids May 5 17:02:36 DVRServer vdr: [11423] VNSI: Video Input - new pmt, attaching receiver May 5 17:03:22 DVRServer vdr: [11374] VNSI-Error: cParser::AddPESPacket - max buffer size reached, pid: 523

OSCAM 128 debug log:

2015/05/05 17:00:47 880008C0 h (webif) all debug_level=128 2015/05/05 17:02:09 7B26F0 c (dvbapi) new socket connection fd: 45 2015/05/05 17:02:09 7B26F0 c (dvbapi) Client connected: 'vdr-plugin-dvbapi 2.2.0 / VDR 2.2.0' (protocol version = 2) 2015/05/05 17:02:09 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:02:09 7B26F0 c (dvbapi) FF FF 00 02 00 02 43 4F 53 43 61 6D 20 76 31 2E 2015/05/05 17:02:09 7B26F0 c (dvbapi) 32 30 2D 75 6E 73 74 61 62 6C 65 5F 73 76 6E 2C 2015/05/05 17:02:09 7B26F0 c (dvbapi) 20 62 75 69 6C 64 20 72 30 20 28 78 38 36 5F 36 2015/05/05 17:02:09 7B26F0 c (dvbapi) 34 2D 70 63 2D 6C 69 6E 75 78 2D 67 6E 75 2D 73 2015/05/05 17:02:09 7B26F0 c (dvbapi) 73 6C 2D 6C 69 62 75 73 62 29 2015/05/05 17:02:36 7B26F0 c (dvbapi) PMT Update on socket 45. 2015/05/05 17:02:36 7B26F0 c (dvbapi) Parsing 1 PMT object(s): 2015/05/05 17:02:36 7B26F0 c (dvbapi) 9F 80 3F 04 83 02 00 FF 2015/05/05 17:02:36 7B26F0 c (dvbapi) capmt 3f: 2015/05/05 17:02:36 7B26F0 c (dvbapi) 9F 80 3F 04 83 02 00 FF 2015/05/05 17:02:36 7B26F0 c (dvbapi) PMT Update on socket 45. 2015/05/05 17:02:36 7B26F0 c (dvbapi) Parsing 1 PMT object(s): 2015/05/05 17:02:36 7B26F0 c (dvbapi) 9F 80 32 82 00 68 03 1B 6F 00 00 0E 01 82 02 00 2015/05/05 17:02:36 7B26F0 c (dvbapi) 00 09 07 18 17 E7 0A 02 00 6A 02 02 0B 00 25 01 2015/05/05 17:02:36 7B26F0 c (dvbapi) 09 11 01 00 E7 0A 00 6A FF FF E0 00 00 00 00 00 2015/05/05 17:02:36 7B26F0 c (dvbapi) 00 32 A5 09 0F 05 00 EC 1E 10 01 00 13 01 20 14 2015/05/05 17:02:36 7B26F0 c (dvbapi) 03 05 19 00 06 00 53 00 25 01 09 11 01 00 E7 0A 2015/05/05 17:02:36 7B26F0 c (dvbapi) 00 6A FF FF E0 00 00 00 00 00 00 32 A5 09 0F 05 2015/05/05 17:02:36 7B26F0 c (dvbapi) 00 EC 1E 10 01 00 13 01 20 14 03 05 19 00 2015/05/05 17:02:36 7B26F0 c (dvbapi) capmt: 2015/05/05 17:02:36 7B26F0 c (dvbapi) 03 1B 6F 00 00 0E 01 82 02 00 00 09 07 18 17 E7 2015/05/05 17:02:36 7B26F0 c (dvbapi) 0A 02 00 6A 02 02 0B 00 25 01 09 11 01 00 E7 0A 2015/05/05 17:02:36 7B26F0 c (dvbapi) 00 6A FF FF E0 00 00 00 00 00 00 32 A5 09 0F 05 2015/05/05 17:02:36 7B26F0 c (dvbapi) 00 EC 1E 10 01 00 13 01 20 14 03 05 19 00 06 00 2015/05/05 17:02:36 7B26F0 c (dvbapi) 53 00 25 01 09 11 01 00 E7 0A 00 6A FF FF E0 00 2015/05/05 17:02:36 7B26F0 c (dvbapi) 00 00 00 00 00 32 A5 09 0F 05 00 EC 1E 10 01 00 2015/05/05 17:02:36 7B26F0 c (dvbapi) 13 01 20 14 03 05 19 00 2015/05/05 17:02:36 7B26F0 c (dvbapi) Receiver sends PMT command 3 for channel 1B6F 2015/05/05 17:02:36 7B26F0 c (dvbapi) Receiver wants to demux srvid 1B6F on adapter 0000 camask 0001 index 0000 pmtpid 0000 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 added new ecmpid 0 CAID: 1817 ECM_PID: 070A PROVID: 00006A 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 added new stream Videostream (type: 02 pid: 020b length: 37) 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 added new ecmpid 1 CAID: 0100 ECM_PID: 070A PROVID: 00006A 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 added new ecmpid 2 CAID: 0500 ECM_PID: 0C1E PROVID: 051900 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 added new stream Datastream (type: 06 pid: 0053 length: 37) 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 skipped stream CAID: 0100 ECM_PID: 070A PROVID: 00006A (Same as ECMPID 1) 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 skipped stream CAID: 0500 ECM_PID: 0C1E PROVID: 051900 (Same as ECMPID 2) 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 found 3 ECMpids and 2 STREAMpids in PMT 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 receiver wants to demux srvid 1B6F on adapter 0000 camask 0001 index 0000 pmtpid 0000 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 new program number: 1B6F (1817:1B6F unknown) [pmt_list_management 3] 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 demux_index: 0 ca_mask: 01 program_info_length: 14 ca_pmt_list_management 03 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 found in channel cache: 0100&00006A/1B6F/070A/5C00/0000/00:(null) 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 prio ecmpid 1 0100:00006A:070A (found caid/provid/srvid in cache - weight: 2) 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 prio ecmpid 1 0100:00006A:070A:5C00 (localrdr: cds-3 weight: 8) 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 ignore ecmpid 0 1817:00006A:070A:10000 (no matching reader) 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 ignore ecmpid 2 0500:051900:0C1E:10000 (no matching reader) 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 forced ecmpid 1 0100:00006A:070A:5C00 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 0100 PROVID 00006A ECMPID 070A CHID 5C00 PMTPID 0000 VPID 020B 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 try to start new filter for caid: 0100, provid: 00006A, pid: 070A 2015/05/05 17:02:36 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:02:36 7B26F0 c (dvbapi) 40 3C 6F 2B 00 00 00 07 0A 80 00 00 00 00 00 00 2015/05/05 17:02:36 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 F0 00 00 00 00 00 00 2015/05/05 17:02:36 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 2015/05/05 17:02:36 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 0B B8 00 00 00 2015/05/05 17:02:36 7B26F0 c (dvbapi) 04 2015/05/05 17:02:36 7B26F0 c (dvbapi) Demuxer 0 Filter 1 started successfully (caid 0100 provid 00006A pid 070A) 2015/05/05 17:02:36 7B26F0 c (dvbapi) PMT Update on socket 45. 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 Filter 1 fetched ECM data (ecmlength = 064) 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 ECMTYPE 81 CAID 0100 PROVID 00006A ECMPID 070A FAKECHID 5C00 (unique part in ecm) 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 Filter 1 set ecmtable to EVEN (CAID 0100 PROVID 00006A FD 65535) 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 Filter 1 set chid to 5C00 on fd 65535 2015/05/05 17:02:37 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:02:37 7B26F0 c (dvbapi) 40 3C 6F 2B 00 00 00 07 0A 80 00 00 00 00 5C 00 2015/05/05 17:02:37 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 FF 00 00 00 00 F0 FF 2015/05/05 17:02:37 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 2015/05/05 17:02:37 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 2015/05/05 17:02:37 7B26F0 c (dvbapi) 04 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 get controlword! 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 controlword received for PID 1 CAID 0100 PROVID 00006A ECMPID 070A CHID 5C00 VPID 020B 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 descrambling PID 1 CAID 0100 PROVID 00006A ECMPID 070A CHID 5C00 VPID 020B 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 PID: 1 CAID: 0100 ECMPID: 070A is using index 0 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 020B -> write! 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 0053 -> write! 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 writing odd part (B786CD0A77050E8A) of controlword, replacing expired (0000000000000000) 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 write cw0 index: 0 (ca0) 2015/05/05 17:02:37 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:02:37 7B26F0 c (dvbapi) 40 10 6F 86 00 00 00 00 00 00 00 00 00 B7 86 CD 2015/05/05 17:02:37 7B26F0 c (dvbapi) 0A 77 05 0E 8A 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 020B -> write! 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 0053 -> write! 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 writing even part (5127E0589D8AFD24) of controlword, replacing expired (0000000000000000) 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 write cw1 index: 0 (ca0) 2015/05/05 17:02:37 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:02:37 7B26F0 c (dvbapi) 40 10 6F 86 00 00 00 00 00 00 00 00 01 51 27 E0 2015/05/05 17:02:37 7B26F0 c (dvbapi) 58 9D 8A FD 24 2015/05/05 17:02:37 7B26F0 c (dvbapi) FF FF 00 03 00 1B 6F 01 00 07 0A 00 00 00 6A 00 2015/05/05 17:02:37 7B26F0 c (dvbapi) 00 00 01 04 73 65 63 61 05 43 61 63 68 65 06 63 2015/05/05 17:02:37 7B26F0 c (dvbapi) 61 63 68 65 31 04 6E 6F 6E 65 00 2015/05/05 17:02:37 7B26F0 c (ecm) dvrserver (0100&00006A/1B6F/070A/5C00/0000/64:B786CD0A77050E8A5127E0589D8AFD24): cache1 (1 ms) by cds - RTL 5 HD 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 request controlword for ecm 0100&00006A/1B6F/070A/5C00/0000/64:B786CD0A77050E8A5127E0589D8AFD24 2015/05/05 17:02:37 7B26F0 c (dvbapi) Demuxer 0 has 3 ecmpids, 2 streampids, 1 ecmfilters and 0 of max 0 emmfilters 2015/05/05 17:02:41 7B26F0 c (dvbapi) PMT Update on socket 45. 2015/05/05 17:02:41 7B26F0 c (dvbapi) Demuxer 0 Filter 1 fetched ECM data (ecmlength = 064) 2015/05/05 17:02:41 7B26F0 c (dvbapi) Demuxer 0 ECMTYPE 80 CAID 0100 PROVID 00006A ECMPID 070A FAKECHID 5C00 (unique part in ecm) 2015/05/05 17:02:41 7B26F0 c (dvbapi) Demuxer 0 Filter 1 set ecmtable to ODD (CAID 0100 PROVID 00006A FD 65535) 2015/05/05 17:02:41 7B26F0 c (dvbapi) Demuxer 0 Filter 1 set chid to 5C00 on fd 65535 2015/05/05 17:02:41 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:02:41 7B26F0 c (dvbapi) 40 3C 6F 2B 00 00 00 07 0A 81 00 00 00 00 5C 00 2015/05/05 17:02:41 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 FF 00 00 00 00 F0 FF 2015/05/05 17:02:41 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 2015/05/05 17:02:41 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 2015/05/05 17:02:41 7B26F0 c (dvbapi) 04 2015/05/05 17:02:41 7B26F0 c (dvbapi) Demuxer 0 get controlword! 2015/05/05 17:02:41 7B26F0 c (dvbapi) Demuxer 0 request controlword for ecm 0100&00006A/1B6F/070A/5C00/0000/64:00000000000000000000000000000000 2015/05/05 17:02:41 7B26F0 c (dvbapi) Demuxer 0 controlword received for PID 1 CAID 0100 PROVID 00006A ECMPID 070A CHID 5C00 VPID 020B 2015/05/05 17:02:41 7B26F0 c (dvbapi) Demuxer 0 requested controlword for ecm C9BC35B8BAECDA6A580E9F1F385839F3 on fd 65535 2015/05/05 17:02:41 7B26F0 c (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 020B -> write! 2015/05/05 17:02:41 7B26F0 c (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 0053 -> write! 2015/05/05 17:02:41 7B26F0 c (dvbapi) Demuxer 0 writing even part (3126E43B89542502) of controlword, replacing expired (5127E0589D8AFD24) 2015/05/05 17:02:41 7B26F0 c (dvbapi) Demuxer 0 write cw1 index: 0 (ca0) 2015/05/05 17:02:41 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:02:41 7B26F0 c (dvbapi) 40 10 6F 86 00 00 00 00 00 00 00 00 01 31 26 E4 2015/05/05 17:02:41 7B26F0 c (dvbapi) 3B 89 54 25 02 2015/05/05 17:02:41 7B26F0 c (dvbapi) FF FF 00 03 00 1B 6F 01 00 07 0A 00 00 00 6A 00 2015/05/05 17:02:41 7B26F0 c (dvbapi) 00 00 F2 04 73 65 63 61 05 43 61 63 68 65 06 63 2015/05/05 17:02:41 7B26F0 c (dvbapi) 61 63 68 65 32 04 6E 6F 6E 65 00 2015/05/05 17:02:41 7B26F0 c (ecm) dvrserver (0100&00006A/1B6F/070A/5C00/0000/64:B786CD0A77050E8A3126E43B89542502): cache2 (242 ms) by cds - RTL 5 HD 2015/05/05 17:02:51 7B26F0 c (dvbapi) PMT Update on socket 45. 2015/05/05 17:02:51 7B26F0 c (dvbapi) Demuxer 0 Filter 1 fetched ECM data (ecmlength = 064) 2015/05/05 17:02:51 7B26F0 c (dvbapi) Demuxer 0 ECMTYPE 81 CAID 0100 PROVID 00006A ECMPID 070A FAKECHID 5C00 (unique part in ecm) 2015/05/05 17:02:51 7B26F0 c (dvbapi) Demuxer 0 Filter 1 set ecmtable to EVEN (CAID 0100 PROVID 00006A FD 65535) 2015/05/05 17:02:51 7B26F0 c (dvbapi) Demuxer 0 Filter 1 set chid to 5C00 on fd 65535 2015/05/05 17:02:51 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:02:51 7B26F0 c (dvbapi) 40 3C 6F 2B 00 00 00 07 0A 80 00 00 00 00 5C 00 2015/05/05 17:02:51 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 FF 00 00 00 00 F0 FF 2015/05/05 17:02:51 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 2015/05/05 17:02:51 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 2015/05/05 17:02:51 7B26F0 c (dvbapi) 04 2015/05/05 17:02:51 7B26F0 c (dvbapi) Demuxer 0 get controlword! 2015/05/05 17:02:51 7B26F0 c (dvbapi) Demuxer 0 request controlword for ecm 0100&00006A/1B6F/070A/5C00/0000/64:00000000000000000000000000000000 2015/05/05 17:02:51 7B26F0 c (dvbapi) Demuxer 0 controlword received for PID 1 CAID 0100 PROVID 00006A ECMPID 070A CHID 5C00 VPID 020B 2015/05/05 17:02:51 7B26F0 c (dvbapi) Demuxer 0 requested controlword for ecm 5759D216C1F598334151CCCF2EDEC947 on fd 65535 2015/05/05 17:02:51 7B26F0 c (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 020B -> write! 2015/05/05 17:02:51 7B26F0 c (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 0053 -> write! 2015/05/05 17:02:51 7B26F0 c (dvbapi) Demuxer 0 writing odd part (1CAAC48A8C4226F4) of controlword, replacing expired (B786CD0A77050E8A) 2015/05/05 17:02:51 7B26F0 c (dvbapi) Demuxer 0 write cw0 index: 0 (ca0) 2015/05/05 17:02:51 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:02:51 7B26F0 c (dvbapi) 40 10 6F 86 00 00 00 00 00 00 00 00 00 1C AA C4 2015/05/05 17:02:51 7B26F0 c (dvbapi) 8A 8C 42 26 F4 2015/05/05 17:02:51 7B26F0 c (dvbapi) FF FF 00 03 00 1B 6F 01 00 07 0A 00 00 00 6A 00 2015/05/05 17:02:51 7B26F0 c (dvbapi) 00 00 D8 04 73 65 63 61 05 43 61 63 68 65 06 63 2015/05/05 17:02:51 7B26F0 c (dvbapi) 61 63 68 65 32 04 6E 6F 6E 65 00 2015/05/05 17:02:51 7B26F0 c (ecm) dvrserver (0100&00006A/1B6F/070A/5C00/0000/64:1CAAC48A8C4226F43126E43B89542502): cache2 (216 ms) by cds - RTL 5 HD 2015/05/05 17:03:01 7B26F0 c (dvbapi) PMT Update on socket 45. 2015/05/05 17:03:01 7B26F0 c (dvbapi) Demuxer 0 Filter 1 fetched ECM data (ecmlength = 064) 2015/05/05 17:03:01 7B26F0 c (dvbapi) Demuxer 0 ECMTYPE 80 CAID 0100 PROVID 00006A ECMPID 070A FAKECHID 5C00 (unique part in ecm) 2015/05/05 17:03:01 7B26F0 c (dvbapi) Demuxer 0 Filter 1 set ecmtable to ODD (CAID 0100 PROVID 00006A FD 65535) 2015/05/05 17:03:01 7B26F0 c (dvbapi) Demuxer 0 Filter 1 set chid to 5C00 on fd 65535 2015/05/05 17:03:01 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:03:01 7B26F0 c (dvbapi) 40 3C 6F 2B 00 00 00 07 0A 81 00 00 00 00 5C 00 2015/05/05 17:03:01 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 FF 00 00 00 00 F0 FF 2015/05/05 17:03:01 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 2015/05/05 17:03:01 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 2015/05/05 17:03:01 7B26F0 c (dvbapi) 04 2015/05/05 17:03:01 7B26F0 c (dvbapi) Demuxer 0 get controlword! 2015/05/05 17:03:01 7B26F0 c (dvbapi) Demuxer 0 request controlword for ecm 0100&00006A/1B6F/070A/5C00/0000/64:00000000000000000000000000000000 2015/05/05 17:03:01 7B26F0 c (dvbapi) Demuxer 0 controlword received for PID 1 CAID 0100 PROVID 00006A ECMPID 070A CHID 5C00 VPID 020B 2015/05/05 17:03:01 7B26F0 c (dvbapi) Demuxer 0 requested controlword for ecm 5A63A2CD474F6987993155E0A40A1D4E on fd 65535 2015/05/05 17:03:01 7B26F0 c (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 020B -> write! 2015/05/05 17:03:01 7B26F0 c (dvbapi) Demuxer 0 ca0 is using index 0 for streampid 0053 -> write! 2015/05/05 17:03:01 7B26F0 c (dvbapi) Demuxer 0 writing even part (B7B4FE69B16290A3) of controlword, replacing expired (3126E43B89542502) 2015/05/05 17:03:01 7B26F0 c (dvbapi) Demuxer 0 write cw1 index: 0 (ca0) 2015/05/05 17:03:01 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:03:01 7B26F0 c (dvbapi) 40 10 6F 86 00 00 00 00 00 00 00 00 01 B7 B4 FE 2015/05/05 17:03:01 7B26F0 c (dvbapi) 69 B1 62 90 A3 2015/05/05 17:03:01 7B26F0 c (dvbapi) FF FF 00 03 00 1B 6F 01 00 07 0A 00 00 00 6A 00 2015/05/05 17:03:01 7B26F0 c (dvbapi) 00 00 D1 04 73 65 63 61 05 43 61 63 68 65 06 63 2015/05/05 17:03:01 7B26F0 c (dvbapi) 61 63 68 65 32 04 6E 6F 6E 65 00 2015/05/05 17:03:01 7B26F0 c (ecm) dvrserver (0100&00006A/1B6F/070A/5C00/0000/64:1CAAC48A8C4226F4B7B4FE69B16290A3): cache2 (209 ms) by cds - RTL 5 HD 2015/05/05 17:03:07 7B26F0 c (dvbapi) Demuxer 0 try to start new filter for caid: 0001, provid: 000001, pid: 0001 2015/05/05 17:03:07 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:03:07 7B26F0 c (dvbapi) 40 3C 6F 2B 00 00 01 00 01 01 00 00 00 00 00 00 2015/05/05 17:03:07 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 FF 00 00 00 00 00 00 2015/05/05 17:03:07 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 2015/05/05 17:03:07 7B26F0 c (dvbapi) 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 2015/05/05 17:03:07 7B26F0 c (dvbapi) 04 2015/05/05 17:03:07 7B26F0 c (dvbapi) Demuxer 0 Filter 2 started successfully (caid 0001 provid 000001 pid 0001) 2015/05/05 17:03:07 7B26F0 c (dvbapi) Demuxer 0 has 3 ecmpids, 2 streampids, 1 ecmfilters and 1 of max 0 emmfilters 2015/05/05 17:03:07 7B26F0 c (dvbapi) PMT Update on socket 45. 2015/05/05 17:03:07 7B26F0 c (dvbapi) receiving cat 2015/05/05 17:03:07 7B26F0 c (dvbapi) cat: 2015/05/05 17:03:07 7B26F0 c (dvbapi) 01 B0 C4 FF FF CD 00 00 09 04 06 22 E1 36 09 19 2015/05/05 17:03:07 7B26F0 c (dvbapi) 01 00 E0 B6 05 E0 B7 00 6A E0 B8 00 6B E0 B9 00 2015/05/05 17:03:07 7B26F0 c (dvbapi) 6C E0 BA 00 6D E0 BB 00 00 09 04 0D 96 FF 40 09 2015/05/05 17:03:07 7B26F0 c (dvbapi) 04 06 24 FF 41 09 20 05 00 E0 AA 13 01 20 14 03 2015/05/05 17:03:07 7B26F0 c (dvbapi) 04 25 00 14 03 04 25 10 14 03 04 25 20 14 03 04 2015/05/05 17:03:07 7B26F0 c (dvbapi) 25 30 14 03 05 19 00 09 07 18 17 E0 B6 02 FE 22 2015/05/05 17:03:07 7B26F0 c (dvbapi) 09 07 18 18 E0 B6 02 FE 22 09 07 18 19 E0 B6 02 2015/05/05 17:03:07 7B26F0 c (dvbapi) FE 22 09 07 18 17 E0 BC 02 00 6A 09 07 18 18 E0 2015/05/05 17:03:07 7B26F0 c (dvbapi) BC 02 00 6C 09 07 18 19 E0 BC 02 00 6D 09 07 18 2015/05/05 17:03:07 7B26F0 c (dvbapi) 17 E0 BB 02 01 C0 09 07 18 18 E0 BB 02 01 C0 09 2015/05/05 17:03:07 7B26F0 c (dvbapi) 07 18 19 E0 BB 02 01 C0 09 07 18 17 E0 B7 02 00 2015/05/05 17:03:07 7B26F0 c (dvbapi) 6A 09 07 18 18 E0 B9 47 02 0B 12 C7 DB 70 56 39 2015/05/05 17:03:07 7B26F0 c (dvbapi) E8 C5 C7 CD 62 C5 22 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 0 CAID: 0622 EMM_PID: 0136 PROVID: 000000 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 1 CAID: 0100 EMM_PID: 00B6 PROVID: 000000 TYPE :UNIQUE:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 2 CAID: 0100 EMM_PID: 00B7 PROVID: 00006A TYPE :SHARED: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 3 CAID: 0100 EMM_PID: 00B8 PROVID: 00006B TYPE :SHARED: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 4 CAID: 0100 EMM_PID: 00B9 PROVID: 00006C TYPE :SHARED: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 5 CAID: 0100 EMM_PID: 00BA PROVID: 00006D TYPE :SHARED: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 6 CAID: 0100 EMM_PID: 00BB PROVID: 000000 TYPE :SHARED: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 7 CAID: 0D96 EMM_PID: 1F40 PROVID: 000000 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 8 CAID: 0624 EMM_PID: 1F41 PROVID: 000000 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 9 CAID: 0500 EMM_PID: 00AA PROVID: 042500 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 10 CAID: 0500 EMM_PID: 00AA PROVID: 042510 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 11 CAID: 0500 EMM_PID: 00AA PROVID: 042520 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 12 CAID: 0500 EMM_PID: 00AA PROVID: 042530 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 13 CAID: 0500 EMM_PID: 00AA PROVID: 051900 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 14 CAID: 1817 EMM_PID: 00B6 PROVID: 00FE22 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 15 CAID: 1818 EMM_PID: 00B6 PROVID: 00FE22 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 16 CAID: 1819 EMM_PID: 00B6 PROVID: 00FE22 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 17 CAID: 1817 EMM_PID: 00BC PROVID: 00006A TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 18 CAID: 1818 EMM_PID: 00BC PROVID: 00006C TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 19 CAID: 1819 EMM_PID: 00BC PROVID: 00006D TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 20 CAID: 1817 EMM_PID: 00BB PROVID: 0001C0 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 21 CAID: 1818 EMM_PID: 00BB PROVID: 0001C0 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 22 CAID: 1819 EMM_PID: 00BB PROVID: 0001C0 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 23 CAID: 1817 EMM_PID: 00B7 PROVID: 00006A TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 24 CAID: 1818 EMM_PID: 00B9 PROVID: 00020B TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 25 CAID: 1818 EMM_PID: 00B9 PROVID: 0012C7 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 26 CAID: 1818 EMM_PID: 00B9 PROVID: 00DB70 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 27 CAID: 1818 EMM_PID: 00B9 PROVID: 005639 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 28 CAID: 1818 EMM_PID: 00B9 PROVID: 00E8C5 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 29 CAID: 1818 EMM_PID: 00B9 PROVID: 00C7CD TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 30 CAID: 1818 EMM_PID: 00B9 PROVID: 0062C5 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 31 CAID: 1818 EMM_PID: 00B9 PROVID: 00220F TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 32 CAID: 1818 EMM_PID: 00B9 PROVID: 000500 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 33 CAID: 1818 EMM_PID: 00B9 PROVID: 00EC39 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 34 CAID: 1818 EMM_PID: 00B9 PROVID: 001001 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 35 CAID: 1818 EMM_PID: 00B9 PROVID: 000013 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 36 CAID: 1818 EMM_PID: 00B9 PROVID: 000120 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 37 CAID: 1818 EMM_PID: 00B9 PROVID: 001403 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 38 CAID: 1818 EMM_PID: 00B9 PROVID: 000519 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 39 CAID: 1818 EMM_PID: 00B9 PROVID: 000009 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 40 CAID: 1818 EMM_PID: 00B9 PROVID: 000F05 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 41 CAID: 1818 EMM_PID: 00B9 PROVID: 0000ED TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 42 CAID: 1818 EMM_PID: 00B9 PROVID: 000110 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 43 CAID: 1818 EMM_PID: 00B9 PROVID: 000100 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 44 CAID: 1818 EMM_PID: 00B9 PROVID: 001301 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 45 CAID: 1818 EMM_PID: 00B9 PROVID: 002014 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 46 CAID: 1818 EMM_PID: 00B9 PROVID: 000305 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 47 CAID: 1818 EMM_PID: 00B9 PROVID: 001900 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Added new emmpid 48 CAID: 1818 EMM_PID: 00B9 PROVID: 000000 TYPE :UNIQUE:SHARED:GLOBAL: 2015/05/05 17:03:07 7B26F0 c (dvbapi) Demuxer 0 stop Filter 2 (fd: 65535 api: 0, caid: 0001, provid: 000001, emmpid: 0001) 2015/05/05 17:03:07 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:03:07 7B26F0 c (dvbapi) 00 00 6F 2A 00 00 01 00 01 2015/05/05 17:03:07 7B26F0 c (dvbapi) Demuxer 0 has 3 ecmpids, 2 streampids, 1 ecmfilters and 0 of max 6168 emmfilters 2015/05/05 17:03:08 7B26F0 c (dvbapi) Demuxer 0 Unable to open PMT file /tmp/ -> stop descrambling! 2015/05/05 17:03:08 7B26F0 c (dvbapi) Demuxer 0 stop descrambling program number 1B07 (0000:1B07 unknown) 2015/05/05 17:03:08 7B26F0 c (dvbapi) Demuxer 0 stop Filter 1 (fd: 65535 api: 0, caid: 0100, provid: 00006A, ecmpid: 070A) 2015/05/05 17:03:08 7B26F0 c (dvbapi) Sending packet to dvbapi client (fd=45): 2015/05/05 17:03:08 7B26F0 c (dvbapi) 00 00 6F 2A 00 00 00 07 0A

Let me know if you need more info.

posixx commented 9 years ago

Addition; after restarting oscam the channel runs fine, in the VDR log i see:

May 5 17:24:57 DVRServer vdr: [736] VNSI: exit streamer thread May 5 17:24:57 DVRServer vdr: [736] cLiveStreamer stream processor thread ended (pid=32437, tid=736) May 5 17:24:57 DVRServer vdr: [731] VNSI: LiveStreamer::Close - close May 5 17:24:57 DVRServer vdr: [731] VNSI: close video input ... May 5 17:24:57 DVRServer vdr: [731] VNSI: call retune ... May 5 17:24:57 DVRServer vdr: [731] CAM 1: unassigned May 5 17:24:57 DVRServer vdr: [731] VNSI: call retune ... May 5 17:24:57 DVRServer vdr: [731] VNSI: close video input ... May 5 17:24:57 DVRServer vdr: [731] VNSI: LiveStreamer::Close - close May 5 17:24:57 DVRServer vdr: [731] VNSI: close video input ... May 5 17:24:57 DVRServer vdr: [32592] DVBAPI-Error: SetCaPid: Parameter(s) out of range: adapter_index=0, pid=0xcdab, index=0xffffffff May 5 17:24:57 DVRServer vdr: [798] device 1 TS buffer thread ended (pid=32437, tid=798) May 5 17:24:57 DVRServer vdr: [796] buffer stats: 176156 (3%) used May 5 17:24:57 DVRServer vdr: [796] device 1 receiver thread ended (pid=32437, tid=796) May 5 17:24:57 DVRServer vdr: [731] CAM 1: assigned to device 1 May 5 17:24:57 DVRServer vdr: [2713] device 1 receiver thread started (pid=32437, tid=2713, prio=high) May 5 17:24:57 DVRServer vdr: [731] VNSI: Successfully switched to channel 5 - RTL5 HD May 5 17:24:57 DVRServer vdr: [731] VNSI: Started streaming of channel RTL5 HD (timeout 10 seconds) May 5 17:24:57 DVRServer vdr: [2718] cLiveStreamer stream processor thread started (pid=32437, tid=2718, prio=high) May 5 17:24:57 DVRServer vdr: [2720] device 1 TS buffer thread started (pid=32437, tid=2720, prio=high) May 5 17:24:57 DVRServer vdr: [2715] VNSI: VideoInput: no pat/pmt within timeout, falling back to channel pids May 5 17:24:57 DVRServer vdr: [2715] VNSI: Video Input - new pmt, attaching receiver May 5 17:24:57 DVRServer vdr: [2718] VNSI: Created stream for pid=523 and type=8 May 5 17:24:57 DVRServer vdr: [2718] VNSI: Created stream for pid=83 and type=1 May 5 17:24:57 DVRServer vdr: [2718] VNSI: Created stream for pid=33 and type=11 May 5 17:24:58 DVRServer vdr: [2718] VNSI-Error: cParser::AddPESPacket - max buffer size reached, pid: 523 May 5 17:24:58 DVRServer vdr: [32605] VNSI: Requesting clients to reload channel list May 5 17:24:59 DVRServer vdr: [2718] VNSI-Error: cParser::AddPESPacket - max buffer size reached, pid: 523 May 5 17:24:59 DVRServer vdr: [32437] VNSI: re-tune to channel RTL5 HD May 5 17:24:59 DVRServer vdr: [2718] VNSI: close video input ... May 5 17:24:59 DVRServer vdr: [2718] VNSI: call retune ... May 5 17:24:59 DVRServer vdr: [2718] CAM 1: unassigned May 5 17:24:59 DVRServer vdr: [2718] VNSI: call retune ... May 5 17:24:59 DVRServer vdr: [2718] CAM 1: assigned to device 1 May 5 17:24:59 DVRServer vdr: [2720] device 1 TS buffer thread ended (pid=32437, tid=2720) May 5 17:24:59 DVRServer vdr: [2713] buffer stats: 169388 (3%) used May 5 17:24:59 DVRServer vdr: [2713] device 1 receiver thread ended (pid=32437, tid=2713) May 5 17:24:59 DVRServer vdr: [2781] device 1 receiver thread started (pid=32437, tid=2781, prio=high) May 5 17:24:59 DVRServer vdr: [2783] device 1 TS buffer thread started (pid=32437, tid=2783, prio=high) May 5 17:24:59 DVRServer vdr: [2782] VNSI: VideoInput: no pat/pmt within timeout, falling back to channel pids May 5 17:24:59 DVRServer vdr: [2782] VNSI: Video Input - new pmt, attaching receiver May 5 17:25:32 DVRServer vdr: [32592] DVBAPI-Error: SetCaPid: Parameter(s) out of range: adapter_index=0, pid=0xce2d, index=0x0

Looks like some issue with EMM filter activation / handling?

manio commented 9 years ago

I don't have this kind of problems with this OSCam revision (and also no report about the problems you mentioned). Are you sure about your config? What have you changed? Why OSCam it is telling you something about "PMT files"?

3PO commented 9 years ago

I don't have this kind of problems with this OSCam revision ...

Same here, everything works as fine. ;)

posixx commented 9 years ago

I have no idea why oscam reports this. I use DVBAPI networked mode:

[dvbapi] enabled = 1 au = 1 pmt_mode = 4 request_mode = 1 listen_port = 2000 user = dvrserver boxtype = pc

VDR runs on separate server, OSCam on my Synology NAS. on the VDR server i use Andrey Pavlenko's PPA, i will wait until the next build and try again.

Until now no problem with this combo same as last night. Only this afternoon i had this problem. After restarting oscam it works.

I keep having the failing back and DVBAPI-Error messages, any idea what causes them?

posixx commented 9 years ago

Strange, when i use a second streamer (bedroom) the same error reappears. I need to restart oscam to have it working again. I will revert to an older oscam version tomorrow.

posixx commented 9 years ago

I have reverted oscam to 10651 and first test indicate the problem is gone. So i will test this the upcoming days and update this report.

posixx commented 9 years ago

Sorry, spoke to soon:

2015/05/06 15:04:04 7B0B00 c (dvbapi) Demuxer 0 Unable to open PMT file /tmp/2 -> stop descrambling!

Same problem.

manio commented 9 years ago

Please give me pastebin-ed logs:

  1. vdr log with dvbapi loglevel=3
  2. oscam log with level=128
posixx commented 9 years ago

Here you go:

syslog vdr: http://pastebin.com/NSzJyLBi oscam log: http://pastebin.com/tGHemcBu

oscam crashed completely so don's see the 'stop descrambling' message in these logs

posixx commented 9 years ago

it's getting worse, i cannot seem to have it working like before. I installed an older vdr-plugin-dvbapi version with protocol 1 but also that is failing, see oscam log:

http://pastebin.com/4QG6Uu57

i'm using pmt_mode=4

posixx commented 9 years ago

Tried oscam on same server as VDR, running latest build 10656. Same problem!! I'm going to remove vdr tomorrow and build from scratch

manio commented 9 years ago

You have not only OSCam crashing, but even maybe some problems with your hardware, I can see kernel dump traces in your dmesg.

Are you compiling OSCam yourself? I still don't know why it is using PMT files! It should not at all!

Look at your error: "Demuxer 0 Unable to open PMT file /tmp/ -> stop descrambling!" And note the strange characters at the end. Something is definitely wrong there.

Sorry, I cannot help you if your working configuration is not working any more. We have to stay on working config and then upgrade oscam/plugin step by step to see what could cause the regression (if there is any, because even in your old config it is not working). Was it working fine before?

I would not be surprised if the core of the problem is something related to your dvb hardware or modules.

posixx commented 9 years ago

It was working fine before. i don't know which oscam version was on the synology as i don't build these myself. I have setup oscam latest build on the VDR server and connect through cccam client to synology so i can debug more. I opened a post on streamboard as this looks an oscam issue to me:

http://www.streamboard.tv/wbb2/thread.php?postid=542660#post542660

manio commented 9 years ago

Ok. I have too little information about this whole issue. In this case (and your assumption about oscam) I am closing it. Please reopen if you are sure that the problem is with the dvbapi plugin.

posixx commented 9 years ago

Well, it's a problem of the new network protocol of dvbapi for sure. If it's within your plugin or oscam i can't say. But when i use the old mode (/tmp/camd.socket) in oscam and VDR i have no problems anymore. Tested with 2 clients for about 2 hours now, keeps working all the time.

See http://www.streamboard.tv/wbb2/thread.php?postid=542667#post542667 for logs