Oct  4 19:13:15.761 [core.ci] 2/0.0 -> 00 01 a0 1e 01 90 02 00 01 9f 80 32 15 04 08 34 01 00 00 02 08 35 00 00 04 08 36 00 00 04 08 37 00 00
Oct  4 19:13:15.761 [core.ci] 2/0.0 CA_PMT decoding len=15 lm=4 prg=2100 len=0/f pid=2,835 len=0/a pid=4,836 len=0/5 pid=4,837 len=0/0
Oct  4 19:13:15.761 [core.ci] 2/0.0 got CA pmt ciCmd=-1 caLm=4
Oct  4 19:13:15.761 [core.ci] 2/0.0 answer to query surpressed
Oct  4 19:13:15.761 [core.ci] 2/0.0 set CAM decrypt (prg 2100)
Oct  4 19:13:15.761 [core.pids] 2/0: add SID 2100 (zero=0 noshift=1)
Oct  4 19:13:15.761 [core.pids] 2/0: pids VIDEO=0835 AUDIO=0836 AUDIO=0837
Oct  4 19:13:15.761 [core.pids] Ca descriptors after simplify (pidCa=0)
Oct  4 19:13:15.761 [core.pids] prgca: <empty>
Oct  4 19:13:15.761 [core.pids] pidca 0835: <empty>
Oct  4 19:13:15.761 [core.pids] pidca 0836: <empty>
Oct  4 19:13:15.761 [core.pids] pidca 0837: <empty>
Oct  4 19:13:15.761 [core.pids] 2/0: SID=2100 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/-
Oct  4 19:13:15.761 [core.pids] 2/0: found handler for SID 2100 (2/0.1 idle=1 idx=1)
Oct  4 19:13:15.761 [core.ecm] 2/0.1: setting new SID 2100
Oct  4 19:13:15.761 [core.pids] 2/0.1: pids on entry
Oct  4 19:13:15.761 [core.pids] 2/0.1: pids after delete
Oct  4 19:13:15.761 [core.pids] 2/0: descrambling pid 0835 on index 1
Oct  4 19:13:15.761 [core.pids] 2/0: descrambling pid 0836 on index 1
Oct  4 19:13:15.761 [core.pids] 2/0: descrambling pid 0837 on index 1
Oct  4 19:13:15.761 [core.pids] 2/0.1: pids after add VIDEO=0835 AUDIO=0836 AUDIO=0837
Oct  4 19:13:15.761 [core.ecm] 2/0.1: is no longer idle
Oct  4 19:13:15.821 [core.ecm] 2/0.1: triggered SID -1/2100 idx -1/1 mode -1/0 -
Oct  4 19:13:17.013 [core.ci] 2/0.0 -> 00 01 a0 0f 01 90 02 00 01 9f 80 32 06 05 08 34 01 00 00
Oct  4 19:13:17.013 [core.ci] 2/0.0 CA_PMT decoding len=6 lm=5 prg=2100 len=0/0
Oct  4 19:13:17.013 [core.ci] 2/0.0 got CA pmt ciCmd=-1 caLm=5
Oct  4 19:13:17.013 [core.ci] 2/0.0 answer to query surpressed
Oct  4 19:13:17.013 [core.ci] 2/0.0 set CAM decrypt (prg 2100)
Oct  4 19:13:17.013 [core.pids] 2/0: update SID 2100 (zero=0 noshift=1)
Oct  4 19:13:17.013 [core.pids] 2/0: SID=2100 zero=0 | sid=1/2100/0 zero=-/-/- idle=-/-/-
Oct  4 19:13:17.013 [core.pids] 2/0: found handler for SID 2100 (2/0.1 idle=0 idx=1)
Oct  4 19:13:17.013 [core.pids] 2/0.1: pids on entry VIDEO=0835 AUDIO=0836 AUDIO=0837
Oct  4 19:13:17.013 [core.pids] 2/0.1: pids after delete
Oct  4 19:13:17.013 [core.pids] 2/0.1: pids after add
Oct  4 19:13:17.013 [core.ecm] 2/0.1: is idle now
Oct  4 19:13:17.113 [core.pids] 2/0: tune to same source/transponder
Oct  4 19:13:17.113 [core.ci] 2/0.0 -> 00 01 a0 2c 01 90 02 00 01 9f 80 32 23 04 08 34 01 00 00 02 08 35 00 07 01 09 04 09 3e e0 99 04 08 36 00 07 01 09 04 09 3e e0 99 04 08 37 00 00
Oct  4 19:13:17.113 [core.ci] 2/0.0 CA_PMT decoding len=23 lm=4 prg=2100 len=0/1d pid=2,835 len=7/18 ci_cmd(S)=1 pid=4,836 len=7/c ci_cmd(S)=1 pid=4,837 len=0/0
Oct  4 19:13:17.113 [core.ci] 2/0.0 got CA pmt ciCmd=1 caLm=4
Oct  4 19:13:17.113 [core.ci] 2/0.0 answer to query surpressed
Oct  4 19:13:17.113 [core.ci] 2/0.0 set CAM decrypt (prg 2100)
Oct  4 19:13:17.113 [core.pids] 2/0: add SID 2100 (zero=0 noshift=1)
Oct  4 19:13:17.113 [core.pids] 2/0: pids VIDEO=0835 AUDIO=0836 AUDIO=0837
Oct  4 19:13:17.113 [core.pids] Ca descriptors after simplify (pidCa=1)
Oct  4 19:13:17.113 [core.pids] prgca: <empty>
Oct  4 19:13:17.113 [core.pids] pidca 0835: 09 04 09 3E E0 99
Oct  4 19:13:17.113 [core.pids] pidca 0836: 09 04 09 3E E0 99
Oct  4 19:13:17.113 [core.pids] pidca 0837: <empty>
Oct  4 19:13:17.113 [core.pids] 2/0: SID 2100 is handled as splitted
Oct  4 19:13:17.113 [core.pids] 2/0: added to list
Oct  4 19:13:17.113 [core.pids] 2/0: split SID list now: 2100 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
Oct  4 19:13:17.113 [core.pids] 2/0: group 1 pids 0835 0836
Oct  4 19:13:17.113 [core.pids] 2/0: SID=2100 zero=0 | sid=1/2100/1 zero=-/-/- idle=1/2100/1
Oct  4 19:13:17.113 [core.pids] 2/0: found handler for group-SID 102100 (2/0.1 idle=1 idx=1)
Oct  4 19:13:17.113 [core.ecm] 2/0.1: setting new SID 102100
Oct  4 19:13:17.113 [core.pids] 2/0.1: pids on entry
Oct  4 19:13:17.113 [core.pids] 2/0.1: pids after delete
Oct  4 19:13:17.113 [core.pids] 2/0: descrambling pid 0835 on index 1
Oct  4 19:13:17.113 [core.pids] 2/0: descrambling pid 0836 on index 1
Oct  4 19:13:17.113 [core.pids] 2/0.1: pids after add VIDEO=0835 AUDIO=0836
Oct  4 19:13:17.113 [core.ecm] 2/0.1: is no longer idle
Oct  4 19:13:17.113 [core.pids] 2/0: group 2 pids 0837
Oct  4 19:13:17.113 [core.pids] 2/0: SID=202100 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/-
Oct  4 19:13:17.113 [core.pids] 2/0: found handler for group-SID 202100 (2/0.2 idle=1 idx=2)
Oct  4 19:13:17.113 [core.ecm] 2/0.2: setting new SID 202100
Oct  4 19:13:17.113 [core.pids] 2/0.2: pids on entry
Oct  4 19:13:17.113 [core.pids] 2/0.2: pids after delete
Oct  4 19:13:17.113 [core.pids] 2/0: descrambling pid 0837 on index 2
Oct  4 19:13:17.113 [core.pids] 2/0.2: pids after add AUDIO=0837
Oct  4 19:13:17.113 [core.ecm] 2/0.2: is no longer idle
Oct  4 19:13:17.143 [core.ecm] 2/0.1: triggered SID 2100/102100 idx 1/1 mode 1/0 -
Oct  4 19:13:17.143 [core.ecm] 2/0.1: new caDescr: 09 04 09 3E E0 99
Oct  4 19:13:17.143 [core.ecm] 2/0.1: CA descriptors for SID 102100 (len=6)
Oct  4 19:13:17.143 [core.ecm] 2/0.1: descriptor 09 3e e0 99
Oct  4 19:13:17.143 [core.ecm] 2/0.1: found 093e(0000) (Cardclient) id 0000 with ecm 99/80 (new)
Oct  4 19:13:17.143 [core.ecm] 2/0.1: try system Cardclient (093e) id 0000 with ecm 99 (pri=-15)
Oct  4 19:13:17.149 [cardclient.core] cc-loop
Oct  4 19:13:17.149 [cardclient.core] now trying client Newcamd (server IP:port)
Oct  4 19:13:17.167 [core.net] connecting to server IP:port/tcp (0.0.0.0)
Oct  4 19:13:17.174 [core.ecm] 2/0.2: triggered SID -1/202100 idx -1/2 mode -1/0 -
Oct  4 19:13:17.195 [core.au] 2/0: chain caid 090f -> none available
Oct  4 19:13:17.195 [core.au] 2/0: chain caid 093e -> Cardclient(-15) [00c1-82/ff]
Oct  4 19:13:17.195 [core.au] 2/0: starting chain 093e
Oct  4 19:13:17.438 [cardclient.login] Newcamd: CaID=093e admin=0 srvUA=0000000000000000 provider 000000/0000000000000000
Oct  4 19:13:17.836 [core.ecm] 2/0.1: correct key found
Oct  4 19:13:37.357 [core.ecm] 2/0.2: no encryption system found
Oct  4 19:14:17.165 [core.auStats] EMM packet load average (1/4/10min)   39    9    3 pks/s

