Keine Verbindung ( VDR OSCam Client - RaspPi OSCam-Server ) - Wo liegt der Fehler?

[MagicMouse]

Hallo zusammen,

ich habe daheim einen funktionierenden OSCam-Server (RaspberryPi) und an diesem einen OSCam-Client (Xtrend et 4000) hängen. Soweit alles gut.

Nun wollte ich meinen VDR als OSCam-Client ebenfalls an den Pi hängen. Doch hier beginnen meine Schwierigkeiten. Ich bekomme "kein Bild" und weiß nicht warum.

Könnt ihr bitte mal auf meine Logs schauen. Wo steckt der Fehler? Was mache ich falsch?

Log-Datei vom VDR

Spoiler

2015/06/30 14:05:12 00000000 s >> OSCam << cardserver log switched, version 1.20-unstable_svn, build r10864 (x86_64-linux-gnu-ssl-libusb-pcsc)
2015/06/30 14:05:12 00000000 s (main) System name = Linux
2015/06/30 14:05:12 00000000 s (main) Host name = XXXX-server
2015/06/30 14:05:12 00000000 s (main) Release = 3.16.0-4-amd64
2015/06/30 14:05:12 00000000 s (main) Version = #1 SMP Debian 3.16.7-ckt11-1 (2015-05-24)
2015/06/30 14:05:12 00000000 s (main) Machine = x86_64
2015/06/30 14:05:12 00000000 s (main) creating pidfile /tmp/.oscam/oscam.pid with pid 20099
2015/06/30 14:05:12 00000000 s (config) userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2015/06/30 14:05:12 00000000 s (main) signal handling initialized
2015/06/30 14:05:12 00000000 s (reader) camd3 [cs357x] creating thread for device 10.32.1.54
2015/06/30 14:05:12 00000000 s (stat) loadbalancer: could not open /tmp/.oscam/stat for reading (errno=2 No such file or directory)
2015/06/30 14:05:12 00000000 s (main) waiting for local card init
2015/06/30 14:05:12 590C9746 p (reader) camd3 [cs357x] proxy XXX.XXX.XXX.XXX:12345
2015/06/30 14:05:12 590C9746 p (reader) camd3 [cs357x] proxy initialized, server XXX.XXX.XXX.XXX:12345
2015/06/30 14:05:12 60A1D0A1 h (webif) webif: decompressed 163118 bytes back into 389544 bytes
2015/06/30 14:05:12 60A1D0A1 h (webif) HTTP Server running. ip=:: port=8888
2015/06/30 14:05:12 00000000 s (main) init for all local cards done
2015/06/30 14:05:12 00000000 s (emmcache) loading emmcache disabled since no reader is using it!
2015/06/30 14:05:12 00000000 s (emmcache) loading emmstats disabled since no reader is using it!
2015/06/30 14:05:12 00000000 s (anticasc) anti cascading disabled
2015/06/30 14:05:12 0BB9783E c (client) plain dvbapi-client granted (local, au=on (1 reader))
2015/06/30 14:05:12 0BB9783E c (dvbapi) dvbapi channelcache loaded from /etc/oscam/oscam.ccache
2015/06/30 14:05:12 0BB9783E c (dvbapi) Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 0

VDR oscam.conf

Spoiler

[global]
logfile = /etc/oscam/oscam.log
nice = -1
maxlogsize = 2048
emmlogdir =


[dvbapi]
enabled = 1
au = 1
user = local

[webif]
httpport = 8888
httpallowed = 10.0.0.0-10.255.255.255,172.16.0.0-172.31.255.255,192.168.0.0-192.168.255.255,127.0.0.1

VDR oscam.server

Spoiler

[reader]
label = camd3
protocol = camd35
device = XXX.XXX.XXX.XXX,12345
user = vdr
password = 1234
caid = 098C
group = 1

VDR oscam.user

Spoiler

[account]
user = local
au = camd3
group = 1

VDR oscam.dvbapi

Spoiler

P:098C
I:0

Raspberry Pi oscam.user

Spoiler

[account]
user = test
pwd = 1234
group = 1,2
au = 1

[account]
user = vdr
pwd = 1234
group = 1,2
# au = 1

Danke für eure Hilfe.

Grüße

 

[prangsta]

AW: Keine Verbindung ( VDR OSCam Client - RaspPi OSCam-Server ) - Wo liegt der Fehler

Wie sieht denn der log beim server aus wenn der user versucht zu connecten ??

 

[MagicMouse]

Augenscheinlich kommt da nichts an:

RaspPi oscam.log

Spoiler

