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

"PMT BUFFER OVERFLOW, PLEASE REPORT!" #79

Closed CReimer closed 9 years ago

CReimer commented 9 years ago

Am I right with this here, or should I report that to oscam directly? I do not have more logs, because I don't had vdr-dvbapi's loglevel on 3 while this happened.

2014/10/31 21:02:26 1145330 c dvbapi (1843&000000/0000/EF78/89:982CB791DB67C7CE37C42F2B58F408E3): found (392 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:02:33 1145330 c dvbapi (1843&000000/0000/EF78/89:F035E0E7C7C39F5355700964FFDC5EA0): found (392 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:02:35 1145330 c dvbapi (0648&000000/0001/132F/44:9AE730EBAA7BA1C6B707D1DEE259EBF1): found (113 ms) by orf-ice - ORF1 HD
2014/10/31 21:02:40 1145330 c dvbapi (1843&000000/0000/EF78/89:ADB84EE79E746F4585C14830851C56EA): found (396 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:02:45 1145330 c dvbapi (0648&000000/0001/132F/44:2C2C1F674FB2179EA5E4526749573413): found (114 ms) by orf-ice - ORF1 HD
2014/10/31 21:02:47 1145330 c dvbapi (1843&000000/0000/EF78/89:FFA610CDF2D273780CFC356447EDBF44): found (395 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:02:54 1145330 c dvbapi (1843&000000/0000/EF78/89:3D0613CAE6119F9D118A919A317D3C5E): found (395 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:02:55 1145330 c dvbapi (0648&000000/0001/132F/44:68D7FC0B1A511E36DE19C7118F19071D): found (112 ms) by orf-ice - ORF1 HD
2014/10/31 21:03:01 1145330 c dvbapi (1843&000000/0000/EF78/89:4B03D6C28CB9CF64FF3B765166B6AEBC): found (392 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:03:05 1145330 c dvbapi (0648&000000/0001/132F/44:5CBC44EC79B0026EB45CF9B3751C373C): found (111 ms) by orf-ice - ORF1 HD
2014/10/31 21:03:08 1145330 c dvbapi (1843&000000/0000/EF78/89:7129D5FE3F7B4DD9FDB437899ED5ECD8): found (395 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:03:15 1145330 c dvbapi (1843&000000/0000/EF78/89:9BF767F76C19853CFA8908242825E6DE): found (398 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:03:15 1145330 c dvbapi (0648&000000/0001/132F/44:4B18985B4F7D1FB2AED8C65C2718BCC3): found (113 ms) by orf-ice - ORF1 HD
2014/10/31 21:03:22 1145330 c dvbapi (1843&000000/0000/EF78/89:CA83026C0A189CCB7792A09C37F210AB): found (396 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:03:25 1145330 c dvbapi (0648&000000/0001/132F/44:D37D78692FF4B420380F306F4EE890D2): found (112 ms) by orf-ice - ORF1 HD
2014/10/31 21:03:29 1145330 c dvbapi (1843&000000/0000/EF78/89:8D7272CEB9F349EF3556E042AE21035C): found (397 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:03:35 1145330 c dvbapi (0648&000000/0001/132F/44:39C369F59F89AED49355CFF2B3EADFE1): found (112 ms) by orf-ice - ORF1 HD
2014/10/31 21:03:36 1145330 c dvbapi (1843&000000/0000/EF78/89:B0D7EED6DD458FC75426BCF3DE8D3D42): found (389 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:03:43 1145330 c dvbapi (1843&000000/0000/EF78/89:59D312AD02F7C7491E27463FA2C90528): found (392 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:03:45 1145330 c dvbapi (0648&000000/0001/132F/44:AE2CD642E781E2901829159ACC6B9E00): found (111 ms) by orf-ice - ORF1 HD
2014/10/31 21:03:50 1145330 c dvbapi (1843&000000/0000/EF78/89:056C81BDC4E75B3F92BEA32362D2973A): found (391 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:03:55 1145330 c dvbapi (0648&000000/0001/132F/44:2383989D9FEF034D2A3F7CCCF515D57B): found (114 ms) by orf-ice - ORF1 HD
2014/10/31 21:03:57 1145330 c dvbapi (1843&000000/0000/EF78/89:D0C63E30EC9CF0D6E0A54620BCC869E2): found (398 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:04:04 1145330 c dvbapi (1843&000000/0000/EF78/89:C0DFBA51BA749AD935F7E5C252BA5EC3): found (395 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:04:05 1145330 c dvbapi (0648&000000/0001/132F/44:6E15D9A3BBB3A50A3BCB180DB42D3796): found (111 ms) by orf-ice - ORF1 HD
2014/10/31 21:04:06 1145330 c [DVBAPI] ***** WARNING: PMT BUFFER OVERFLOW, PLEASE REPORT! ******
2014/10/31 21:04:06 1145330 c [DVBAPI] Unknown socket command received: 0xFFFFFFFF
2014/10/31 21:04:06 0 --- Skipped 1 duplicated log lines ---
2014/10/31 21:04:11 0 --- Skipped 99 duplicated log lines ---
2014/10/31 21:04:11 1145330 c dvbapi (1843&000000/0000/EF78/89:3E68B40159867C8438FE8C84BBDCC2A4): found (395 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:04:15 1145330 c dvbapi (0648&000000/0001/132F/44:E77817612D31BCB8679C422F3D0D7496): found (113 ms) by orf-ice - ORF1 HD
2014/10/31 21:04:18 1145330 c dvbapi (1843&000000/0000/EF78/89:700FC40A04E6728C79EE1CC789BDF604): found (393 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:04:25 1145330 c dvbapi (1843&000000/0000/EF78/89:AB6FBDC69CA1AC6B1F5F98098EEBF2B7): found (391 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:04:25 1145330 c dvbapi (0648&000000/0001/132F/44:675E37445AD26271985E0C1792E57E63): found (111 ms) by orf-ice - ORF1 HD
2014/10/31 21:04:32 1145330 c dvbapi (1843&000000/0000/EF78/89:61D8A5892D47B14447F3E348A1B23007): found (393 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:04:35 1145330 c dvbapi (0648&000000/0001/132F/44:153278716C4E7E42EAC6F57366F3BABE): found (112 ms) by orf-ice - ORF1 HD
2014/10/31 21:04:39 1145330 c dvbapi (1843&000000/0000/EF78/89:4F0DC20BDE804EF41B5E10EC2E8678EE): found (399 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:04:45 1145330 c dvbapi (0648&000000/0001/132F/44:5DC66FB8BDC8A9333C3405DB19602186): found (112 ms) by orf-ice - ORF1 HD
2014/10/31 21:04:46 1145330 c dvbapi (1843&000000/0000/EF78/89:C4371B40A79B992D94F6206CB8D59228): found (397 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:04:53 1145330 c dvbapi (1843&000000/0000/EF78/89:C42FFCE3499B28476B14F990E4758BD7): found (395 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:04:55 1145330 c dvbapi (0648&000000/0001/132F/44:6FF40D30AD459EAB775E2A11F89700CD): found (113 ms) by orf-ice - ORF1 HD
2014/10/31 21:05:00 1145330 c dvbapi (1843&000000/0000/EF78/89:9FB084F03B600B39B66CD6BAD7970466): found (392 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:05:05 1145330 c dvbapi (0648&000000/0001/132F/44:104ABE1EC25677560EF0EF3B913F1E6C): found (112 ms) by orf-ice - ORF1 HD
2014/10/31 21:05:07 1145330 c dvbapi (1843&000000/0000/EF78/89:0D08AA70562FC2D3BE15D0BFE3D2D773): found (395 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:05:14 1145330 c dvbapi (1843&000000/0000/EF78/89:003CD24537B438E6F46A2CF983EF0DE2): found (395 ms) by hdplus02 - ProSieben MAXX HD
2014/10/31 21:05:15 1145330 c dvbapi (0648&000000/0001/132F/44:6BD6DD86F748883B51DBEDBE9D1D8C1C): found (112 ms) by orf-ice - ORF1 HD
CReimer commented 9 years ago

Here's a set of logs (VDR+OSCAM). Now with loglevel on 3 https://gist.github.com/CReimer/762f03eb7c11e4a2b803

At the moment it looks like this overflow happens in a 30 minutes interval

manio commented 9 years ago

I can see that the PMT data is very big (sending len=1366). This could be the problem, because the buffer in the OSCam is smaller. There could be various reasons - maybe the data parser is wrong. I have to analyze it. On what channels you have it? Is it working despite this error?

3PO commented 9 years ago

Checkout SkinDesigner, this revison (or newer) and your Problems are gone: --> http://projects.vdr-developer.org/git/vdr-plugin-skindesigner.git/commit/?id=f9f68cae8d64f5c60ffaa34118b66f5ebab28506

CReimer commented 9 years ago

This has nothing to do with skindesigner as this plugin wasn't even loaded at that time.

@manio: I think it only happens while two channels are decrypted. It's happening with all encrypted channels I tried.

manio commented 9 years ago

@CReimer 3PO was probably talking about issue https://github.com/manio/vdr-plugin-dvbapi/issues/77 which you've suffer...

and about this issue: besides this PMT error, are channels decrypted correctly or freezes?

CReimer commented 9 years ago

Everything works as expected. No visible problems at all. Also softhddevice doesn't complain about broken frames or anything.

manio commented 9 years ago

@CReimer Can I close this ticket now? Or you still have such problems?

CReimer commented 9 years ago

No. I think, whatever it was, is gone.

manio commented 9 years ago

Ok, thanks :)

CReimer commented 9 years ago

It's back... My ORF cards somehow stopped working in Cryptoworks mode. So I switched it into Irdeto Mode.

It's exactly the same as before:

socket_fd=7 len=1213 wrote=1213

and

Unknown socket command received: 0xC6EBD78A ***** WARNING: PMT BUFFER OVERFLOW, PLEASE REPORT! ******

in the oscam log

3PO commented 9 years ago

This is not a Problem of the dvbapi plugin.

My ORF Card is working in ICE Mode as expected:

server01 ~ # log o |grep -i orf
2015/04/25 19:23:07   973D20 c   (dvbapi) Demuxer 0 new program number: 132F (ORF eins HD) [pmt_list_management 3]
2015/04/25 19:23:08   973D20 c      (ecm) vdr_dvbapi (0648&000000/0001/132F/44:E06946BCD5462D66158DF234E6E31D22): found (86 ms) by orf (L/1/4/4) - ORF eins HD
2015/04/25 19:23:15   973D20 c   (reader) orf [irdeto] vdr_dvbapi emmtype=global, len=36, cnt=2: skipped (0 ms)
2015/04/25 19:23:15   973D20 c      (ecm) vdr_dvbapi (0648&000000/0001/132F/44:A69EA65C0174875F536DD872BCE7B3BB): found (87 ms) by orf (L/1/4/4) - ORF eins HD
2015/04/25 19:23:20   973D20 c   (reader) orf [irdeto] vdr_dvbapi emmtype=global, len=36, cnt=2: skipped (0 ms)
2015/04/25 19:23:24   973D20 c   (reader) orf [irdeto] vdr_dvbapi emmtype=global, len=36, cnt=2: skipped (0 ms)
2015/04/25 19:23:25   973D20 c      (ecm) vdr_dvbapi (0648&000000/0001/132F/44:C9BB3CEB4BA2121D69C25421295588E2): found (88 ms) by orf (L/1/4/4) - ORF eins HD
2015/04/25 19:23:29   973D20 c   (reader) orf [irdeto] vdr_dvbapi emmtype=global, len=36, cnt=2: skipped (0 ms)
manio commented 9 years ago

I think it may be some temporary problems: it was working for fine for several months and now it appears again in your case. The unknown socket command sometimes appear because of "auto-sensing" of old OSCam version. Please contact @MegaV0lt, he is currently successfully testing my patches, this could help in your case. Anyway - closing the issue as I am unable to catch this problem in such a rare reveals.