May 28 13:00:08 maus-vdr vdr: [9313] LNB -9: Switching device 3 to channel 27
May 28 13:00:08 maus-vdr vdr: [9313] LNB 1: Switching device 2 to channel 27
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1: tune to same source/transponder
May 28 13:00:08 maus-vdr vdr: [9313] LNB 1: Device check for channel 27 on device 2. OK
May 28 13:00:08 maus-vdr vdr: [9313] [core.ci] 1.0 -> 00 01 a0 36 01 90 02 00 01 9f 80 32 2d 04 32 c9 01 00 13 01 09 04 17 02 e1 2d 09 04 18 33 e1 91 09 04 09 c4 e1 e1 02 00 a0 00 00 04 00 a1 00 00 06 00 a3 00 00 06 00 a5 00 00
May 28 13:00:08 maus-vdr vdr: [9313] [core.ci] 1.0 CA_PMT decoding len=2d lm=4 prg=13001 len=13/27 ci_cmd(G)=01 pid=2,a0 len=0/f pid=4,a1 len=0/a pid=6,a3 len=0/5 pid=6,a5 len=0/0
May 28 13:00:08 maus-vdr vdr: [9313] [core.ci] 1.0 got CA pmt ciCmd=1 caLm=4
May 28 13:00:08 maus-vdr vdr: [9313] [core.ci] 1.0 set CAM decrypt (prg 13001)
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1: add SID 13001 (zero=0 noshift=1)
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1: pids VIDEO=00a0 AUDIO=00a1 DOLBY=00a3 DOLBY=00a5
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] SimplyCa entry pidCa=0
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] prgca: 09 04 17 02 E1 2D 09 04 18 33 E1 91 09 04 09 C4 E1 E1
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] pidca 00a0: <empty>
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] pidca 00a1: <empty>
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] pidca 00a3: <empty>
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] pidca 00a5: <empty>
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] SimplyCa exit pidCa=0
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] prgca: 09 04 17 02 E1 2D 09 04 18 33 E1 91 09 04 09 C4 E1 E1
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] pidca 00a0: <empty>
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] pidca 00a1: <empty>
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] pidca 00a3: <empty>
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] pidca 00a5: <empty>
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1: SID=13001 zero=0 | sid=-/-/- zero=-/-/- idle=-/-/-
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1: found handler for SID 13001 (1.2 idle=1 idx=2)
May 28 13:00:08 maus-vdr vdr: [9313] [core.ecm] 1.2: setting new SID 13001
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1.2: pids on entry
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1.2: pids after delete
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1: descrambling pid 00a0 on index 2
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1: descrambling pid 00a1 on index 2
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1: descrambling pid 00a3 on index 2
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1: descrambling pid 00a5 on index 2
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1.2: pids after add VIDEO=00a0 AUDIO=00a1 DOLBY=00a3 DOLBY=00a5
May 28 13:00:08 maus-vdr vdr: [9313] [core.ecm] 1.2: is no longer idle
May 28 13:00:08 maus-vdr vdr: [9384] ecmhandler 1 filter thread started (pid=9313, tid=9384)
May 28 13:00:08 maus-vdr vdr: [9348] osdteletext-receiver thread ended (pid=9313, tid=9348)
May 28 13:00:08 maus-vdr vdr: [9313] [core.ci] 1.0 -> 00 01 a0 22 01 90 02 00 01 9f 80 32 19 05 32 ca 01 00 13 01 09 04 17 02 e1 2e 09 04 18 33 e1 92 09 04 09 c4 e1 e2
May 28 13:00:08 maus-vdr vdr: [9313] [core.ci] 1.0 CA_PMT decoding len=19 lm=5 prg=13002 len=13/13 ci_cmd(G)=01
May 28 13:00:08 maus-vdr vdr: [9313] [core.ci] 1.0 got CA pmt ciCmd=1 caLm=5
May 28 13:00:08 maus-vdr vdr: [9313] [core.ci] 1.0 set CAM decrypt (prg 13002)
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1: update SID 13002 (zero=0 noshift=1)
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1: SID=13002 zero=0 | sid=1/13002/0 zero=-/-/- idle=-/-/-
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1: found handler for SID 13002 (1.1 idle=0 idx=1)
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1.1: pids on entry DOLBY=01f9
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1.1: pids after delete
May 28 13:00:08 maus-vdr vdr: [9313] [core.pids] 1.1: pids after add
May 28 13:00:08 maus-vdr vdr: [9313] [core.ecm] 1.1: is idle now
May 28 13:00:08 maus-vdr vdr: [9313] buffer stats: 0 (0%) used
May 28 13:00:08 maus-vdr vdr: [9313] creating directory /var/run/vdr/vtx/S19.2E-1-1117-13001
May 28 13:00:08 maus-vdr vdr: [9385] osdteletext-receiver thread started (pid=9313, tid=9385)
May 28 13:00:08 maus-vdr vdr: [9384] [core.ecm] 1.2: triggered SID -1/13001 idx -1/2 mode -1/0 -
May 28 13:00:08 maus-vdr vdr: [9384] [core.ecm] 1.2: new caDescr: 09 04 17 02 E1 2D 09 04 18 33 E1 91 09 04 09 C4 E1 E1
May 28 13:00:08 maus-vdr vdr: [9384] [core.ecm] 1.2: CA descriptors for SID 13001 (len=18)
May 28 13:00:08 maus-vdr vdr: [9384] [core.ecm] 1.2: descriptor 17 02 e1 2d
May 28 13:00:08 maus-vdr vdr: [9384] [core.ecm] 1.2: found 1702(0000) (Irdeto) id 0000 with ecm 12d/80 (new)
May 28 13:00:08 maus-vdr vdr: [9384] [core.ecm] 1.2: descriptor 18 33 e1 91
May 28 13:00:08 maus-vdr vdr: [9384] [core.ecm] 1.2: found 1833(0000) (Nagra2) id 0000 with ecm 191/80 (new)
May 28 13:00:08 maus-vdr vdr: [9384] [core.ecm] 1.2: descriptor 09 c4 e1 e1
May 28 13:00:08 maus-vdr vdr: [9384] [core.ecm] 1.2: found 09c4(0000) (Cardclient) id 0000 with ecm 1e1/80 (new)
May 28 13:00:08 maus-vdr vdr: [9384] [core.ecm] 1.2: try system Irdeto (1702) id 0000 with ecm 12d (pri=-10)
May 28 13:00:08 maus-vdr vdr: [9342] [core.ecm] 1.1: try system Nagra2 (1833) id 0000 with ecm 192 (pri=-10)
May 28 13:00:08 maus-vdr vdr: [9342] [nagra.key] missing 001c M1 key
May 28 13:00:08 maus-vdr vdr: [9342] [core.ecm] system: no key found for N 001C 00
May 28 13:00:08 maus-vdr vdr: [9384] [irdeto.ecm] incomplete ECM structure
May 28 13:00:08 maus-vdr vdr: [9342] [nagra.key] missing 001c M1 key
May 28 13:00:08 maus-vdr vdr: [9384] [irdeto.ecm] incomplete ECM structure
May 28 13:00:08 maus-vdr vdr: [9342] [core.ecm] 1.1: try system Cardclient (1702) id 0000 with ecm 12e (pri=-15)
May 28 13:00:09 maus-vdr vdr: [9384] [core.ecm] 1.2: try system Nagra2 (1833) id 0000 with ecm 191 (pri=-10)
May 28 13:00:09 maus-vdr vdr: [9342] [cardclient.core] cc-loop
May 28 13:00:09 maus-vdr vdr: [9342] [cardclient.core] now trying client cccam2 (127.0.0.1:12000)
May 28 13:00:09 maus-vdr vdr: [9342] [cardclient.cccam2] logout from server initiated
May 28 13:00:09 maus-vdr vdr: [9342] [cardclient.cccam2extra] reader thread stopped
May 28 13:00:09 maus-vdr vdr: [9342] [cardclient.cccam2extra] network shut down
May 28 13:00:09 maus-vdr vdr: [9342] [cardclient.cccam2extra] logout done
May 28 13:00:09 maus-vdr vdr: [9342] [core.net] connecting to 127.0.0.1:12000/tcp (127.0.0.1)
May 28 13:00:09 maus-vdr vdr: [9342] [cardclient.cccam2extra] welcome checksum correct
May 28 13:00:09 maus-vdr vdr: [9342] [cardclient.login] CCcam login succeed
May 28 13:00:09 maus-vdr vdr: [9342] [cardclient.core] client cccam2 (127.0.0.1:12000) ECM failed (2 ms)
May 28 13:00:09 maus-vdr vdr: [9342] [cardclient.core] now trying client Camd35 (127.0.0.1:14000)
May 28 13:00:09 maus-vdr vdr: [9386] CCcam2 reader thread started (pid=9313, tid=9386)
May 28 13:00:09 maus-vdr vdr: [9386] [general.error] socket: EOF on read
May 28 13:00:09 maus-vdr vdr: [9386] [cardclient.core] recv error. reconnecting...
May 28 13:00:09 maus-vdr vdr: [9386] [cardclient.cccam2] logout from server initiated
May 28 13:00:09 maus-vdr vdr: [9386] [cardclient.cccam2extra] reader thread stopped
May 28 13:00:09 maus-vdr vdr: [9386] [cardclient.cccam2extra] network shut down
May 28 13:00:09 maus-vdr vdr: [9386] [cardclient.cccam2extra] logout done
May 28 13:00:09 maus-vdr vdr: [9386] CCcam2 reader thread ended (pid=9313, tid=9386)
May 28 13:00:09 maus-vdr vdr: [9384] [nagra.key] missing 0059 M1 key
May 28 13:00:09 maus-vdr vdr: [9384] [core.ecm] system: no key found for N 0059 01
May 28 13:00:09 maus-vdr vdr: [9384] [nagra.key] missing 0059 M1 key
May 28 13:00:09 maus-vdr vdr: [9384] [core.ecm] 1.2: try system Cardclient (1702) id 0000 with ecm 12d (pri=-15)
May 28 13:00:10 maus-vdr vdr: [9384] [cardclient.core] cc-loop
May 28 13:00:10 maus-vdr vdr: [9384] [cardclient.core] now trying client cccam2 (127.0.0.1:12000)
May 28 13:00:10 maus-vdr vdr: [9384] [cardclient.cccam2] logout from server initiated
May 28 13:00:10 maus-vdr vdr: [9384] [cardclient.cccam2extra] reader thread stopped
May 28 13:00:10 maus-vdr vdr: [9384] [cardclient.cccam2extra] network shut down
May 28 13:00:10 maus-vdr vdr: [9384] [cardclient.cccam2extra] logout done
May 28 13:00:10 maus-vdr vdr: [9384] [core.net] connecting to 127.0.0.1:12000/tcp (127.0.0.1)
May 28 13:00:10 maus-vdr vdr: [9384] [cardclient.cccam2extra] welcome checksum correct
May 28 13:00:10 maus-vdr vdr: [9384] [cardclient.login] CCcam login succeed
May 28 13:00:10 maus-vdr vdr: [9384] [cardclient.core] client cccam2 (127.0.0.1:12000) ECM failed (2 ms)
May 28 13:00:10 maus-vdr vdr: [9387] CCcam2 reader thread started (pid=9313, tid=9387)
May 28 13:00:10 maus-vdr vdr: [9384] [cardclient.core] now trying client Camd35 (127.0.0.1:14000)
May 28 13:00:10 maus-vdr vdr: [9387] [general.error] socket: EOF on read
May 28 13:00:10 maus-vdr vdr: [9387] [cardclient.core] recv error. reconnecting...
May 28 13:00:10 maus-vdr vdr: [9387] [cardclient.cccam2] logout from server initiated
May 28 13:00:10 maus-vdr vdr: [9387] [cardclient.cccam2extra] reader thread stopped
May 28 13:00:10 maus-vdr vdr: [9387] [cardclient.cccam2extra] network shut down
May 28 13:00:10 maus-vdr vdr: [9387] [cardclient.cccam2extra] logout done
May 28 13:00:10 maus-vdr vdr: [9387] CCcam2 reader thread ended (pid=9313, tid=9387)
May 28 13:00:14 maus-vdr vdr: [9342] [cardclient.ecm] Camd35: CW request timed out
May 28 13:00:14 maus-vdr vdr: [9342] [cardclient.core] client Camd35 (127.0.0.1:14000) ECM failed (5016 ms)
May 28 13:00:14 maus-vdr vdr: [9342] [cardclient.core] cc-loop
May 28 13:00:14 maus-vdr vdr: [9342] [cardclient.core] now trying client cccam2 (127.0.0.1:12000)
May 28 13:00:14 maus-vdr vdr: [9342] [cardclient.cccam2] logout from server initiated
May 28 13:00:14 maus-vdr vdr: [9342] [cardclient.cccam2extra] reader thread stopped
May 28 13:00:14 maus-vdr vdr: [9342] [cardclient.cccam2extra] network shut down
May 28 13:00:14 maus-vdr vdr: [9342] [cardclient.cccam2extra] logout done
May 28 13:00:14 maus-vdr vdr: [9342] [core.net] connecting to 127.0.0.1:12000/tcp (127.0.0.1)
May 28 13:00:14 maus-vdr vdr: [9342] [cardclient.cccam2extra] welcome checksum correct
May 28 13:00:14 maus-vdr vdr: [9342] [cardclient.login] CCcam login succeed
May 28 13:00:14 maus-vdr vdr: [9342] [cardclient.core] client cccam2 (127.0.0.1:12000) ECM failed (5 ms)
May 28 13:00:14 maus-vdr vdr: [9389] CCcam2 reader thread started (pid=9313, tid=9389)
May 28 13:00:14 maus-vdr vdr: [9342] [cardclient.core] now trying client Camd35 (127.0.0.1:14000)
May 28 13:00:14 maus-vdr vdr: [9389] [general.error] socket: EOF on read
May 28 13:00:14 maus-vdr vdr: [9389] [cardclient.core] recv error. reconnecting...
May 28 13:00:14 maus-vdr vdr: [9389] [cardclient.cccam2] logout from server initiated
May 28 13:00:14 maus-vdr vdr: [9389] [cardclient.cccam2extra] reader thread stopped
May 28 13:00:14 maus-vdr vdr: [9389] [cardclient.cccam2extra] network shut down
May 28 13:00:14 maus-vdr vdr: [9389] [cardclient.cccam2extra] logout done
May 28 13:00:14 maus-vdr vdr: [9389] CCcam2 reader thread ended (pid=9313, tid=9389)
May 28 13:00:19 maus-vdr vdr: [9384] [cardclient.ecm] Camd35: CW request timed out
May 28 13:00:19 maus-vdr vdr: [9384] [cardclient.core] client Camd35 (127.0.0.1:14000) ECM failed (9118 ms)
May 28 13:00:19 maus-vdr vdr: [9384] [core.ecm] 1.2: filter flush (elapsed 9121)
May 28 13:00:19 maus-vdr vdr: [9342] [cardclient.ecm] Camd35: server is unable to handle ECM
May 28 13:00:19 maus-vdr vdr: [9342] [cardclient.core] client Camd35 (127.0.0.1:14000) ECM failed (5062 ms)
May 28 13:00:19 maus-vdr vdr: [9342] [core.ecm] 1.1: try system Cardclient (1833) id 0000 with ecm 192 (pri=-15)
May 28 13:00:19 maus-vdr vdr: [9384] [cardclient.core] cc-loop
May 28 13:00:19 maus-vdr vdr: [9384] [cardclient.core] now trying client cccam2 (127.0.0.1:12000)
May 28 13:00:19 maus-vdr vdr: [9384] [cardclient.cccam2] logout from server initiated
May 28 13:00:19 maus-vdr vdr: [9384] [cardclient.cccam2extra] reader thread stopped
May 28 13:00:19 maus-vdr vdr: [9384] [cardclient.cccam2extra] network shut down
May 28 13:00:19 maus-vdr vdr: [9384] [cardclient.cccam2extra] logout done
May 28 13:00:19 maus-vdr vdr: [9384] [core.net] connecting to 127.0.0.1:12000/tcp (127.0.0.1)
May 28 13:00:19 maus-vdr vdr: [9384] [cardclient.cccam2extra] welcome checksum correct
May 28 13:00:19 maus-vdr vdr: [9384] [cardclient.login] CCcam login succeed
May 28 13:00:19 maus-vdr vdr: [9384] [cardclient.core] client cccam2 (127.0.0.1:12000) ECM failed (2 ms)
May 28 13:00:19 maus-vdr vdr: [9384] [cardclient.core] now trying client Camd35 (127.0.0.1:14000)
May 28 13:00:19 maus-vdr vdr: [9390] CCcam2 reader thread started (pid=9313, tid=9390)
May 28 13:00:19 maus-vdr vdr: [9390] [general.error] socket: EOF on read
May 28 13:00:19 maus-vdr vdr: [9390] [cardclient.core] recv error. reconnecting...
May 28 13:00:19 maus-vdr vdr: [9390] [cardclient.cccam2] logout from server initiated
May 28 13:00:19 maus-vdr vdr: [9390] [cardclient.cccam2extra] reader thread stopped
May 28 13:00:19 maus-vdr vdr: [9390] [cardclient.cccam2extra] network shut down
May 28 13:00:19 maus-vdr vdr: [9390] [cardclient.cccam2extra] logout done
May 28 13:00:19 maus-vdr vdr: [9390] CCcam2 reader thread ended (pid=9313, tid=9390)
May 28 13:00:19 maus-vdr vdr: [9342] [cardclient.core] cc-loop
May 28 13:00:19 maus-vdr vdr: [9342] [cardclient.core] now trying client cccam2 (127.0.0.1:12000)
May 28 13:00:19 maus-vdr vdr: [9342] [cardclient.cccam2] logout from server initiated
May 28 13:00:19 maus-vdr vdr: [9342] [cardclient.cccam2extra] reader thread stopped
May 28 13:00:19 maus-vdr vdr: [9342] [cardclient.cccam2extra] network shut down
May 28 13:00:19 maus-vdr vdr: [9342] [cardclient.cccam2extra] logout done
May 28 13:00:19 maus-vdr vdr: [9342] [core.net] connecting to 127.0.0.1:12000/tcp (127.0.0.1)
May 28 13:00:19 maus-vdr vdr: [9342] [cardclient.cccam2extra] welcome checksum correct
May 28 13:00:19 maus-vdr vdr: [9342] [cardclient.login] CCcam login succeed
May 28 13:00:19 maus-vdr vdr: [9342] [cardclient.core] client cccam2 (127.0.0.1:12000) ECM failed (2 ms)
May 28 13:00:19 maus-vdr vdr: [9342] [cardclient.core] now trying client Camd35 (127.0.0.1:14000)
May 28 13:00:19 maus-vdr vdr: [9391] CCcam2 reader thread started (pid=9313, tid=9391)
May 28 13:00:19 maus-vdr vdr: [9391] [general.error] socket: EOF on read
May 28 13:00:19 maus-vdr vdr: [9391] [cardclient.core] recv error. reconnecting...
May 28 13:00:19 maus-vdr vdr: [9391] [cardclient.cccam2] logout from server initiated
May 28 13:00:19 maus-vdr vdr: [9391] [cardclient.cccam2extra] reader thread stopped
May 28 13:00:19 maus-vdr vdr: [9391] [cardclient.cccam2extra] network shut down
May 28 13:00:19 maus-vdr vdr: [9391] [cardclient.cccam2extra] logout done