#1 17/06/2011 00:44:13

zorglups
Membre
Inscription : 16/01/2009
Messages : 96

TT3200, Infinity USB Smart, ,Oscam, sasc-ng et BisTV sur Hotbird S13E0

Mon environnement est le suivant:
mythtv .24 tournant sur un BE ArchLinux (2.6.39) possédant 2 cartes TT3200 et un lecteur Infinity USB Smart.
Je possède une carte d'abonnement BisTV violette (abonnement mensuel).

Le lecteur Infinity USB smart fut reconnu par le noyau ArchLinux 2.6.39 sans que je n'y fasse rien

[    7.852952] USB Serial support registered for FTDI USB Serial Device
[    7.853000] ftdi_sio 1-1.1:1.0: FTDI USB Serial Device converter detected
[    7.853027] usb 1-1.1: Detected FT232BM
[    7.853029] usb 1-1.1: Number of endpoints 2
[    7.853030] usb 1-1.1: Endpoint 1 MaxPacketSize 64
[    7.853032] usb 1-1.1: Endpoint 2 MaxPacketSize 64
[    7.853034] usb 1-1.1: Setting MaxPacketSize 64
[    7.853742] usb 1-1.1: FTDI USB Serial Device converter now attached to ttyUSB0
[    7.853763] usbcore: registered new interface driver ftdi_sio
[    7.853764] ftdi_sio: v1.6.0:USB FTDI Serial Converters Driver

J'ai installé Oscam qui s'occupe de l'accès à la carte d'abonnement en suivant ce wiki:
https://wiki.archlinux.org/index.php/Di … Cardreader

/etc/oscam/oscam.conf

#
# main configuration
#

[global]
nice          = -1
WaitForCards  = 1

# logging

pidfile       = /var/run/oscam.pid
logfile       = /var/log/oscam/oscam.log
usrfile       = /var/log/oscam/oscamuser.log
cwlogdir      = /var/log/oscam/cw

# monitor

[monitor]
port          = 988
aulow         = 120
monlevel      = 1

# web interface

[webif]
httpport      = 8888
httpuser      = myusername
httppwd       = mypassword

# protocols

[newcamd]
key=0102030405060708091011121314
port=15050@0500:042800,042810
#key            = 000102030405060708090A0B0C0D
#port           = 15050@0B00:0E030

/etc/oscam/oscam.server

# reader configuration

[reader]
label    = bistv
protocol = mouse
detect   = CD
device   = /dev/ttyUSB0
group    = 1
emmcache = 1,3,2
services = services1
#caid     = 0B00
caid     = 0500
mhz      = 500
cardmhz  = 500
ident =0500:042800,042810

/etc/oscam/oscam.services

# definition of services
#
# format:
# [name]
# caid=CAID[,CAID]...
# provid = provider ID[,provider ID]...
# srvid = service ID[,service ID]...

[services1]
caid=0B00
provid=042800,042810
srvid=

/etc/oscam/oscam.user

# user configuration

[account]
user       = user1
pwd        = password1
monlevel   = 0
uniq       = 1
group      = 1
au         = bistv
ident      = 0500:042800,042810
caid       = 0500

J'ai ensuite créé le répertoire de log de oscam et l'ai démarré.

[root@bureau log]# mkdir /var/log/oscam
# date
Thu Jun 16 23:48:11 CEST 2011
# /etc/rc.d/oscam start
:: Starting oscam  [DONE]

Dans le log d'oscam, tout semble bien se passer:

[root@bureau log]# cat /var/log/oscam/oscam.log

-------------------------------------------------------------------------------
>> OSCam <<  cardserver started at Thu Jun 16 23:48:26 2011
-------------------------------------------------------------------------------
2011/06/16 23:48:26   4272 s   version=0.99.4svn, build #3146, system=i686-pc-linux, nice=-1
2011/06/16 23:48:26   4272 s   max. clients=509, client max. idle=120 sec
2011/06/16 23:48:26   4272 s   max. logsize=unlimited
2011/06/16 23:48:26   4272 s   client timeout=5000 ms, fallback timeout=2500 ms, cache delay=0 ms
2011/06/16 23:48:26   4272 s   shared memory initialized (size=4340618, id=6815744)
2011/06/16 23:48:26   4272 s   auth size=4772
2011/06/16 23:48:26   4272 s   services reloaded: 0 services freed, 1 services loaded
2011/06/16 23:48:26   4272 s   userdb reloaded: 0 accounts freed, 1 accounts loaded, 0 expired, 0 disabled
2011/06/16 23:48:26   4272 s   signal handling initialized (type=sysv)
2011/06/16 23:48:26   4272 s   can't open file "/etc/oscam/oscam.srvid" (err=2), no service-id's loaded
2011/06/16 23:48:26   4272 s   can't open file "/etc/oscam/oscam.tiers" (err=2), no tier-id's loaded
2011/06/16 23:48:26   4272 s   can't open file "/etc/oscam/oscam.provid" (err=2), no provids's loaded
2011/06/16 23:48:26   4273 s   monitor: initialized (fd=7, port=988)
2011/06/16 23:48:26   4273 s   camd 3.3x: disabled
2011/06/16 23:48:26   4273 s   camd 3.5x: disabled
2011/06/16 23:48:26   4273 s   cs378x: disabled
2011/06/16 23:48:26   4273 s   newcamd: initialized (fd=8, port=15050, crypted)
2011/06/16 23:48:26   4273 s   CAID: 0500
2011/06/16 23:48:26   4273 s   provid #0: 042800
2011/06/16 23:48:26   4273 s   provid #1: 042810
2011/06/16 23:48:26   4273 s   cccam: disabled
2011/06/16 23:48:26   4273 s   radegast: disabled
2011/06/16 23:48:26   4273 s   logger started (pid=4274)
2011/06/16 23:48:26   4273 s   http started (pid=4275)
2011/06/16 23:48:26   4273 s   reader started (pid=4276, device=/dev/ttyUSB0, detect=cd, mhz=500, cardmhz=500)
2011/06/16 23:48:26   4275 h   HTTP Server listening on port 8888
2011/06/16 23:48:26   4273 s   waiting for local card init
2011/06/16 23:48:28   4276 r02 card detected
2011/06/16 23:48:36   4276 r02 ATR: 3F 77 18 00 00 C2 7A 44 02 68 90 00
2011/06/16 23:48:38   4276 r02 Maximum frequency for this card is formally 5 Mhz, clocking it to 5.00 Mhz
2011/06/16 23:48:41   4276 r02 card system not supported
2011/06/16 23:48:41   4276 r02 Normal mode failed, reverting to Deprecated Mode
2011/06/16 23:48:48   4276 r02 ATR: 3F 77 18 00 00 C2 7A 44 02 68 90 00
2011/06/16 23:48:48   4276 r02 Warning: D=0 is invalid, forcing D=1
2011/06/16 23:48:49   4276 r02 Maximum frequency for this card is formally 5 Mhz, clocking it to 5.00 Mhz
2011/06/16 23:48:51   4276 r02 type: Viaccess (standard atr), caid: 0500, serial: 4000151211
2011/06/16 23:48:51   4276 r02 providers: 3 (FFF400,042800,042810)
2011/06/16 23:48:51   4276 r02 [viaccess-reader] ready for requests
2011/06/16 23:48:51   4276 r02 [viaccess-reader] card detected
2011/06/16 23:48:52   4276 r02 [viaccess-reader] serial: 4000151211
2011/06/16 23:48:52   4276 r02 provider: 1, id: FFF400, name: ISSUER, sa: EE6D76AB, geo: empty
2011/06/16 23:48:53   4276 r02 provider: 2, id: 042800, name: BIS, sa: EE6D76AB, geo: FF FF FF FF
2011/06/16 23:48:53   4276 r02 class: 32, expiry date: 2011/05/22 - 2011/06/30
2011/06/16 23:48:53   4276 r02 class: 64, expiry date: 2011/05/22 - 2011/06/30
2011/06/16 23:48:53   4276 r02 provider: 3, id: 042810, name: BIS 2, sa: EE6D76AB, geo: FF FF FF FF
2011/06/16 23:48:54   4273 s   init for all local cards done
2011/06/16 23:48:54   4273 s   anti cascading disabled
2011/06/16 23:48:54   4273 s   dvbapi: dvbapi disabled

