Blöde Frage: v14 freischalten mit headless VDR

[ztrac]

Hi,

nachdem nun mein Oscam die v14 erkannt hat, stellt sich mir die Frage, wie ich EMMs loggen kann. vdr läuft hier headless, als reiner Rekorder. Ich habe jetzt vdr mal gesagt, es soll Sky Krimi aufnehmen. Passt das so? Ich frage, weil vdr immer kurz aufzunehmen versucht und dann mit Fehlermeldung abbricht:

Spoiler

Jul 10 15:58:43 vdr: [20901] switching device 1 to channel 203 (Sky Krimi)
Jul 10 15:58:43 vdr: [20901] timer 55 (203 1448-1605 'Siska') start
Jul 10 15:58:43 vdr: [20901] Title: 'Siska' Subtitle: 'Hass ist ein stiller Mijrder'
Jul 10 15:58:43 vdr: [20901] executing '/usr/lib/vdr/vdr-recordingaction before "/var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec"'
Jul 10 15:58:43 recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom before recording /var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec
Jul 10 15:58:43 vdr: [20901] record /var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec
Jul 10 15:58:43 vdr: [20901] cFileName::SetOffset: removing zero-sized file /var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec/00001.ts
Jul 10 15:58:43 vdr: [20901] recording to '/var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec/00001.ts'
Jul 10 15:58:43 vdr: [21869] recording thread started (pid=20901, tid=21869, prio=high)
Jul 10 15:58:43 vdr: [20901] DVBAPI: 0.0 set CAM decrypt (SID 23 (0x0017), caLm 4, HasCaDescriptors 1)
Jul 10 15:58:43 vdr: [21870] device 1 receiver thread started (pid=20901, tid=21870, prio=high)
Jul 10 15:58:43 vdr: [21871] device 1 TS buffer thread started (pid=20901, tid=21871, prio=high)
Jul 10 15:58:47 vdr: [21870] detaching receiver - won't decrypt channel S19.2E-133-1-23 with CAM 1
Jul 10 15:58:47 vdr: [21869] recording thread ended (pid=20901, tid=21869)
Jul 10 15:58:47 vdr: [21870] DVBAPI: 0.0 set CAM decrypt (SID 23 (0x0017), caLm 5, HasCaDescriptors 1)
Jul 10 15:58:47 vdr: [21870] CAM 1: unassigned
Jul 10 15:58:47 vdr: [21871] device 1 TS buffer thread ended (pid=20901, tid=21871)
Jul 10 15:58:47 vdr: [21870] buffer stats: 111108 (2%) used
Jul 10 15:58:47 vdr: [21870] device 1 receiver thread ended (pid=20901, tid=21870)
Jul 10 15:58:47 vdr: [20901] buffer stats: 82908 (0%) used
Jul 10 15:58:47 vdr: [20901] timer 55 (203 1448-1605 'Siska') stop
Jul 10 15:58:47 vdr: [20901] executing '/usr/lib/vdr/vdr-recordingaction after "/var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec"'
Jul 10 15:58:47 recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom after recording /var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec
Jul 10 15:59:01 vdr: [20901] switching device 1 to channel 203 (Sky Krimi)
Jul 10 15:59:04 vdr: [20901] CAM 1: assigned to device 1
Jul 10 15:59:04 vdr: [20901] switching device 1 to channel 203 (Sky Krimi)
Jul 10 15:59:04 vdr: [20901] timer 55 (203 1448-1605 'Siska') start
Jul 10 15:59:04 vdr: [20901] Title: 'Siska' Subtitle: 'Hass ist ein stiller Mijrder'
Jul 10 15:59:04 vdr: [20901] executing '/usr/lib/vdr/vdr-recordingaction before "/var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec"'
Jul 10 15:59:04 recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom before recording /var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec
Jul 10 15:59:04 vdr: [20901] record /var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec
Jul 10 15:59:04 vdr: [20901] cFileName::SetOffset: removing zero-sized file /var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec/00001.ts
Jul 10 15:59:04 vdr: [20901] recording to '/var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec/00001.ts'
Jul 10 15:59:04 vdr: [22056] recording thread started (pid=20901, tid=22056, prio=high)
Jul 10 15:59:04 vdr: [20901] DVBAPI: 0.0 set CAM decrypt (SID 23 (0x0017), caLm 4, HasCaDescriptors 1)
Jul 10 15:59:04 vdr: [22057] device 1 receiver thread started (pid=20901, tid=22057, prio=high)
Jul 10 15:59:04 vdr: [22058] device 1 TS buffer thread started (pid=20901, tid=22058, prio=high)
Jul 10 15:59:08 vdr: [22057] detaching receiver - won't decrypt channel S19.2E-133-1-23 with CAM 1
Jul 10 15:59:08 vdr: [22056] recording thread ended (pid=20901, tid=22056)
Jul 10 15:59:08 vdr: [22057] DVBAPI: 0.0 set CAM decrypt (SID 23 (0x0017), caLm 5, HasCaDescriptors 1)
Jul 10 15:59:08 vdr: [22057] CAM 1: unassigned
Jul 10 15:59:08 vdr: [22058] device 1 TS buffer thread ended (pid=20901, tid=22058)
Jul 10 15:59:08 vdr: [22057] buffer stats: 117500 (2%) used
Jul 10 15:59:08 vdr: [22057] device 1 receiver thread ended (pid=20901, tid=22057)
Jul 10 15:59:08 vdr: [20901] buffer stats: 75388 (0%) used
Jul 10 15:59:08 vdr: [20901] timer 55 (203 1448-1605 'Siska') stop
Jul 10 15:59:08 vdr: [20901] executing '/usr/lib/vdr/vdr-recordingaction after "/var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec"'
Jul 10 15:59:08 recordingaction: executing /usr/share/vdr/recording-hooks/R90.custom after recording /var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec
Jul 10 15:59:23 vdr: [20901] switching device 1 to channel 203 (Sky Krimi)
Jul 10 15:59:25 vdr: [20901] CAM 1: assigned to device 1
Jul 10 15:59:25 vdr: [20901] switching device 1 to channel 203 (Sky Krimi)
Jul 10 15:59:25 vdr: [20901] timer 55 (203 1448-1605 'Siska') start
Jul 10 15:59:25 vdr: [20901] Title: 'Siska' Subtitle: 'Hass ist ein stiller Mijrder'
Jul 10 15:59:25 vdr: [20901] executing '/usr/lib/vdr/vdr-recordingaction before "/var/lib/vdr/Siska/2015-07-10.14.48.203-0.rec"'
[...]

