{Patch] Verifizierung der Daten vor Ermittlung der EMM-Pids

HelmutB · 23. Mai 2019

corvy hat hier beschrieben dass bei ihm gelegentlich nach dem Start einer verschlüsselten Aufnahme VDR mit einem "emergency exit" einen Neustart durchführt.

Eine Ursache dafür könnten fehlerhafte Daten in der CAT section sein, die dann in weiterer Folge zur Ermittlung einer falschen EMM-Pid führen und damit das Programm nicht entschlüsselt wird.

Der Patch vdr-2.4.0-verify-cat-crc.patch prüft die Gültigkeit der Daten der CAT Section über die CRC32 Prüfsumme und die EMM-Pids werden dann nur bei fehlerfreien Daten ermittelt.

Da ich mir einerseits nicht ganz sicher bin, ob damit wirklich die Ursache des Problems behoben wird, andererseits der Fehler aber eher selten aufzutreten scheint und damit gar nicht leicht zu finden ist habe ich einen 2. Patch der im Hintergrund laufend alle einlangenden CAT-Sections überprüft und eine entsprechende Fehlermeldung ausgibt.

Ich selbst konnte bei einem Kurztest noch keinen Fehler feststellen. abe rVielleicht hat noch jemand Anderer Interesse diesen 2. Patch einzuspielen und Auffälligkeiten hier zu posten.

corvy : The HEXDUMP Macro is now includet in thevdr-2.4.0-verify-cat-crc-2-check-all.patch - manual patching is not required anymore.

Helmut

corvy · 23. Mai 2019

So HelmutB should I apply both of these patches or only the check_all one? My german is not good enough

haraldov · 23. Mai 2019

How can I catch the CRC-error in /var/log/syslog? Must I enable vdr debug logging or logging for vdr-plugin-ddci2.

HelmutB · 23. Mai 2019

Hallo

corvy - only this Patch: vdr-2-4-0-verify-cat-crc-2-check-all-patch -this one checks each received CAT-section (which is received normaly every 1 or 2 seconds) and reports if there is an CRC error into the syslog file.

haraldov : I usually have VDR loglevel set to 3 (no ddci2 debug required), My syslog-file is /var/log/messages (gentoo) in which i see also all "normal" VDR messages . To watch this logfile "live" i use the command tail -F /var/log/messages as root in an seperate xterm window.

Helmut

corvy · 23. Mai 2019

Thanks!

corvy · 3. Juni 2019

Hello, been working fine until today. Suddenly I got error "no data".

Here I captured the logs before I fixed it with a reboot:

Zitat

Jun 3 22:23:04 timeshift vdr: [1739] loading /var/lib/vdr/plugins/vnsiserver/allowed_hosts.conf

Jun 3 22:23:04 timeshift vdr: [1739] VNSI: Klient med ID 159 tilkoblet: 10.0.0.114:58572

3.6 22:23:04 tidsforskyvningen VDR: [14052] VNSI klient 159-> 10.0.0.114:58572 tråd startet (PID = 1721 Tid = 14052, prio = høy)

Jun 3 22:23:04 timeshift vdr: [14052] VNSI: Velkommen klient 'XBMC Media Center' med protokollversjon '13'

Jun 3 22:23:04 timeshift vdr: [14052] VNSI: LiveStreamer :: Lukk - lukk

Jun 3 22:23:04 timeshift vdr: [14052] VNSI: lukk videoinngang ...

Jun 3 22:23:04 timeshift vdr: [14052] CAM 1/2: gjenbruk av MTD CAM-sporet

Jun 3 22:23:04 timeshift vdr: [14052] CAM 1: Tilordnet til enhet 2

3.6 22:23:04 tidsforskyvningen VDR: [14052] VNSI: ble funnet følgende anordning: 0x55ce5d55b240 (2) for å motta, prioritet = 0

Juni 3 22:23:04 timeshift vdr: [14052] BuildCaPmts: [1] ActiveProgs: 0 of 1

Jun 3 22:23:04 timeshift vdr: [14053] enhet 2 mottaker tråd startet (pid = 1721, tid = 14053, prio = høy)

Jun 3 22:23:04 timeshift vdr: [14052] SendCaPmts: [0] aktiver i CAM: 0 -> 0

Jun 3 22:23:04 timeshift vdr: [14052] VNSI: Dummy-mottaker (0x7f45d400bf10) aktivert

Jun 3 22:23:04 timeshift vdr: [14054] enhet 2 TS buffer tråd startet (pid = 1721, tid = 14054, prio = høy)

Jun 3 22:23:04 timeshift vdr: [14052] VNSI: aktiver live mottaker: 1