J'ai ensuite installé open-sasc-ng comme expliqué dans ce post:
http://mythtv-fr.org/forums/viewtopic.p … 552#p18552
Ma configuration sasc-ng est la suivante:
Pour rappel, j'ai dans mon backend 2 cartes DVB-S2 TT3200. Je dois donc déclarer 2 adapters qui correspondent à /dev/dvb/adapter0 et /dev/dvb/adapter1
sasc-ng va donc créer 2 adaptateurs virtuels :
/dev/dvb/adapter2 et /dev/dvb/adapter3

/etc/conf.d/sasc-ng

# Use -j <real>:<virtual> to link adapters

SASCNG_ARGS="-j 0:2 -j 1:3 --cam-budget --sid-allpid --sid-nocache"
DVBLOOPBACK_ARGS="num_adapters=2"
LOGDIR="/var/log/"
CAMDIR=/etc/camdir

/etc/camdir/cardclient.conf

#
# Comment lines can start with # or ;
#
# every client line starts with the client name, followed by some arguments:
# 'hostname' is the name of the server
# 'port'     is the port on the server
# 'emm'      is a flag to allow EMM transfers to the server
#            (0=disabled 1=enabled)
# 'caid'     (optional) caid on which this client should work
# 'mask'     (optional) mask for caid e.g. caid=1700 mask=FF00 would allow
#            anything between 1700 & 17FF.
#            Default is 1700 & FF00. If only caid is given mask is FFFF.
#            You may give multiple caid/mask values comma separated
#            (e.g. 1702,1722,0d0c/ff00).
# 'username' is the login username
# 'password' is the login password
#
# newcamd client
# 'cfgkey' is the config key (28bytes)
#newcamd:localhost:15050:emm/caid/mask:dummy:dummy:0102030405060708091011121314
newcamd:localhost:15050:1/0500/FF00:user1:password1:0102030405060708091011121314

J'ai ensuite démarré sasc-ng:

