lemosh Posted October 24, 2010 · Report post Есть Ubuntu Server x64 10.04LTS, на нем стоит sasc-ng + гетстрим, 2*SS2 + 1*SS3. Вещаю в сеть 3 транспондера триколор. До недлавнего времени все работало отично без с боев, но последние 2-3 дня рвется картинка, либо вообще не хочет декодить каналы сасц. На каждый транспондер запускаю свой сасц. Декодирую используя шаринг-сервер, один и тот же для всех транспондеров, только разные логины. В опредененный момент может без сбоев работать какой-то из транспондеров - этим делаю вывод что шаринг-сервер не виноват... В логах сасца следующее: Oct 24 09:05:16.471 : Version: 0.0.2-1cc3497be31c+ Oct 24 09:05:16.539 CAM: initializing plugin: SoftCam (1.0.0pre-HG-1cc3497be31c+): A software emulated CAM Oct 24 09:05:16.552 [general.info] SC version 1.0.0pre-HG-1cc3497be31c+ initializing (VDR 1.6.0) Oct 24 09:05:16.561 CAM: starting plugin: Oct 24 09:05:16.569 [general.info] SC version 1.0.0pre-HG-1cc3497be31c+ starting (VDR 1.6.0) Oct 24 09:05:16.577 [core.load] ** Plugin config: Oct 24 09:05:16.586 [core.load] ** Key updates (AU) are enabled (active CAIDs) (no prestart) Oct 24 09:05:16.594 [core.load] ** Local systems DON'T take priority over cached remote Oct 24 09:05:16.602 [core.load] ** Concurrent FF recordings are NOT allowed Oct 24 09:05:16.611 [core.load] ** Force transfermode with digital audio Oct 24 09:05:16.619 [core.load] ** ECM cache is set to enabled Oct 24 09:05:16.627 [core.load] ** ScCaps are 1 2 0 0 0 0 0 0 0 0 Oct 24 09:05:16.636 [general.info] loading cardclient config from /etc/camfiles/12190/cardclient.conf Oct 24 09:05:16.644 [cardclient.newcamd] now using protocol version 525 (cdLen=8) Oct 24 09:05:16.652 [cardclient.core] hostname=shara2.dyndns.tv port=3002 emm=0 emmCaids 4ae1/ffff Oct 24 09:05:16.661 [cardclient.core] Newcamd: username=***** password=******* key=0102030405060708091011121314 Oct 24 09:05:16.669 [cardclient.core] client 'Newcamd' ready Oct 24 09:05:16.747 [core.net] connecting to shara2.dyndns.tv:3002/tcp (92.243.83.130) Oct 24 09:05:17.198 [cardclient.login] Newcamd: CaID=4ae1 admin=1 srvUA=0000000000000000 provider 000000/0000000000000032 <unhandled> Oct 24 09:05:17.202 [cardclient.newcamd] now using protocol version 525 (cdLen=8) Oct 24 09:05:17.210 [cardclient.core] hostname=shara3.dyndns.tv port=3002 emm=0 emmCaids 4ae1/ffff Oct 24 09:05:17.219 [cardclient.core] Newcamd: username=******** password=********** key=0102030405060708091011121314 Oct 24 09:05:17.227 [cardclient.core] client 'Newcamd' ready Oct 24 09:05:17.299 [core.net] connecting to shara3.dyndns.tv:3002/tcp (188.72.230.240) Oct 24 09:05:17.591 [cardclient.login] Newcamd: CaID=4ae1 admin=1 srvUA=0000000000000000 provider 000000/0000000000000032 <unhandled> Oct 24 09:05:17.594 [general.error] failed open /etc/camfiles/12190/SoftCam.Key: No such file or directory Oct 24 09:05:17.602 [general.info] loading ecm cache from /etc/camfiles/12190/ecm.cache Oct 24 09:05:17.611 [general.error] failed open /etc/camfiles/12190/smartcard.conf: No such file or directory Oct 24 09:05:17.619 [general.error] failed open /etc/camfiles/12190/cardslot.conf: No such file or directory Oct 24 09:05:17.627 [general.error] failed open /etc/camfiles/12190/override.conf: No such file or directory Oct 24 09:05:17.635 [general.error] no keys loaded for softcam! Oct 24 09:05:17.644 [core.load] ** registered systems: Oct 24 09:05:17.652 [core.load] ** Cardclient (pri -15) Oct 24 09:05:17.660 [core.load] ** Conax (pri -10) Oct 24 09:05:17.669 [core.load] ** ConstCW (pri -20) Oct 24 09:05:17.677 [core.load] ** Cryptoworks (pri -10) Oct 24 09:05:17.685 [core.load] ** Irdeto (pri -10) Oct 24 09:05:17.693 [core.load] ** Irdeto2 (pri -8) Oct 24 09:05:17.702 [core.load] ** Nagra (pri -10) Oct 24 09:05:17.710 [core.load] ** Nagra2 (pri -10) Oct 24 09:05:17.718 [core.load] ** Fake-NDS (pri -12) Oct 24 09:05:17.727 [core.load] ** SC-Conax (pri -5) Oct 24 09:05:17.735 [core.load] ** SC-Cryptoworks (pri -5) Oct 24 09:05:17.743 [core.load] ** SC-Irdeto (pri -5) Oct 24 09:05:17.752 [core.load] ** SC-Nagra (pri -5) Oct 24 09:05:17.760 [core.load] ** SC-Seca (pri -5) Oct 24 09:05:17.769 [core.load] ** SC-Viaccess (pri -5) Oct 24 09:05:17.777 [core.load] ** SC-VideoGuard2 (pri -5) Oct 24 09:05:17.785 [core.load] ** Seca (pri -10) Oct 24 09:05:17.793 [core.load] ** @SHL (pri -10) Oct 24 09:05:17.802 [core.load] ** Viaccess (pri -10) Oct 24 09:05:18.814 frontend: Starting thread on /dev/dvb/adapter5/frontend1 The thread scheduling parameters indicate: policy = 0 priority = 0 Oct 24 09:05:18.814 demux: Starting thread on /dev/dvb/adapter5/demux1 The thread scheduling parameters indicate: policy = 0 priority = 0 Oct 24 09:05:18.901 dvr: Starting thread on /dev/dvb/adapter5/dvr1 The thread scheduling parameters indicate: policy = 1 priority = 99 Oct 24 09:05:18.910 : Listening on port 5456 Failed to bind to debug port:: Address already in use Oct 24 09:05:18.926 DEBUG: The debug port will not be availableOct 24 09:05:21.482 CHANNEL: Clearing tuning cache due to switch cmd Oct 24 09:05:21.484 CHANNEL: Clearing tuning cache due to switch cmd Oct 24 09:05:21.492 CHANNEL: Tuning frontend Oct 24 09:05:21.501 CSA: Got command(5): I idx: 0 pid: 0 Orbit: 00000360E Oct 24 09:05:23.074 [core.pids] 2: now tuned to source 8968(S36.0E) transponder 4c1fc Oct 24 09:05:23.083 CAM: SC completed Tune cmd Oct 24 09:05:23.092 [core.pids] 2: update SID 25110 (zero=0 noshift=0) Oct 24 09:05:23.100 [core.pids] 2: pids typ5=044d typ5=044e Oct 24 09:05:23.108 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:23.117 [core.pids] prgca: 09 05 4A E1 E0 2A 11 09 04 4A E0 E0 26 09 05 4A E0 E0 2F 15 Oct 24 09:05:23.125 [core.pids] pidca 044d: <empty> Oct 24 09:05:23.133 [core.pids] pidca 044e: <empty> Oct 24 09:05:23.142 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:23.150 [core.pids] prgca: 09 05 4A E1 E0 2A 11 09 04 4A E0 E0 26 09 05 4A E0 E0 2F 15 Oct 24 09:05:23.158 [core.pids] pidca 044d: <empty> Oct 24 09:05:23.167 [core.pids] pidca 044e: <empty> Oct 24 09:05:23.175 [core.pids] 2: SID=25110 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/- Oct 24 09:05:23.183 [core.pids] 2: found handler for SID 25110 (2.1 idle=1 idx=1) Oct 24 09:05:23.192 [core.ecm] 2.1: setting new SID 25110 Oct 24 09:05:23.200 [core.pids] 2.1: pids on entry Oct 24 09:05:23.208 [core.pids] 2.1: pids after delete Oct 24 09:05:23.217 [core.pids] 2: descrambling pid 044d on index 1 Called cSascDvbDevice::SetCaPid Oct 24 09:05:23.242 CSA: Got command(5): P idx: 1 pid: 1101 Oct 24 09:05:23.250 [core.pids] 2: descrambling pid 044e on index 1 Called cSascDvbDevice::SetCaPid Oct 24 09:05:23.275 CSA: Got command(5): P idx: 1 pid: 1102 Oct 24 09:05:23.283 [core.pids] 2.1: pids after add typ5=044d typ5=044e Oct 24 09:05:23.292 [core.ecm] 2.1: is no longer idle Oct 24 09:05:23.300 MSG: Got unprocessed message type: 1 Oct 24 09:05:23.308 [core.pids] 2: update SID 25050 (zero=0 noshift=0) Oct 24 09:05:23.317 [core.pids] 2: pids typ5=01f5 typ5=01f6 Oct 24 09:05:23.325 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:23.333 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:23.342 [core.pids] pidca 01f5: <empty> Oct 24 09:05:23.350 [core.pids] pidca 01f6: <empty> Oct 24 09:05:23.358 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:23.361 [core.ecm] 2.1: triggered SID -1/25110 idx -1/1 mode -1/0 - Oct 24 09:05:23.367 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:23.375 [core.ecm] 2.1: new caDescr: 09 05 4A E1 E0 2A 11 09 04 4A E0 E0 26 09 05 4A E0 E0 2F 15 Oct 24 09:05:23.383 [core.pids] pidca 01f5: <empty> Oct 24 09:05:23.392 [core.ecm] from cache: system Cardclient (4ae1) id 0000 with ecm 2a/80 Oct 24 09:05:23.400 [core.pids] pidca 01f6: <empty> Oct 24 09:05:23.408 [core.ecm] 2.1: CA descriptors for SID 25110 (len=20) Oct 24 09:05:23.417 [core.pids] 2: SID=25050 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/- Oct 24 09:05:23.425 [core.ecm] 2.1: descriptor 4a e1 e0 2a 11 Oct 24 09:05:23.433 [core.pids] 2: found handler for SID 25050 (2.2 idle=1 idx=2) Oct 24 09:05:23.442 [core.ecm] 2.1: found 4ae1(0000) (Cardclient) id 0000 with ecm 2a/80 (already present) Oct 24 09:05:23.450 [core.ecm] 2.2: setting new SID 25050 Oct 24 09:05:23.458 [core.ecm] 2.1: descriptor 4a e0 e0 26 Oct 24 09:05:23.467 [core.pids] 2.2: pids on entry Oct 24 09:05:23.525 [core.ecm] 2.1: no module available for system 4ae0 Oct 24 09:05:23.533 [core.pids] 2.2: pids after delete Oct 24 09:05:23.558 [core.pids] 2: descrambling pid 01f5 on index 2 Called cSascDvbDevice::SetCaPid Oct 24 09:05:23.583 CSA: Got command(5): P idx: 2 pid: 501 Oct 24 09:05:23.662 [core.pids] 2: descrambling pid 01f6 on index 2 Called cSascDvbDevice::SetCaPid Oct 24 09:05:23.708 CSA: Got command(5): P idx: 2 pid: 502 Oct 24 09:05:23.717 [core.pids] 2.2: pids after add typ5=01f5 typ5=01f6 Oct 24 09:05:23.550 [core.ecm] 2.1: descriptor 4a e0 e0 2f 15 Oct 24 09:05:23.725 [core.ecm] 2.2: is no longer idle Oct 24 09:05:23.742 MSG: Got unprocessed message type: 1 Oct 24 09:05:23.750 [core.pids] 2: update SID 25060 (zero=0 noshift=0) Oct 24 09:05:23.758 [core.pids] 2: pids typ5=0259 typ5=025a Oct 24 09:05:23.767 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:23.775 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:23.783 [core.pids] pidca 0259: <empty> Oct 24 09:05:23.792 [core.pids] pidca 025a: <empty> Oct 24 09:05:23.800 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:23.808 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:23.802 [core.ecm] 2.2: triggered SID -1/25050 idx -1/2 mode -1/0 - Oct 24 09:05:23.825 [core.ecm] 2.2: new caDescr: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:23.833 [core.ecm] from cache: system Cardclient (4ae1) id 0000 with ecm 29/80 Oct 24 09:05:23.842 [core.ecm] 2.2: CA descriptors for SID 25050 (len=20) Oct 24 09:05:23.850 [core.ecm] 2.2: descriptor 4a e1 e0 29 11 Oct 24 09:05:23.858 [core.ecm] 2.2: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:23.867 [core.ecm] 2.2: descriptor 4a e0 e0 25 Oct 24 09:05:23.817 [core.pids] pidca 0259: <empty> Oct 24 09:05:23.733 [core.ecm] 2.1: no module available for system 4ae0 Oct 24 09:05:23.875 [core.ecm] 2.2: no module available for system 4ae0 Oct 24 09:05:23.883 [core.pids] pidca 025a: <empty> Oct 24 09:05:23.908 [core.pids] 2: SID=25060 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/- Oct 24 09:05:23.917 [core.pids] 2: found handler for SID 25060 (2.3 idle=1 idx=3) Oct 24 09:05:23.900 [core.ecm] 2.2: descriptor 4a e0 e0 2e 15 Oct 24 09:05:23.925 [core.ecm] 2.3: setting new SID 25060 Oct 24 09:05:23.933 [core.ecm] 2.2: no module available for system 4ae0 Oct 24 09:05:23.942 [core.pids] 2.3: pids on entry Oct 24 09:05:23.958 [core.pids] 2.3: pids after delete Oct 24 09:05:23.967 [core.pids] 2: descrambling pid 0259 on index 3 Called cSascDvbDevice::SetCaPid Oct 24 09:05:23.992 CSA: Got command(5): P idx: 3 pid: 601 Oct 24 09:05:24.000 [core.pids] 2: descrambling pid 025a on index 3 Called cSascDvbDevice::SetCaPid Oct 24 09:05:24.025 CSA: Got command(5): P idx: 3 pid: 602 Oct 24 09:05:24.033 [core.pids] 2.3: pids after add typ5=0259 typ5=025a Oct 24 09:05:24.042 [core.ecm] 2.3: is no longer idle Oct 24 09:05:24.050 MSG: Got unprocessed message type: 1 Oct 24 09:05:24.058 [core.pids] 2: update SID 25100 (zero=0 noshift=0) Oct 24 09:05:24.067 [core.pids] 2: pids typ5=03e9 typ5=03ea Oct 24 09:05:24.051 [core.ecm] 2.1: try system Cardclient (4ae1) id 0000 with ecm 2a (cached) (pri=-15) Oct 24 09:05:24.051 [core.ecm] 2.2: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:24.075 [core.au] 2: chain caid 4ae1 -> Cardclient(-15) [0027-82/ff/00] Oct 24 09:05:24.075 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:24.083 [cardclient.core] cc-loop Oct 24 09:05:24.117 [cardclient.core] now trying client Newcamd (shara2.dyndns.tv:3002) Oct 24 09:05:24.100 [core.au] 2: chain caid 4ae0 -> none available Oct 24 09:05:24.108 [core.pids] prgca: 09 05 4A E1 E0 2A 11 09 04 4A E0 E0 26 09 05 4A E0 E0 2F 15 Oct 24 09:05:24.141 [core.pids] pidca 03e9: <empty> Oct 24 09:05:24.150 [core.pids] pidca 03ea: <empty> Oct 24 09:05:24.133 [core.au] 2: chain caid 4ae0 -> none available Oct 24 09:05:24.110 [core.ecm] 2.3: triggered SID -1/25060 idx -1/3 mode -1/0 - Oct 24 09:05:24.175 [core.ecm] 2.3: new caDescr: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:24.158 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:24.167 [core.au] 2: chain caid 4ae0 -> none available Oct 24 09:05:24.092 [cardclient.core] now trying client Newcamd (shara2.dyndns.tv:3002) Oct 24 09:05:24.183 [core.ecm] from cache: system Cardclient (4ae1) id 0000 with ecm 29/80 Oct 24 09:05:24.295 [core.ecm] 2.3: CA descriptors for SID 25060 (len=20) Oct 24 09:05:24.200 [core.au] 2: chain caid 4ae0 -> none available Called cSascDvbDevice::SetCaDescr Oct 24 09:05:24.329 CSA: Got command(5): E idx: 1 pid: 0 key: 6186...05 Oct 24 09:05:24.304 [core.ecm] 2.3: descriptor 4a e1 e0 29 11 Oct 24 09:05:24.312 [core.au] 2: starting chain 4ae1 Oct 24 09:05:24.192 [core.pids] prgca: 09 05 4A E1 E0 2A 11 09 04 4A E0 E0 26 09 05 4A E0 E0 2F 15 Oct 24 09:05:24.362 [core.pids] pidca 03e9: <empty> Oct 24 09:05:24.345 [core.ecm] 2.3: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Called cSascDvbDevice::SetCaDescr Oct 24 09:05:24.395 CSA: Got command(5): O idx: 1 pid: 0 key: 039c...1f Oct 24 09:05:24.404 [core.ecm] 2.1: correct key found Oct 24 09:05:24.370 [core.pids] pidca 03ea: <empty> Oct 24 09:05:24.420 [core.pids] 2: SID=25100 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/- Oct 24 09:05:24.429 [core.pids] 2: found handler for SID 25100 (2.4 idle=1 idx=4) Oct 24 09:05:24.437 [core.ecm] 2.4: setting new SID 25100 Oct 24 09:05:24.445 [core.pids] 2.4: pids on entry Oct 24 09:05:24.454 [core.pids] 2.4: pids after delete Oct 24 09:05:24.462 [core.pids] 2: descrambling pid 03e9 on index 4 Called cSascDvbDevice::SetCaPid Called cSascDvbDevice::SetCaDescr Oct 24 09:05:24.379 [core.ecm] 2.3: descriptor 4a e0 e0 25 Oct 24 09:05:24.487 CSA: Got command(5): P idx: 4 pid: 1001 Oct 24 09:05:24.520 [core.pids] 2: descrambling pid 03ea on index 4 Oct 24 09:05:24.512 [core.ecm] 2.3: no module available for system 4ae0 Oct 24 09:05:24.537 [core.ecm] 2.3: descriptor 4a e0 e0 2e 15 Called cSascDvbDevice::SetCaPid Oct 24 09:05:24.504 CSA: Got command(5): E idx: 2 pid: 0 key: 3e3f...d6 Oct 24 09:05:24.545 [core.ecm] 2.3: no module available for system 4ae0 Oct 24 09:05:24.562 CSA: Got command(5): P idx: 4 pid: 1002 Called cSascDvbDevice::SetCaDescr Oct 24 09:05:24.580 CSA: Creating csa for rb: 5 Oct 24 09:05:25.512 CSA: Got command(5): O idx: 2 pid: 0 key: 00be...77 Oct 24 09:05:25.521 [core.pids] 2.4: pids after add typ5=03e9 typ5=03ea Oct 24 09:05:25.520 CSA: Removing csa for rb: 5 Oct 24 09:05:25.528 [core.ecm] 2.2: correct key found Oct 24 09:05:25.537 [core.ecm] 2.4: is no longer idle Oct 24 09:05:25.562 [core.pids] 2: update SID 25080 (zero=0 noshift=0) Oct 24 09:05:25.570 [core.pids] 2: pids typ5=0321 typ5=0322 Oct 24 09:05:25.578 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:25.562 [core.ecm] 2.3: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:25.587 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:25.595 [cardclient.core] cc-loop Oct 24 09:05:25.612 [cardclient.core] now trying client Newcamd (shara2.dyndns.tv:3002) Called cSascDvbDevice::SetCaDescr Oct 24 09:05:25.637 CSA: Got command(5): E idx: 3 pid: 0 key: 3e3f...d6 Oct 24 09:05:25.622 [core.ecm] 2.4: triggered SID -1/25100 idx -1/4 mode -1/0 - Oct 24 09:05:25.603 [core.pids] pidca 0321: <empty> Called cSascDvbDevice::SetCaDescr Oct 24 09:05:25.678 CSA: Got command(5): O idx: 3 pid: 0 key: 00be...77 Oct 24 09:05:25.662 [core.pids] pidca 0322: <empty> Oct 24 09:05:25.653 [core.ecm] 2.4: new caDescr: 09 05 4A E1 E0 2A 11 09 04 4A E0 E0 26 09 05 4A E0 E0 2F 15 Oct 24 09:05:25.687 [core.ecm] 2.3: correct key found Oct 24 09:05:25.695 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:25.720 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:25.703 [core.ecm] from cache: system Cardclient (4ae1) id 0000 with ecm 2a/80 Oct 24 09:05:25.728 [core.pids] pidca 0321: <empty> Oct 24 09:05:25.737 [core.ecm] 2.4: CA descriptors for SID 25100 (len=20) Oct 24 09:05:25.745 [core.pids] pidca 0322: <empty> Oct 24 09:05:25.753 [core.ecm] 2.4: descriptor 4a e1 e0 2a 11 Oct 24 09:05:25.762 [core.pids] 2: SID=25080 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/- Oct 24 09:05:25.770 [core.ecm] 2.4: found 4ae1(0000) (Cardclient) id 0000 with ecm 2a/80 (already present) Oct 24 09:05:25.778 [core.pids] 2: found handler for SID 25080 (2.5 idle=1 idx=5) Oct 24 09:05:25.845 [core.ecm] 2.4: descriptor 4a e0 e0 26 Oct 24 09:05:25.874 [core.ecm] 2.5: setting new SID 25080 Oct 24 09:05:25.883 [core.ecm] 2.4: no module available for system 4ae0 Oct 24 09:05:25.891 [core.pids] 2.5: pids on entry Oct 24 09:05:25.899 [core.ecm] 2.4: descriptor 4a e0 e0 2f 15 Oct 24 09:05:25.908 [core.pids] 2.5: pids after delete Oct 24 09:05:25.916 [core.ecm] 2.4: no module available for system 4ae0 Oct 24 09:05:25.924 [core.pids] 2: descrambling pid 0321 on index 5 Called cSascDvbDevice::SetCaPid Oct 24 09:05:25.958 CSA: Got command(5): P idx: 5 pid: 801 Oct 24 09:05:25.966 [core.pids] 2: descrambling pid 0322 on index 5 Called cSascDvbDevice::SetCaPid Oct 24 09:05:25.991 CSA: Got command(5): P idx: 5 pid: 802 Oct 24 09:05:25.999 [core.pids] 2.5: pids after add typ5=0321 typ5=0322 Oct 24 09:05:26.008 [core.ecm] 2.5: is no longer idle Oct 24 09:05:26.016 MSG: Got unprocessed message type: 1 Oct 24 09:05:26.016 [core.ecm] 2.4: try system Cardclient (4ae1) id 0000 with ecm 2a (cached) (pri=-15) Oct 24 09:05:26.024 [core.pids] 2: update SID 25020 (zero=0 noshift=0) Oct 24 09:05:26.041 [core.pids] 2: pids typ5=00c9 typ5=00ca Oct 24 09:05:26.049 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:26.058 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:26.066 [core.pids] pidca 00c9: <empty> Oct 24 09:05:26.074 [core.pids] pidca 00ca: <empty> Oct 24 09:05:26.076 [core.ecm] 2.5: triggered SID -1/25080 idx -1/5 mode -1/0 - Oct 24 09:05:26.083 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:26.091 [core.ecm] 2.5: new caDescr: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:26.099 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:26.116 [core.pids] pidca 00c9: <empty> Oct 24 09:05:26.108 [core.ecm] from cache: system Cardclient (4ae1) id 0000 with ecm 29/80 Oct 24 09:05:26.124 [core.pids] pidca 00ca: <empty> Oct 24 09:05:26.133 [core.ecm] 2.5: CA descriptors for SID 25080 (len=20) Oct 24 09:05:26.141 [core.pids] 2: SID=25020 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/- Oct 24 09:05:26.149 [core.ecm] 2.5: descriptor 4a e1 e0 29 11 Oct 24 09:05:26.158 [core.pids] 2: found handler for SID 25020 (2.6 idle=1 idx=6) Oct 24 09:05:26.166 [core.ecm] 2.5: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:27.952 [core.ecm] 2.5: descriptor 4a e0 e0 25 Oct 24 09:05:27.977 [core.ecm] 2.5: no module available for system 4ae0 Oct 24 09:05:28.002 [core.ecm] 2.5: descriptor 4a e0 e0 2e 15 Oct 24 09:05:28.011 [core.ecm] 2.5: no module available for system 4ae0 Oct 24 09:05:27.927 [core.ecm] 2.6: setting new SID 25020 Oct 24 09:05:28.027 [core.pids] 2.6: pids on entry Oct 24 09:05:28.036 [core.pids] 2.6: pids after delete Oct 24 09:05:28.136 [core.pids] 2: descrambling pid 00c9 on index 6 Called cSascDvbDevice::SetCaPid Oct 24 09:05:28.203 CSA: Got command(5): P idx: 6 pid: 201 Oct 24 09:05:28.224 [core.pids] 2: descrambling pid 00ca on index 6 Called cSascDvbDevice::SetCaPid Oct 24 09:05:28.287 CSA: Got command(5): P idx: 6 pid: 202 Oct 24 09:05:28.307 [core.pids] 2.6: pids after add typ5=00c9 typ5=00ca Oct 24 09:05:28.328 [core.ecm] 2.6: is no longer idle Oct 24 09:05:28.349 MSG: Got unprocessed message type: 1 Oct 24 09:05:28.349 [core.ecm] 2.4: CA descriptors for SID 25100 (len=20) Oct 24 09:05:28.390 [core.ecm] 2.4: descriptor 4a e1 e0 2a 11 Oct 24 09:05:28.412 [core.ecm] 2.4: found 4ae1(0000) (Cardclient) id 0000 with ecm 2a/80 (already present) Oct 24 09:05:28.432 [core.ecm] 2.4: descriptor 4a e0 e0 26 Oct 24 09:05:28.453 [core.ecm] 2.4: no module available for system 4ae0 Oct 24 09:05:28.370 [core.pids] 2: update SID 25010 (zero=0 noshift=0) Oct 24 09:05:28.495 [core.pids] 2: pids typ5=0065 typ5=0066 Oct 24 09:05:28.507 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:28.474 [core.ecm] 2.4: descriptor 4a e0 e0 2f 15 Oct 24 09:05:28.349 [core.ecm] 2.5: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:28.409 [core.ecm] 2.6: triggered SID -1/25020 idx -1/6 mode -1/0 - Oct 24 09:05:28.515 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:28.523 [core.ecm] 2.4: no module available for system 4ae0 Oct 24 09:05:28.602 [core.ecm] 2.6: new caDescr: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:28.611 [core.pids] pidca 0065: <empty> Oct 24 09:05:28.636 [core.pids] pidca 0066: <empty> Oct 24 09:05:28.627 [core.ecm] from cache: system Cardclient (4ae1) id 0000 with ecm 29/80 Oct 24 09:05:28.644 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:28.652 [core.ecm] 2.6: CA descriptors for SID 25020 (len=20) Oct 24 09:05:28.661 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:28.669 [core.ecm] 2.6: descriptor 4a e1 e0 29 11 Oct 24 09:05:28.677 [core.pids] pidca 0065: <empty> Oct 24 09:05:28.686 [core.ecm] 2.6: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:28.694 [core.pids] pidca 0066: <empty> Oct 24 09:05:28.702 [core.ecm] 2.6: descriptor 4a e0 e0 25 Oct 24 09:05:28.711 [core.pids] 2: SID=25010 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/- Oct 24 09:05:28.719 [core.ecm] 2.6: no module available for system 4ae0 Oct 24 09:05:28.727 [core.pids] 2: found handler for SID 25010 (2.7 idle=1 idx=7) Oct 24 09:05:28.736 [core.ecm] 2.6: descriptor 4a e0 e0 2e 15 Oct 24 09:05:28.744 [core.ecm] 2.7: setting new SID 25010 Oct 24 09:05:28.752 [core.ecm] 2.6: no module available for system 4ae0 Oct 24 09:05:28.761 [core.pids] 2.7: pids on entry Oct 24 09:05:28.777 [core.pids] 2.7: pids after delete Oct 24 09:05:28.786 [core.pids] 2: descrambling pid 0065 on index 7 Called cSascDvbDevice::SetCaPid Oct 24 09:05:28.944 CSA: Got command(5): P idx: 7 pid: 101 Oct 24 09:05:28.952 [core.pids] 2: descrambling pid 0066 on index 7 Called cSascDvbDevice::SetCaPid Oct 24 09:05:28.977 CSA: Got command(5): P idx: 7 pid: 102 Oct 24 09:05:28.986 [core.pids] 2.7: pids after add typ5=0065 typ5=0066 Oct 24 09:05:28.994 [core.ecm] 2.7: is no longer idle Oct 24 09:05:29.002 MSG: Got unprocessed message type: 1 Oct 24 09:05:29.011 [core.pids] 2: update SID 25000 (zero=0 noshift=0) Oct 24 09:05:29.019 [core.pids] 2: pids typ5=00fb typ5=00fc Oct 24 09:05:29.003 [core.ecm] 2.4: try system Cardclient (4ae1) id 0000 with ecm 2a (cached) (pri=-15) Oct 24 09:05:29.003 [core.ecm] 2.6: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:29.027 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:29.052 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:29.060 [core.pids] pidca 00fb: <empty> Oct 24 09:05:29.063 [core.ecm] 2.7: triggered SID -1/25010 idx -1/7 mode -1/0 - Oct 24 09:05:29.069 [core.pids] pidca 00fc: <empty> Oct 24 09:05:29.085 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:29.094 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:29.102 [core.pids] pidca 00fb: <empty> Oct 24 09:05:29.110 [core.pids] pidca 00fc: <empty> Oct 24 09:05:29.077 [core.ecm] 2.7: new caDescr: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:29.127 [core.pids] 2: SID=25000 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/- Oct 24 09:05:29.136 [core.pids] 2: found handler for SID 25000 (2.8 idle=1 idx=8) Oct 24 09:05:29.144 [core.ecm] 2.8: setting new SID 25000 Oct 24 09:05:29.127 [core.ecm] from cache: system Cardclient (4ae1) id 0000 with ecm 29/80 Oct 24 09:05:29.152 [core.pids] 2.8: pids on entry Oct 24 09:05:29.160 [core.ecm] 2.7: CA descriptors for SID 25010 (len=20) Oct 24 09:05:29.169 [core.pids] 2.8: pids after delete Oct 24 09:05:29.177 [core.ecm] 2.7: descriptor 4a e1 e0 29 11 Oct 24 09:05:29.185 [core.pids] 2: descrambling pid 00fb on index 8 Called cSascDvbDevice::SetCaPid Oct 24 09:05:29.194 [core.ecm] 2.7: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:29.219 CSA: Got command(5): P idx: 8 pid: 251 Oct 24 09:05:29.227 [core.ecm] 2.7: descriptor 4a e0 e0 25 Oct 24 09:05:29.235 [core.pids] 2: descrambling pid 00fc on index 8 Called cSascDvbDevice::SetCaPid Oct 24 09:05:29.280 [core.ecm] 2.7: no module available for system 4ae0 Oct 24 09:05:29.315 CSA: Got command(5): P idx: 8 pid: 252 Oct 24 09:05:29.332 [core.pids] 2.8: pids after add typ5=00fb typ5=00fc Oct 24 09:05:29.340 [core.ecm] 2.8: is no longer idle Oct 24 09:05:29.323 [core.ecm] 2.7: descriptor 4a e0 e0 2e 15 Oct 24 09:05:29.348 MSG: Got unprocessed message type: 1 Oct 24 09:05:29.357 [core.ecm] 2.7: no module available for system 4ae0 Oct 24 09:05:29.365 [core.pids] 2: update SID 25030 (zero=0 noshift=0) Oct 24 09:05:29.382 [core.pids] 2: pids typ5=012d typ5=012e Oct 24 09:05:29.390 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:29.398 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:29.407 [core.pids] pidca 012d: <empty> Oct 24 09:05:29.409 [core.ecm] 2.8: triggered SID -1/25000 idx -1/8 mode -1/0 - Oct 24 09:05:29.415 [core.pids] pidca 012e: <empty> Oct 24 09:05:29.424 [core.ecm] 2.8: new caDescr: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:29.432 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:29.440 [core.ecm] from cache: system Cardclient (4ae1) id 0000 with ecm 29/80 Oct 24 09:05:29.448 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:29.457 [core.ecm] 2.8: CA descriptors for SID 25000 (len=20) Oct 24 09:05:29.465 [core.pids] pidca 012d: <empty> Oct 24 09:05:29.473 [core.ecm] 2.8: descriptor 4a e1 e0 29 11 Oct 24 09:05:29.482 [core.pids] pidca 012e: <empty> Oct 24 09:05:29.490 [core.ecm] 2.8: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:29.498 [core.pids] 2: SID=25030 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/- Oct 24 09:05:29.515 [core.pids] 2: found handler for SID 25030 (2.9 idle=1 idx=9) Oct 24 09:05:29.523 [core.ecm] 2.9: setting new SID 25030 Oct 24 09:05:29.531 [core.pids] 2.9: pids on entry Oct 24 09:05:29.540 [core.pids] 2.9: pids after delete Oct 24 09:05:29.548 [core.pids] 2: descrambling pid 012d on index 9 Called cSascDvbDevice::SetCaPid Oct 24 09:05:29.573 CSA: Got command(5): P idx: 9 pid: 301 Oct 24 09:05:29.581 [core.pids] 2: descrambling pid 012e on index 9 Called cSascDvbDevice::SetCaPid Oct 24 09:05:29.606 CSA: Got command(5): P idx: 9 pid: 302 Oct 24 09:05:29.615 [core.pids] 2.9: pids after add typ5=012d typ5=012e Oct 24 09:05:29.623 [core.ecm] 2.9: is no longer idle Oct 24 09:05:29.632 MSG: Got unprocessed message type: 1 Oct 24 09:05:29.640 [core.pids] 2: update SID 25040 (zero=0 noshift=0) Oct 24 09:05:29.648 [core.pids] 2: pids typ5=0191 typ5=0192 Oct 24 09:05:29.506 [core.ecm] 2.8: descriptor 4a e0 e0 25 Oct 24 09:05:29.632 [core.ecm] 2.5: CA descriptors for SID 25080 (len=20) Oct 24 09:05:29.673 [core.ecm] 2.5: descriptor 4a e1 e0 29 11 Oct 24 09:05:29.681 [core.ecm] 2.5: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:29.665 [core.ecm] 2.8: no module available for system 4ae0 Oct 24 09:05:29.632 [core.ecm] 2.7: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:29.656 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:29.715 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:29.692 [core.ecm] 2.9: triggered SID -1/25030 idx -1/9 mode -1/0 - Oct 24 09:05:29.698 [core.ecm] 2.8: descriptor 4a e0 e0 2e 15 Oct 24 09:05:29.690 [core.ecm] 2.5: descriptor 4a e0 e0 25 Oct 24 09:05:29.748 [core.ecm] 2.5: no module available for system 4ae0 Oct 24 09:05:29.732 [core.ecm] 2.9: new caDescr: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:29.740 [core.ecm] 2.8: no module available for system 4ae0 Oct 24 09:05:29.723 [core.pids] pidca 0191: <empty> Oct 24 09:05:29.781 [core.pids] pidca 0192: <empty> Oct 24 09:05:29.765 [core.ecm] from cache: system Cardclient (4ae1) id 0000 with ecm 29/80 Oct 24 09:05:29.756 [core.ecm] 2.5: descriptor 4a e0 e0 2e 15 Oct 24 09:05:29.790 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:29.798 [core.ecm] 2.9: CA descriptors for SID 25030 (len=20) Oct 24 09:05:29.806 [core.ecm] 2.5: no module available for system 4ae0 Oct 24 09:05:29.888 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:29.915 [core.ecm] 2.9: descriptor 4a e1 e0 29 11 Oct 24 09:05:29.931 [core.pids] pidca 0191: <empty> Oct 24 09:05:29.940 [core.ecm] 2.9: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:29.948 [core.pids] pidca 0192: <empty> Oct 24 09:05:29.956 [core.ecm] 2.9: descriptor 4a e0 e0 25 Oct 24 09:05:29.965 [core.pids] 2: SID=25040 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/- Oct 24 09:05:29.973 [core.ecm] 2.9: no module available for system 4ae0 Oct 24 09:05:29.981 [core.pids] 2: found handler for SID 25040 (2.10 idle=1 idx=10) Oct 24 09:05:29.998 [core.ecm] 2.10: setting new SID 25040 Oct 24 09:05:30.006 [core.pids] 2.10: pids on entry Oct 24 09:05:30.015 [core.pids] 2.10: pids after delete Oct 24 09:05:30.023 [core.pids] 2: descrambling pid 0191 on index a Called cSascDvbDevice::SetCaPid Oct 24 09:05:30.048 CSA: Got command(5): P idx: 10 pid: 401 Oct 24 09:05:30.056 [core.pids] 2: descrambling pid 0192 on index a Called cSascDvbDevice::SetCaPid Oct 24 09:05:30.081 CSA: Got command(5): P idx: 10 pid: 402 Oct 24 09:05:30.090 [core.pids] 2.10: pids after add typ5=0191 typ5=0192 Oct 24 09:05:29.990 [core.ecm] 2.9: descriptor 4a e0 e0 2e 15 Oct 24 09:05:30.148 [core.ecm] 2.9: no module available for system 4ae0 Oct 24 09:05:30.140 [core.ecm] 2.10: is no longer idle Oct 24 09:05:30.165 MSG: Got unprocessed message type: 1 Oct 24 09:05:30.173 [core.pids] 2: update SID 25070 (zero=0 noshift=0) Oct 24 09:05:30.181 [core.pids] 2: pids typ5=02bd typ5=02be Oct 24 09:05:30.165 [core.ecm] 2.6: CA descriptors for SID 25020 (len=20) Oct 24 09:05:30.165 [core.ecm] 2.5: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:30.165 [core.ecm] 2.9: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:30.165 [core.ecm] 2.8: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:30.165 [core.ecm] 2.4: CA descriptors for SID 25100 (len=20) Oct 24 09:05:30.231 [core.ecm] 2.4: descriptor 4a e1 e0 2a 11 Oct 24 09:05:30.198 [core.ecm] 2.6: descriptor 4a e1 e0 29 11 Oct 24 09:05:30.248 [core.ecm] 2.6: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:30.190 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:30.240 [core.ecm] 2.4: found 4ae1(0000) (Cardclient) id 0000 with ecm 2a/80 (already present) Oct 24 09:05:30.225 [core.ecm] 2.10: triggered SID -1/25040 idx -1/10 mode -1/0 - Oct 24 09:05:30.256 [core.ecm] 2.6: descriptor 4a e0 e0 25 Oct 24 09:05:30.290 [core.ecm] 2.6: no module available for system 4ae0 Oct 24 09:05:30.273 [core.ecm] 2.4: descriptor 4a e0 e0 26 Oct 24 09:05:30.281 [core.ecm] 2.10: new caDescr: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:30.265 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:30.298 [core.ecm] 2.6: descriptor 4a e0 e0 2e 15 Oct 24 09:05:30.331 [core.ecm] 2.6: no module available for system 4ae0 Oct 24 09:05:30.315 [core.ecm] from cache: system Cardclient (4ae1) id 0000 with ecm 29/80 Oct 24 09:05:30.323 [core.pids] pidca 02bd: <empty> Oct 24 09:05:30.306 [core.ecm] 2.4: no module available for system 4ae0 Oct 24 09:05:30.348 [core.ecm] 2.10: CA descriptors for SID 25040 (len=20) Oct 24 09:05:30.356 [core.pids] pidca 02be: <empty> Oct 24 09:05:30.381 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:30.373 [core.ecm] 2.10: descriptor 4a e1 e0 29 11 Oct 24 09:05:30.365 [core.ecm] 2.4: descriptor 4a e0 e0 2f 15 Oct 24 09:05:30.406 [core.ecm] 2.4: no module available for system 4ae0 Oct 24 09:05:30.398 [core.ecm] 2.10: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:30.390 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:30.423 [core.ecm] 2.10: descriptor 4a e0 e0 25 Oct 24 09:05:30.431 [core.pids] pidca 02bd: <empty> Oct 24 09:05:30.489 [core.ecm] 2.10: no module available for system 4ae0 Oct 24 09:05:30.515 [core.pids] pidca 02be: <empty> Oct 24 09:05:30.523 [core.ecm] 2.10: descriptor 4a e0 e0 2e 15 Oct 24 09:05:30.531 [core.pids] 2: SID=25070 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/- Oct 24 09:05:30.548 [core.pids] 2: found handler for SID 25070 (2.11 idle=1 idx=11) Oct 24 09:05:30.540 [core.ecm] 2.10: no module available for system 4ae0 Oct 24 09:05:30.556 [core.ecm] 2.11: setting new SID 25070 Oct 24 09:05:30.573 [core.pids] 2.11: pids on entry Oct 24 09:05:30.581 [core.pids] 2.11: pids after delete Oct 24 09:05:30.590 [core.pids] 2: descrambling pid 02bd on index b Called cSascDvbDevice::SetCaPid Oct 24 09:05:30.615 CSA: Got command(5): P idx: 11 pid: 701 Oct 24 09:05:30.623 [core.pids] 2: descrambling pid 02be on index b Called cSascDvbDevice::SetCaPid Oct 24 09:05:30.648 CSA: Got command(5): P idx: 11 pid: 702 Oct 24 09:05:30.656 [core.pids] 2.11: pids after add typ5=02bd typ5=02be Oct 24 09:05:30.665 [core.ecm] 2.11: is no longer idle Oct 24 09:05:30.673 MSG: Got unprocessed message type: 1 Oct 24 09:05:30.673 [core.ecm] 2.6: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:30.673 [core.ecm] 2.4: try system Cardclient (4ae1) id 0000 with ecm 2a (cached) (pri=-15) Oct 24 09:05:30.673 [core.ecm] 2.7: CA descriptors for SID 25010 (len=20) Oct 24 09:05:30.673 [core.ecm] 2.10: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:30.681 [core.pids] 2: update SID 25090 (zero=0 noshift=0) Oct 24 09:05:30.723 [core.pids] 2: pids typ5=0385 typ5=0386 Oct 24 09:05:30.731 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:30.740 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:30.748 [core.pids] pidca 0385: <empty> Oct 24 09:05:30.756 [core.pids] pidca 0386: <empty> Oct 24 09:05:30.765 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:30.706 [core.ecm] 2.7: descriptor 4a e1 e0 29 11 Oct 24 09:05:30.733 [core.ecm] 2.11: triggered SID -1/25070 idx -1/11 mode -1/0 - Oct 24 09:05:30.773 [core.pids] prgca: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:30.781 [core.ecm] 2.7: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:30.790 [core.ecm] 2.11: new caDescr: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:30.798 [core.pids] pidca 0385: <empty> Oct 24 09:05:30.823 [core.pids] pidca 0386: <empty> Oct 24 09:05:30.831 [core.pids] 2: SID=25090 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/- Oct 24 09:05:30.806 [core.ecm] 2.7: descriptor 4a e0 e0 25 Oct 24 09:05:30.815 [core.ecm] from cache: system Cardclient (4ae1) id 0000 with ecm 29/80 Oct 24 09:05:30.840 [core.pids] 2: found handler for SID 25090 (2.12 idle=1 idx=12) Oct 24 09:05:30.848 [core.ecm] 2.7: no module available for system 4ae0 Oct 24 09:05:30.873 [core.ecm] 2.7: descriptor 4a e0 e0 2e 15 Oct 24 09:05:30.865 [core.ecm] 2.12: setting new SID 25090 Oct 24 09:05:30.856 [core.ecm] 2.11: CA descriptors for SID 25070 (len=20) Oct 24 09:05:30.881 [core.ecm] 2.7: no module available for system 4ae0 Oct 24 09:05:30.890 [core.pids] 2.12: pids on entry Oct 24 09:05:30.898 [core.ecm] 2.11: descriptor 4a e1 e0 29 11 Oct 24 09:05:30.915 [core.pids] 2.12: pids after delete Oct 24 09:05:30.923 [core.ecm] 2.11: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:30.931 [core.pids] 2: descrambling pid 0385 on index c Called cSascDvbDevice::SetCaPid Oct 24 09:05:30.964 CSA: Got command(5): P idx: 12 pid: 901 Oct 24 09:05:30.973 [core.pids] 2: descrambling pid 0386 on index c Called cSascDvbDevice::SetCaPid Oct 24 09:05:30.998 CSA: Got command(5): P idx: 12 pid: 902 Oct 24 09:05:30.940 [core.ecm] 2.11: descriptor 4a e0 e0 25 Oct 24 09:05:31.006 [core.pids] 2.12: pids after add typ5=0385 typ5=0386 Oct 24 09:05:31.014 [core.ecm] 2.11: no module available for system 4ae0 Oct 24 09:05:31.023 [core.ecm] 2.12: is no longer idle Oct 24 09:05:31.031 [core.ecm] 2.11: descriptor 4a e0 e0 2e 15 Oct 24 09:05:31.040 MSG: Got unprocessed message type: 1 Oct 24 09:05:31.040 [core.ecm] 2.7: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:31.056 [core.ecm] 2.9: CA descriptors for SID 25030 (len=20) Oct 24 09:05:31.140 [core.ecm] 2.9: descriptor 4a e1 e0 29 11 Oct 24 09:05:31.148 [core.ecm] 2.9: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:31.100 [core.ecm] 2.12: triggered SID -1/25090 idx -1/12 mode -1/0 - Oct 24 09:05:31.108 [core.ecm] 2.5: CA descriptors for SID 25080 (len=20) Oct 24 09:05:31.123 [core.pids] 2: update SID 25090 (zero=0 noshift=0) Oct 24 09:05:31.064 [core.ecm] 2.8: CA descriptors for SID 25000 (len=20) Oct 24 09:05:31.189 [core.ecm] 2.8: descriptor 4a e1 e0 29 11 Oct 24 09:05:31.156 [core.ecm] 2.9: descriptor 4a e0 e0 25 Oct 24 09:05:31.165 [core.ecm] 2.12: new caDescr: 09 05 4A E1 E0 29 11 09 04 4A E0 E0 25 09 05 4A E0 E0 2E 15 Oct 24 09:05:31.173 [core.ecm] 2.5: descriptor 4a e1 e0 29 11 Oct 24 09:05:31.181 [core.pids] 2: pids typ5=0385 Oct 24 09:05:31.097 [core.ecm] 2.11: no module available for system 4ae0 Oct 24 09:05:31.198 [core.ecm] 2.8: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:31.248 [core.ecm] 2.8: descriptor 4a e0 e0 25 Oct 24 09:05:31.256 [core.ecm] 2.8: no module available for system 4ae0 Oct 24 09:05:31.223 [core.ecm] 2.5: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:31.231 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:31.281 [core.pids] prgca: <empty> Oct 24 09:05:31.289 [core.pids] pidca 0385: <empty> Oct 24 09:05:31.298 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:31.273 [core.ecm] 2.5: descriptor 4a e0 e0 25 Oct 24 09:05:31.206 [core.ecm] 2.9: no module available for system 4ae0 Oct 24 09:05:31.323 [core.ecm] 2.9: descriptor 4a e0 e0 2e 15 Oct 24 09:05:31.331 [core.ecm] 2.9: no module available for system 4ae0 Oct 24 09:05:31.306 [core.pids] prgca: <empty> Oct 24 09:05:31.314 [core.ecm] 2.5: no module available for system 4ae0 Oct 24 09:05:31.214 [core.ecm] from cache: system Cardclient (4ae1) id 0000 with ecm 29/80 Oct 24 09:05:31.264 [core.ecm] 2.8: descriptor 4a e0 e0 2e 15 Oct 24 09:05:31.373 [core.ecm] 2.8: no module available for system 4ae0 Oct 24 09:05:31.356 [core.ecm] 2.5: descriptor 4a e0 e0 2e 15 Oct 24 09:05:31.364 [core.ecm] 2.12: CA descriptors for SID 25090 (len=20) Oct 24 09:05:31.348 [core.pids] pidca 0385: <empty> Oct 24 09:05:31.414 [core.pids] 2: SID=25090 zero=0 | sid=12/25090/0 zero=-/-/- idle=-/-/- Oct 24 09:05:31.406 [core.ecm] 2.12: descriptor 4a e1 e0 29 11 Oct 24 09:05:31.401 [core.ecm] 2.5: no module available for system 4ae0 Oct 24 09:05:31.423 [core.pids] 2: found handler for SID 25090 (2.12 idle=0 idx=12) Oct 24 09:05:31.431 [core.ecm] 2.12: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:31.448 [core.pids] 2.12: pids on entry typ5=0385 typ5=0386 Oct 24 09:05:31.464 [core.pids] 2.12: pids after delete typ5=0385 Oct 24 09:05:31.473 [core.pids] 2.12: pids after add typ5=0385 Oct 24 09:05:31.456 [core.ecm] 2.12: descriptor 4a e0 e0 25 Oct 24 09:05:31.481 [core.pids] 2: update SID 25090 (zero=0 noshift=1) Oct 24 09:05:31.489 [core.ecm] 2.12: no module available for system 4ae0 Oct 24 09:05:31.498 [core.pids] 2: SID=25090 zero=0 | sid=12/25090/0 zero=-/-/- idle=-/-/- Oct 24 09:05:31.506 [core.ecm] 2.12: descriptor 4a e0 e0 2e 15 Oct 24 09:05:31.514 [core.pids] 2: found handler for SID 25090 (2.12 idle=0 idx=12) Oct 24 09:05:31.523 [core.ecm] 2.12: no module available for system 4ae0 Oct 24 09:05:31.531 [core.pids] 2.12: pids on entry typ5=0385 Oct 24 09:05:31.548 [core.pids] 2.12: pids after delete Oct 24 09:05:31.556 [core.pids] 2.12: pids after add Oct 24 09:05:31.564 [core.ecm] 2.12: is idle now Oct 24 09:05:31.573 [core.pids] 2: update SID 25070 (zero=0 noshift=0) Oct 24 09:05:31.581 [core.pids] 2: pids typ5=02bd Oct 24 09:05:31.589 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:31.598 [core.pids] prgca: <empty> Oct 24 09:05:31.606 [core.pids] pidca 02bd: <empty> Oct 24 09:05:31.656 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:31.688 [core.pids] prgca: <empty> Oct 24 09:05:31.697 [core.pids] pidca 02bd: <empty> Oct 24 09:05:31.705 [core.pids] 2: SID=25070 zero=0 | sid=11/25070/0 zero=-/-/- idle=12/25090/1 Oct 24 09:05:31.713 [core.pids] 2: found handler for SID 25070 (2.11 idle=0 idx=11) Oct 24 09:05:31.722 [core.pids] 2.11: pids on entry typ5=02bd typ5=02be Oct 24 09:05:31.730 [core.pids] 2.11: pids after delete typ5=02bd Oct 24 09:05:31.738 [core.pids] 2.11: pids after add typ5=02bd Oct 24 09:05:31.747 [core.ecm] 2.8: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:31.747 [core.ecm] 2.5: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:31.747 [core.pids] 2: update SID 25070 (zero=0 noshift=1) Oct 24 09:05:31.747 [core.ecm] 2.11: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:31.772 [core.pids] 2: SID=25070 zero=0 | sid=11/25070/0 zero=-/-/- idle=12/25090/1 Oct 24 09:05:31.780 [core.ecm] 2.11: triggered SID 25070/25070 idx 11/11 mode 1/0 - Oct 24 09:05:31.797 [core.ecm] 2.11: new caDescr: <empty> Oct 24 09:05:31.805 [core.pids] 2: found handler for SID 25070 (2.11 idle=0 idx=11) Oct 24 09:05:31.813 [core.pids] 2.11: pids on entry typ5=02bd Oct 24 09:05:31.822 [core.pids] 2.11: pids after delete Oct 24 09:05:31.830 [core.pids] 2.11: pids after add Oct 24 09:05:31.838 [core.ecm] 2.11: is idle now Oct 24 09:05:31.847 [core.ecm] 2.4: CA descriptors for SID 25100 (len=20) Oct 24 09:05:31.847 [core.ecm] 2.12: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:31.847 [core.ecm] 2.9: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:31.847 [core.ecm] 2.10: CA descriptors for SID 25040 (len=20) Oct 24 09:05:31.847 [core.ecm] 2.6: CA descriptors for SID 25020 (len=20) Oct 24 09:05:31.888 [core.ecm] 2.6: descriptor 4a e1 e0 29 11 Oct 24 09:05:31.855 [core.ecm] 2.4: descriptor 4a e1 e0 2a 11 Oct 24 09:05:31.863 [core.ecm] 2.12: triggered SID 25090/25090 idx 12/12 mode 1/0 - Oct 24 09:05:31.913 [core.ecm] 2.12: new caDescr: <empty> Oct 24 09:05:31.847 [core.pids] 2: update SID 25040 (zero=0 noshift=0) Oct 24 09:05:31.897 [core.ecm] 2.6: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:31.905 [core.ecm] 2.4: found 4ae1(0000) (Cardclient) id 0000 with ecm 2a/80 (already present) Oct 24 09:05:31.880 [core.ecm] 2.10: descriptor 4a e1 e0 29 11 Oct 24 09:05:31.930 [core.pids] 2: pids typ5=0191 Oct 24 09:05:31.938 [core.ecm] 2.6: descriptor 4a e0 e0 25 Oct 24 09:05:31.947 [core.ecm] 2.4: descriptor 4a e0 e0 26 Oct 24 09:05:31.955 [core.ecm] 2.10: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:31.963 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:31.972 [core.ecm] 2.6: no module available for system 4ae0 Oct 24 09:05:31.980 [core.ecm] 2.4: no module available for system 4ae0 Oct 24 09:05:31.988 [core.ecm] 2.10: descriptor 4a e0 e0 25 Oct 24 09:05:31.997 [core.pids] prgca: <empty> Oct 24 09:05:32.005 [core.ecm] 2.6: descriptor 4a e0 e0 2e 15 Oct 24 09:05:32.013 [core.ecm] 2.4: descriptor 4a e0 e0 2f 15 Oct 24 09:05:32.022 [core.ecm] 2.10: no module available for system 4ae0 Oct 24 09:05:32.030 [core.pids] pidca 0191: <empty> Oct 24 09:05:32.038 [core.ecm] 2.6: no module available for system 4ae0 Oct 24 09:05:32.047 [core.ecm] 2.4: no module available for system 4ae0 Oct 24 09:05:32.055 [core.ecm] 2.10: descriptor 4a e0 e0 2e 15 Oct 24 09:05:32.063 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:32.097 [core.pids] prgca: <empty> Oct 24 09:05:32.105 [core.pids] pidca 0191: <empty> Oct 24 09:05:32.113 [core.pids] 2: SID=25040 zero=0 | sid=10/25040/0 zero=-/-/- idle=11/25070/1 Oct 24 09:05:32.122 [core.pids] 2: found handler for SID 25040 (2.10 idle=0 idx=10) Oct 24 09:05:32.088 [core.ecm] 2.10: no module available for system 4ae0 Oct 24 09:05:32.130 [core.pids] 2.10: pids on entry typ5=0191 typ5=0192 Oct 24 09:05:32.146 [core.pids] 2.10: pids after delete typ5=0191 Oct 24 09:05:32.198 [core.pids] 2.10: pids after add typ5=0191 Oct 24 09:05:32.223 [core.pids] 2: update SID 25040 (zero=0 noshift=1) Oct 24 09:05:32.231 [core.pids] 2: SID=25040 zero=0 | sid=10/25040/0 zero=-/-/- idle=11/25070/1 Oct 24 09:05:32.239 [core.pids] 2: found handler for SID 25040 (2.10 idle=0 idx=10) Oct 24 09:05:32.248 [core.pids] 2.10: pids on entry typ5=0191 Oct 24 09:05:32.256 [core.pids] 2.10: pids after delete Oct 24 09:05:32.264 [core.pids] 2.10: pids after add Oct 24 09:05:32.273 [core.ecm] 2.10: is idle now Oct 24 09:05:32.281 [core.pids] 2: update SID 25030 (zero=0 noshift=0) Oct 24 09:05:32.289 [core.pids] 2: pids typ5=012d Oct 24 09:05:32.297 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:32.306 [core.pids] prgca: <empty> Oct 24 09:05:32.314 [core.pids] pidca 012d: <empty> Oct 24 09:05:32.322 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:32.331 [core.pids] prgca: <empty> Oct 24 09:05:32.339 [core.pids] pidca 012d: <empty> Oct 24 09:05:32.347 [core.pids] 2: SID=25030 zero=0 | sid=9/25030/0 zero=-/-/- idle=10/25040/1 Oct 24 09:05:32.356 [core.pids] 2: found handler for SID 25030 (2.9 idle=0 idx=9) Oct 24 09:05:32.364 [core.pids] 2.9: pids on entry typ5=012d typ5=012e Oct 24 09:05:32.373 [core.pids] 2.9: pids after delete typ5=012d Oct 24 09:05:32.381 [core.pids] 2.9: pids after add typ5=012d Oct 24 09:05:32.389 [core.ecm] 2.4: try system Cardclient (4ae1) id 0000 with ecm 2a (cached) (pri=-15) Oct 24 09:05:32.397 [core.ecm] 2.4: stopping message log until valid key is found Oct 24 09:05:32.389 [core.pids] 2: update SID 25030 (zero=0 noshift=1) Oct 24 09:05:32.412 [core.ecm] 2.9: triggered SID 25030/25030 idx 9/9 mode 3/0 - Oct 24 09:05:32.425 [core.ecm] 2.9: new caDescr: <empty> Oct 24 09:05:32.431 [core.pids] 2: SID=25030 zero=0 | sid=9/25030/0 zero=-/-/- idle=10/25040/1 Oct 24 09:05:32.439 [core.pids] 2: found handler for SID 25030 (2.9 idle=0 idx=9) Oct 24 09:05:32.447 [core.pids] 2.9: pids on entry typ5=012d Oct 24 09:05:32.456 [core.pids] 2.9: pids after delete Oct 24 09:05:32.464 [core.pids] 2.9: pids after add Oct 24 09:05:32.472 [core.ecm] 2.9: is idle now Oct 24 09:05:32.481 [core.ecm] 2.7: CA descriptors for SID 25010 (len=20) Oct 24 09:05:32.489 [core.ecm] 2.7: descriptor 4a e1 e0 29 11 Oct 24 09:05:32.497 [core.ecm] 2.7: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:32.506 [core.ecm] 2.7: descriptor 4a e0 e0 25 Oct 24 09:05:32.514 [core.ecm] 2.7: no module available for system 4ae0 Oct 24 09:05:32.522 [core.ecm] 2.7: descriptor 4a e0 e0 2e 15 Oct 24 09:05:32.531 [core.ecm] 2.7: no module available for system 4ae0 Oct 24 09:05:32.481 [core.ecm] 2.6: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:32.481 [core.ecm] 2.9: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:32.481 [core.pids] 2: update SID 25000 (zero=0 noshift=0) Oct 24 09:05:32.564 [core.pids] 2: pids typ5=00fb Oct 24 09:05:32.481 [core.ecm] 2.11: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:32.481 [core.ecm] 2.10: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:32.597 [core.ecm] 2.10: triggered SID 25040/25040 idx 10/10 mode 4/0 - Oct 24 09:05:32.606 [core.ecm] 2.10: new caDescr: <empty> Oct 24 09:05:32.572 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:32.622 [core.pids] prgca: <empty> Oct 24 09:05:32.635 [core.pids] pidca 00fb: <empty> Oct 24 09:05:32.639 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:32.647 [core.pids] prgca: <empty> Oct 24 09:05:32.656 [core.pids] pidca 00fb: <empty> Oct 24 09:05:32.664 [core.pids] 2: SID=25000 zero=0 | sid=8/25000/0 zero=-/-/- idle=9/25030/1 Oct 24 09:05:32.672 [core.pids] 2: found handler for SID 25000 (2.8 idle=0 idx=8) Oct 24 09:05:32.681 [core.pids] 2.8: pids on entry typ5=00fb typ5=00fc Oct 24 09:05:32.689 [core.pids] 2.8: pids after delete typ5=00fb Oct 24 09:05:32.697 [core.pids] 2.8: pids after add typ5=00fb Oct 24 09:05:32.706 [core.pids] 2: update SID 25000 (zero=0 noshift=1) Oct 24 09:05:32.716 [core.ecm] 2.8: triggered SID 25000/25000 idx 8/8 mode 3/0 - Oct 24 09:05:32.788 [core.ecm] 2.8: new caDescr: <empty> Oct 24 09:05:32.796 [core.pids] 2: SID=25000 zero=0 | sid=8/25000/0 zero=-/-/- idle=9/25030/1 Oct 24 09:05:32.805 [core.pids] 2: found handler for SID 25000 (2.8 idle=0 idx=8) Oct 24 09:05:32.813 [core.pids] 2.8: pids on entry typ5=00fb Oct 24 09:05:32.821 [core.pids] 2.8: pids after delete Oct 24 09:05:32.830 [core.pids] 2.8: pids after add Oct 24 09:05:32.838 [core.ecm] 2.8: is idle now Oct 24 09:05:32.846 [core.ecm] 2.7: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:32.846 [core.ecm] 2.12: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:32.846 [core.ecm] 2.5: CA descriptors for SID 25080 (len=20) Oct 24 09:05:32.871 [core.ecm] 2.5: descriptor 4a e1 e0 29 11 Oct 24 09:05:32.847 [core.pids] 2: update SID 25010 (zero=0 noshift=0) Oct 24 09:05:32.847 [core.ecm] 2.8: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:32.880 [core.ecm] 2.5: found 4ae1(0000) (Cardclient) id 0000 with ecm 29/80 (already present) Oct 24 09:05:32.905 [core.ecm] 2.5: descriptor 4a e0 e0 25 Oct 24 09:05:32.913 [core.ecm] 2.5: no module available for system 4ae0 Oct 24 09:05:32.921 [core.ecm] 2.5: descriptor 4a e0 e0 2e 15 Oct 24 09:05:32.930 [core.ecm] 2.5: no module available for system 4ae0 Oct 24 09:05:32.888 [core.pids] 2: pids typ5=0065 Oct 24 09:05:32.946 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:32.955 [core.pids] prgca: <empty> Oct 24 09:05:32.963 [core.pids] pidca 0065: <empty> Oct 24 09:05:32.971 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:32.980 [core.pids] prgca: <empty> Oct 24 09:05:32.988 [core.pids] pidca 0065: <empty> Oct 24 09:05:32.996 [core.pids] 2: SID=25010 zero=0 | sid=7/25010/0 zero=-/-/- idle=8/25000/1 Oct 24 09:05:33.005 [core.pids] 2: found handler for SID 25010 (2.7 idle=0 idx=7) Oct 24 09:05:33.013 [core.pids] 2.7: pids on entry typ5=0065 typ5=0066 Oct 24 09:05:33.021 [core.pids] 2.7: pids after delete typ5=0065 Oct 24 09:05:33.030 [core.pids] 2.7: pids after add typ5=0065 Oct 24 09:05:33.038 [core.ecm] 2.7: triggered SID 25010/25010 idx 7/7 mode 4/0 - Oct 24 09:05:33.038 [core.pids] 2: update SID 25010 (zero=0 noshift=1) Oct 24 09:05:33.046 [core.ecm] 2.7: new caDescr: <empty> Oct 24 09:05:33.063 [core.pids] 2: SID=25010 zero=0 | sid=7/25010/0 zero=-/-/- idle=8/25000/1 Oct 24 09:05:33.071 [core.pids] 2: found handler for SID 25010 (2.7 idle=0 idx=7) Oct 24 09:05:33.080 [core.pids] 2.7: pids on entry typ5=0065 Oct 24 09:05:33.088 [core.pids] 2.7: pids after delete Oct 24 09:05:33.096 [core.pids] 2.7: pids after add Oct 24 09:05:33.105 [core.ecm] 2.7: is idle now Oct 24 09:05:33.113 [core.pids] 2: update SID 25020 (zero=0 noshift=0) Oct 24 09:05:33.121 [core.pids] 2: pids typ5=00c9 Oct 24 09:05:33.130 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:33.138 [core.pids] prgca: <empty> Oct 24 09:05:33.146 [core.pids] pidca 00c9: <empty> Oct 24 09:05:33.155 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:33.163 [core.pids] prgca: <empty> Oct 24 09:05:33.171 [core.pids] pidca 00c9: <empty> Oct 24 09:05:33.180 [core.pids] 2: SID=25020 zero=0 | sid=6/25020/0 zero=-/-/- idle=7/25010/1 Oct 24 09:05:33.188 [core.pids] 2: found handler for SID 25020 (2.6 idle=0 idx=6) Oct 24 09:05:33.196 [core.pids] 2.6: pids on entry typ5=00c9 typ5=00ca Oct 24 09:05:33.205 [core.pids] 2.6: pids after delete typ5=00c9 Oct 24 09:05:33.213 [core.pids] 2.6: pids after add typ5=00c9 Oct 24 09:05:33.221 [core.ecm] 2.5: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:33.221 [core.ecm] 2.7: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:33.221 [core.pids] 2: update SID 25020 (zero=0 noshift=1) Oct 24 09:05:33.246 [core.pids] 2: SID=25020 zero=0 | sid=6/25020/0 zero=-/-/- idle=7/25010/1 Oct 24 09:05:33.255 [core.pids] 2: found handler for SID 25020 (2.6 idle=0 idx=6) Oct 24 09:05:33.263 [core.pids] 2.6: pids on entry typ5=00c9 Oct 24 09:05:33.271 [core.pids] 2.6: pids after delete Oct 24 09:05:33.316 [core.pids] 2.6: pids after add Oct 24 09:05:33.238 [core.ecm] 2.7: stopping message log until valid key is found Oct 24 09:05:33.230 [core.ecm] 2.5: stopping message log until valid key is found Oct 24 09:05:33.330 [core.ecm] 2.6: is idle now Oct 24 09:05:33.355 [core.ecm] 2.6: triggered SID 25020/25020 idx 6/6 mode 3/0 - Oct 24 09:05:33.355 [core.pids] 2: update SID 25080 (zero=0 noshift=0) Oct 24 09:05:33.363 [core.ecm] 2.6: new caDescr: <empty> Oct 24 09:05:33.371 [core.pids] 2: pids typ5=0321 Oct 24 09:05:33.388 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:33.396 [core.pids] prgca: <empty> Oct 24 09:05:33.405 [core.pids] pidca 0321: <empty> Oct 24 09:05:33.413 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:33.421 [core.pids] prgca: <empty> Oct 24 09:05:33.430 [core.pids] pidca 0321: <empty> Oct 24 09:05:33.438 [core.pids] 2: SID=25080 zero=0 | sid=5/25080/0 zero=-/-/- idle=6/25020/1 Oct 24 09:05:33.446 [core.pids] 2: found handler for SID 25080 (2.5 idle=0 idx=5) Oct 24 09:05:33.455 [core.pids] 2.5: pids on entry typ5=0321 typ5=0322 Oct 24 09:05:33.463 [core.pids] 2.5: pids after delete typ5=0321 Oct 24 09:05:33.471 [core.pids] 2.5: pids after add typ5=0321 Oct 24 09:05:33.480 [core.ecm] 2.6: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:33.488 [core.ecm] 2.6: stopping message log until valid key is found Oct 24 09:05:33.480 [core.ecm] 2.10: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:33.480 [core.pids] 2: update SID 25080 (zero=0 noshift=1) Oct 24 09:05:33.513 [core.pids] 2: SID=25080 zero=0 | sid=5/25080/0 zero=-/-/- idle=6/25020/1 Oct 24 09:05:33.521 [core.pids] 2: found handler for SID 25080 (2.5 idle=0 idx=5) Oct 24 09:05:33.480 [core.ecm] 2.9: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:33.527 [core.ecm] 2.5: triggered SID 25080/25080 idx 5/5 mode 4/0 - Oct 24 09:05:33.538 [core.ecm] 2.9: stopping message log until valid key is found Oct 24 09:05:33.546 [core.ecm] 2.5: new caDescr: <empty> Oct 24 09:05:33.563 [core.pids] 2.5: pids on entry typ5=0321 Oct 24 09:05:33.571 [core.pids] 2.5: pids after delete Oct 24 09:05:33.580 [core.pids] 2.5: pids after add Oct 24 09:05:33.588 [core.ecm] 2.5: is idle now Oct 24 09:05:33.596 [core.pids] 2: update SID 25100 (zero=0 noshift=0) Oct 24 09:05:33.604 [core.pids] 2: pids typ5=03e9 Oct 24 09:05:33.613 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:33.621 [core.pids] prgca: <empty> Oct 24 09:05:33.629 [core.pids] pidca 03e9: <empty> Oct 24 09:05:33.638 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:33.646 [core.pids] prgca: <empty> Oct 24 09:05:33.654 [core.pids] pidca 03e9: <empty> Oct 24 09:05:33.663 [core.pids] 2: SID=25100 zero=0 | sid=4/25100/0 zero=-/-/- idle=5/25080/1 Oct 24 09:05:33.671 [core.pids] 2: found handler for SID 25100 (2.4 idle=0 idx=4) Oct 24 09:05:33.679 [core.pids] 2.4: pids on entry typ5=03e9 typ5=03ea Oct 24 09:05:33.688 [core.pids] 2.4: pids after delete typ5=03e9 Oct 24 09:05:33.696 [core.pids] 2.4: pids after add typ5=03e9 Oct 24 09:05:33.704 [core.pids] 2: update SID 25100 (zero=0 noshift=1) Oct 24 09:05:33.713 [core.pids] 2: SID=25100 zero=0 | sid=4/25100/0 zero=-/-/- idle=5/25080/1 Oct 24 09:05:33.720 [core.ecm] 2.4: triggered SID 25100/25100 idx 4/4 mode 4/0 - Oct 24 09:05:33.729 [core.ecm] 2.4: new caDescr: <empty> Oct 24 09:05:33.738 [core.pids] 2: found handler for SID 25100 (2.4 idle=0 idx=4) Oct 24 09:05:33.746 [core.pids] 2.4: pids on entry typ5=03e9 Oct 24 09:05:33.756 [core.pids] 2.4: pids after delete Oct 24 09:05:33.763 [core.pids] 2.4: pids after add Oct 24 09:05:33.771 [core.ecm] 2.4: is idle now Oct 24 09:05:33.780 [core.pids] 2: update SID 25060 (zero=0 noshift=0) Oct 24 09:05:33.788 [core.pids] 2: pids typ5=0259 Oct 24 09:05:33.796 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:33.804 [core.pids] prgca: <empty> Oct 24 09:05:33.813 [core.pids] pidca 0259: <empty> Oct 24 09:05:33.821 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:33.829 [core.pids] prgca: <empty> Oct 24 09:05:33.838 [core.pids] pidca 0259: <empty> Oct 24 09:05:33.883 [core.pids] 2: SID=25060 zero=0 | sid=3/25060/0 zero=-/-/- idle=4/25100/1 Oct 24 09:05:33.896 [core.pids] 2: found handler for SID 25060 (2.3 idle=0 idx=3) Oct 24 09:05:33.913 [core.pids] 2.3: pids on entry typ5=0259 typ5=025a Oct 24 09:05:33.921 [core.pids] 2.3: pids after delete typ5=0259 Oct 24 09:05:33.929 [core.pids] 2.3: pids after add typ5=0259 Oct 24 09:05:33.938 [core.ecm] 2.11: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:33.938 [core.ecm] 2.8: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:33.938 [core.pids] 2: update SID 25060 (zero=0 noshift=1) Oct 24 09:05:33.949 [core.ecm] 2.3: triggered SID 25060/25060 idx 3/3 mode 3/0 sync Oct 24 09:05:33.971 [core.ecm] 2.3: new caDescr: <empty> Oct 24 09:05:33.954 [core.ecm] 2.8: stopping message log until valid key is found Oct 24 09:05:33.979 [core.pids] 2: SID=25060 zero=0 | sid=3/25060/0 zero=-/-/- idle=4/25100/1 Oct 24 09:05:33.996 [core.pids] 2: found handler for SID 25060 (2.3 idle=0 idx=3) Oct 24 09:05:34.005 [core.pids] 2.3: pids on entry typ5=0259 Oct 24 09:05:34.013 [core.pids] 2.3: pids after delete Oct 24 09:05:34.021 [core.pids] 2.3: pids after add Oct 24 09:05:34.029 [core.ecm] 2.3: is idle now Oct 24 09:05:34.038 [core.pids] 2: update SID 25050 (zero=0 noshift=0) Oct 24 09:05:34.046 [core.pids] 2: pids typ5=01f5 Oct 24 09:05:34.054 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:34.063 [core.pids] prgca: <empty> Oct 24 09:05:34.071 [core.pids] pidca 01f5: <empty> Oct 24 09:05:34.079 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:34.088 [core.pids] prgca: <empty> Oct 24 09:05:34.096 [core.pids] pidca 01f5: <empty> Oct 24 09:05:34.104 [core.pids] 2: SID=25050 zero=0 | sid=2/25050/0 zero=-/-/- idle=3/25060/1 Oct 24 09:05:34.113 [core.pids] 2: found handler for SID 25050 (2.2 idle=0 idx=2) Oct 24 09:05:34.121 [core.pids] 2.2: pids on entry typ5=01f5 typ5=01f6 Oct 24 09:05:34.129 [core.pids] 2.2: pids after delete typ5=01f5 Oct 24 09:05:34.138 [core.pids] 2.2: pids after add typ5=01f5 Oct 24 09:05:34.146 [core.pids] 2: update SID 25050 (zero=0 noshift=1) Oct 24 09:05:34.154 [core.pids] 2: SID=25050 zero=0 | sid=2/25050/0 zero=-/-/- idle=3/25060/1 Oct 24 09:05:34.163 [core.pids] 2: found handler for SID 25050 (2.2 idle=0 idx=2) Oct 24 09:05:34.166 [core.ecm] 2.2: triggered SID 25050/25050 idx 2/2 mode 3/0 sync Oct 24 09:05:34.179 [core.ecm] 2.2: new caDescr: <empty> Oct 24 09:05:34.188 [core.pids] 2.2: pids on entry typ5=01f5 Oct 24 09:05:34.196 [core.pids] 2.2: pids after delete Oct 24 09:05:34.204 [core.pids] 2.2: pids after add Oct 24 09:05:34.213 [core.ecm] 2.2: is idle now Oct 24 09:05:34.221 [core.pids] 2: update SID 25110 (zero=0 noshift=0) Oct 24 09:05:34.229 [core.pids] 2: pids typ5=044d Oct 24 09:05:34.238 [core.pids] SimplyCa entry pidCa=0 Oct 24 09:05:34.246 [core.pids] prgca: <empty> Oct 24 09:05:34.254 [core.pids] pidca 044d: <empty> Oct 24 09:05:34.263 [core.pids] SimplyCa exit pidCa=0 Oct 24 09:05:34.271 [core.pids] prgca: <empty> Oct 24 09:05:34.279 [core.pids] pidca 044d: <empty> Oct 24 09:05:34.288 [core.pids] 2: SID=25110 zero=0 | sid=1/25110/0 zero=-/-/- idle=2/25050/1 Oct 24 09:05:34.296 [core.pids] 2: found handler for SID 25110 (2.1 idle=0 idx=1) Oct 24 09:05:34.304 [core.pids] 2.1: pids on entry typ5=044d typ5=044e Oct 24 09:05:34.313 [core.pids] 2.1: pids after delete typ5=044d Oct 24 09:05:34.321 [core.pids] 2.1: pids after add typ5=044d Oct 24 09:05:34.329 [core.pids] 2: update SID 25110 (zero=0 noshift=1) Oct 24 09:05:34.338 [core.pids] 2: SID=25110 zero=0 | sid=1/25110/0 zero=-/-/- idle=2/25050/1 Oct 24 09:05:34.346 [core.pids] 2: found handler for SID 25110 (2.1 idle=0 idx=1) Oct 24 09:05:34.354 [core.pids] 2.1: pids on entry typ5=044d Oct 24 09:05:34.363 [core.pids] 2.1: pids after delete Oct 24 09:05:34.371 [core.pids] 2.1: pids after add Oct 24 09:05:34.379 [core.ecm] 2.1: is idle now Oct 24 09:05:34.388 [core.ecm] 2.1: triggered SID 25110/25110 idx 1/1 mode 3/0 sync Oct 24 09:05:34.396 [core.ecm] 2.1: new caDescr: <empty> Oct 24 09:05:34.452 [core.ecm] 2.1: stop Oct 24 09:05:34.464 [core.ecm] 2.2: stop Oct 24 09:05:34.464 [core.ecm] 2.1: triggered SID 25110/-1 idx 1/1 mode 3/-1 sync Oct 24 09:05:34.480 [core.ecm] 2.3: stop Oct 24 09:05:34.488 [core.ecm] 2.2: triggered SID 25050/-1 idx 2/2 mode 3/-1 sync Oct 24 09:05:34.497 [core.ecm] 2.4: stop Oct 24 09:05:34.513 [core.ecm] 2.5: stop Oct 24 09:05:34.520 [core.ecm] 2.3: triggered SID 25060/-1 idx 3/3 mode 3/-1 sync Oct 24 09:05:34.522 [core.ecm] 2.6: stop Oct 24 09:05:34.538 [core.ecm] 2.7: stop Oct 24 09:05:34.547 [core.ecm] 2.8: stop Oct 24 09:05:34.539 [core.ecm] 2.5: triggered SID 25080/-1 idx 5/5 mode 3/-1 - Oct 24 09:05:34.539 [core.ecm] 2.4: triggered SID 25100/-1 idx 4/4 mode 4/-1 - Oct 24 09:05:34.555 [core.ecm] 2.9: stop Oct 24 09:05:34.580 [core.ecm] 2.10: stop Oct 24 09:05:34.588 [core.ecm] 2.11: stop Oct 24 09:05:34.589 [core.ecm] 2.8: triggered SID 25000/-1 idx 8/8 mode 4/-1 - Oct 24 09:05:34.597 [core.ecm] 2.12: stop Oct 24 09:05:34.607 [core.ecm] 2.11: triggered SID 25070/-1 idx 11/11 mode 3/-1 - Oct 24 09:05:34.613 [core.au] 2: stopping chain 4ae1 Oct 24 09:05:34.630 CSA: Got command(5): I idx: 0 pid: 0 Oct 24 09:05:34.630 [core.ecm] 2.6: triggered SID 25020/-1 idx 6/6 mode 4/-1 - Oct 24 09:05:34.631 [core.ecm] 2.12: try system Cardclient (4ae1) id 0000 with ecm 29 (cached) (pri=-15) Oct 24 09:05:34.655 [core.ecm] 2.12: triggered SID 25090/-1 idx 12/12 mode 4/-1 - Oct 24 09:05:34.636 [core.ecm] 2.9: triggered SID 25030/-1 idx 9/9 mode 3/-1 - Oct 24 09:05:34.646 [core.ecm] 2.10: triggered SID 25040/-1 idx 10/10 mode 3/-1 - Oct 24 09:05:34.631 [core.ecm] 2.7: triggered SID 25010/-1 idx 7/7 mode 4/-1 - Oct 24 09:07:17.959 [core.net] idle timeout, disconnected shara3.dyndns.tv:3002 Oct 24 09:07:24.971 [core.net] idle timeout, disconnected shara2.dyndns.tv:3002 Вставить ник Quote Ответить с цитированием Share this post Link to post Share on other sites More sharing options...
lemosh Posted October 24, 2010 · Report post появилось что-то новое в логах.. вот свежий лог Oct 24 20:31:37.998 : Version: 0.0.2-1cc3497be31c+ Oct 24 20:31:38.060 CAM: initializing plugin: SoftCam (1.0.0pre-HG-1cc3497be31c+): A software emulated CAM Oct 24 20:31:38.076 [general.info] SC version 1.0.0pre-HG-1cc3497be31c+ initializing (VDR 1.6.0) Oct 24 20:31:38.084 CAM: starting plugin: Oct 24 20:31:38.093 [general.info] SC version 1.0.0pre-HG-1cc3497be31c+ starting (VDR 1.6.0) Oct 24 20:31:38.101 [core.load] ** Plugin config: Oct 24 20:31:38.109 [core.load] ** Key updates (AU) are enabled (active CAIDs) (no prestart) Oct 24 20:31:38.118 [core.load] ** Local systems DON'T take priority over cached remote Oct 24 20:31:38.126 [core.load] ** Concurrent FF recordings are NOT allowed Oct 24 20:31:38.134 [core.load] ** Force transfermode with digital audio Oct 24 20:31:38.143 [core.load] ** ECM cache is set to enabled Oct 24 20:31:38.151 [core.load] ** ScCaps are 1 2 0 0 0 0 0 0 0 0 Oct 24 20:31:38.159 [general.info] loading cardclient config from /etc/camfiles/12190/cardclient.conf Oct 24 20:31:38.168 [cardclient.newcamd] now using protocol version 525 (cdLen=8) Oct 24 20:31:38.176 [cardclient.core] hostname=shara2.dyndns.tv port=3002 emm=0 emmCaids 4ae1/ffff Oct 24 20:31:38.184 [cardclient.core] Newcamd: username=******* password=******** key=0102030405060708091011121314 Oct 24 20:31:38.193 [cardclient.core] client 'Newcamd' ready Oct 24 20:31:38.433 [core.net] connecting to shara2.dyndns.tv:3002/tcp (92.243.83.130) Oct 24 20:31:38.786 [cardclient.login] Newcamd: CaID=4ae1 admin=1 srvUA=0000000000000000 provider 000000/0000000000000032 <unhandled> Oct 24 20:31:38.793 [cardclient.newcamd] now using protocol version 525 (cdLen=8) Oct 24 20:31:38.801 [cardclient.core] hostname=shara3.dyndns.tv port=3002 emm=0 emmCaids 4ae1/ffff Oct 24 20:31:38.809 [cardclient.core] Newcamd: username=******** password=******** key=0102030405060708091011121314 Oct 24 20:31:38.817 [cardclient.core] client 'Newcamd' ready Oct 24 20:31:39.168 [core.net] connecting to shara3.dyndns.tv:3002/tcp (188.72.230.240) Oct 24 20:31:39.474 [cardclient.login] Newcamd: CaID=4ae1 admin=1 srvUA=0000000000000000 provider 000000/0000000000000032 <unhandled> Oct 24 20:31:39.476 [general.error] failed open /etc/camfiles/12190/SoftCam.Key: No such file or directory Oct 24 20:31:39.484 [general.info] loading ecm cache from /etc/camfiles/12190/ecm.cache Oct 24 20:31:39.492 [general.error] failed open /etc/camfiles/12190/smartcard.conf: No such file or directory Oct 24 20:31:39.501 [general.error] failed open /etc/camfiles/12190/cardslot.conf: No such file or directory Oct 24 20:31:39.509 [general.error] failed open /etc/camfiles/12190/override.conf: No such file or directory Oct 24 20:31:39.517 [general.error] no keys loaded for softcam! Oct 24 20:31:39.526 [core.load] ** registered systems: Oct 24 20:31:39.534 [core.load] ** Cardclient (pri -15) Oct 24 20:31:39.542 [core.load] ** Conax (pri -10) Oct 24 20:31:39.550 [core.load] ** ConstCW (pri -20) Oct 24 20:31:39.559 [core.load] ** Cryptoworks (pri -10) Oct 24 20:31:39.567 [core.load] ** Irdeto (pri -10) Oct 24 20:31:39.575 [core.load] ** Irdeto2 (pri -8) Oct 24 20:31:39.584 [core.load] ** Nagra (pri -10) Oct 24 20:31:39.592 [core.load] ** Nagra2 (pri -10) Oct 24 20:31:39.600 [core.load] ** Fake-NDS (pri -12) Oct 24 20:31:39.609 [core.load] ** SC-Conax (pri -5) Oct 24 20:31:39.617 [core.load] ** SC-Cryptoworks (pri -5) Oct 24 20:31:39.625 [core.load] ** SC-Irdeto (pri -5) Oct 24 20:31:39.634 [core.load] ** SC-Nagra (pri -5) Oct 24 20:31:39.642 [core.load] ** SC-Seca (pri -5) Oct 24 20:31:39.650 [core.load] ** SC-Viaccess (pri -5) Oct 24 20:31:39.659 [core.load] ** SC-VideoGuard2 (pri -5) Oct 24 20:31:39.667 [core.load] ** Seca (pri -10) Oct 24 20:31:39.675 [core.load] ** @SHL (pri -10) Oct 24 20:31:39.684 [core.load] ** Viaccess (pri -10) Oct 24 20:31:40.729 demux: Starting thread on /dev/dvb/adapter5/demux1 The thread scheduling parameters indicate: policy = 0 priority = 0 Oct 24 20:31:40.729 dvr: Starting thread on /dev/dvb/adapter5/dvr1 The thread scheduling parameters indicate: policy = 1 priority = 99 Oct 24 20:31:40.729 frontend: Starting thread on /dev/dvb/adapter5/frontend1 The thread scheduling parameters indicate: policy = 0 priority = 0 Oct 24 20:31:40.850 : Listening on port 5456 Failed to bind to debug port:: Address already in use Oct 24 20:31:40.867 DEBUG: The debug port will not be availableOct 24 20:31:43.006 frontend: Opened fd: 0=10 mode: 104002 Oct 24 20:31:43.008 frontend: Got command 83 (size: 108) Oct 24 20:31:43.016 frontend: ioctl on (10) returned: 0 Oct 24 20:31:43.024 frontend: Got command 67 (size: 20) Oct 24 20:31:43.033 frontend: ioctl on (10) returned: 0 Oct 24 20:31:43.041 : FE_SET_VOLTAGE(10): 18 Oct 24 20:31:43.049 CHANNEL: Clearing tuning cache due to switch cmd Oct 24 20:31:43.058 frontend: Got command 66 (size: 20) Oct 24 20:31:43.066 frontend: ioctl on (10) returned: 0 Oct 24 20:31:43.074 : FE_SET_TONE(10): ON Oct 24 20:31:43.083 CHANNEL: Clearing tuning cache due to switch cmd Oct 24 20:31:43.091 frontend: Got command 76 (size: 52) Oct 24 20:31:43.099 frontend: ioctl on (10) returned: 0 Oct 24 20:31:43.108 : FE_SET_FRONTEND(10): freq: 1440000 inv: AUTO QPSK: sr: 20000000 fec: 9 Oct 24 20:31:43.116 CHANNEL: Tuning frontend Oct 24 20:31:43.124 CSA: Got command(5): I idx: 0 pid: 0 Oct 24 20:31:43.125 demux: Opened fd: 0=12 mode: 100002 Oct 24 20:31:43.141 demux: Got command 44 (size: 36) Oct 24 20:31:43.149 demux: ioctl on (12) returned: 0 Oct 24 20:31:43.158 : DMX_SET_PES_FILTER(12): pid:0 in:FRONTEND out:TS_TAP type:OTHER flags: IMMEDIATE_START Oct 24 20:31:43.166 CHANNEL: Sending PID: 0 Oct 24 20:31:43.174 CHANNEL: Got Start! Oct 24 20:31:43.176 frontend: Got command 78 (size: 56) Oct 24 20:31:43.191 frontend: ioctl on (10) returned: 0 Oct 24 20:31:43.199 : FE_GET_EVENT(10) returned 0 Oct 24 20:31:43.209 frontend: Got command 78 (size: 56) Oct 24 20:31:43.216 frontend: ioctl on (10) returned: 0 Oct 24 20:31:43.217 CHANNEL: found NIT at PID: 16Oct 24 20:31:43.233 CHANNEL: found PID: 250 for sid: 25000 Oct 24 20:31:43.241 CHANNEL: found PID: 100 for sid: 25010 Oct 24 20:31:43.249 CHANNEL: found PID: 200 for sid: 25020 Oct 24 20:31:43.258 CHANNEL: found PID: 300 for sid: 25030 Oct 24 20:31:43.225 : FE_GET_EVENT(10) returned 0 SIGNAL CARRIER VITERBI SYNC LOCK Oct 24 20:31:43.266 CHANNEL: found PID: 400 for sid: 25040 Oct 24 20:31:43.275 demux: Opened fd: 1=14 mode: 100002 Oct 24 20:31:43.283 CHANNEL: found PID: 500 for sid: 25050 Oct 24 20:31:43.291 demux: Got command 44 (size: 36) Oct 24 20:31:43.299 CHANNEL: found PID: 600 for sid: 25060 Oct 24 20:31:43.308 demux: ioctl on (14) returned: 0 Oct 24 20:31:43.316 CHANNEL: found PID: 700 for sid: 25070 Oct 24 20:31:43.324 : DMX_SET_PES_FILTER(14): pid:250 in:FRONTEND out:TS_TAP type:OTHER flags: IMMEDIATE_START Oct 24 20:31:43.333 CHANNEL: found PID: 800 for sid: 25080 Oct 24 20:31:43.341 CHANNEL: Sending PID: 250 Oct 24 20:31:43.358 demux: Opened fd: 2=15 mode: 100002 Oct 24 20:31:43.366 demux: Got command 44 (size: 36) Oct 24 20:31:43.374 demux: ioctl on (15) returned: 0 Oct 24 20:31:43.383 : DMX_SET_PES_FILTER(15): pid:100 in:FRONTEND out:TS_TAP type:OTHER flags: IMMEDIATE_START Oct 24 20:31:43.391 CHANNEL: Sending PID: 100 Oct 24 20:31:43.399 demux: Opened fd: 3=16 mode: 100002 Oct 24 20:31:43.349 CHANNEL: found PID: 900 for sid: 25090 Oct 24 20:31:43.408 demux: Got command 44 (size: 36) Oct 24 20:31:43.424 demux: ioctl on (16) returned: 0 Oct 24 20:31:43.417 CHANNEL: found PID: 1000 for sid: 25100 Oct 24 20:31:43.433 : DMX_SET_PES_FILTER(16): pid:200 in:FRONTEND out:TS_TAP type:OTHER flags: IMMEDIATE_START Oct 24 20:31:43.441 CHANNEL: found PID: 1100 for sid: 25110 Oct 24 20:31:43.449 CHANNEL: Sending PID: 200 Oct 24 20:31:43.466 demux: Opened fd: 4=17 mode: 100002 Oct 24 20:31:43.474 demux: Got command 44 (size: 36) Oct 24 20:31:43.483 demux: ioctl on (17) returned: 0 Oct 24 20:31:43.491 : DMX_SET_PES_FILTER(17): pid:300 in:FRONTEND out:TS_TAP type:OTHER flags: IMMEDIATE_START Oct 24 20:31:43.534 CHANNEL: Sending PID: 300 Oct 24 20:31:43.558 demux: Opened fd: 5=18 mode: 100002 Oct 24 20:31:43.566 demux: Got command 44 (size: 36) Oct 24 20:31:43.574 demux: ioctl on (18) returned: 0 Oct 24 20:31:43.584 : DMX_SET_PES_FILTER(18): pid:400 in:FRONTEND out:TS_TAP type:OTHER flags: IMMEDIATE_START Oct 24 20:31:43.591 CHANNEL: Sending PID: 400 Oct 24 20:31:43.599 demux: Opened fd: 6=19 mode: 100002 Oct 24 20:31:43.608 demux: Got command 44 (size: 36) Oct 24 20:31:43.616 demux: ioctl on (19) returned: 0 Oct 24 20:31:43.624 : DMX_SET_PES_FILTER(19): pid:500 in:FRONTEND out:TS_TAP type:OTHER flags: IMMEDIATE_START Oct 24 20:31:43.633 CHANNEL: Sending PID: 500 Oct 24 20:31:43.641 demux: Opened fd: 7=20 mode: 100002 Oct 24 20:31:43.649 demux: Got command 44 (size: 36) Oct 24 20:31:43.658 demux: ioctl on (20) returned: 0 Oct 24 20:31:43.658 CHANNEL: start: read pes returned err: 11 start: read pes returned: Resource temporarily unavailable Oct 24 20:31:43.666 : DMX_SET_PES_FILTER(20): pid:600 in:FRONTEND out:TS_TAP type:OTHER flags: IMMEDIATE_START Oct 24 20:31:43.683 CHANNEL: Sending PID: 600 Oct 24 20:31:43.683 CHANNEL: read_nit expected table 0x40 or 0x41 but got 0x00 Oct 24 20:31:43.691 demux: Opened fd: 8=21 mode: 100002 Orbit: 00000360E Oct 24 20:31:43.708 demux: Got command 44 (size: 36) Oct 24 20:31:43.724 demux: ioctl on (21) returned: 0 Oct 24 20:31:43.733 : DMX_SET_PES_FILTER(21): pid:700 in:FRONTEND out:TS_TAP type:OTHER flags: IMMEDIATE_START Oct 24 20:31:43.716 CHANNEL: Reading 2 of 2 filters Oct 24 20:31:43.749 CHANNEL: polling 2 fds Oct 24 20:31:43.757 CHANNEL: Read 52 bytes Oct 24 20:31:43.766 CHANNEL: read_pmt: sid: 25100 pcrpid: 1001 skip: 20 count: 48 Oct 24 20:31:43.774 CHANNEL: read_pmt: epid 1001 (type 2) mapped to sid 25100 Oct 24 20:31:43.782 CHANNEL: read_pmt: epid 1002 (type 4) mapped to sid 25100 Oct 24 20:31:43.741 CHANNEL: Sending PID: 700 Oct 24 20:31:43.799 CHANNEL: polling 2 fds Oct 24 20:31:43.808 CHANNEL: Read 52 bytes Oct 24 20:31:43.816 CHANNEL: read_pmt: sid: 25110 pcrpid: 1101 skip: 20 count: 48 Oct 24 20:31:43.824 CHANNEL: read_pmt: epid 1101 (type 2) mapped to sid 25110 Oct 24 20:31:43.832 CHANNEL: read_pmt: epid 1102 (type 4) mapped to sid 25110 Oct 24 20:31:43.841 CHANNEL: Reading 2 of 2 filters Oct 24 20:31:43.849 CHANNEL: polling 2 fds Oct 24 20:31:43.799 demux: Opened fd: 9=23 mode: 100002 Oct 24 20:31:43.866 demux: Got command 44 (size: 36) Oct 24 20:31:43.874 demux: ioctl on (23) returned: 0 Oct 24 20:31:43.882 : DMX_SET_PES_FILTER(23): pid:800 in:FRONTEND out:TS_TAP type:OTHER flags: IMMEDIATE_START Oct 24 20:31:43.891 CHANNEL: Sending PID: 800 Oct 24 20:31:43.899 demux: Opened fd: 10=24 mode: 100002 Oct 24 20:31:43.907 demux: Got command 44 (size: 36) Oct 24 20:31:43.933 demux: ioctl on (24) returned: 0 Oct 24 20:31:43.974 : DMX_SET_PES_FILTER(24): pid:900 in:FRONTEND out:TS_TAP type:OTHER flags: IMMEDIATE_START Oct 24 20:31:44.000 CHANNEL: Sending PID: 900 Oct 24 20:31:44.033 demux: Opened fd: 11=25 mode: 100002 Oct 24 20:31:44.058 CHANNEL: polling 2 fds Oct 24 20:31:44.125 CHANNEL: Read 52 bytes Oct 24 20:31:44.174 CHANNEL: read_pmt: sid: 25090 pcrpid: 901 skip: 20 count: 48 Oct 24 20:31:44.083 demux: Got command 44 (size: 36) Oct 24 20:31:44.216 CHANNEL: read_pmt: epid 901 (type 2) mapped to sid 25090 Oct 24 20:31:44.266 demux: ioctl on (25) returned: 0 Oct 24 20:31:44.316 CHANNEL: read_pmt: epid 902 (type 4) mapped to sid 25090 Oct 24 20:31:44.358 : DMX_SET_PES_FILTER(25): pid:301 in:FRONTEND out:TS_TAP type:OTHER flags: IMMEDIATE_START Oct 24 20:31:44.408 CHANNEL: polling 2 fds Oct 24 20:31:44.491 CHANNEL: Read 52 bytes Oct 24 20:31:44.449 CHANNEL: Sending PID: 301 Oct 24 20:31:44.533 CHANNEL: read_pmt: sid: 25090 pcrpid: 901 skip: 20 count: 48 Oct 24 20:31:44.624 CHANNEL: Already seen sid: 25090 Oct 24 20:31:44.666 CHANNEL: Read 52 bytes Oct 24 20:31:44.575 demux: Opened fd: 12=26 mode: 100002 Oct 24 20:31:44.691 CHANNEL: read_pmt: sid: 25080 pcrpid: 801 skip: 20 count: 48 Oct 24 20:31:44.774 CHANNEL: read_pmt: epid 801 (type 2) mapped to sid 25080 Oct 24 20:31:44.875 CHANNEL: read_pmt: epid 802 (type 4) mapped to sid 25080 Oct 24 20:31:44.733 demux: Got command 44 (size: 36) Oct 24 20:31:44.958 demux: ioctl on (26) returned: 0 Oct 24 20:31:45.007 : DMX_SET_PES_FILTER(26): pid:302 in:FRONTEND out:TS_TAP type:OTHER flags: IMMEDIATE_START Oct 24 20:31:44.927 CHANNEL: Reading 2 of 2 filters Oct 24 20:31:45.101 CHANNEL: polling 2 fds Oct 24 20:31:45.073 CHANNEL: Sending PID: 302 Oct 24 20:31:45.131 CHANNEL: Read 52 bytes Oct 24 20:31:45.190 CHANNEL: read_pmt: sid: 25070 pcrpid: 701 skip: 20 count: 48 Oct 24 20:31:45.178 frontend: Closed fd: 10 ret: 0 Oct 24 20:31:45.178 CSA: Got command(5): I idx: 0 pid: 0 Oct 24 20:31:45.232 CSA: Removing csa for rb: 5 Oct 24 20:31:45.160 demux: Opened fd: 13=27 mode: 100002 Oct 24 20:31:45.281 demux: Closed fd: 12 ret: 0 Oct 24 20:31:45.210 CHANNEL: read_pmt: epid 701 (type 2) mapped to sid 25070 Oct 24 20:31:45.301 demux: Closed fd: 14 ret: 0 Oct 24 20:31:45.323 CHANNEL: read_pmt: epid 702 (type 4) mapped to sid 25070 Oct 24 20:31:45.351 CHANNEL: Read 52 bytes Oct 24 20:31:45.381 CHANNEL: read_pmt: sid: 25060 pcrpid: 601 skip: 20 count: 48 Oct 24 20:31:45.402 CHANNEL: read_pmt: epid 601 (type 2) mapped to sid 25060 Oct 24 20:31:45.423 CHANNEL: read_pmt: epid 602 (type 4) mapped to sid 25060 Oct 24 20:31:45.434 CHANNEL: Reading 2 of 2 filters Oct 24 20:31:45.443 CHANNEL: polling 2 fds Oct 24 20:31:45.343 demux: Closed fd: 15 ret: 0 Oct 24 20:31:45.459 demux: Closed fd: 16 ret: 0 Oct 24 20:31:45.468 demux: Closed fd: 17 ret: 0 Oct 24 20:31:45.476 demux: Closed fd: 18 ret: 0 Oct 24 20:31:45.484 demux: Closed fd: 19 ret: 0 Oct 24 20:31:45.493 demux: Closed fd: 20 ret: 0 Oct 24 20:31:45.501 demux: Closed fd: 21 ret: 0 Oct 24 20:31:45.509 demux: Closed fd: 23 ret: 0 Oct 24 20:31:45.518 demux: Closed fd: 24 ret: 0 Oct 24 20:31:45.526 demux: Closed fd: 25 ret: 0 Oct 24 20:31:45.534 demux: Closed fd: 26 ret: 0 Oct 24 20:31:45.651 CHANNEL: polling 2 fds Oct 24 20:31:45.859 CHANNEL: polling 2 fds Oct 24 20:31:46.068 CHANNEL: polling 2 fds Oct 24 20:31:46.276 CHANNEL: polling 2 fds Oct 24 20:31:46.484 CHANNEL: polling 2 fds Oct 24 20:31:46.693 CHANNEL: polling 2 fds Oct 24 20:31:46.901 CHANNEL: polling 2 fds Oct 24 20:31:47.109 CHANNEL: polling 2 fds Oct 24 20:31:47.317 CHANNEL: polling 2 fds Oct 24 20:31:47.526 CHANNEL: polling 2 fds Oct 24 20:31:47.734 CHANNEL: polling 2 fds Oct 24 20:31:47.942 CHANNEL: polling 2 fds Oct 24 20:31:48.150 CHANNEL: polling 2 fds Oct 24 20:31:48.359 CHANNEL: polling 2 fds Oct 24 20:31:48.567 CHANNEL: polling 2 fds Oct 24 20:31:48.775 CHANNEL: polling 2 fds Oct 24 20:31:48.983 CHANNEL: polling 2 fds Oct 24 20:31:49.192 CHANNEL: polling 2 fds Oct 24 20:31:49.400 CHANNEL: polling 2 fds Oct 24 20:31:49.608 CHANNEL: polling 2 fds Oct 24 20:31:49.816 CHANNEL: polling 2 fds Oct 24 20:31:50.025 CHANNEL: polling 2 fds Oct 24 20:31:50.307 CHANNEL: polling 2 fds Oct 24 20:31:50.533 CHANNEL: polling 2 fds Oct 24 20:31:50.741 CHANNEL: polling 2 fds Oct 24 20:31:50.949 CHANNEL: polling 2 fds Oct 24 20:31:51.158 CHANNEL: polling 2 fds Oct 24 20:31:51.366 CHANNEL: polling 2 fds Oct 24 20:31:51.574 CHANNEL: polling 2 fds Oct 24 20:31:51.782 CHANNEL: polling 2 fds Oct 24 20:31:51.991 CHANNEL: polling 2 fds Oct 24 20:31:52.199 CHANNEL: polling 2 fds Oct 24 20:31:52.407 CHANNEL: polling 2 fds Oct 24 20:31:52.615 CHANNEL: polling 2 fds Oct 24 20:31:52.824 CHANNEL: polling 2 fds Oct 24 20:31:53.032 CHANNEL: polling 2 fds Oct 24 20:31:53.240 CHANNEL: polling 2 fds Oct 24 20:31:53.448 CHANNEL: polling 2 fds Oct 24 20:31:53.703 CHANNEL: polling 2 fds Oct 24 20:31:53.907 CHANNEL: polling 2 fds Oct 24 20:31:54.115 CHANNEL: polling 2 fds Oct 24 20:31:54.323 CHANNEL: polling 2 fds Oct 24 20:31:54.531 CHANNEL: polling 2 fds Oct 24 20:31:54.740 CHANNEL: polling 2 fds Oct 24 20:31:54.948 CHANNEL: polling 2 fds Oct 24 20:31:55.156 CHANNEL: polling 2 fds Oct 24 20:31:55.364 CHANNEL: polling 2 fds кто подскажет где копать??? самое интересное что есть еще 2 карты, на них вроде более ли менее наладилась трансляция после переустановки драйверов v4l-dvb... Вставить ник Quote Ответить с цитированием Share this post Link to post Share on other sites More sharing options...