Juni 3 22:23:04 timeshift vdr: [14052] BuildCaPmts: [1] ActiveProgs: 1 of 1

Jun 3 22:23:04 timeshift vdr: [14052] SendCaPmts: [1] aktiver i CAM: 0 -> 1

Jun 3 22:23:04 timeshift vdr: [14052] VNSI: Vellykket byttet til kanal 1 - NRK1 Østlandssendingen

Jun 3 22:23:04 timeshift vdr: [14052] VNSI: Startet streaming av kanal NRK1 Østlandssendingen (timeout 10 sekunder)

Jun 3 22:23:04 timeshift vdr: [14055] cLiveStreamer stream prosessor tråd startet (pid = 1721, tid = 14055, prio = høy)

Jun 3 22:23:04 timeshift vdr: [1739] loading /var/lib/vdr/plugins/vnsiserver/allowed_hosts.conf

Jun 3 22:23:04 timeshift vdr: [1739] VNSI: Klient med ID 160 tilkoblet: 10.0.0.114:58573

Jun 3 22:23:04 timeshift vdr: [14056] VNSI Client 160-> 10.0.0.114:58573 tråd startet (pid = 1721, tid = 14056, prio = høy)

Jun 3 22:23:04 timeshift vdr: [14056] VNSI: Velkommen klient 'XBMC Media Center' med protokollversjon '13'

Jun 3 22:23:04 timeshift vdr: [14056] VNSI klient 160-> 10.0.0.114:58573 tråd avsluttet (pid = 1721, tid = 14056)

3 juni 22:23:04 timeshift kernel: [746320,263812] dvb_frontend: dvb_frontend_get_frequency_limits: frekvensintervall: tuner: 48000000 ... 864 millioner, frontend: 47000000 ... 865 000 000

Jun 3 22:23:04 timeshift vdr: [1740] VNSI: fjerner klient med ID 160 fra klientliste

Jun 3 22:23:05 timeshift vdr: [14055] VNSI: Laget strøm for pid = 512 og type = 8

3.6 22:23:05 tidsforskyvningen VDR: [14055] VNSI: Laget strøm for PID = 641 og type = 1

Jun 3 22:23:05 timeshift vdr: [14055] VNSI: Laget strøm for pid = 640 og type = 5

3.6 22:23:05 tidsforskyvningen VDR: [14055] VNSI: Laget strøm for PID = 600 og type = 10

3.6 22:23:05 tidsforskyvningen VDR: [14055] VNSI: Laget strøm for PID = 601 og type = 10

3.6 22:23:05 tidsforskyvningen VDR: [14055] VNSI: Laget strøm for PID = 3003 og type = 12

Jun 3 22:23:14 timeshift vdr: [14055] VNSI: Kanal: ingen data 16

Alles anzeigen

After a reboot it works, logs::

Zitat

Jun 3 22:27:03 timeshift vdr: [1836] CAM 1: Ufordelt fra enhet 2

Jun 3 22:27:03 timeshift vdr: [1836] VNSI: Dummy-mottaker (0x7f6040111400) deaktivert

Jun 3 22:27:03 timeshift vdr: [1836] VNSI: Lukk videoinngang ...

Jun 3 22:27:03 timeshift vdr: [1836] VNSI: cxSocket :: les (fd = 33): eof, tilkobling lukket

Jun 3 22:27:03 timeshift vdr: [1836] VNSI Client 4-> 10.0.0.114:58777 tråd avsluttet (pid = 1304, tid = 1836)

Jun 3 22:27:03 timeshift vdr: [1323] loading /var/lib/vdr/plugins/vnsiserver/allowed_hosts.conf

Jun 3 22:27:03 timeshift vdr: [1323] VNSI: Klient med ID 6 tilkoblet: 10.0.0.114:58783

Jun 3 22:27:03 timeshift vdr: [1896] VNSI Client 6-> 10.0.0.114:58783 tråd startet (pid = 1304, tid = 1896, prio = høy)

Jun 3 22:27:03 timeshift vdr: [1896] VNSI: Velkommen klient 'XBMC Media Center' med protokollversjon '13'

Jun 3 22:27:03 timeshift vdr: [1896] VNSI: LiveStreamer :: Lukk - lukk

Jun 3 22:27:03 timeshift vdr: [1896] VNSI: lukk videoinngang ...

Jun 3 22:27:03 timeshift vdr: [1896] CAM 1: CanDecrypt (163)

Jun 3 22:27:03 timeshift vdr: [1896] CAM 1: CanDecrypt (163) grense 4 - aktiv 0 -> SANT