/etc/rc.d/sasc-ng start
:: Loading dvbloopback kernel module  [DONE]
:: Starting SASC-NG daemon              [DONE][

dmesg montre alors les évènements suivants:

[83448.806644] /var/abs/local/yaourtbuild/open-sasc-ng/src/sc-build/contrib/sasc-ng/dvbloopback/module/dvb_loopback.c: frontend loopback driver v0.0.1
[83448.806651] dvbloopback: registering 2 adapters
[83448.806698] DVB: registering new adapter (DVB-LOOPBACK)
[83448.807700] DVB: registering new adapter (DVB-LOOPBACK)

Le log /var/log/sasc-ng.log montre ceci:

Jun 17 00:16:12.977 : Version: 0.0.2-61975953edd0+
Jun 17 00:16:13.048 CAM: initializing plugin: SoftCam (1.0.0pre-HG-61975953edd0+): A software emulated CAM
Jun 17 00:16:13.073 CAM(general.info): SC version 1.0.0pre-HG-61975953edd0+ initializing (VDR 1.6.0)
Jun 17 00:16:13.098 CAM: starting plugin:
Jun 17 00:16:13.123 CAM(general.info): SC version 1.0.0pre-HG-61975953edd0+ starting (VDR 1.6.0)
Jun 17 00:16:13.148 CAM(core.load): ** Plugin config:
Jun 17 00:16:13.181 CAM(core.load): ** Key updates (AU) are enabled (active CAIDs) (no prestart)
Jun 17 00:16:13.224 CAM(core.load): ** Local systems DON'T take priority over cached remote
Jun 17 00:16:13.257 CAM(core.load): ** Concurrent FF recordings are NOT allowed
Jun 17 00:16:13.290 CAM(core.load): ** Force transfermode with digital audio
Jun 17 00:16:13.324 CAM(core.load): ** ECM cache is set to enabled
Jun 17 00:16:13.357 CAM(core.load): ** ScCaps are 1 2 0 0 0 0 0 0 0 0
Jun 17 00:16:13.390 CAM(general.info): loading cardclient config from /etc/camdir/cardclient.conf
Jun 17 00:16:13.424 CAM(cardclient.newcamd): now using protocol version 525 (cdLen=8)
Jun 17 00:16:13.457 CAM(cardclient.core): hostname=localhost port=15050 emm=1 emmCaids 0500/ff00
Jun 17 00:16:13.490 CAM(cardclient.core): Newcamd: username=user1 password=password1 key=0102030405060708091011121314
Jun 17 00:16:13.524 CAM(cardclient.core): client 'Newcamd' ready
Jun 17 00:16:13.557 CAM(core.net): connecting to localhost:15050/tcp (127.0.0.1)
Jun 17 00:16:13.597 CAM(cardclient.login): Newcamd: CaID=0500 admin=1 srvUA=00000000EE6D76AB provider 042810/00000000EE6D76AB 042800/00000000EE6D76AB FFF400/00000000EE6D76AB
Jun 17 00:16:13.632 CAM(general.error): failed open /etc/camdir/SoftCam.Key: No such file or directory
Jun 17 00:16:13.665 CAM(general.error): failed open /etc/camdir/smartcard.conf: No such file or directory
Jun 17 00:16:13.699 CAM(general.error): failed open /etc/camdir/cardslot.conf: No such file or directory
Jun 17 00:16:13.732 CAM(general.error): failed open /etc/camdir/override.conf: No such file or directory
Jun 17 00:16:13.765 CAM(general.error): no keys loaded for softcam!
Jun 17 00:16:13.798 CAM(core.load): ** registered systems:
Jun 17 00:16:13.832 CAM(core.load): ** Cardclient        (pri -15)
Jun 17 00:16:13.865 CAM(core.load): ** Conax             (pri -10)
Jun 17 00:16:13.898 CAM(core.load): ** ConstCW           (pri -20)
Jun 17 00:16:13.932 CAM(core.load): ** Cryptoworks       (pri -10)
Jun 17 00:16:13.965 CAM(core.load): ** Irdeto            (pri -10)
Jun 17 00:16:13.998 CAM(core.load): ** Irdeto2           (pri  -8)
Jun 17 00:16:14.032 CAM(core.load): ** Nagra             (pri -10)
Jun 17 00:16:14.057 CAM(core.load): ** Nagra2            (pri -10)
Jun 17 00:16:14.082 CAM(core.load): ** Fake-NDS          (pri -12)
Jun 17 00:16:14.107 CAM(core.load): ** SC-Conax          (pri  -5)
Jun 17 00:16:14.132 CAM(core.load): ** SC-Cryptoworks    (pri  -5)
Jun 17 00:16:14.157 CAM(core.load): ** SC-Irdeto         (pri  -5)
Jun 17 00:16:14.182 CAM(core.load): ** SC-Nagra          (pri  -5)
Jun 17 00:16:14.207 CAM(core.load): ** SC-Seca           (pri  -5)
Jun 17 00:16:14.232 CAM(core.load): ** SC-Viaccess       (pri  -5)
Jun 17 00:16:14.257 CAM(core.load): ** SC-VideoGuard2    (pri  -5)
Jun 17 00:16:14.282 CAM(core.load): ** Seca              (pri -10)
Jun 17 00:16:14.307 CAM(core.load): ** @SHL              (pri -10)
Jun 17 00:16:14.332 CAM(core.load): ** Viaccess          (pri -10)
Jun 17 00:16:15.359 demux: Starting thread on /dev/dvb/adapter2/demux1
The thread scheduling parameters indicate:
policy = 0
priority = 0
Jun 17 00:16:15.359 dvr: Starting thread on /dev/dvb/adapter2/dvr1
The thread scheduling parameters indicate:
policy = 1
priority = 99
Jun 17 00:16:15.359 frontend: Starting thread on /dev/dvb/adapter2/frontend1
The thread scheduling parameters indicate:
policy = 0
priority = 0
Jun 17 00:16:16.478 dvr: Starting thread on /dev/dvb/adapter3/dvr1
The thread scheduling parameters indicate:
policy = 1
priority = 99
Jun 17 00:16:16.478 frontend: Starting thread on /dev/dvb/adapter3/frontend1
The thread scheduling parameters indicate:
policy = 0
priority = 0
Jun 17 00:16:16.478 demux: Starting thread on /dev/dvb/adapter3/demux1
The thread scheduling parameters indicate:
policy = 0
priority = 0
Jun 17 00:16:16.580 : Listening on port 5456
Jun 17 00:18:13.603 CAM(core.net): idle timeout, disconnected localhost:15050

Au même moment, on voit que tout se passe bien dans le log /var/log/oscam/oscam.log

2011/06/17  0:16:13   4273 s   client(1) connect from 127.0.0.1 (pid=4339, pipfd=14)
2011/06/17  0:16:13   4339 c01 encrypted newcamd:15050-client 127.0.0.1 granted (user1, au=bistv)
2011/06/17  0:16:13   4339 c01 user user1 authenticated successfully (generic)
2011/06/17  0:16:13   4339 c01 AU enabled for user user1 on reader bistv
2011/06/17  0:18:13   4339 c01 Connection closed to client
2011/06/17  0:18:13   4339 c01 user1 disconnected  from 127.0.0.1

Avec mythtv-setup, j'ai fait en sorte d'utiliser /dev/dvb/adapter2 plutôt que /dev/dvb/adapter0.
/dev/dvb/adapter1 n'est pas encore utilisé pour le moment.

J'ai ensuite démarré le backend:
/etc/rc.d/mythbackend start

C'est ici que les choses se compliquent... Si je laisse le backend tranquille, je finis par voir de l'activité sasc/oscam (probablement une lecture des grilles de programme). Si je démarre un livetv sur un frontend, j'ai le même type d'activité, à un rythme plus soutenu.

En gros... c'est ici que cela se corse et où j'ai besoin d'aide.

Le log /var/log/sasc-ng.log me montre:

2011/06/17  0:28:54   4273 s   client(1) connect from 127.0.0.1 (pid=4472, pipfd=14)
2011/06/17  0:28:54   4472 c01 encrypted newcamd:15050-client 127.0.0.1 granted (user1, au=bistv)
2011/06/17  0:28:54   4472 c01 user user1 authenticated successfully (generic)
2011/06/17  0:28:54   4472 c01 AU enabled for user user1 on reader bistv
2011/06/17  0:28:54   4472 c01 user1 (0500&042800/012D/3F:EFEA): rejected group (0 ms)
2011/06/17  0:28:54   4472 c01 user1 (0500&042800/012D/3F:EFEA): rejected group (0 ms)
2011/06/17  0:28:55   4472 c01 user1 (0500&032920/012D/B8:CBF7): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:28:55   4472 c01 user1 (0500&032920/012D/B8:CBF7): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:28:55   4472 c01 user1 (0500&042500/012D/3D:F4AF): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:28:56   4472 c01 user1 (0500&042500/012D/3D:F4AF): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:28:59   4472 c01 user1 (0500&042800/012D/3F:EF91): rejected group (1 ms)
2011/06/17  0:28:59   4472 c01 user1 (0500&042800/012D/3F:EF91): rejected group (0 ms)
2011/06/17  0:29:00   4472 c01 user1 (0500&032920/012D/B8:71D6): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:29:00   4472 c01 user1 (0500&032920/012D/B8:71D6): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:29:00   4472 c01 user1 (0500&042500/012D/3D:F4AE): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:29:00   4472 c01 user1 (0500&042500/012D/3D:F4AE): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:29:05   4276 r02 nano A9: class: 32, expiry date: 2011/05/22 - 2011/06/30
2011/06/17  0:29:05   4276 r02 nano A9: class: 64, expiry date: 2011/05/22 - 2011/06/30
2011/06/17  0:29:05   4276 r02 user1 emmtype=shared, len=72, idx=0, cnt=1: written (408 ms) by bistv
2011/06/17  0:29:11   4472 c01 user1 (0500&042800/012D/3F:EF9E): rejected group (0 ms)
2011/06/17  0:29:12   4472 c01 user1 (0500&042800/012D/3F:EF9E): rejected group (0 ms)
2011/06/17  0:29:12   4472 c01 user1 (0500&032920/012D/B8:2207): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:29:12   4472 c01 user1 (0500&032920/012D/B8:2207): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:29:13   4472 c01 user1 (0500&042500/012D/3D:F4AF): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:29:13   4472 c01 user1 (0500&042500/012D/3D:F4AF): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:29:21   4472 c01 user1 (0500&042800/012D/3F:EF85): rejected group (0 ms)
2011/06/17  0:29:22   4472 c01 user1 (0500&042800/012D/3F:EF85): rejected group (0 ms)
2011/06/17  0:29:22   4472 c01 user1 (0500&032920/012D/B8:44EC): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:29:22   4472 c01 user1 (0500&032920/012D/B8:44EC): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:29:23   4472 c01 user1 (0500&042500/012D/3D:F4AE): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:29:23   4472 c01 user1 (0500&042500/012D/3D:F4AE): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:29:31   4472 c01 user1 (0500&042800/012D/3F:EFB2): rejected group (0 ms)
2011/06/17  0:29:32   4472 c01 user1 (0500&042800/012D/3F:EFB2): rejected group (0 ms)
2011/06/17  0:29:32   4472 c01 user1 (0500&032920/012D/B8:11B0): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:29:32   4472 c01 user1 (0500&032920/012D/B8:11B0): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:29:33   4472 c01 user1 (0500&042500/012D/3D:F4AF): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:29:33   4472 c01 user1 (0500&042500/012D/3D:F4AF): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:29:41   4472 c01 user1 (0500&042800/012D/3F:EFB9): rejected group (0 ms)
2011/06/17  0:29:42   4472 c01 user1 (0500&042800/012D/3F:EFB9): rejected group (0 ms)
2011/06/17  0:29:42   4472 c01 user1 (0500&032920/012D/B8:4F50): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:29:42   4472 c01 user1 (0500&032920/012D/B8:4F50): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:29:43   4472 c01 user1 (0500&042500/012D/3D:F4AE): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:29:43   4472 c01 user1 (0500&042500/012D/3D:F4AE): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:29:51   4472 c01 user1 (0500&042800/012D/3F:EFA6): rejected group (0 ms)
2011/06/17  0:29:52   4472 c01 user1 (0500&042800/012D/3F:EFA6): rejected group (0 ms)
2011/06/17  0:29:52   4472 c01 user1 (0500&032920/012D/B8:ED76): rejected user ident (1 ms) (no card support 0500:032920)
2011/06/17  0:29:52   4472 c01 user1 (0500&032920/012D/B8:ED76): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:29:53   4472 c01 user1 (0500&042500/012D/3D:F4AF): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:29:53   4472 c01 user1 (0500&042500/012D/3D:F4AF): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:30:01   4472 c01 user1 (0500&042800/012D/3F:EFAD): rejected group (0 ms)
2011/06/17  0:30:02   4472 c01 user1 (0500&042800/012D/3F:EFAD): rejected group (0 ms)
2011/06/17  0:30:02   4472 c01 user1 (0500&032920/012D/B8:EE8F): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:30:02   4472 c01 user1 (0500&032920/012D/B8:EE8F): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:30:03   4472 c01 user1 (0500&042500/012D/3D:F4AE): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:30:03   4472 c01 user1 (0500&042500/012D/3D:F4AE): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:30:11   4472 c01 user1 (0500&042800/012D/3F:EF5A): rejected group (0 ms)
2011/06/17  0:30:12   4472 c01 user1 (0500&042800/012D/3F:EF5A): rejected group (0 ms)
2011/06/17  0:30:12   4472 c01 user1 (0500&032920/012D/B8:70E8): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:30:12   4472 c01 user1 (0500&032920/012D/B8:70E8): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:30:13   4472 c01 user1 (0500&042500/012D/3D:F4AF): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:30:13   4472 c01 user1 (0500&042500/012D/3D:F4AF): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:30:21   4472 c01 user1 (0500&042800/012D/3F:EF41): rejected group (0 ms)
2011/06/17  0:30:22   4472 c01 user1 (0500&042800/012D/3F:EF41): rejected group (0 ms)
2011/06/17  0:30:22   4472 c01 user1 (0500&032920/012D/B8:1A0E): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:30:22   4472 c01 user1 (0500&032920/012D/B8:1A0E): rejected user ident (0 ms) (no card support 0500:032920)
2011/06/17  0:30:23   4472 c01 user1 (0500&042500/012D/3D:F4AE): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:30:23   4472 c01 user1 (0500&042500/012D/3D:F4AE): rejected user ident (0 ms) (no card support 0500:042500)
2011/06/17  0:30:31   4472 c01 user1 (0500&042800/012D/3F:EF4E): rejected group (0 ms)
2011/06/17  0:30:31   4472 c01 user1 (0500&042800/012D/3F:EF4E): rejected group (0 ms)
2011/06/17  0:30:32   4472 c01 user1 (0500&032920/012D/B8:A01C): rejected user ident (0 ms) (no card support 0500:032920)

Dans le log /var/log/oscam/oscam.log, je trouve ceci:

Jun 17 00:27:43.412 CSA: Got command(2): I idx: 0 pid: 0
Jun 17 00:27:43.448 CSA: Got command(2): I idx: 0 pid: 0
Jun 17 00:27:43.565 CHANNEL: Clearing tuning cache due to switch cmd
Jun 17 00:27:44.703 CHANNEL: Clearing tuning cache due to switch cmd
Jun 17 00:27:44.884 CHANNEL: Clearing tuning cache due to switch cmd
Jun 17 00:27:44.916 CHANNEL: Tuning frontend (new)
Jun 17 00:27:44.950 CSA: Got command(2): I idx: 0 pid: 0
Jun 17 00:27:44.950 CHANNEL: Tuning frontend (new)
Jun 17 00:27:45.016 CSA: Got command(2): I idx: 0 pid: 0
Jun 17 00:27:45.191 CSA: Got command(2): I idx: 0 pid: 0
Jun 17 00:27:45.224 CSA: Got command(2): I idx: 0 pid: 0
Jun 17 00:27:45.201 CHANNEL: Clearing tuning cache due to switch cmd
Jun 17 00:27:46.396 CHANNEL: Clearing tuning cache due to switch cmd
Jun 17 00:27:46.609 CHANNEL: Clearing tuning cache due to switch cmd
Jun 17 00:27:46.642 CHANNEL: Tuning frontend (new)
Jun 17 00:27:46.676 CSA: Got command(2): I idx: 0 pid: 0
Jun 17 00:27:46.676 CHANNEL: Tuning frontend (new)
Jun 17 00:27:46.742 CSA: Got command(2): I idx: 0 pid: 0
Jun 17 00:27:46.928 CSA: Got command(2): I idx: 0 pid: 0
Jun 17 00:28:45.216 CHANNEL: Clearing tuning cache due to switch cmd
Jun 17 00:28:46.356 CHANNEL: Clearing tuning cache due to switch cmd
Jun 17 00:28:47.036 CHANNEL: Clearing tuning cache due to switch cmd
Jun 17 00:28:47.098 CHANNEL: Tuning frontend (new)
Jun 17 00:28:47.157 CSA: Got command(2): I idx: 0 pid: 0
Jun 17 00:28:47.157 CHANNEL: Tuning frontend (new)
Jun 17 00:28:47.249 CSA: Got command(2): I idx: 0 pid: 0
Jun 17 00:28:47.964 CSA: Removing csa for rb: 2
Jun 17 00:28:50.209 CAM(core.pids): 0: now tuned to source 1(1) transponder 0
Jun 17 00:28:50.242 CAM: SC completed  Tune cmd
Jun 17 00:28:50.276 CAM(core.pids): 0: update SID 301 (zero=0 noshift=0)
Jun 17 00:28:50.309 CAM(core.pids): 0: pids typ5=01ff typ5=0200 typ5=0201 typ5=0203 typ5=0204
Jun 17 00:28:50.342 CAM(core.pids): SimplyCa entry pidCa=0
Jun 17 00:28:50.376 CAM(core.pids): prgca: 09 07 18 19 F5 88 02 00 6D 09 0F 05 00 F5 8E 10 01 00 13 01 20 14 03 04 28 00 09 0F 05 00 F5 89 10 01 00 13 01 20 14 03 03 29 20 09 11 01 00 F5 88 00 6D FF FF FF FF FF FF FF FF FF 0C 21 09 0F 05 00 F5 8D 10 01 00 13 01 20 14 03 04 25 00
Jun 17 00:28:50.409 CAM(core.pids): pidca 01ff: <empty>
Jun 17 00:28:50.442 CAM(core.pids): pidca 0200: <empty>
Jun 17 00:28:50.476 CAM(core.pids): pidca 0201: <empty>
Jun 17 00:28:50.509 CAM(core.pids): pidca 0203: <empty>
Jun 17 00:28:50.542 CAM(core.pids): pidca 0204: <empty>
Jun 17 00:28:50.567 CAM(core.pids): SimplyCa exit pidCa=0
Jun 17 00:28:50.592 CAM(core.pids): prgca: 09 07 18 19 F5 88 02 00 6D 09 0F 05 00 F5 8E 10 01 00 13 01 20 14 03 04 28 00 09 0F 05 00 F5 89 10 01 00 13 01 20 14 03 03 29 20 09 11 01 00 F5 88 00 6D FF FF FF FF FF FF FF FF FF 0C 21 09 0F 05 00 F5 8D 10 01 00 13 01 20 14 03 04 25 00
Jun 17 00:28:50.617 CAM(core.pids): pidca 01ff: <empty>
Jun 17 00:28:50.642 CAM(core.pids): pidca 0200: <empty>
Jun 17 00:28:50.667 CAM(core.pids): pidca 0201: <empty>
Jun 17 00:28:50.692 CAM(core.pids): pidca 0203: <empty>
Jun 17 00:28:50.717 CAM(core.pids): pidca 0204: <empty>
Jun 17 00:28:50.742 CAM(core.pids): 0: SID=301 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/-
Jun 17 00:28:50.767 CAM(core.pids): 0: found handler for SID 301 (0.1 idle=1 idx=1)
Jun 17 00:28:50.792 CAM(core.ecm): 0.1: setting new SID 301
Jun 17 00:28:50.817 CAM(core.pids): 0.1: pids on entry
Jun 17 00:28:50.842 CAM(core.pids): 0.1: pids after delete
Jun 17 00:28:50.869 CAM(core.pids): 0: descrambling pid 01ff on index 1
Called cSascDvbDevice::SetCaPid
Jun 17 00:28:50.944 CSA: Got command(2): P idx: 1 pid: 511
Jun 17 00:28:50.969 CAM(core.pids): 0: descrambling pid 0200 on index 1
Called cSascDvbDevice::SetCaPid
Jun 17 00:28:51.052 CSA: Got command(2): P idx: 1 pid: 512
Jun 17 00:28:51.094 CAM(core.pids): 0: descrambling pid 0201 on index 1
Called cSascDvbDevice::SetCaPid
Jun 17 00:28:51.194 CSA: Got command(2): P idx: 1 pid: 513
Jun 17 00:28:51.227 CAM(core.pids): 0: descrambling pid 0203 on index 1
Called cSascDvbDevice::SetCaPid
Jun 17 00:28:51.327 CSA: Got command(2): P idx: 1 pid: 515
Jun 17 00:28:51.387 CAM(core.pids): 0: descrambling pid 0204 on index 1
Called cSascDvbDevice::SetCaPid
Jun 17 00:28:51.518 CSA: Got command(2): P idx: 1 pid: 516
Jun 17 00:28:51.551 CAM(core.pids): 0.1: pids after add typ5=01ff typ5=0200 typ5=0201 typ5=0203 typ5=0204
Jun 17 00:28:51.585 CAM(core.ecm): 0.1: is no longer idle
Jun 17 00:28:51.618 MSG: Got unprocessed message type: 1
Jun 17 00:28:51.651 MSG: Got unprocessed message type: 1
Jun 17 00:28:51.678 CAM(core.ecm): 0.1: triggered SID -1/301 idx -1/1 mode -1/0 -
Jun 17 00:28:51.701 MSG: Got unprocessed message type: 1
Jun 17 00:28:51.751 MSG: Got unprocessed message type: 1
Jun 17 00:28:51.726 CAM(core.ecm): 0.1: new caDescr: 09 07 18 19 F5 88 02 00 6D 09 0F 05 00 F5 8E 10 01 00 13 01 20 14 03 04 28 00 09 0F 05 00 F5 89 10 01 00 13 01 20 14 03 03 29 20 09 11 01 00 F5 88 00 6D FF FF FF FF FF FF FF FF FF 0C 21 09 0F 05 00 F5 8D 10 01 00 13 01 20 14 03 04 25 00
Jun 17 00:28:51.801 CAM(core.ecm): 0.1: CA descriptors for SID 301 (len=79)
Jun 17 00:28:51.826 CAM(core.ecm): 0.1: descriptor 18 19 f5 88 02 00 6d
Jun 17 00:28:51.851 CAM(core.ecm): 0.1: found 1819(0000) (Nagra2) id 0000 with ecm 1588/80 (new)
Jun 17 00:28:51.876 CAM(core.ecm): 0.1: descriptor 05 00 f5 8e 10 01 00 13 01 20 14 03 04 28 00
Jun 17 00:28:51.901 CAM(core.ecm): 0.1: found 0500(0000) (Viaccess) id 42800 with ecm 158e/80 (new)
Jun 17 00:28:51.926 CAM(core.ecm): 0.1: descriptor 05 00 f5 89 10 01 00 13 01 20 14 03 03 29 20
Jun 17 00:28:51.960 CAM(core.ecm): 0.1: found 0500(0000) (Viaccess) id 32920 with ecm 1589/80 (new)
Jun 17 00:28:52.001 CAM(core.ecm): 0.1: descriptor 01 00 f5 88 00 6d ff ff ff ff ff ff ff ff ff 0c 21
Jun 17 00:28:52.026 CAM(core.ecm): 0.1: found 0100(0000) (Seca) id 006d with ecm 1588/80 (dup) (new)
Jun 17 00:28:52.051 CAM(core.ecm): 0.1: descriptor 05 00 f5 8d 10 01 00 13 01 20 14 03 04 25 00
Jun 17 00:28:52.076 CAM(core.ecm): 0.1: found 0500(0000) (Viaccess) id 42500 with ecm 158d/80 (new)
Jun 17 00:28:52.102 CAM(core.ecm): 0.1: try system Nagra2 (1819) id 0000 with ecm 1588 (pri=-10)
Jun 17 00:28:52.119 CAM(core.au): 0: chain caid 0500 -> Viaccess(-10) Cardclient(-15) [1e1e-8b/fe/07]
Jun 17 00:28:52.176 CAM(core.au): 0: chain caid 0500 ++ [1e1e-8b/fe/07] [1e14-8b/fe/07]
Jun 17 00:28:52.194 CAM(nagra.ecm): bad ECM message msgLen=104 sctLen=100
Jun 17 00:28:52.201 CAM(core.au): 0: chain caid 0500 ++ [1e1e-8b/fe/07] [1e14-8b/fe/07] [1d4d-8b/fe/07]
Jun 17 00:28:52.251 CAM(core.au): 0: chain caid 0500 ++ [1e1e-8b/fe/07] [1e14-8b/fe/07] [1d4d-8b/fe/07] [1d4c-8b/fe/07]
Jun 17 00:28:52.295 CAM(nagra.ecm): bad ECM message msgLen=104 sctLen=100
Jun 17 00:28:52.318 CAM(core.au): 0: starting chain 0500
Jun 17 00:28:52.343 CAM(core.ecm): 0.1: try system Viaccess (0500) id 42800 with ecm 158e (pri=-10)
Jun 17 00:28:52.487 CAM(core.ecm): system: no key found for V 042800 08
Jun 17 00:28:52.889 CAM(core.ecm): 0.1: try system Viaccess (0500) id 32920 with ecm 1589 (pri=-10)
Jun 17 00:28:53.593 CAM(core.ecm): 0.1: try system Seca (0100) id 006d with ecm 1588 (pri=-10)
Jun 17 00:28:53.694 CAM(core.ecm): system: no key found for S 006D 0C
Jun 17 00:28:53.895 CAM(core.ecm): 0.1: try system Viaccess (0500) id 42500 with ecm 158d (pri=-10)
Jun 17 00:28:54.489 CAM(core.ecm): 0.1: try system Cardclient (0500) id 42800 with ecm 158e (pri=-15)
Jun 17 00:28:54.690 CAM(cardclient.core): cc-loop
Jun 17 00:28:54.725 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:28:54.759 CAM(core.net): connecting to localhost:15050/tcp (127.0.0.1)
Jun 17 00:28:54.798 CAM(cardclient.login): Newcamd: CaID=0500 admin=1 srvUA=00000000EE6D76AB provider 042810/00000000EE6D76AB 042800/00000000EE6D76AB FFF400/00000000EE6D76AB
Jun 17 00:28:54.836 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:28:54.875 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (117 ms)
Jun 17 00:28:54.900 CAM(cardclient.core): cc-loop
Jun 17 00:28:54.925 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:28:54.952 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:28:54.975 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (25 ms)
Jun 17 00:28:55.093 CAM(core.ecm): 0.1: try system Cardclient (0500) id 32920 with ecm 1589 (pri=-15)
Jun 17 00:28:55.386 CAM(cardclient.core): cc-loop
Jun 17 00:28:55.441 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:28:55.470 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:28:55.499 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:28:55.587 CAM(cardclient.core): cc-loop
Jun 17 00:28:55.616 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:28:55.653 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:28:55.682 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:28:55.788 CAM(core.ecm): 0.1: try system Cardclient (0500) id 42500 with ecm 158d (pri=-15)
Jun 17 00:28:55.889 CAM(cardclient.core): cc-loop
Jun 17 00:28:55.923 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:28:55.958 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:28:55.990 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (34 ms)
Jun 17 00:28:56.090 CAM(cardclient.core): cc-loop
Jun 17 00:28:56.123 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:28:56.157 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:28:56.189 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:28:56.291 CAM(core.ecm): 0.1: CA descriptors for SID 301 (len=79)
Jun 17 00:28:56.322 CAM(core.ecm): 0.1: descriptor 18 19 f5 88 02 00 6d
Jun 17 00:28:56.356 CAM(core.ecm): 0.1: found 1819(0000) (Nagra2) id 0000 with ecm 1588/80 (already present)
Jun 17 00:28:56.389 CAM(core.ecm): 0.1: descriptor 05 00 f5 8e 10 01 00 13 01 20 14 03 04 28 00
Jun 17 00:28:56.422 CAM(core.ecm): 0.1: found 0500(0000) (Viaccess) id 42800 with ecm 158e/80 (already present)
Jun 17 00:28:56.456 CAM(core.ecm): 0.1: descriptor 05 00 f5 89 10 01 00 13 01 20 14 03 03 29 20
Jun 17 00:28:56.489 CAM(core.ecm): 0.1: found 0500(0000) (Viaccess) id 32920 with ecm 1589/80 (already present)
Jun 17 00:28:56.522 CAM(core.ecm): 0.1: descriptor 01 00 f5 88 00 6d ff ff ff ff ff ff ff ff ff 0c 21
Jun 17 00:28:56.556 CAM(core.ecm): 0.1: found 0100(0000) (Seca) id 006d with ecm 1588/80 (dup) (already present)
Jun 17 00:28:56.589 CAM(core.ecm): 0.1: descriptor 05 00 f5 8d 10 01 00 13 01 20 14 03 04 25 00
Jun 17 00:28:56.622 CAM(core.ecm): 0.1: found 0500(0000) (Viaccess) id 42500 with ecm 158d/80 (already present)
Jun 17 00:28:56.656 CAM(core.ecm): 0.1: try system Nagra2 (1819) id 0000 with ecm 1588 (pri=-10)
Jun 17 00:28:56.693 CAM(nagra.ecm): bad ECM message msgLen=104 sctLen=100
Jun 17 00:28:56.894 CAM(core.ecm): 0.1: try system Viaccess (0500) id 42800 with ecm 158e (pri=-10)
Jun 17 00:28:57.087 CAM(core.ecm): system: no key found for V 042800 08
Jun 17 00:28:57.489 CAM(core.ecm): 0.1: try system Viaccess (0500) id 32920 with ecm 1589 (pri=-10)
Jun 17 00:28:58.193 CAM(core.ecm): 0.1: try system Seca (0100) id 006d with ecm 1588 (pri=-10)
Jun 17 00:28:58.293 CAM(core.ecm): system: no key found for S 006D 0C
Jun 17 00:28:58.494 CAM(core.ecm): 0.1: try system Viaccess (0500) id 42500 with ecm 158d (pri=-10)
Jun 17 00:28:59.089 CAM(core.ecm): 0.1: try system Cardclient (0500) id 42800 with ecm 158e (pri=-15)
Jun 17 00:28:59.274 CAM(cardclient.core): cc-loop
Jun 17 00:28:59.295 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:28:59.321 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:28:59.353 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:28:59.475 CAM(cardclient.core): cc-loop
Jun 17 00:28:59.503 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:28:59.529 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:28:59.553 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (25 ms)
Jun 17 00:28:59.676 CAM(core.ecm): 0.1: try system Cardclient (0500) id 32920 with ecm 1589 (pri=-15)
Jun 17 00:28:59.977 CAM(cardclient.core): cc-loop
Jun 17 00:29:00.001 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:00.028 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:00.059 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:29:00.170 CAM(cardclient.core): cc-loop
Jun 17 00:29:00.192 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:00.219 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:00.251 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (34 ms)
Jun 17 00:29:00.371 CAM(core.ecm): 0.1: try system Cardclient (0500) id 42500 with ecm 158d (pri=-15)
Jun 17 00:29:00.471 CAM(cardclient.core): cc-loop
Jun 17 00:29:00.491 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:00.517 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:00.550 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (34 ms)
Jun 17 00:29:00.672 CAM(cardclient.core): cc-loop
Jun 17 00:29:00.699 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:00.725 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:00.758 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (34 ms)
Jun 17 00:29:00.874 CAM(core.ecm): 0.1: CA descriptors for SID 301 (len=79)
Jun 17 00:29:00.899 CAM(core.ecm): 0.1: descriptor 18 19 f5 88 02 00 6d
Jun 17 00:29:00.924 CAM(core.ecm): 0.1: found 1819(0000) (Nagra2) id 0000 with ecm 1588/80 (already present)
Jun 17 00:29:00.949 CAM(core.ecm): 0.1: descriptor 05 00 f5 8e 10 01 00 13 01 20 14 03 04 28 00
Jun 17 00:29:00.974 CAM(core.ecm): 0.1: found 0500(0000) (Viaccess) id 42800 with ecm 158e/80 (already present)
Jun 17 00:29:01.007 CAM(core.ecm): 0.1: descriptor 05 00 f5 89 10 01 00 13 01 20 14 03 03 29 20
Jun 17 00:29:01.041 CAM(core.ecm): 0.1: found 0500(0000) (Viaccess) id 32920 with ecm 1589/80 (already present)
Jun 17 00:29:01.074 CAM(core.ecm): 0.1: descriptor 01 00 f5 88 00 6d ff ff ff ff ff ff ff ff ff 0c 21
Jun 17 00:29:01.107 CAM(core.ecm): 0.1: found 0100(0000) (Seca) id 006d with ecm 1588/80 (dup) (already present)
Jun 17 00:29:01.140 CAM(core.ecm): 0.1: descriptor 05 00 f5 8d 10 01 00 13 01 20 14 03 04 25 00
Jun 17 00:29:01.174 CAM(core.ecm): 0.1: found 0500(0000) (Viaccess) id 42500 with ecm 158d/80 (already present)
Jun 17 00:29:01.207 CAM(core.ecm): 0.1: try system Nagra2 (1819) id 0000 with ecm 1588 (pri=-10)
Jun 17 00:29:09.269 CAM(nagra.ecm): bad ECM message msgLen=104 sctLen=100
Jun 17 00:29:09.470 CAM(core.ecm): 0.1: try system Viaccess (0500) id 42800 with ecm 158e (pri=-10)
Jun 17 00:29:09.671 CAM(core.ecm): system: no key found for V 042800 08
Jun 17 00:29:10.073 CAM(core.ecm): 0.1: try system Viaccess (0500) id 32920 with ecm 1589 (pri=-10)
Jun 17 00:29:10.769 CAM(core.ecm): 0.1: try system Seca (0100) id 006d with ecm 1588 (pri=-10)
Jun 17 00:29:10.869 CAM(core.ecm): system: no key found for S 006D 0C
Jun 17 00:29:11.070 CAM(core.ecm): 0.1: try system Viaccess (0500) id 42500 with ecm 158d (pri=-10)
Jun 17 00:29:11.674 CAM(core.ecm): 0.1: try system Cardclient (0500) id 42800 with ecm 158e (pri=-15)
Jun 17 00:29:11.875 CAM(cardclient.core): cc-loop
Jun 17 00:29:11.904 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:11.939 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:11.971 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:29:12.076 CAM(cardclient.core): cc-loop
Jun 17 00:29:12.105 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:12.131 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:12.164 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (34 ms)
Jun 17 00:29:12.268 CAM(core.ecm): 0.1: try system Cardclient (0500) id 32920 with ecm 1589 (pri=-15)
Jun 17 00:29:12.570 CAM(cardclient.core): cc-loop
Jun 17 00:29:12.604 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:12.639 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:12.670 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:29:12.771 CAM(cardclient.core): cc-loop
Jun 17 00:29:12.803 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:12.838 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:12.870 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (34 ms)
Jun 17 00:29:12.972 CAM(core.ecm): 0.1: try system Cardclient (0500) id 42500 with ecm 158d (pri=-15)
Jun 17 00:29:13.072 CAM(cardclient.core): cc-loop
Jun 17 00:29:13.102 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:13.137 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:13.169 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:29:13.274 CAM(cardclient.core): cc-loop
Jun 17 00:29:13.302 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:13.336 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:13.369 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (34 ms)
Jun 17 00:29:13.475 CAM(core.ecm): 0.1: CA descriptors for SID 301 (len=79)
Jun 17 00:29:13.502 CAM(core.ecm): 0.1: descriptor 18 19 f5 88 02 00 6d
Jun 17 00:29:13.535 CAM(core.ecm): 0.1: found 1819(0000) (Nagra2) id 0000 with ecm 1588/80 (already present)
Jun 17 00:29:13.568 CAM(core.ecm): 0.1: descriptor 05 00 f5 8e 10 01 00 13 01 20 14 03 04 28 00
Jun 17 00:29:13.602 CAM(core.ecm): 0.1: found 0500(0000) (Viaccess) id 42800 with ecm 158e/80 (already present)
Jun 17 00:29:13.635 CAM(core.ecm): 0.1: descriptor 05 00 f5 89 10 01 00 13 01 20 14 03 03 29 20
Jun 17 00:29:13.668 CAM(core.ecm): 0.1: found 0500(0000) (Viaccess) id 32920 with ecm 1589/80 (already present)
Jun 17 00:29:13.702 CAM(core.ecm): 0.1: descriptor 01 00 f5 88 00 6d ff ff ff ff ff ff ff ff ff 0c 21
Jun 17 00:29:13.735 CAM(core.ecm): 0.1: found 0100(0000) (Seca) id 006d with ecm 1588/80 (dup) (already present)
Jun 17 00:29:13.768 CAM(core.ecm): 0.1: descriptor 05 00 f5 8d 10 01 00 13 01 20 14 03 04 25 00
Jun 17 00:29:13.801 CAM(core.ecm): 0.1: found 0500(0000) (Viaccess) id 42500 with ecm 158d/80 (already present)
Jun 17 00:29:13.835 CAM(core.ecm): 0.1: try system Nagra2 (1819) id 0000 with ecm 1588 (pri=-10)
Jun 17 00:29:13.868 CAM(core.ecm): 0.1: stopping message log until valid key is found
Jun 17 00:29:21.853 CAM(cardclient.core): cc-loop
Jun 17 00:29:21.878 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:21.904 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:21.928 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (25 ms)
Jun 17 00:29:22.054 CAM(cardclient.core): cc-loop
Jun 17 00:29:22.077 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:22.103 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:22.127 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (25 ms)
Jun 17 00:29:22.557 CAM(cardclient.core): cc-loop
Jun 17 00:29:22.584 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:22.613 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:22.642 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:29:22.758 CAM(cardclient.core): cc-loop
Jun 17 00:29:22.792 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:22.827 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:22.858 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:29:23.059 CAM(cardclient.core): cc-loop
Jun 17 00:29:23.092 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:23.118 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:23.150 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:29:23.261 CAM(cardclient.core): cc-loop
Jun 17 00:29:23.283 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:23.309 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:23.342 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (34 ms)
Jun 17 00:29:31.840 CAM(cardclient.core): cc-loop
Jun 17 00:29:31.865 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:31.891 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:31.924 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (34 ms)
Jun 17 00:29:32.041 CAM(cardclient.core): cc-loop
Jun 17 00:29:32.065 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:32.092 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:32.123 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:29:32.543 CAM(cardclient.core): cc-loop
Jun 17 00:29:32.571 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:32.598 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:32.630 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:29:32.736 CAM(cardclient.core): cc-loop
Jun 17 00:29:32.771 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:32.808 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:32.837 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:29:33.038 CAM(cardclient.core): cc-loop
Jun 17 00:29:33.070 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:33.104 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:33.137 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (34 ms)
Jun 17 00:29:33.239 CAM(cardclient.core): cc-loop
Jun 17 00:29:33.269 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:33.304 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:33.336 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:29:41.826 CAM(cardclient.core): cc-loop
Jun 17 00:29:41.860 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:41.894 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:41.926 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (33 ms)
Jun 17 00:29:42.028 CAM(cardclient.core): cc-loop
Jun 17 00:29:42.059 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:42.093 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:42.126 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (34 ms)
Jun 17 00:29:42.522 CAM(cardclient.core): cc-loop
Jun 17 00:29:42.549 CAM(cardclient.core): now trying client Newcamd (localhost:15050)
Jun 17 00:29:42.584 CAM(cardclient.ecm): Newcamd: card was not able to decode the channel
Jun 17 00:29:42.616 CAM(cardclient.core): client Newcamd (localhost:15050) ECM failed (34 ms)

Toutes les idées sont les bienvenues.

Hors ligne

#2 17/06/2011 07:01:59

FabriceMG
Développeur cinépassion.plcinépassion.pl sur le wiki.
Inscription : 03/11/2009
Messages : 193

Re : TT3200, Infinity USB Smart, ,Oscam, sasc-ng et BisTV sur Hotbird S13E0

Bonjour

Pas compliquer, il y a déjà une erreur dans la defintion du service oscam caid = 0500
Tu peux faire une copie complète du log oscam stp sur pastin.com

Hors ligne

#3 17/06/2011 09:54:49

zorglups
Membre
Inscription : 16/01/2009
Messages : 96

Re : TT3200, Infinity USB Smart, ,Oscam, sasc-ng et BisTV sur Hotbird S13E0

Bonjour et merci pour la réponse rapide.
Je suppose que tu parles du caid mis à 0B00 dans /etc/oscam/oscam.services

En effet, j'ai loupé celui-là. Je devrais arrêter de faire ces config de nuit :-)

Je vais changer cela ce soir et si cela ne fonctionne pas mieux, alors, je posterai mes oscam.log et sasg-nc.log sur pastebin.

Hors ligne

#4 17/06/2011 10:25:38

FabriceMG
Développeur cinépassion.plcinépassion.pl sur le wiki.
Inscription : 03/11/2009
Messages : 193

Re : TT3200, Infinity USB Smart, ,Oscam, sasc-ng et BisTV sur Hotbird S13E0

zorglups a écrit :

Bonjour et merci pour la réponse rapide.
Je suppose que tu parles du caid mis à 0B00 dans /etc/oscam/oscam.services

En effet, j'ai loupé celui-là. Je devrais arrêter de faire ces config de nuit :-)

Je vais changer cela ce soir et si cela ne fonctionne pas mieux, alors, je posterai mes oscam.log et sasg-nc.log sur pastebin.

Je vais pas te rassuré mais ce n'est pas la seule erreur ! c'est pour cela que je voudrai voir la version complete du log oscam pour ne pas y revenir plusieur fois.
Verifie que tu as bien compilé oscam avec l'interface web, ca sera plus facile a configurer

cmake -DCS_CONFDIR=/data/oscam -DWEBIF=1 ..

Hors ligne

#5 21/06/2011 23:08:03

zorglups
Membre
Inscription : 16/01/2009
Messages : 96

Re : TT3200, Infinity USB Smart, ,Oscam, sasc-ng et BisTV sur Hotbird S13E0

Tu avais donc bien raison.
J'ai change le caid dans /etc/oscam/oscam.services de 0B00 à 0500.

J'ai bien-sûr dû redémarrer oscam/sasc-ng/mythbackend et mythtv s'est mis à décoder mes flux DVB-S2 de BisTV.

Au début, ça saccadait pas mal lorsque de me mettais sur des chaînes en HD (Fr2 HD) mais j'ai vite trouvé que je devais me mettre en VDPAU "normal" sans quoi mon frontend avait du mal.

Il me reste encore un soucis :
- si je laisse le frontend sur une chaîne HD ou SD pendant quelques temps, il finit par sortir du LiveTV avec le message d'erreur : "La mise en tampon de trames vidéo a échoué trop de fois.

- si j'essaie de changer de chaine alors que je suis en LiveTV sur une chaine, le frontend sort souvent du LiveTV avec le message d'erreur suivant : Erreur à l'ouverture du fichier de saut de programme.

Je dois encore investiguer mais créerai une thread séparée sur ce forum pour suivre ce problème.

Merci beaucoup pour ton aide.

Hors ligne

Réponse rapide

Veuillez composer votre message et l'envoyer
Si vous êtes un être humain ne changez pas le contenu de ces deux champs.

Pied de page des forums

Propulsé par FluxBB

Webmasteur SnouF

Hébergé par Tuxfamily

Valid XHTML 1.0 Strict