DVB-S Skystar1 dekodovanie sasc-ng Ubuntu 10.04

Dobry den, snazim sa ubuntu 10.04 rozbehat CSLINK pomocou, sasc-ng + oscam + phoenix (s usb-serial prevnodnikom pl2303) a samozrejme kartou CSLINK. Vyzera ze vsetko funguje v poriadku, vypisy sa zdaju OK ale obraz z toho nedostanem. Skusal som VDR, Mythtv, kaffeine, a nikde nic. Nekodovane programy idu bez problemov. Jadro: 2.6.32-27-generic.

Vypis z lspci:

Multimedia controller: Philips Semiconductors SAA7146 (rev 01)

log sasc-ng:

Jan 16 13:00:18.713 CAM(general.info): SC version 1.0.0pre-HG-61975953edd0+ initializing (VDR 1.6.0)
Jan 16 13:00:18.713 CAM: starting plugin:
Jan 16 13:00:18.713 CAM(general.info): SC version 1.0.0pre-HG-61975953edd0+ starting (VDR 1.6.0)
Jan 16 13:00:18.713 CAM(core.load): ** Plugin config:
Jan 16 13:00:18.714 CAM(core.load): ** Key updates (AU) are enabled (active CAIDs) (no prestart)
Jan 16 13:00:18.714 CAM(core.load): ** Local systems DON'T take priority over cached remote
Jan 16 13:00:18.714 CAM(core.load): ** Concurrent FF recordings are NOT allowed
Jan 16 13:00:18.714 CAM(core.load): ** Force transfermode with digital audio
Jan 16 13:00:18.714 CAM(core.load): ** ECM cache is set to enabled
Jan 16 13:00:18.714 CAM(core.load): ** ScCaps are 1 2 0 0 0 0 0 0 0 0
Jan 16 13:00:18.714 CAM(general.info): loading cardclient config from /etc/sasc//cardclient.conf
Jan 16 13:00:18.714 CAM(cardclient.newcamd): now using protocol version 525 (cdLen=8)
Jan 16 13:00:18.714 CAM(cardclient.core): hostname=localhost port=34000 emm=1 emmCaids 0d0f/ffff
Jan 16 13:00:18.714 CAM(cardclient.core): Newcamd: username=**** password=**** key=******************
Jan 16 13:00:18.714 CAM(cardclient.core): client 'Newcamd' ready
Jan 16 13:00:18.716 CAM(core.net): connecting to localhost:34000/tcp (127.0.0.1)
Jan 16 13:00:29.471 CAM(cardclient.login): Newcamd: CaID=0d0f admin=1 srvUA=********** provider 000010/0000000000000000 00000C/0000000000000000 000008/0000000000000000 000004/0000000000000000
Jan 16 13:00:29.471 CAM(general.error): failed open /etc/sasc//SoftCam.Key: No such file or directory
Jan 16 13:00:29.471 CAM(general.info): loading ecm cache from /etc/sasc//ecm.cache
Jan 16 13:00:29.483 CAM(general.error): failed open /etc/sasc//smartcard.conf: No such file or directory
Jan 16 13:00:29.483 CAM(general.error): failed open /etc/sasc//cardslot.conf: No such file or directory
Jan 16 13:00:29.484 CAM(general.error): failed open /etc/sasc//override.conf: No such file or directory
Jan 16 13:00:29.484 CAM(general.error): no keys loaded for softcam!
Jan 16 13:00:29.484 CAM(core.load): ** registered systems:
Jan 16 13:00:29.484 CAM(core.load): ** Cardclient        (pri -15)
Jan 16 13:00:29.484 CAM(core.load): ** Conax             (pri -10)
Jan 16 13:00:29.484 CAM(core.load): ** ConstCW           (pri -20)
Jan 16 13:00:29.484 CAM(core.load): ** Cryptoworks       (pri -10)
Jan 16 13:00:29.484 CAM(core.load): ** Irdeto            (pri -10)
Jan 16 13:00:29.484 CAM(core.load): ** Irdeto2           (pri  -8)
Jan 16 13:00:29.484 CAM(core.load): ** Nagra             (pri -10)
Jan 16 13:00:29.484 CAM(core.load): ** Nagra2            (pri -10)
Jan 16 13:00:29.484 CAM(core.load): ** Fake-NDS          (pri -12)
Jan 16 13:00:29.484 CAM(core.load): ** SC-Conax          (pri  -5)
Jan 16 13:00:29.484 CAM(core.load): ** SC-Cryptoworks    (pri  -5)
Jan 16 13:00:29.484 CAM(core.load): ** SC-Irdeto         (pri  -5)
Jan 16 13:00:29.484 CAM(core.load): ** SC-Nagra          (pri  -5)
Jan 16 13:00:29.484 CAM(core.load): ** SC-Seca           (pri  -5)
Jan 16 13:00:29.485 CAM(core.load): ** SC-Viaccess       (pri  -5)
Jan 16 13:00:29.485 CAM(core.load): ** SC-VideoGuard2    (pri  -5)
Jan 16 13:00:29.485 CAM(core.load): ** Seca              (pri -10)
Jan 16 13:00:29.485 CAM(core.load): ** @SHL              (pri -10)
Jan 16 13:00:29.485 CAM(core.load): ** Viaccess          (pri -10)
Jan 16 13:00:30.493 frontend: Starting thread on /dev/dvb/adapter1/frontend1
The thread scheduling parameters indicate:
policy = 0
priority = 0
Jan 16 13:00:30.494 dvr: Starting thread on /dev/dvb/adapter1/dvr1
The thread scheduling parameters indicate:
policy = 1
priority = 99
Jan 16 13:00:30.494 demux: Starting thread on /dev/dvb/adapter1/demux1
The thread scheduling parameters indicate:
policy = 0
priority = 0
Jan 16 13:00:30.494 : Listening on port 5456
Jan 16 13:00:41.338 CHANNEL: Clearing tuning cache due to switch cmd
Jan 16 13:00:41.338 CHANNEL: Clearing tuning cache due to switch cmd
Jan 16 13:00:41.354 CHANNEL: Clearing tuning cache due to switch cmd
Jan 16 13:00:41.369 CHANNEL: Clearing tuning cache due to switch cmd
Jan 16 13:00:41.445 CHANNEL: Clearing tuning cache due to switch cmd
Jan 16 13:00:41.445 CHANNEL: Tuning frontend
Jan 16 13:00:41.445 CSA: Got command(1): I idx: 0 pid: 0
Orbit: 00000235E
Jan 16 13:00:42.365 MSG: Got unprocessed message type: 1
Jan 16 13:00:42.365 MSG: Got unprocessed message type: 1
Jan 16 13:00:46.098 CSA: Removing csa for rb: 1
Jan 16 13:00:46.098 CSA: Got command(1): I idx: 0 pid: 0
Jan 16 13:00:46.114 CHANNEL: Clearing tuning cache due to switch cmd
Jan 16 13:00:46.115 CHANNEL: Clearing tuning cache due to switch cmd
Jan 16 13:00:46.130 CHANNEL: Clearing tuning cache due to switch cmd
Jan 16 13:00:46.145 CHANNEL: Clearing tuning cache due to switch cmd
Jan 16 13:00:46.222 CHANNEL: Clearing tuning cache due to switch cmd
Jan 16 13:00:46.222 CHANNEL: Tuning frontend
Jan 16 13:00:46.222 CSA: Got command(1): I idx: 0 pid: 0
Orbit: 00000235E
Jan 16 13:00:47.173 CAM(core.pids): 0: now tuned to source 88eb(S23.5E) transponder 33e2d
Jan 16 13:00:47.173 CAM: SC completed  Tune cmd
Jan 16 13:00:47.173 CAM(core.pids): 0: update SID 8003 (zero=0 noshift=0)
Jan 16 13:00:47.173 CAM(core.pids): 0: pids typ5=0028 typ5=0058 typ5=0059 typ5=005a typ5=00a2
Jan 16 13:00:47.173 CAM(core.pids): SimplyCa entry pidCa=0
Jan 16 13:00:47.173 CAM(core.pids): prgca: 09 04 0D 03 E6 0F 09 04 0D 0F E6 53 09 04 0D 70 E7 01 09 04 0D 96 EF 00 09 04 06 24 EF 01
Jan 16 13:00:47.173 CAM(core.pids): pidca 0028: empty
Jan 16 13:00:47.173 CAM(core.pids): pidca 0058: empty
Jan 16 13:00:47.173 CAM(core.pids): pidca 0059: empty
Jan 16 13:00:47.173 CAM(core.pids): pidca 005a: empty
Jan 16 13:00:47.174 CAM(core.pids): pidca 00a2: empty
Jan 16 13:00:47.174 CAM(core.pids): SimplyCa exit pidCa=0
Jan 16 13:00:47.174 CAM(core.pids): prgca: 09 04 0D 03 E6 0F 09 04 0D 0F E6 53 09 04 0D 70 E7 01 09 04 0D 96 EF 00 09 04 06 24 EF 01
Jan 16 13:00:47.174 CAM(core.pids): pidca 0028: empty
Jan 16 13:00:47.174 CAM(core.pids): pidca 0058: empty
Jan 16 13:00:47.174 CAM(core.pids): pidca 0059: empty
Jan 16 13:00:47.174 CAM(core.pids): pidca 005a: empty
Jan 16 13:00:47.174 CAM(core.pids): pidca 00a2: empty
Jan 16 13:00:47.174 CAM(core.pids): 0: SID=8003 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/-
Jan 16 13:00:47.174 CAM(core.pids): 0: found handler for SID 8003 (0.1 idle=1 idx=1)
Jan 16 13:00:47.174 CAM(core.ecm): 0.1: setting new SID 8003
Jan 16 13:00:47.174 CAM(core.pids): 0.1: pids on entry
Jan 16 13:00:47.174 CAM(core.pids): 0.1: pids after delete
Jan 16 13:00:47.174 CAM(core.pids): 0: descrambling pid 0028 on index 1
Called cSascDvbDevice::SetCaPid
Jan 16 13:00:47.174 CSA: Got command(1): P idx: 1 pid: 40
Jan 16 13:00:47.174 CAM(core.pids): 0: descrambling pid 0058 on index 1
Called cSascDvbDevice::SetCaPid
Jan 16 13:00:47.174 CSA: Got command(1): P idx: 1 pid: 88
Jan 16 13:00:47.175 CAM(core.pids): 0: descrambling pid 0059 on index 1
Called cSascDvbDevice::SetCaPid
Jan 16 13:00:47.175 CSA: Got command(1): P idx: 1 pid: 89
Jan 16 13:00:47.175 CAM(core.pids): 0: descrambling pid 005a on index 1
Called cSascDvbDevice::SetCaPid
Jan 16 13:00:47.175 CSA: Got command(1): P idx: 1 pid: 90
Jan 16 13:00:47.175 CAM(core.pids): 0: descrambling pid 00a2 on index 1
Called cSascDvbDevice::SetCaPid
Jan 16 13:00:47.175 CSA: Got command(1): P idx: 1 pid: 162
Jan 16 13:00:47.175 CAM(core.pids): 0.1: pids after add typ5=0028 typ5=0058 typ5=0059 typ5=005a typ5=00a2
Jan 16 13:00:47.175 CAM(core.ecm): 0.1: is no longer idle
Jan 16 13:00:47.175 MSG: Got unprocessed message type: 1
Jan 16 13:00:47.235 CAM(core.ecm): 0.1: triggered SID -1/8003 idx -1/1 mode -1/0 -
Jan 16 13:00:47.235 CAM(core.ecm): 0.1: new caDescr: 09 04 0D 03 E6 0F 09 04 0D 0F E6 53 09 04 0D 70 E7 01 09 04 0D 96 EF 00 09 04 06 24 EF 01
Jan 16 13:00:47.236 CAM(core.ecm): from cache: system Cardclient (0d0f) id 0000 with ecm 653/80
Jan 16 13:00:47.236 CAM(core.ecm): 0.1: CA descriptors for SID 8003 (len=30)
Jan 16 13:00:47.236 CAM(core.ecm): 0.1: descriptor 0d 03 e6 0f
Jan 16 13:00:47.236 CAM(core.ecm): 0.1: found 0d03(0000) (Cryptoworks) id 0000 with ecm 60f/80 (new)
Jan 16 13:00:47.236 CAM(core.ecm): 0.1: descriptor 0d 0f e6 53
Jan 16 13:00:47.236 CAM(core.ecm): 0.1: found 0d0f(0000) (Cryptoworks) id 0000 with ecm 653/80 (already present)
Jan 16 13:00:47.236 CAM(core.ecm): 0.1: descriptor 0d 70 e7 01
Jan 16 13:00:47.236 CAM(core.ecm): 0.1: found 0d70(0000) (Cryptoworks) id 0000 with ecm 701/80 (new)
Jan 16 13:00:47.236 CAM(core.ecm): 0.1: descriptor 0d 96 ef 00
Jan 16 13:00:47.236 CAM(core.ecm): 0.1: found 0d96(0000) (Cryptoworks) id 0000 with ecm f00/80 (new)
Jan 16 13:00:47.236 CAM(core.ecm): 0.1: descriptor 06 24 ef 01
Jan 16 13:00:47.236 CAM(core.ecm): 0.1: found 0624(0000) (Irdeto2) id 0000 with ecm f01/80 (new)
Jan 16 13:00:47.250 CAM(core.ecm): 0.1: try system Cardclient (0d0f) id 0000 with ecm 653 (cached) (pri=-15)
Jan 16 13:00:47.252 CAM(core.au): 0: chain caid 0d0f -> Cardclient(-15) [00c9-80/ff/06] [00c9-88/fe/00]
Jan 16 13:00:47.252 CAM(core.au): 0: chain caid 0d03 -> none available
Jan 16 13:00:47.252 CAM(core.au): 0: chain caid 0d70 -> none available
Jan 16 13:00:47.252 CAM(core.au): 0: chain caid 0d96 -> none available
Jan 16 13:00:47.253 CAM(core.au): 0: chain caid 0624 -> Irdeto2(-8) Irdeto(-10) [0113-82/ff/00]
Jan 16 13:00:47.253 CAM(core.au): 0: starting chain 0d0f
Jan 16 13:00:47.253 CAM(cardclient.core): cc-loop
Jan 16 13:00:47.253 CAM(cardclient.core): now trying client Newcamd (localhost:34000)
Called cSascDvbDevice::SetCaDescr
Jan 16 13:00:47.539 CSA: Got command(1): E idx: 1 pid: 0 key: 8ed8...d9
Called cSascDvbDevice::SetCaDescr
Jan 16 13:00:47.539 CSA: Got command(1): O idx: 1 pid: 0 key: b750...ba
Jan 16 13:00:47.539 CAM(core.ecm): 0.1: correct key found
Jan 16 13:00:47.539 CSA: Creating csa for rb: 1
Called cSascDvbDevice::SetCaDescr
Jan 16 13:00:48.139 CSA: Got command(1): O idx: 1 pid: 0 key: fb0b...93
Called cSascDvbDevice::SetCaDescr
Jan 16 13:00:49.586 CSA: Got command(1): E idx: 1 pid: 0 key: 8ed8...d9
Called cSascDvbDevice::SetCaDescr
Jan 16 13:00:49.586 CSA: Got command(1): O idx: 1 pid: 0 key: fb0b...93
Called cSascDvbDevice::SetCaDescr
Jan 16 13:00:58.279 CSA: Got command(1): E idx: 1 pid: 0 key: f00e...ee
Called cSascDvbDevice::SetCaDescr
Jan 16 13:01:08.411 CSA: Got command(1): O idx: 1 pid: 0 key: 4669...7b
Called cSascDvbDevice::SetCaDescr
Jan 16 13:01:18.542 CSA: Got command(1): E idx: 1 pid: 0 key: f96b...4c

Neviem kde moze byt problem, skusil som vsetko a nic nefunguje, obrazovka stale cierna. :-(

Dotaz: DVB-S Skystar1 dekodovanie sasc-ng Ubuntu 10.04