Jun 3 22:27:03 timeshift vdr: [1896] CAM 1: CanDecrypt (163)

Jun 3 22:27:03 timeshift vdr: [1896] CAM 1: CanDecrypt (163) grense 4 - aktiv 0 -> SANT

Jun 3 22:27:03 timeshift vdr: [1896] VNSI: Vellykket funnet følgende enhet: 0x556bfc061ed0 (1) for mottak, prioritet = 0

Juni 3 22:27:03 timeshift vdr: [1896] BuildCaPmts: [1] ActiveProgs: 1 of 2

Jun 3 22:27:03 timeshift vdr: [1896] SendCaPmts: [0] aktiver i CAM: 0 -> 1

Jun 3 22:27:03 timeshift vdr: [1896] VNSI: Dummy-mottaker (0x7f604000b380) aktivert

Jun 3 22:27:03 timeshift vdr: [1896] VNSI: aktiver live mottaker: 1

Juni 3 22:27:03 timeshift vdr: [1896] BuildCaPmts: [1] ActiveProgs: 2 of 2

Juni 3 22:27:03 timeshift vdr: [1896] SendCaPmts: [1] aktiver i CAM: 1 -> 2

Jun 3 22:27:03 timeshift vdr: [1896] VNSI: Vellykket byttet til kanal 6 - TV2 Livsstil HD

Jun 3 22:27:03 timeshift vdr: [1896] VNSI: Start streaming TV2 Livsstil HD (timeout 10 sekunder)

Jun 3 22:27:03 timeshift vdr: [1897] cLiveStreamer stream prosessor tråd startet (pid = 1304, tid = 1897, prio = høy)

Jun 3 22:27:03 timeshift vdr: [1323] loading /var/lib/vdr/plugins/vnsiserver/allowed_hosts.conf

Jun 3 22:27:03 timeshift vdr: [1323] VNSI: Klient med ID 7 tilkoblet: 10.0.0.114:58784

Jun 3 22:27:03 timeshift vdr: [1898] VNSI Client 7-> 10.0.0.114:58784 tråd startet (pid = 1304, tid = 1898, prio = høy)

Jun 3 22:27:03 timeshift vdr: [1898] VNSI: Velkommen klient 'XBMC Media Center' med protokollversjon '13'

Jun 3 22:27:03 timeshift vdr: [1898] VNSI Client 7-> 10.0.0.114:58784 tråd avsluttet (pid = 1304, tid = 1898)

Jun 3 22:27:03 timeshift vdr: [1842] enhet 2 TS buffer tråd endte (pid = 1304, tid = 1842)

Jun 3 22:27:03 timeshift vdr: [1841] bufferstatistikk: 114680 (2%) brukt

Jun 3 22:27:03 timeshift vdr: [1841] enhet 2 mottaker tråd endte (pid = 1304, tid = 1841)

Jun 3 22:27:03 timeshift vdr: [1324] VNSI: fjerner klient med ID 4 fra klientliste

Jun 3 22:27:03 timeshift vdr: [1324] VNSI: fjerner klient med ID 7 fra klientliste

Jun 3 22:27:03 timeshift vdr: [1897] VNSI: Laget strøm for pid = 1069 og type = 8

Jun 3 22:27:03 timeshift vdr: [1897] VNSI: Laget strøm for pid = 3168 og type = 2

Jun 3 22:27:04 timeshift vdr: [1897] VNSI: Lydstrømskifte, pid: 3168, kanaler: 2, samplerate: 48000

3 juni 22:27:04 timeshift vdr: [1897] VNSI: Video stream endring, pid: 1069, bredde: 1280, høyde: 720, aspekt: 1,777778

3 juni 22:27:04 timeshift kernel: [160.533873] dvb_frontend: dvb_frontend_get_frequency_limits: frekvensintervall: tuner: 48000000 ... 864 000 000, frontend: 47000000 ... 865 000 000

Alles anzeigen

Complete syslog attached.

HelmutB · 4. Juni 2019

I dont know if this is CAM related, At least no CRC-errors in your logfiles.

VNSI: Channel: no data 16 - have you seen this: https://github.com/FernetMenta…ugin-vnsiserver/issues/97 - discussed here too: Kodi18 / VNSI Plugin .

Helmut

corvy · 4. Juni 2019

Well .. if this is my issue it seems to not have a solution for now. Very strange stuff. Maybe I could do with just restarting the VNSI server plugin of VDR to solve it?

{Patch] Verifizierung der Daten vor Ermittlung der EMM-Pids

Jetzt mitmachen!

Teilen

Benutzer online in diesem Thema