Das zugehörige oscam.log sieht so aus:

Spoiler

2015/07/10 15:58:43 49A7FB09 c (-) -- Skipped 1 duplicated log lines --
2015/07/10 15:58:43 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 1702 ECM_PID: 1740 PROVID: 000000
2015/07/10 15:58:43 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 1833 ECM_PID: 1840 PROVID: 000000
2015/07/10 15:58:43 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 09C4 ECM_PID: 1B40 PROVID: 000000
2015/07/10 15:58:43 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 3 CAID: 09AF ECM_PID: 1F40 PROVID: 000000
2015/07/10 15:58:43 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 4 CAID: 098C ECM_PID: 1A40 PROVID: 000000
2015/07/10 15:58:43 49A7FB09 c (dvbapi) Demuxer 0 found 5 ECMpids and 2 STREAMpids in PMT
2015/07/10 15:58:43 49A7FB09 c (dvbapi) Demuxer 0 serving srvid 0017 (1702@000000:0017 unknown) on adapter 0000 camask 0001 index 0000 pmtpid 0000
2015/07/10 15:58:43 49A7FB09 c (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 098C PROVID 000000 ECMPID 1A40 ANY CHID PMTPID 0000 VPID 01FF
2015/07/10 15:58:43 4FAC5CF0 r (reader) v14 [videoguard2] classD3 ins54: no cw --> Card isn't active
2015/07/10 15:58:43 4FAC5CF0 r (reader) v14 [videoguard2] classD3 ins54: no cw --> Card needs pairing/extra data
2015/07/10 15:58:43 4FAC5CF0 r (reader) v14 [videoguard2] classD3 ins54: no cw --> No tier found
2015/07/10 15:58:43 4FAC5CF0 r (reader) v14 [videoguard2] classD3 ins54: no cw --> Tier expired
2015/07/10 15:58:43 49A7FB09 c (ecm) vdr (098C@000000/01FB/0017/98:BB52CB2B693F7E3392F49FCA59085E38:023020): not found (110 ms) by v14
2015/07/10 15:58:43 49A7FB09 c (ecm) vdr (098C@000000/01FB/0017/98:BB52CB2B693F7E3392F49FCA59085E38:023020): not found (0 ms) by v14
2015/07/10 15:58:44 49A7FB09 c (-) -- Skipped 1 duplicated log lines --
2015/07/10 15:58:44 49A7FB09 c (ecm) vdr (098C@000000/01FB/0017/98:BB52CB2B693F7E3392F49FCA59085E38:023020): not found (1 ms) by v14
2015/07/10 15:58:44 49A7FB09 c (ecm) vdr (098C@000000/01FB/0017/98:BB52CB2B693F7E3392F49FCA59085E38:023020): not found (0 ms) by v14
2015/07/10 15:58:46 49A7FB09 c (-) -- Skipped 8 duplicated log lines --
2015/07/10 15:58:46 49A7FB09 c (ecm) vdr (098C@000000/01FB/0017/98:BB52CB2B693F7E3392F49FCA59085E38:023020): not found (1 ms) by v14
2015/07/10 15:59:04 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 1702 ECM_PID: 1740 PROVID: 000000
2015/07/10 15:59:04 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 1833 ECM_PID: 1840 PROVID: 000000
2015/07/10 15:59:04 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 09C4 ECM_PID: 1B40 PROVID: 000000
2015/07/10 15:59:04 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 3 CAID: 09AF ECM_PID: 1F40 PROVID: 000000
2015/07/10 15:59:04 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 4 CAID: 098C ECM_PID: 1A40 PROVID: 000000
2015/07/10 15:59:04 49A7FB09 c (dvbapi) Demuxer 0 found 5 ECMpids and 2 STREAMpids in PMT
2015/07/10 15:59:04 49A7FB09 c (dvbapi) Demuxer 0 serving srvid 0017 (1702@000000:0017 unknown) on adapter 0000 camask 0001 index 0000 pmtpid 0000
2015/07/10 15:59:04 49A7FB09 c (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 098C PROVID 000000 ECMPID 1A40 ANY CHID PMTPID 0000 VPID 01FF
2015/07/10 15:59:05 4FAC5CF0 r (reader) v14 [videoguard2] classD3 ins54: no cw --> Card isn't active
2015/07/10 15:59:05 4FAC5CF0 r (reader) v14 [videoguard2] classD3 ins54: no cw --> Card needs pairing/extra data
2015/07/10 15:59:05 4FAC5CF0 r (reader) v14 [videoguard2] classD3 ins54: no cw --> No tier found
2015/07/10 15:59:05 4FAC5CF0 r (reader) v14 [videoguard2] classD3 ins54: no cw --> Tier expired
2015/07/10 15:59:05 49A7FB09 c (ecm) vdr (098C@000000/01FB/0017/98:A41846729C1C0C80F281B9A425E0ED95:023020): not found (111 ms) by v14
2015/07/10 15:59:05 49A7FB09 c (ecm) vdr (098C@000000/01FB/0017/98:A41846729C1C0C80F281B9A425E0ED95:023020): not found (0 ms) by v14
2015/07/10 15:59:07 49A7FB09 c (-) -- Skipped 9 duplicated log lines --
2015/07/10 15:59:07 49A7FB09 c (ecm) vdr (098C@000000/01FB/0017/98:A41846729C1C0C80F281B9A425E0ED95:023020): not found (1 ms) by v14
2015/07/10 15:59:07 49A7FB09 c (ecm) vdr (098C@000000/01FB/0017/98:A41846729C1C0C80F281B9A425E0ED95:023020): not found (0 ms) by v14
2015/07/10 15:59:26 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 1702 ECM_PID: 1740 PROVID: 000000
2015/07/10 15:59:26 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 1833 ECM_PID: 1840 PROVID: 000000
2015/07/10 15:59:26 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 09C4 ECM_PID: 1B40 PROVID: 000000
2015/07/10 15:59:26 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 3 CAID: 09AF ECM_PID: 1F40 PROVID: 000000
2015/07/10 15:59:26 49A7FB09 c (dvbapi) Demuxer 0 ecmpid 4 CAID: 098C ECM_PID: 1A40 PROVID: 000000
2015/07/10 15:59:26 49A7FB09 c (dvbapi) Demuxer 0 found 5 ECMpids and 2 STREAMpids in PMT
2015/07/10 15:59:26 49A7FB09 c (dvbapi) Demuxer 0 serving srvid 0017 (1702@000000:0017 unknown) on adapter 0000 camask 0001 index 0000 pmtpid 0000
2015/07/10 15:59:26 49A7FB09 c (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 098C PROVID 000000 ECMPID 1A40 ANY CHID PMTPID 0000 VPID 01FF
2015/07/10 15:59:26 4FAC5CF0 r (reader) v14 [videoguard2] classD3 ins54: no cw --> Card isn't active
2015/07/10 15:59:26 4FAC5CF0 r (reader) v14 [videoguard2] classD3 ins54: no cw --> Card needs pairing/extra data
2015/07/10 15:59:26 4FAC5CF0 r (reader) v14 [videoguard2] classD3 ins54: no cw --> No tier found
2015/07/10 15:59:26 4FAC5CF0 r (reader) v14 [videoguard2] classD3 ins54: no cw --> Tier expired
2015/07/10 15:59:26 49A7FB09 c (ecm) vdr (098C@000000/01FB/0017/98:3F52A0BA9930CC0BD55DD3219B160D8A:023020): not found (110 ms) by v14
2015/07/10 15:59:26 49A7FB09 c (ecm) vdr (098C@000000/01FB/0017/98:3F52A0BA9930CC0BD55DD3219B160D8A:023020): not found (0 ms) by v14
2015/07/10 15:59:29 49A7FB09 c (-) -- Skipped 9 duplicated log lines --

Reicht das so, oder kann ich vdr irgendwie dazu bringen, durchgehend zu empfangen anstatt mit dem Fehler, dass nicht decrypted werden kann, abzubrechen und dann wieder anzufangen?

Danke.

 

[legenwaitforitdary]

AW: Blöde Frage: v14 freischalten mit headless VDR

Kannst du so machen, reicht auch, wenn du auf einem Client auf einen Sky Sender schaltest.
Karte neu oder schon aktiviert?

 

[ztrac]

AW: Blöde Frage: v14 freischalten mit headless VDR

Die Karte ist neu, muss freigeschaltet werden.

Habe jetzt mal testweise auf einer Openelec-Maschine einen VNSI Clienten installiert und den verbunden. Free-TV kommt an. Logfile VDR:

Spoiler

Jul 11 15:25:51 vdr vdr: [19427] VNSI: Channel: no data 16
Jul 11 15:26:01 vdr vdr: [19427] VNSI: Channel: no data 16
Jul 11 15:26:11 vdr vdr: [19427] VNSI: Channel: no data 16
Jul 11 15:26:21 vdr vdr: [19427] VNSI: Channel: no data 16
Jul 11 15:26:31 vdr vdr: [19427] VNSI: Channel: no data 16

Kanal ist Sky Sport News HD.

oscam.log:

Spoiler

2015/07/11 12:36:47 00000000 s >> OSCam << cardserver log switched, version 1.20-unstable_svn, build r10888 (x86_64-linux-gnu)
2015/07/11 12:36:47 00000000 s (main) System name = Linux
2015/07/11 12:36:47 00000000 s (main) Host name = vdr
2015/07/11 12:36:47 00000000 s (main) Release = 3.16.0-43-generic
2015/07/11 12:36:47 00000000 s (main) Version = #58~14.04.1-Ubuntu SMP Mon Jun 22 10:21:20 UTC 2015
2015/07/11 12:36:47 00000000 s (main) Machine = x86_64
2015/07/11 12:36:47 00000000 s (main) creating pidfile /tmp/.oscam/oscam.pid with pid 1169
2015/07/11 12:36:47 00000000 s (config) services reloaded: 0 services freed, 4 services loaded, rejected 0
2015/07/11 12:36:47 00000000 s (config) userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2015/07/11 12:36:47 00000000 s (main) signal handling initialized
2015/07/11 12:36:47 00000000 s (config) 215 service-id's loaded in 0 ms
2015/07/11 12:36:47 00000000 s (reader) v14 [mouse] creating thread for device /dev/ttyUSB0
2015/07/11 12:36:47 00000000 s (stat) loadbalancer: could not open /tmp/.oscam/stat for reading (errno=2 No such file or directory)
2015/07/11 12:36:47 00000000 s (main) waiting for local card init
2015/07/11 12:36:47 13678FC3 h (webif) webif: decompressed 162611 bytes back into 388256 bytes
2015/07/11 12:36:47 13678FC3 h (webif) HTTP Server running. ip=:: port=8083
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Buffers readed 0 bytes total time_us 75091
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 1 value 03 time_us 4267
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 2 value 40 time_us 1987
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 3 value 37 time_us 40980
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 4 value 5b time_us 979
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 5 value bf time_us 991
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 6 value f5 time_us 874
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 7 value fe time_us 1000
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 8 value 0f time_us 986
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 9 value 7d time_us 992
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 10 value f2 time_us 985
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 11 value af time_us 1045
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 12 value 69 time_us 992
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 13 value 00 time_us 1075
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 14 value ad time_us 959
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 15 value f5 time_us 850
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 16 value f0 time_us 1001
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 17 value ff time_us 964
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 18 value ff time_us 988
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 19 value f5 time_us 1001
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 20 value 73 time_us 957
2015/07/11 12:36:47 0ABE5A77 r (reader) v14 [mouse] Flush readed byte Nr 21 value 3f time_us 1008
2015/07/11 12:36:48 0ABE5A77 r (reader) v14 [mouse] Buffers readed 21 bytes total time_us 140227
2015/07/11 12:36:48 0ABE5A77 r (reader) v14 [mouse] Reader initialized (device=/dev/ttyUSB0, detect=cd, mhz=600, cardmhz=357)
2015/07/11 12:36:48 0ABE5A77 r (reader) v14 [mouse] card detected
2015/07/11 12:36:48 0ABE5A77 r (reader) v14 [mouse] Buffers readed 0 bytes total time_us 75085
2015/07/11 12:36:50 0ABE5A77 r (reader) v14 [mouse] ATR: 3F FD 13 25 02 50 80 0F 41 B0 0A 69 FF 4A 50 F0 00 00 50 31 03
2015/07/11 12:36:50 0ABE5A77 r (reader) v14 [mouse] Init card protocol T0, FI=1, F=372, D=4, N=2
2015/07/11 12:36:50 0ABE5A77 r (reader) v14 [mouse] Setting baudrate to 38400 bps
2015/07/11 12:36:50 0ABE5A77 r (reader) v14 [mouse] Calculated work ETU is 15.50 us reader mhz = 600
2015/07/11 12:36:50 0ABE5A77 r (reader) v14 [mouse] Buffers readed 0 bytes total time_us 75091
2015/07/11 12:36:50 0ABE5A77 r (reader) v14 [mouse] ATR Fsmax is 5 MHz, clocking card to wanted user cardspeed off 6.00 MHz (specified in reader->mhz)
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [mouse] Card type: P1TV
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [mouse] Rom version: 20AA
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [mouse] Credit available on card: 0 euro
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [mouse] Extended 4C detected
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [mouse] FuseByte: 00
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [mouse] Region Code:
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [mouse] Country Code: DEU
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [mouse] Pincode read: 6811
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [mouse] PCB settings: FF FF FF FF
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [mouse] type: VideoGuard Sky Austria/Germany (098C), caid: 098C
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [mouse] serial: ########, BoxID: ########, baseyear: 2004
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [mouse] ready for requests
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [mouse] found card system videoguard2
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [videoguard2] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [videoguard2] card detected
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [videoguard2] type: VideoGuard Sky Austria/Germany (098C)
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [videoguard2] ------------------------------------------------------------------
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [videoguard2] |- class -|-- tier --|----- valid to ------|--- package name ----|
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [videoguard2] +---------+----------+---------------------+---------------------+
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [videoguard2] |------- This card is not active, so no package available! ------|
2015/07/11 12:36:51 0ABE5A77 r (reader) v14 [videoguard2] ------------------------------------------------------from-ins70--
2015/07/11 12:36:52 00000000 s (main) init for all local cards done
2015/07/11 12:36:52 00000000 s (emmcache) loaded 0 emmcache records from /etc/oscam/oscam.emmcache in 0 ms
2015/07/11 12:36:52 00000000 s (emmcache) loaded 0 emmstat records from /etc/oscam/oscam.emmstat in 0 ms
2015/07/11 12:36:52 00000000 s (anticasc) anti cascading disabled
2015/07/11 12:36:52 7EE91F6D c (client) plain dvbapi-client granted (vdr, au=on (1 reader))
2015/07/11 12:36:52 7EE91F6D c (dvbapi) dvbapi channelcache loaded from /etc/oscam/oscam.ccache
2015/07/11 12:36:52 7EE91F6D c (dvbapi) Using TCP listen socket, API forced to DVBAPIv3 (0), userconfig boxtype: 11
2015/07/11 12:37:00 7EE91F6D c (dvbapi) Client connected: 'vdr-plugin-dvbapi 2.2.0 / VDR 2.2.0' (protocol version = 2)
2015/07/11 14:58:00 7EE91F6D c (-) -- Skipped 2 duplicated log lines --
2015/07/11 14:58:00 7EE91F6D c (dvbapi) Demuxer 0 ecmpid 0 CAID: 1833 ECM_PID: 180F PROVID: 000000
2015/07/11 14:58:00 7EE91F6D c (dvbapi) Demuxer 0 ecmpid 1 CAID: 09C4 ECM_PID: 1B0F PROVID: 000000
2015/07/11 14:58:00 7EE91F6D c (dvbapi) Demuxer 0 ecmpid 2 CAID: 09AF ECM_PID: 1F0F PROVID: 000000
2015/07/11 14:58:00 7EE91F6D c (dvbapi) Demuxer 0 ecmpid 3 CAID: 098C ECM_PID: 1A0F PROVID: 000000
2015/07/11 14:58:00 7EE91F6D c (dvbapi) Demuxer 0 found 4 ECMpids and 2 STREAMpids in PMT
2015/07/11 14:58:00 7EE91F6D c (dvbapi) Demuxer 0 serving srvid 006C (Sky Sport News HD) on adapter 0000 camask 0001 index 0000 pmtpid 0000
2015/07/11 14:58:00 7EE91F6D c (dvbapi) Demuxer 0 trying to descramble PID 3 CAID 098C PROVID 000000 ECMPID 1A0F ANY CHID PMTPID 0000 VPID 03FF

Seitdem tut sich im oscam.log nichts mehr.

Wenn das so ok ist und ich jetzt nur noch Geduld brauche, prima. Wenn ich was anderes machen soll, bitte ich um einen hilfreichen Tipp.

Nur der Vollständigkeit halber:

oscam.conf:

Spoiler

[global]
usrfile = /var/log/oscam/oscamuser.log
logfile = /var/log/oscam/oscam.log
cwlogdir = /var/log/oscam/cw
emmlogdir = /var/log/oscam/
maxlogsize = 512
nice = -1
preferlocalcards = 1

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

[webif]
httpport = 8083
httpuser = oscam
httppwd = oscam
httprefresh = 10
httptpl = /etc/oscam/tpl
httphelplang = de
httprefresh = 10
httpshowpicons = 1
httppiconsize = 24
httpshowmeminfo = 1
httpshowuserinfo = 1
httpshowcacheexinfo = 1
httpshowecminfo = 1
httpshowloadinfo = 1
httpallowed = 127.0.0.1,192.168.0.0-192.168.255.255

oscam.dvbapi:

Spoiler

P:098C 1
I:0

oscam.server:

Spoiler

[reader]
label = v14
protocol = mouse
device = /dev/ttyUSB0
caid = 098C
boxid = 12345678
ndsversion = 2
ins7e11 = 13
mhz = 600
cardmhz = 357
autospeed = 0
detect = cd
ident = 098C:000000
group = 1
emmcache = 1,1,10
blockemm-unknown = 1
blockemm-u = 1
blockemm-s = 1
blockemm-g = 1
saveemm-u = 1

oscam.user

Spoiler

[account]
User = vdr
Pwd = vdr
AU = v14
Group = 1

vdr samt Komponenten ist aus dem Frodo ppa, Verbindung dvbapi über Port 2000, wie oben zu sehen. Das geht ohne weitere Patches von VDR, oder?

Edit: Scheinbar geht das tatsächlich nicht. Erst nach dem Umstellen auf sc (wie https://www.digital-eliteboard.com/...vbapi-dazu-die-emm-zu-senden.html#post2702251 beschrieben) kommen EMMs an. Noch keine für mich, aber immerhin überhaupt welche.