2015/06/30 14:09:39 0 s >> OSCam << cardserver started, version 1.20-unstable_svn, build r10634 (arm-bcm2708hardfp-linux-gnueabi-libusb-pcsc)
2015/06/30 14:09:39 0 s (main) System name = Linux
2015/06/30 14:09:39 0 s (main) Host name = OSCam-Server
2015/06/30 14:09:39 0 s (main) Release = 3.18.7+
2015/06/30 14:09:39 0 s (main) Version = #755 PREEMPT Thu Feb 12 17:14:31 GMT 2015
2015/06/30 14:09:39 0 s (main) Machine = armv6l
2015/06/30 14:09:39 0 s (main) creating pidfile /tmp/.oscam/oscam.pid with pid 3559
2015/06/30 14:09:39 0 s (config) userdb reloaded: 2 accounts loaded, 0 expired, 0 disabled
2015/06/30 14:09:39 0 s (main) signal handling initialized
2015/06/30 14:09:39 0 s (net) cs357x: initialized (fd=6, port=12345)
2015/06/30 14:09:39 0 s (reader) sky_v14 [mouse] creating thread for device /dev/SkyDE
2015/06/30 14:09:39 0 s (reader) hd02 [mouse] creating thread for device /dev/HDplus
2015/06/30 14:09:39 0 s (stat) loadbalancer: can't read from file /tmp/.oscam/stat
2015/06/30 14:09:39 0 s (main) waiting for local card init
2015/06/30 14:09:39 464FA0 h (webif) webif: decompressed 159579 bytes back into 381416 bytes
2015/06/30 14:09:39 464FA0 h (webif) HTTP Server running. ip=0.0.0.0 port=8888
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Buffers readed 0 bytes total time_us 75508
2015/06/30 14:09:39 464A40 r (reader) hd02 [mouse] Buffers readed 0 bytes total time_us 76001
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 1 value 03 time_us 6829
2015/06/30 14:09:39 464A40 r (reader) hd02 [mouse] Flush readed byte Nr 1 value 03 time_us 7532
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 2 value 40 time_us 1448
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 3 value 57 time_us 33903
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 4 value 5b time_us 1356
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 5 value bf time_us 1230
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 6 value f5 time_us 1352
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 7 value fe time_us 1225
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 8 value 0f time_us 1356
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 9 value 7d time_us 2616
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 10 value f2 time_us 1371
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 11 value af time_us 1198
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 12 value 69 time_us 1359
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 13 value 00 time_us 1223
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 14 value ad time_us 1349
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 15 value f5 time_us 2611
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 16 value f0 time_us 1351
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 17 value ff time_us 1223
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 18 value ff time_us 1355
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 19 value f5 time_us 1226
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 20 value 73 time_us 1383
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Flush readed byte Nr 21 value 3f time_us 2532
2015/06/30 14:09:39 464A40 r (reader) hd02 [mouse] Buffers readed 1 bytes total time_us 82912
2015/06/30 14:09:39 464A40 r (reader) hd02 [mouse] Reader initialized (device=/dev/HDplus, detect=cd, mhz=357, cardmhz=357)
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Buffers readed 21 bytes total time_us 147952
2015/06/30 14:09:39 464570 r (reader) sky_v14 [mouse] Reader initialized (device=/dev/SkyDE, detect=cd, mhz=357, cardmhz=357)
2015/06/30 14:09:40 464A40 r (reader) hd02 [mouse] card detected
2015/06/30 14:09:40 464570 r (reader) sky_v14 [mouse] card detected
2015/06/30 14:09:40 464A40 r (reader) hd02 [mouse] Buffers readed 0 bytes total time_us 75242
2015/06/30 14:09:40 464570 r (reader) sky_v14 [mouse] Buffers readed 0 bytes total time_us 75386
2015/06/30 14:09:41 464570 r (reader) sky_v14 [mouse] ATR: XXX
2015/06/30 14:09:41 464570 r (reader) sky_v14 [mouse] Init card protocol T0, FI=1, F=372, D=16, N=2
2015/06/30 14:09:41 464570 r (reader) sky_v14 [mouse] Setting baudrate to 153600 bps
2015/06/30 14:09:41 464570 r (reader) sky_v14 [mouse] Calculated work ETU is 6.51 us reader mhz = 357
2015/06/30 14:09:41 464570 r (reader) sky_v14 [mouse] Buffers readed 0 bytes total time_us 75217
2015/06/30 14:09:41 464570 r (reader) sky_v14 [mouse] ATR Fsmax is 5 MHz, clocking card to wanted user cardspeed off 3.57 MHz (specified in reader->mhz)
2015/06/30 14:09:42 464A40 r (reader) hd02 [mouse] ATR: XXX
2015/06/30 14:09:42 464A40 r (reader) hd02 [mouse] Init card protocol T1, FI=9, F=512, D=16, N=255
2015/06/30 14:09:42 464A40 r (reader) hd02 [mouse] Setting baudrate to 111600 bps
2015/06/30 14:09:42 464A40 r (reader) hd02 [mouse] Calculated work ETU is 8.96 us reader mhz = 357
2015/06/30 14:09:42 464A40 r (reader) hd02 [mouse] Buffers readed 0 bytes total time_us 75251
2015/06/30 14:09:42 464A40 r (reader) hd02 [mouse] ATR Fsmax is 5 MHz, clocking card to wanted user cardspeed off 3.57 MHz (specified in reader->mhz)
2015/06/30 14:09:42 464A40 r (reader) hd02 [mouse] Card responded ok for ifsd request of 160
2015/06/30 14:09:43 464570 r (reader) sky_v14 [mouse] Card type: P1TV
2015/06/30 14:09:43 464570 r (reader) sky_v14 [mouse] Rom version: 20AA
2015/06/30 14:09:43 464570 r (reader) sky_v14 [mouse] Credit available on card: 0 euro
2015/06/30 14:09:43 464570 r (reader) sky_v14 [mouse] Extended 4C detected
2015/06/30 14:09:43 464570 r (reader) sky_v14 [mouse] FuseByte: 05
2015/06/30 14:09:43 464570 r (reader) sky_v14 [mouse] Region Code: XXX
2015/06/30 14:09:43 464570 r (reader) sky_v14 [mouse] Country Code: DEU
2015/06/30 14:09:43 464A40 r (reader) hd02 [mouse] detect native nagra card
2015/06/30 14:09:43 464570 r (reader) sky_v14 [mouse] Pincode read: 0566
2015/06/30 14:09:43 464570 r (reader) sky_v14 [mouse] PCB settings: FF FF FF FF
2015/06/30 14:09:43 464570 r (reader) sky_v14 [mouse] type: VideoGuard Sky Austria/Germany (098C), caid: 098C
2015/06/30 14:09:43 464570 r (reader) sky_v14 [mouse] serial: ########, BoxID: ########, baseyear: 2004
2015/06/30 14:09:43 464570 r (reader) sky_v14 [mouse] ready for requests
2015/06/30 14:09:43 464570 r (reader) sky_v14 [mouse] found card system videoguard2
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] card detected
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] type: VideoGuard Sky Austria/Germany (098C)
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] ------------------------------------------------------------------
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |- class -|-- tier --|----- valid to ------|--- package name ----|
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] +---------+----------+---------------------+---------------------+
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 0046 --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 007b --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 007d --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 0081 --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 008e --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 00c0 --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 00c8 --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 00c9 --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 00ca --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 00c7 --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 00e4 --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 00e5 --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 00f0 --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 00fa --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 00f3 --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] |-- 00 ---|-- 00ff --| 2015/08/11-01:00:00 |
2015/06/30 14:09:43 464570 r (reader) sky_v14 [videoguard2] ------------------------------------------------------from-ins70--
2015/06/30 14:09:44 464A40 r (reader) hd02 [mouse] ready for requests
2015/06/30 14:09:44 464A40 r (reader) hd02 [mouse] found card system nagra
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] ROM: D N A S P 1 8 0
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] REV: M e r 0 0 0
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] SER: ############
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] CAID: 1843
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] Prv.ID: 00 00 34 11 (sysid)
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] Prv.ID: 00 00 00 00
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] IRD ID: ############
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] active to: 1992/01/01 00:00
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] -----------------------------------------
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] |id |tier |valid from |valid to |
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] +----+--------+------------+------------+
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] |8011|0066 |2010/01/19 |2010/01/20 |
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] |8011|0067 |2010/01/19 |2010/01/20 |
2015/06/30 14:09:44 464A40 r (reader) hd02 [nagra] -----------------------------------------
2015/06/30 14:09:45 0 s (main) init for all local cards done
2015/06/30 14:09:45 0 s (emmcache) loaded 0 emmcache records from /tmp/.oscam/oscam.emmcache in 1 ms
2015/06/30 14:09:45 0 s (emmcache) loaded 0 emmstat records from /tmp/.oscam/oscam.emmstat in 0 ms
2015/06/30 14:09:45 0 s (anticasc) anti cascading disabled

Ich habe nun die Lösung bzw den Fehler gefunden. Die Ursache lag darin, dass ich das dvbapi-Plugin nicht richtig konfiguriert hatte.
Auf der einen Seite habe ich vergessen in der setup.conf die Eintragungen (dvbapi.OSCamNetwork/Host/Port) vorzunehmen und weiterhin diese eingetragenen Ports dann auch in der oscam.conf unter [dvbapi] zu vermerken.

Die Readme zu dem Plugin brachte dann die Erleuchtung (Punkt 6).

Danke für die Mithilfe!

Grüße