May 10 14:06:30 yavdr vdr: [4170] switching to channel 41
May 10 14:06:30 yavdr vdr: [4170] [core.ci] 0/0.0 -> 00 01 a0 16 01 90 02 00 01 9f 80 32 0d 05 00 6a 01 00 07 01 09 04 18 33 f8 09
May 10 14:06:30 yavdr vdr: [4170] [core.ci] 0/0.0 CA_PMT decoding len=d lm=5 prg=106 len=7/7 ci_cmd(G)=01
May 10 14:06:30 yavdr vdr: [4170] [core.ci] 0/0.0 got CA pmt ciCmd=1 caLm=5
May 10 14:06:30 yavdr vdr: [4170] [core.ci] 0/0.0 answer to query surpressed
May 10 14:06:30 yavdr vdr: [4170] [core.ci] 0/0.0 set CAM decrypt (prg 106)
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0: update SID 106 (
zero=0 noshift=1)
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0: SID=106
zero=0 | sid=1/106/0
zero=-/-/- idle=-/-/-
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0: found handler for SID 106 (0/0.1 idle=0 idx=1)
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0.1: pids on entry VIDEO=01ff DOLBY=0203 DOLBY=0204
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0.1: pids after delete
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0.1: pids after add
May 10 14:06:30 yavdr vdr: [4170] [core.ecm] 0/0.1: is idle now
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0: tune to same source/transponder
May 10 14:06:30 yavdr vdr: [4170] [core.ci] 0/0.0 -> 00 01 a0 25 01 90 02 00 01 9f 80 32 1c 04 00 6a 01 00 07 01 09 04 18 33 f8 09 02 01 ff 00 00 06 02 03 00 00 06 02 04 00 00
May 10 14:06:30 yavdr vdr: [4170] [core.ci] 0/0.0 CA_PMT decoding len=1c lm=4 prg=106 len=7/16 ci_cmd(G)=01 pid=2,1ff len=0/a pid=6,203 len=0/5 pid=6,204 len=0/0
May 10 14:06:30 yavdr vdr: [4170] [core.ci] 0/0.0 got CA pmt ciCmd=1 caLm=4
May 10 14:06:30 yavdr vdr: [4170] [core.ci] 0/0.0 answer to query surpressed
May 10 14:06:30 yavdr vdr: [4170] [core.ci] 0/0.0 set CAM decrypt (prg 106)
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0: add SID 106 (
zero=0 noshift=1)
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0: pids VIDEO=01ff DOLBY=0203 DOLBY=0204
May 10 14:06:30 yavdr vdr: [4170] [core.pids] Ca descriptors after simplify (pidCa=0)
May 10 14:06:30 yavdr vdr: [4170] [core.pids] prgca: 09 04 18 33 F8 09
May 10 14:06:30 yavdr vdr: [4170] [core.pids] pidca 01ff: <empty>
May 10 14:06:30 yavdr vdr: [4170] [core.pids] pidca 0203: <empty>
May 10 14:06:30 yavdr vdr: [4170] [core.pids] pidca 0204: <empty>
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0: SID=106
zero=0 | sid=1/106/1
zero=-/-/- idle=1/106/1
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0: found handler for SID 106 (0/0.1 idle=1 idx=1)
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0.1: pids on entry
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0.1: pids after delete
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0: descrambling pid 01ff on index 1
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0: descrambling pid 0203 on index 1
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0: descrambling pid 0204 on index 1
May 10 14:06:30 yavdr vdr: [4170] [core.pids] 0/0.1: pids after add VIDEO=01ff DOLBY=0203 DOLBY=0204
May 10 14:06:30 yavdr vdr: [4170] [core.ecm] 0/0.1: is no longer idle
May 10 14:06:30 yavdr vdr: [4510] TS buffer on device 1 thread ended (pid=4170, tid=4510)
May 10 14:06:30 yavdr vdr: [4509] buffer stats: 174276 (4%) used
May 10 14:06:30 yavdr vdr: [4509] receiver on device 1 thread ended (pid=4170, tid=4509)
May 10 14:06:30 yavdr vdr: [4511] receiver on device 1 thread started (pid=4170, tid=4511)
May 10 14:06:30 yavdr vdr: [4512] TS buffer on device 1 thread started (pid=4170, tid=4512)
May 10 14:06:30 yavdr vdr: [4308] [core.ecm] 0/0.1: triggered SID 106/106 idx 1/1 mode 1/0 -
May 10 14:06:30 yavdr vdr: [4308] [core.ecm] 0/0.1: new caDescr: 09 04 18 33 F8 09
May 10 14:06:30 yavdr vdr: [4308] [core.ecm] 0/0.1: CA descriptors for SID 106 (len=6)
May 10 14:06:30 yavdr vdr: [4308] [core.ecm] 0/0.1: descriptor 18 33 f8 09
May 10 14:06:30 yavdr vdr: [4308] [core.ecm] 0/0.1: found 1833(0000) (Nagra2) id 0000 with ecm 1809/80 (new)
May 10 14:06:30 yavdr vdr: [4308] [core.ecm] 0/0.1: try system Nagra2 (1833) id 0000 with ecm 1809 (pri=-10)
May 10 14:06:30 yavdr vdr: [4312] [core.au] 0/0: chain caid 1833 -> Nagra2(-10) [1002-82/fe]
May 10 14:06:30 yavdr vdr: [4312] [core.au] 0/0: chain caid 09c4 -> none available
May 10 14:06:30 yavdr vdr: [4312] [core.au] 0/0: chain caid 09af -> none available
May 10 14:06:30 yavdr vdr: [4312] [core.au] 0/0: chain caid 098c -> none available
May 10 14:06:30 yavdr vdr: [4312] [core.au] 0/0: starting chain 1833
May 10 14:06:30 yavdr vdr: [4308] [nagra.key] missing 00fb M1 key
May 10 14:06:30 yavdr vdr: [4308] [core.ecm] system: no key found for N 00FB 01
May 10 14:06:30 yavdr vdr: [4238] changing pids of channel 42 from 767+767=27:0;771=deu@106:0:32 to 767+767=27:0;771=deu@106,772=eng@106:0:32
May 10 14:06:30 yavdr vdr: [4308] [nagra.key] missing 00fb M1 key
May 10 14:06:30 yavdr vdr: [4308] [core.ecm] 0/0.1: CA descriptors for SID 106 (len=6)
May 10 14:06:30 yavdr vdr: [4308] [core.ecm] 0/0.1: descriptor 18 33 f8 09
May 10 14:06:30 yavdr vdr: [4308] [core.ecm] 0/0.1: found 1833(0000) (Nagra2) id 0000 with ecm 1809/80 (already present)
May 10 14:06:30 yavdr vdr: [4308] [core.ecm] 0/0.1: try system Nagra2 (1833) id 0000 with ecm 1809 (pri=-10)
May 10 14:06:31 yavdr vdr: [4308] [nagra.key] missing 00fb M1 key
May 10 14:06:31 yavdr vdr: [4308] [core.ecm] system: no key found for N 00FB 01
May 10 14:06:31 yavdr vdr: [4308] [nagra.key] missing 00fb M1 key
May 10 14:06:31 yavdr vdr: [4308] [core.ecm] 0/0.1: CA descriptors for SID 106 (len=6)
May 10 14:06:31 yavdr vdr: [4308] [core.ecm] 0/0.1: descriptor 18 33 f8 09
May 10 14:06:31 yavdr vdr: [4308] [core.ecm] 0/0.1: found 1833(0000) (Nagra2) id 0000 with ecm 1809/80 (already present)
May 10 14:06:31 yavdr vdr: [4308] [core.ecm] 0/0.1: try system Nagra2 (1833) id 0000 with ecm 1809 (pri=-10)
May 10 14:06:33 yavdr vdr: [4508] Text2Skin: channelInfo display update thread ended (pid=4170, tid=4508)
May 10 14:06:34 yavdr vdr: [4308] [nagra.key] missing 004b M1 key
May 10 14:06:34 yavdr vdr: [4308] [core.ecm] system: no key found for N 004B 01
May 10 14:06:34 yavdr vdr: [4308] [nagra.key] missing 004b M1 key
May 10 14:06:34 yavdr vdr: [4308] [core.ecm] 0/0.1: CA descriptors for SID 106 (len=6)
May 10 14:06:34 yavdr vdr: [4308] [core.ecm] 0/0.1: descriptor 18 33 f8 09
May 10 14:06:34 yavdr vdr: [4308] [core.ecm] 0/0.1: found 1833(0000) (Nagra2) id 0000 with ecm 1809/80 (already present)
May 10 14:06:34 yavdr vdr: [4308] [core.ecm] 0/0.1: try system Nagra2 (1833) id 0000 with ecm 1809 (pri=-10)
May 10 14:06:34 yavdr vdr: [4308] [core.ecm] 0/0.1: stopping message log until valid key is found
May 10 14:06:36 yavdr vdr: [4511] ERROR: no useful data seen within 10485888 byte of video stream