------------------------------------------------------------------------------->> OSCam << cardserver started at Sun Nov 23 23:58:17 2014
-------------------------------------------------------------------------------
2014/11/23 23:58:17 0 s >> OSCam << cardserver started, version 1.20-unstable_svn, build r10003 (mipsel-unknown-linux-gnu-ssl-libusb-pcsc)
2014/11/23 23:58:17 0 s creating pidfile /tmp/.oscam/oscam.pid with pid 714
2014/11/23 23:58:18 0 s services reloaded: 0 services freed, 2 services loaded, rejected 0
2014/11/23 23:58:18 0 s userdb reloaded: 6 accounts loaded, 0 expired, 0 disabled
2014/11/23 23:58:18 0 s signal handling initialized
2014/11/23 23:58:18 0 s 221 service-id's loaded in 8 ms
2014/11/23 23:58:18 0 s 154 tier-id's loaded
2014/11/23 23:58:18 0 s 4 provid's loaded
2014/11/23 23:58:18 0 s cccam: initialized (fd=6, port=12000)
2014/11/23 23:58:18 0 s s02_sky [internal] creating thread for device /dev/sci0
2014/11/23 23:58:18 0 s hd02 [internal] creating thread for device /dev/sci1
2014/11/23 23:58:18 0 s loadbalancer: can't read from file /tmp/.oscam/stat
2014/11/23 23:58:18 0 s waiting for local card init
2014/11/23 23:58:18 C032D8 r s02_sky [internal] Reader initialized (device=/dev/sci0, detect=cd, pll max=27.00 MHz, wanted mhz=5.40 MHz
2014/11/23 23:58:18 C09FB0 r hd02 [internal] Reader initialized (device=/dev/sci1, detect=cd, pll max=27.00 MHz, wanted mhz=4.50 MHz
2014/11/23 23:58:18 C032D8 r s02_sky [internal] card detected
2014/11/23 23:58:18 C032D8 r s02_sky [internal] Card is present in readerslot!
2014/11/23 23:58:18 C09FB0 r hd02 [internal] card detected
2014/11/23 23:58:18 C09FB0 r hd02 [internal] Card is present in readerslot!
2014/11/23 23:58:18 C0EDE8 h webif: decompressed 156707 bytes back into 373872 bytes
2014/11/23 23:58:18 C0EDE8 h HTTP Server running. ip=0.0.0.0 port=17000
2014/11/23 23:58:18 C032D8 r s02_sky [internal] Set reader parameters!
2014/11/23 23:58:18 C032D8 r s02_sky [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/23 23:58:18 C09FB0 r hd02 [internal] Set reader parameters!
2014/11/23 23:58:18 C09FB0 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/23 23:58:18 C032D8 r s02_sky [internal] Reset internal cardreader!
2014/11/23 23:58:18 C09FB0 r hd02 [internal] Reset internal cardreader!
2014/11/23 23:58:19 C09FB0 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/23 23:58:19 C09FB0 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/23 23:58:19 C09FB0 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/23 23:58:19 C09FB0 r hd02 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/11/23 23:58:20 C09FB0 r hd02 [internal] Sent reader settings T=0 fs=5 ETU=32 WWT=0 CWT=139 BWT=178571 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/23 23:58:20 C09FB0 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/23 23:58:20 C09FB0 r hd02 [internal] Card responded ok for ifsd request of 160
2014/11/23 23:58:20 C032D8 r s02_sky [internal] ATR: 3B 9F 21 0E 49 52 44 45 54 4F 20 41 43 53 03 84 55 FF 80 6D
2014/11/23 23:58:20 C032D8 r s02_sky [internal] Init card protocol T14, FI=2, F=558, D=1, N=0
2014/11/23 23:58:20 C032D8 r s02_sky [internal] TEST tempo mhz check = 600 mhz
2014/11/23 23:58:20 C032D8 r s02_sky [internal] Calculated work ETU is 103.33 us reader mhz = 540
2014/11/23 23:58:21 C032D8 r s02_sky [internal] Sent reader settings T=14 fs=5 ETU=600 WWT=9600 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=5 I=50 U=0
2014/11/23 23:58:21 C09FB0 r hd02 [internal] detect native nagra card
2014/11/23 23:58:21 C032D8 r s02_sky [internal] PLL Reader: ATR Fsmax is 6 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/23 23:58:22 C032D8 r s02_sky [internal] detect irdeto tunneled nagra card
2014/11/23 23:58:22 C032D8 r s02_sky [internal] no rsa key configured -> using irdeto mode
2014/11/23 23:58:22 C032D8 r s02_sky [internal] detect irdeto card
2014/11/23 23:58:22 C032D8 r s02_sky [internal] caid: 1702, acs: 3.84, country code: GER
2014/11/23 23:58:22 C032D8 r s02_sky [internal] providers: 4, ascii serial: ##########, hex serial: ######, hex base: ##
2014/11/23 23:58:23 C09FB0 r hd02 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2014/11/23 23:58:24 C09FB0 r hd02 [internal] T1 Resync command error, trying to reactivate!
2014/11/23 23:58:24 C09FB0 r hd02 [internal] Card is present in readerslot!
2014/11/23 23:58:24 C09FB0 r hd02 [internal] Set reader parameters!
2014/11/23 23:58:24 C09FB0 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/23 23:58:24 C09FB0 r hd02 [internal] Reset internal cardreader!
2014/11/23 23:58:25 C032D8 r s02_sky [internal] WARNING: For Irdeto cards you will have to set 'cardmhz = 600' in oscam.server
2014/11/23 23:58:25 C032D8 r s02_sky [internal] active providers: 2 (000000,000000)
2014/11/23 23:58:25 C032D8 r s02_sky [internal] found card system irdeto
2014/11/23 23:58:25 C032D8 r s02_sky [irdeto] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2014/11/23 23:58:26 C09FB0 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/23 23:58:26 C09FB0 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/23 23:58:26 C09FB0 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/23 23:58:26 C09FB0 r hd02 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] entitlements for provider: 2, id: 000000
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 05F1, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 0276, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 0609, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 05E8, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 0605, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 00F0, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 04CE, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 7D23, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 0617, date: 2011/07/12 - 2012/03/22
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 0606, date: 2011/06/27 - 2011/11/25
2014/11/23 23:58:26 C09FB0 r hd02 [internal] Sent reader settings T=0 fs=5 ETU=32 WWT=0 CWT=139 BWT=178571 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 05DF, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 05DD, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 05F2, date: 2011/06/27 - 2011/11/25
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 000F, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 05FC, date: 2011/06/27 - 2011/11/25
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 7D27, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 05E7, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 05FB, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 05DE, date: 2012/06/11 - 2013/02/20
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 0103, date: 2008/01/19 - 2008/01/21
2014/11/23 23:58:26 C09FB0 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/23 23:58:26 C09FB0 r hd02 [internal] Card responded ok for ifsd request of 160
2014/11/23 23:58:26 C09FB0 r hd02 [internal] card system not supported
2014/11/23 23:58:26 C09FB0 r hd02 [internal] Normal mode failed, reverting to Deprecated Mode
2014/11/23 23:58:26 C09FB0 r hd02 [internal] Card is present in readerslot!
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 029C, date: 2008/01/19 - 2008/01/21
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 0104, date: 2008/01/19 - 2008/01/21
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 0406, date: 2008/01/19 - 2008/01/21
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 0105, date: 2008/01/19 - 2008/01/21
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] chid: 0004, date: 2008/01/19 - 2008/01/21
2014/11/23 23:58:26 C09FB0 r hd02 [internal] Set reader parameters!
2014/11/23 23:58:26 C09FB0 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/23 23:58:26 C032D8 r s02_sky [irdeto] ready for requests
2014/11/23 23:58:27 C09FB0 r hd02 [internal] Reset internal cardreader!
2014/11/23 23:58:28 C09FB0 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/23 23:58:28 C09FB0 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/23 23:58:28 C09FB0 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/23 23:58:28 C09FB0 r hd02 [internal] Calculated work ETU is 82.67 us reader mhz = 450
2014/11/23 23:58:28 C09FB0 r hd02 [internal] Sent reader settings T=0 fs=6 ETU=372 WWT=0 CWT=139 BWT=15371 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/23 23:58:29 C09FB0 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 4.50 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/23 23:58:30 C09FB0 r hd02 [internal] Warning: Card returned error on setting ifsd value to 160
2014/11/23 23:58:31 C09FB0 r hd02 [internal] detect native nagra card
2014/11/23 23:58:32 C09FB0 r hd02 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2014/11/23 23:58:34 C09FB0 r hd02 [internal] T1 Resync command error, trying to reactivate!
2014/11/23 23:58:34 C09FB0 r hd02 [internal] Card is present in readerslot!
2014/11/23 23:58:34 C09FB0 r hd02 [internal] Set reader parameters!
2014/11/23 23:58:34 C09FB0 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/23 23:58:34 C09FB0 r hd02 [internal] Reset internal cardreader!
2014/11/23 23:58:36 C09FB0 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/23 23:58:36 C09FB0 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/23 23:58:36 C09FB0 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/23 23:58:36 C09FB0 r hd02 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/11/23 23:58:36 C09FB0 r hd02 [internal] Sent reader settings T=0 fs=5 ETU=32 WWT=0 CWT=139 BWT=178571 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/23 23:58:36 C09FB0 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/23 23:58:36 C09FB0 r hd02 [internal] Card responded ok for ifsd request of 160
2014/11/23 23:58:38 C09FB0 r hd02 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2014/11/23 23:58:39 C09FB0 r hd02 [internal] T1 Resync command error, trying to reactivate!
2014/11/23 23:58:39 C09FB0 r hd02 [internal] Card is present in readerslot!
2014/11/23 23:58:39 C09FB0 r hd02 [internal] Set reader parameters!
2014/11/23 23:58:39 C09FB0 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/23 23:58:40 C09FB0 r hd02 [internal] Reset internal cardreader!
2014/11/23 23:58:41 C09FB0 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/23 23:58:41 C09FB0 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/23 23:58:41 C09FB0 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/23 23:58:41 C09FB0 r hd02 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/11/23 23:58:41 C09FB0 r hd02 [internal] Sent reader settings T=0 fs=5 ETU=32 WWT=0 CWT=139 BWT=178571 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/23 23:58:42 C09FB0 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/23 23:58:42 C09FB0 r hd02 [internal] Card responded ok for ifsd request of 160
2014/11/23 23:58:42 C09FB0 r hd02 [internal] card system not supported
2014/11/23 23:58:42 C09FB0 r hd02 [internal] THIS WAS A FAILED START ATTEMPT No 1 out of max alloted of 1
2014/11/23 23:58:42 C09FB0 r hd02 [internal] card initializing error
2014/11/23 23:58:42 0 s init for all local cards done
2014/11/23 23:58:42 0 s anti cascading disabled
2014/11/23 23:58:42 C1D418 c plain dvbapi-client granted (serverbox, au=auto (3 reader))
2014/11/23 23:58:42 C27150 c anonymous disconnected from 217.91.171.164
2014/11/23 23:58:42 C1F890 c anonymous disconnected from 80.149.99.10
2014/11/23 23:58:42 0 --- Skipped 1 duplicated log lines ---
2014/11/23 23:58:42 C25320 c anonymous disconnected from 79.204.52.142
2014/11/23 23:58:42 C234F0 c anonymous disconnected from 84.173.38.35
2014/11/23 23:58:42 C216C0 c anonymous disconnected from 79.204.52.142
2014/11/23 23:58:42 0 --- Skipped 1 duplicated log lines ---
2014/11/23 23:58:42 C3C118 c anonymous disconnected from 217.91.171.164
2014/11/23 23:58:42 C2ADB0 c anonymous disconnected from 79.204.52.142
2014/11/23 23:58:42 C357F0 c anonymous disconnected from 84.173.38.35
2014/11/23 23:58:42 C1D418 c [DVBAPI] Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1
2014/11/23 23:58:43 C1D418 c [ADD PID 0] CAID: 1833 ECM_PID: 18B6 PROVID: 000000
2014/11/23 23:58:43 C1D418 c [ADD PID 1] CAID: 09C4 ECM_PID: 1BB6 PROVID: 000000
2014/11/23 23:58:43 C1D418 c [ADD PID 2] CAID: 09AF ECM_PID: 1FB6 PROVID: 000000
2014/11/23 23:58:43 C1D418 c [ADD PID 3] CAID: 098C ECM_PID: 1AB6 PROVID: 000000
2014/11/23 23:58:43 C1D418 c Found 4 ECMpids and 3 STREAMpids in PMT
2014/11/23 23:58:43 C1D418 c [DVBAPI] Receiver wants to demux srvid 0083 on adapter 0000 camask 0008 index 0003 pmtpid 0064
2014/11/23 23:58:43 C1D418 c New program number: 0083 (Sky Cinema HD Germany) [pmt_list_management 3]
2014/11/23 23:58:43 C1D418 c [DVBAPI] Demuxer #0 trying to descramble PID #0 CAID 1833 PROVID 000000 ECMPID 18B6 ANY CHID PMTPID 0064 VPID 04FF
2014/11/23 23:58:44 C1D418 c serverbox (1702/0083/93): found (650 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/23 23:58:46 C2CBE0 c encrypted cccam-client 80.149.99.10 granted (Mutti, au=off)
2014/11/23 23:58:46 C44D90 c encrypted cccam-client 79.204.52.142 granted (Silke, au=off)
2014/11/23 23:58:46 C47E20 c encrypted cccam-client 84.173.38.35 granted (Max, au=off)
2014/11/23 23:58:47 C4AEB0 c encrypted cccam-client 79.204.52.142 granted (Ronny, au=off)
2014/11/23 23:58:50 C4DF40 c encrypted cccam-client 217.91.171.164 granted (Wohn, au=off)
2014/11/23 23:58:50 C1D418 c serverbox (1702/0083/93): found (592 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/23 23:58:57 C1D418 c serverbox (1702/0083/93): found (594 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/23 23:59:04 C1D418 c serverbox (1702/0083/93): found (593 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/23 23:59:09 C47E20 c Max (1702/006B/93): found (591 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:03:09 C1D418 c [ADD PID 0] CAID: 1830 ECM_PID: 1CCC PROVID: 000000
2014/11/24 00:03:09 C1D418 c [ADD PID 1] CAID: 1843 ECM_PID: 19CC PROVID: 000000
2014/11/24 00:03:09 C1D418 c [ADD PID 2] CAID: 1860 ECM_PID: 1ECC PROVID: 000000
2014/11/24 00:03:09 C1D418 c [ADD PID 3] CAID: 098C ECM_PID: 1ACC PROVID: 000000
2014/11/24 00:03:09 C1D418 c [ADD PID 4] CAID: 09C4 ECM_PID: 1BCC PROVID: 000000
2014/11/24 00:03:09 C1D418 c Found 5 ECMpids and 6 STREAMpids in PMT
2014/11/24 00:03:09 C1D418 c [DVBAPI] Receiver wants to demux srvid EF10 on adapter 0000 camask 0008 index 0003 pmtpid 0060
2014/11/24 00:03:09 C1D418 c New program number: EF10 (RTL HD) [pmt_list_management 3]
2014/11/24 00:03:09 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:09 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:09 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:10 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:10 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:10 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:10 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:11 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:11 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:11 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:12 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:12 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:12 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:13 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:13 C47E20 c Max (1702/006B/93): found (594 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:03:13 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:13 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:13 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:14 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:14 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:14 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:15 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:15 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:15 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:16 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:16 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:16 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:16 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:17 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:17 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:17 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:18 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:18 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:18 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:19 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:19 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:19 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:19 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:20 C47E20 c Max (1702/006B/93): found (592 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:03:20 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:20 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:20 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:21 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:21 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:21 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:22 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:22 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:22 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:22 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:23 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:23 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:23 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:24 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:24 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:24 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:25 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:25 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:25 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:25 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:26 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:26 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:26 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:27 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:27 C47E20 c Max (1702/006B/93): found (589 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:03:27 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:27 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:28 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:28 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:28 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:28 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:29 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:29 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:29 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:30 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:30 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:30 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:31 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:31 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:31 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:31 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:32 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:32 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:03:32 C1D418 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:03:33 C1D418 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
-------------------------------------------------------------------------------
>> OSCam << cardserver started at Mon Nov 24 00:04:38 2014
-------------------------------------------------------------------------------
2014/11/24 00:04:38 0 s >> OSCam << cardserver started, version 1.20-unstable_svn, build r10003 (mipsel-unknown-linux-gnu-ssl-libusb-pcsc)
2014/11/24 00:04:38 0 s creating pidfile /tmp/.oscam/oscam.pid with pid 1880
2014/11/24 00:04:38 0 s services reloaded: 0 services freed, 2 services loaded, rejected 0
2014/11/24 00:04:38 0 s userdb reloaded: 6 accounts loaded, 0 expired, 0 disabled
2014/11/24 00:04:38 0 s signal handling initialized
2014/11/24 00:04:38 0 s 221 service-id's loaded in 7 ms
2014/11/24 00:04:38 0 s 154 tier-id's loaded
2014/11/24 00:04:38 0 s 4 provid's loaded
2014/11/24 00:04:38 0 s cccam: initialized (fd=6, port=12000)
2014/11/24 00:04:38 0 s s02_sky [internal] creating thread for device /dev/sci0
2014/11/24 00:04:38 0 s hd02 [internal] creating thread for device /dev/sci1
2014/11/24 00:04:38 0 s loadbalancer: can't read from file /tmp/.oscam/stat
2014/11/24 00:04:38 0 s waiting for local card init
2014/11/24 00:04:38 76F004F8 r s02_sky [internal] Reader initialized (device=/dev/sci0, detect=cd, pll max=27.00 MHz, wanted mhz=5.40 MHz
2014/11/24 00:04:38 76F02468 r hd02 [internal] Reader initialized (device=/dev/sci1, detect=cd, pll max=27.00 MHz, wanted mhz=4.50 MHz
2014/11/24 00:04:38 C321B8 h webif: decompressed 156707 bytes back into 373872 bytes
2014/11/24 00:04:38 C321B8 h HTTP Server running. ip=0.0.0.0 port=17000
2014/11/24 00:04:39 76F004F8 r s02_sky [internal] card detected
2014/11/24 00:04:39 76F02468 r hd02 [internal] card detected
2014/11/24 00:04:39 76F004F8 r s02_sky [internal] Card is present in readerslot!
2014/11/24 00:04:39 76F02468 r hd02 [internal] Card is present in readerslot!
2014/11/24 00:04:39 76F004F8 r s02_sky [internal] Set reader parameters!
2014/11/24 00:04:39 76F004F8 r s02_sky [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/24 00:04:39 76F02468 r hd02 [internal] Set reader parameters!
2014/11/24 00:04:39 76F02468 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/24 00:04:39 76F004F8 r s02_sky [internal] Reset internal cardreader!
2014/11/24 00:04:39 76F02468 r hd02 [internal] Reset internal cardreader!
2014/11/24 00:04:41 76F02468 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/24 00:04:41 76F02468 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/24 00:04:41 76F02468 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/24 00:04:41 76F02468 r hd02 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/11/24 00:04:41 76F02468 r hd02 [internal] Sent reader settings T=0 fs=5 ETU=32 WWT=0 CWT=139 BWT=178571 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/24 00:04:41 76F02468 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/24 00:04:41 76F02468 r hd02 [internal] Card responded ok for ifsd request of 160
2014/11/24 00:04:42 76F004F8 r s02_sky [internal] ATR: 3B 9F 21 0E 49 52 44 45 54 4F 20 41 43 53 03 84 55 FF 80 6D
2014/11/24 00:04:42 76F004F8 r s02_sky [internal] Init card protocol T14, FI=2, F=558, D=1, N=0
2014/11/24 00:04:42 76F004F8 r s02_sky [internal] TEST tempo mhz check = 600 mhz
2014/11/24 00:04:42 76F004F8 r s02_sky [internal] Calculated work ETU is 103.33 us reader mhz = 540
2014/11/24 00:04:42 76F004F8 r s02_sky [internal] Sent reader settings T=14 fs=5 ETU=600 WWT=9600 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=5 I=50 U=0
2014/11/24 00:04:42 76F02468 r hd02 [internal] detect native nagra card
2014/11/24 00:04:43 76F004F8 r s02_sky [internal] PLL Reader: ATR Fsmax is 6 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/24 00:04:44 76F004F8 r s02_sky [internal] detect irdeto tunneled nagra card
2014/11/24 00:04:44 76F004F8 r s02_sky [internal] no rsa key configured -> using irdeto mode
2014/11/24 00:04:44 76F004F8 r s02_sky [internal] detect irdeto card
2014/11/24 00:04:44 76F004F8 r s02_sky [internal] caid: 1702, acs: 3.84, country code: GER
2014/11/24 00:04:44 76F004F8 r s02_sky [internal] providers: 4, ascii serial: ##########, hex serial: ######, hex base: ##
2014/11/24 00:04:45 76F02468 r hd02 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2014/11/24 00:04:46 76F02468 r hd02 [internal] T1 Resync command error, trying to reactivate!
2014/11/24 00:04:46 76F02468 r hd02 [internal] Card is present in readerslot!
2014/11/24 00:04:46 76F02468 r hd02 [internal] Set reader parameters!
2014/11/24 00:04:46 76F02468 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/24 00:04:46 76F02468 r hd02 [internal] Reset internal cardreader!
2014/11/24 00:04:47 76F004F8 r s02_sky [internal] WARNING: For Irdeto cards you will have to set 'cardmhz = 600' in oscam.server
2014/11/24 00:04:47 76F004F8 r s02_sky [internal] active providers: 2 (000000,000000)
2014/11/24 00:04:47 76F004F8 r s02_sky [internal] found card system irdeto
2014/11/24 00:04:47 76F004F8 r s02_sky [irdeto] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2014/11/24 00:04:47 76F02468 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/24 00:04:47 76F02468 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/24 00:04:47 76F02468 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/24 00:04:47 76F02468 r hd02 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/11/24 00:04:47 76F004F8 r s02_sky [irdeto] entitlements for provider: 2, id: 000000
2014/11/24 00:04:47 76F004F8 r s02_sky [irdeto] chid: 05F1, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:47 76F004F8 r s02_sky [irdeto] chid: 0276, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:47 76F004F8 r s02_sky [irdeto] chid: 0609, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:47 76F004F8 r s02_sky [irdeto] chid: 05E8, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:47 76F004F8 r s02_sky [irdeto] chid: 0605, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:47 76F004F8 r s02_sky [irdeto] chid: 00F0, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:47 76F004F8 r s02_sky [irdeto] chid: 04CE, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:47 76F004F8 r s02_sky [irdeto] chid: 7D23, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:47 76F004F8 r s02_sky [irdeto] chid: 0617, date: 2011/07/12 - 2012/03/22
2014/11/24 00:04:47 76F004F8 r s02_sky [irdeto] chid: 0606, date: 2011/06/27 - 2011/11/25
2014/11/24 00:04:48 76F02468 r hd02 [internal] Sent reader settings T=0 fs=5 ETU=32 WWT=0 CWT=139 BWT=178571 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 05DF, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 05DD, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 05F2, date: 2011/06/27 - 2011/11/25
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 000F, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 05FC, date: 2011/06/27 - 2011/11/25
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 7D27, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 05E7, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 05FB, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 05DE, date: 2012/06/11 - 2013/02/20
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 0103, date: 2008/01/19 - 2008/01/21
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 029C, date: 2008/01/19 - 2008/01/21
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 0104, date: 2008/01/19 - 2008/01/21
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 0406, date: 2008/01/19 - 2008/01/21
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 0105, date: 2008/01/19 - 2008/01/21
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] chid: 0004, date: 2008/01/19 - 2008/01/21
2014/11/24 00:04:48 76F02468 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/24 00:04:48 76F02468 r hd02 [internal] Card responded ok for ifsd request of 160
2014/11/24 00:04:48 76F02468 r hd02 [internal] card system not supported
2014/11/24 00:04:48 76F02468 r hd02 [internal] Normal mode failed, reverting to Deprecated Mode
2014/11/24 00:04:48 76F02468 r hd02 [internal] Card is present in readerslot!
2014/11/24 00:04:48 76F02468 r hd02 [internal] Set reader parameters!
2014/11/24 00:04:48 76F02468 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/24 00:04:48 76F004F8 r s02_sky [irdeto] ready for requests
2014/11/24 00:04:48 76F02468 r hd02 [internal] Reset internal cardreader!
2014/11/24 00:04:49 76F02468 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/24 00:04:49 76F02468 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/24 00:04:49 76F02468 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/24 00:04:49 76F02468 r hd02 [internal] Calculated work ETU is 82.67 us reader mhz = 450
2014/11/24 00:04:50 76F02468 r hd02 [internal] Sent reader settings T=0 fs=6 ETU=372 WWT=0 CWT=139 BWT=15371 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/24 00:04:50 76F02468 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 4.50 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/24 00:04:52 76F02468 r hd02 [internal] Warning: Card returned error on setting ifsd value to 160
2014/11/24 00:04:53 76F02468 r hd02 [internal] detect native nagra card
2014/11/24 00:04:54 76F02468 r hd02 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2014/11/24 00:04:55 76F02468 r hd02 [internal] T1 Resync command error, trying to reactivate!
2014/11/24 00:04:55 76F02468 r hd02 [internal] Card is present in readerslot!
2014/11/24 00:04:56 76F02468 r hd02 [internal] Set reader parameters!
2014/11/24 00:04:56 76F02468 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/24 00:04:56 76F02468 r hd02 [internal] Reset internal cardreader!
2014/11/24 00:04:57 76F02468 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/24 00:04:57 76F02468 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/24 00:04:57 76F02468 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/24 00:04:57 76F02468 r hd02 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/11/24 00:04:57 76F02468 r hd02 [internal] Sent reader settings T=0 fs=5 ETU=32 WWT=0 CWT=139 BWT=178571 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/24 00:04:58 76F02468 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/24 00:04:58 76F02468 r hd02 [internal] Card responded ok for ifsd request of 160
2014/11/24 00:05:00 76F02468 r hd02 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2014/11/24 00:05:01 76F02468 r hd02 [internal] T1 Resync command error, trying to reactivate!
2014/11/24 00:05:01 76F02468 r hd02 [internal] Card is present in readerslot!
2014/11/24 00:05:01 76F02468 r hd02 [internal] Set reader parameters!
2014/11/24 00:05:01 76F02468 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/24 00:05:01 76F02468 r hd02 [internal] Reset internal cardreader!
2014/11/24 00:05:02 76F02468 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/24 00:05:02 76F02468 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/24 00:05:02 76F02468 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/24 00:05:02 76F02468 r hd02 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/11/24 00:05:03 76F02468 r hd02 [internal] Sent reader settings T=0 fs=5 ETU=32 WWT=0 CWT=139 BWT=178571 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/24 00:05:03 76F02468 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/24 00:05:03 76F02468 r hd02 [internal] Card responded ok for ifsd request of 160
2014/11/24 00:05:03 76F02468 r hd02 [internal] card system not supported
2014/11/24 00:05:03 76F02468 r hd02 [internal] THIS WAS A FAILED START ATTEMPT No 1 out of max alloted of 1
2014/11/24 00:05:03 76F02468 r hd02 [internal] card initializing error
2014/11/24 00:05:04 0 s init for all local cards done
2014/11/24 00:05:04 0 s anti cascading disabled
2014/11/24 00:05:04 76F04C80 c plain dvbapi-client granted (serverbox, au=auto (3 reader))
2014/11/24 00:05:04 76F04C80 c [DVBAPI] Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1
2014/11/24 00:05:04 76F12940 c anonymous disconnected from 80.149.99.10
2014/11/24 00:05:04 76F0ECE0 c anonymous disconnected from 84.173.38.35
2014/11/24 00:05:04 76F0B080 c anonymous disconnected from 79.204.52.142
2014/11/24 00:05:04 76F10B10 c anonymous disconnected from 217.91.171.164
2014/11/24 00:05:04 76F09250 c anonymous disconnected from 80.149.99.10
2014/11/24 00:05:04 76F16630 c anonymous disconnected from 79.204.52.142
2014/11/24 00:05:04 76F07420 c anonymous disconnected from 217.91.171.164
2014/11/24 00:05:04 76F18510 c anonymous disconnected from 84.173.38.35
2014/11/24 00:05:04 76F0CEB0 c anonymous disconnected from 79.204.52.142
2014/11/24 00:05:06 0 --- Skipped 1 duplicated log lines ---
2014/11/24 00:05:06 76F1A3F0 c encrypted cccam-client 217.91.171.164 granted (Wohn, au=off)
2014/11/24 00:05:09 76F1C220 c encrypted cccam-client 80.149.99.10 granted (Mutti, au=off)
2014/11/24 00:05:09 76F1E050 c encrypted cccam-client 79.204.52.142 granted (Silke, au=off)
2014/11/24 00:05:09 76F1FE80 c encrypted cccam-client 79.204.52.142 granted (Ronny, au=off)
2014/11/24 00:05:10 76F21CB0 c encrypted cccam-client 84.173.38.35 granted (Max, au=off)
2014/11/24 00:05:14 76F21CB0 c Max (1702/006B/93): found (649 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:05:19 76F21CB0 c Max (1702/006B/93): found (595 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:05:26 76F21CB0 c Max (1702/006B/93): found (597 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:05:29 76F04C80 c [ADD PID 0] CAID: 1830 ECM_PID: 1CCC PROVID: 000000
2014/11/24 00:05:29 76F04C80 c [ADD PID 1] CAID: 1843 ECM_PID: 19CC PROVID: 000000
2014/11/24 00:05:29 76F04C80 c [ADD PID 2] CAID: 1860 ECM_PID: 1ECC PROVID: 000000
2014/11/24 00:05:29 76F04C80 c [ADD PID 3] CAID: 098C ECM_PID: 1ACC PROVID: 000000
2014/11/24 00:05:29 76F04C80 c [ADD PID 4] CAID: 09C4 ECM_PID: 1BCC PROVID: 000000
2014/11/24 00:05:29 76F04C80 c Found 5 ECMpids and 6 STREAMpids in PMT
2014/11/24 00:05:29 76F04C80 c [DVBAPI] Receiver wants to demux srvid EF10 on adapter 0000 camask 0008 index 0003 pmtpid 0060
2014/11/24 00:05:29 76F04C80 c New program number: EF10 (RTL HD) [pmt_list_management 3]
2014/11/24 00:05:29 76F04C80 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:05:29 76F04C80 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:05:29 76F04C80 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:05:29 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:05:29 0 --- Skipped 6 duplicated log lines ---
2014/11/24 00:05:29 76F04C80 c [ADD PID 0] CAID: 1833 ECM_PID: 18B6 PROVID: 000000
2014/11/24 00:05:29 76F04C80 c [ADD PID 1] CAID: 09C4 ECM_PID: 1BB6 PROVID: 000000
2014/11/24 00:05:29 76F04C80 c [ADD PID 2] CAID: 09AF ECM_PID: 1FB6 PROVID: 000000
2014/11/24 00:05:29 76F04C80 c [ADD PID 3] CAID: 098C ECM_PID: 1AB6 PROVID: 000000
2014/11/24 00:05:29 76F04C80 c Found 4 ECMpids and 3 STREAMpids in PMT
2014/11/24 00:05:29 76F04C80 c [DVBAPI] Receiver wants to demux srvid 0083 on adapter 0000 camask 0008 index 0003 pmtpid 0064
2014/11/24 00:05:29 76F04C80 c New program number: 0083 (Sky Cinema HD Germany) [pmt_list_management 3]
2014/11/24 00:05:29 76F04C80 c [DVBAPI] Demuxer #0 trying to descramble PID #0 CAID 1833 PROVID 000000 ECMPID 18B6 ANY CHID PMTPID 0064 VPID 04FF
2014/11/24 00:05:31 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:05:31 0 --- Skipped 5 duplicated log lines ---
2014/11/24 00:05:31 76F04C80 c serverbox (1702/0083/93): found (594 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/24 00:05:34 76F21CB0 c Max (1702/006B/93): found (589 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:05:37 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:05:37 76F04C80 c serverbox (1702/0083/93): found (590 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/24 00:05:41 76F21CB0 c Max (1702/006B/93): found (595 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:05:44 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:05:44 76F04C80 c serverbox (1702/0083/93): found (589 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/24 00:05:48 76F21CB0 c Max (1702/006B/93): found (593 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:05:50 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:05:51 0 --- Skipped 3 duplicated log lines ---
2014/11/24 00:05:51 76F04C80 c Found 0 ECMpids and 9 STREAMpids in PMT
2014/11/24 00:05:51 76F04C80 c [DVBAPI] Receiver wants to demux srvid 283E on adapter 0000 camask 0008 index 0003 pmtpid 13F6
2014/11/24 00:05:51 76F04C80 c New program number: 283E (FFFE:283E unknown) [pmt_list_management 3]
2014/11/24 00:05:54 76F04C80 c [ADD PID 0] CAID: 1833 ECM_PID: 18B6 PROVID: 000000
2014/11/24 00:05:54 76F04C80 c [ADD PID 1] CAID: 09C4 ECM_PID: 1BB6 PROVID: 000000
2014/11/24 00:05:54 76F04C80 c [ADD PID 2] CAID: 09AF ECM_PID: 1FB6 PROVID: 000000
2014/11/24 00:05:54 76F04C80 c [ADD PID 3] CAID: 098C ECM_PID: 1AB6 PROVID: 000000
2014/11/24 00:05:54 76F04C80 c Found 4 ECMpids and 3 STREAMpids in PMT
2014/11/24 00:05:54 76F04C80 c [DVBAPI] Receiver wants to demux srvid 0083 on adapter 0000 camask 0008 index 0003 pmtpid 0064
2014/11/24 00:05:54 76F04C80 c New program number: 0083 (Sky Cinema HD Germany) [pmt_list_management 3]
2014/11/24 00:05:54 76F04C80 c [DVBAPI] Demuxer #0 trying to descramble PID #0 CAID 1833 PROVID 000000 ECMPID 18B6 ANY CHID PMTPID 0064 VPID 04FF
2014/11/24 00:05:54 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:05:54 0 --- Skipped 5 duplicated log lines ---
2014/11/24 00:05:54 76F04C80 c serverbox (1702/0083/93): found (595 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/24 00:05:55 76F21CB0 c Max (1702/006B/93): found (804 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:05:58 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:05:58 76F04C80 c serverbox (1702/0083/93): found (592 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/24 00:06:02 76F21CB0 c Max (1702/006B/93): found (593 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:06:05 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:06:05 76F04C80 c serverbox (1702/0083/93): found (595 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/24 00:06:09 76F21CB0 c Max (1702/006B/93): found (595 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:06:12 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:06:12 76F04C80 c serverbox (1702/0083/93): found (590 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/24 00:06:16 76F21CB0 c Max (1702/006B/93): found (591 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:06:19 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:06:19 76F04C80 c serverbox (1702/0083/93): found (594 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/24 00:06:23 76F21CB0 c Max (1702/006B/93): found (591 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:06:26 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:06:26 76F04C80 c serverbox (1702/0083/93): found (593 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/24 00:06:30 76F21CB0 c Max (1702/006B/93): found (593 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:06:33 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:06:33 76F04C80 c serverbox (1702/0083/93): found (592 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/24 00:06:37 76F21CB0 c Max (1702/006B/93): found (600 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:06:40 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:06:40 76F04C80 c serverbox (1702/0083/93): found (599 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/24 00:06:44 76F21CB0 c Max (1702/006B/93): found (595 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:06:47 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:06:47 76F04C80 c serverbox (1702/0083/93): found (594 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/24 00:06:51 76F21CB0 c Max (1702/006B/93): found (594 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:06:54 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:06:54 76F04C80 c serverbox (1702/0083/93): found (594 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
2014/11/24 00:06:58 76F21CB0 c Max (1702/006B/93): found (594 ms) by s02_sky - Sky Hits HD Germany
2014/11/24 00:07:01 76F04C80 c ERROR: Can't open device /dev/dvb/adapter0/ca3 (errno=16 Device or resource busy)
2014/11/24 00:07:01 76F04C80 c serverbox (1702/0083/93): found (592 ms) by s02_sky(btun 1833) - Sky Cinema HD Germany
-------------------------------------------------------------------------------
>> OSCam << cardserver started at Mon Nov 24 00:08:48 2014
-------------------------------------------------------------------------------
2014/11/24 00:08:48 0 s >> OSCam << cardserver started, version 1.20-unstable_svn, build r10003 (mipsel-unknown-linux-gnu-ssl-libusb-pcsc)
2014/11/24 00:08:48 0 s creating pidfile /tmp/.oscam/oscam.pid with pid 2517
2014/11/24 00:08:48 0 s services reloaded: 0 services freed, 2 services loaded, rejected 0
2014/11/24 00:08:48 0 s userdb reloaded: 6 accounts loaded, 0 expired, 0 disabled
2014/11/24 00:08:48 0 s signal handling initialized
2014/11/24 00:08:48 0 s 221 service-id's loaded in 5 ms
2014/11/24 00:08:48 0 s 154 tier-id's loaded
2014/11/24 00:08:48 0 s 4 provid's loaded
2014/11/24 00:08:48 0 s cccam: initialized (fd=6, port=12000)
2014/11/24 00:08:48 0 s s02_sky [internal] creating thread for device /dev/sci0
2014/11/24 00:08:48 0 s hd02 [internal] creating thread for device /dev/sci1
2014/11/24 00:08:48 0 s loadbalancer: can't read from file /tmp/.oscam/stat
2014/11/24 00:08:48 0 s waiting for local card init
2014/11/24 00:08:48 77600588 r s02_sky [internal] Reader initialized (device=/dev/sci0, detect=cd, pll max=27.00 MHz, wanted mhz=5.40 MHz
2014/11/24 00:08:48 776024F8 r hd02 [internal] Reader initialized (device=/dev/sci1, detect=cd, pll max=27.00 MHz, wanted mhz=4.50 MHz
2014/11/24 00:08:48 9441B8 h webif: decompressed 156707 bytes back into 373872 bytes
2014/11/24 00:08:48 9441B8 h HTTP Server running. ip=0.0.0.0 port=17000
2014/11/24 00:08:49 77600588 r s02_sky [internal] card detected
2014/11/24 00:08:49 776024F8 r hd02 [internal] card detected
2014/11/24 00:08:49 776024F8 r hd02 [internal] Card is present in readerslot!
2014/11/24 00:08:49 77600588 r s02_sky [internal] Card is present in readerslot!
2014/11/24 00:08:49 77600588 r s02_sky [internal] Set reader parameters!
2014/11/24 00:08:49 77600588 r s02_sky [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/24 00:08:49 776024F8 r hd02 [internal] Set reader parameters!
2014/11/24 00:08:49 776024F8 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/24 00:08:49 776024F8 r hd02 [internal] Reset internal cardreader!
2014/11/24 00:08:49 77600588 r s02_sky [internal] Reset internal cardreader!
2014/11/24 00:08:50 776024F8 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/24 00:08:50 776024F8 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/24 00:08:50 776024F8 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/24 00:08:50 776024F8 r hd02 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/11/24 00:08:51 776024F8 r hd02 [internal] Sent reader settings T=0 fs=5 ETU=32 WWT=0 CWT=139 BWT=178571 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/24 00:08:51 776024F8 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/24 00:08:51 776024F8 r hd02 [internal] Card responded ok for ifsd request of 160
2014/11/24 00:08:51 77600588 r s02_sky [internal] ATR: 3B 9F 21 0E 49 52 44 45 54 4F 20 41 43 53 03 84 55 FF 80 6D
2014/11/24 00:08:51 77600588 r s02_sky [internal] Init card protocol T14, FI=2, F=558, D=1, N=0
2014/11/24 00:08:51 77600588 r s02_sky [internal] TEST tempo mhz check = 600 mhz
2014/11/24 00:08:51 77600588 r s02_sky [internal] Calculated work ETU is 103.33 us reader mhz = 540
2014/11/24 00:08:52 77600588 r s02_sky [internal] Sent reader settings T=14 fs=5 ETU=600 WWT=9600 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=5 I=50 U=0
2014/11/24 00:08:52 776024F8 r hd02 [internal] detect native nagra card
2014/11/24 00:08:52 77600588 r s02_sky [internal] PLL Reader: ATR Fsmax is 6 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/24 00:08:53 77600588 r s02_sky [internal] detect irdeto tunneled nagra card
2014/11/24 00:08:53 77600588 r s02_sky [internal] no rsa key configured -> using irdeto mode
2014/11/24 00:08:53 77600588 r s02_sky [internal] detect irdeto card
2014/11/24 00:08:53 77600588 r s02_sky [internal] caid: 1702, acs: 3.84, country code: GER
2014/11/24 00:08:53 77600588 r s02_sky [internal] providers: 4, ascii serial: ##########, hex serial: ######, hex base: ##
2014/11/24 00:08:54 776024F8 r hd02 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2014/11/24 00:08:55 776024F8 r hd02 [internal] T1 Resync command error, trying to reactivate!
2014/11/24 00:08:55 776024F8 r hd02 [internal] Card is present in readerslot!
2014/11/24 00:08:55 776024F8 r hd02 [internal] Set reader parameters!
2014/11/24 00:08:55 776024F8 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/24 00:08:55 776024F8 r hd02 [internal] Reset internal cardreader!
2014/11/24 00:08:56 77600588 r s02_sky [internal] WARNING: For Irdeto cards you will have to set 'cardmhz = 600' in oscam.server
2014/11/24 00:08:56 77600588 r s02_sky [internal] active providers: 2 (000000,000000)
2014/11/24 00:08:56 77600588 r s02_sky [internal] found card system irdeto
2014/11/24 00:08:56 77600588 r s02_sky [irdeto] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2014/11/24 00:08:57 776024F8 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/24 00:08:57 776024F8 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/24 00:08:57 776024F8 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/24 00:08:57 776024F8 r hd02 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] entitlements for provider: 2, id: 000000
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 05F1, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 0276, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 0609, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 05E8, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 0605, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 00F0, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 04CE, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 7D23, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 0617, date: 2011/07/12 - 2012/03/22
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 0606, date: 2011/06/27 - 2011/11/25
2014/11/24 00:08:57 776024F8 r hd02 [internal] Sent reader settings T=0 fs=5 ETU=32 WWT=0 CWT=139 BWT=178571 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 05DF, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 05DD, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 05F2, date: 2011/06/27 - 2011/11/25
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 000F, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 05FC, date: 2011/06/27 - 2011/11/25
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 7D27, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 05E7, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 05FB, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 05DE, date: 2012/06/11 - 2013/02/20
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 0103, date: 2008/01/19 - 2008/01/21
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 029C, date: 2008/01/19 - 2008/01/21
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 0104, date: 2008/01/19 - 2008/01/21
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 0406, date: 2008/01/19 - 2008/01/21
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 0105, date: 2008/01/19 - 2008/01/21
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] chid: 0004, date: 2008/01/19 - 2008/01/21
2014/11/24 00:08:57 776024F8 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/24 00:08:57 776024F8 r hd02 [internal] Card responded ok for ifsd request of 160
2014/11/24 00:08:57 776024F8 r hd02 [internal] card system not supported
2014/11/24 00:08:57 776024F8 r hd02 [internal] Normal mode failed, reverting to Deprecated Mode
2014/11/24 00:08:57 776024F8 r hd02 [internal] Card is present in readerslot!
2014/11/24 00:08:57 776024F8 r hd02 [internal] Set reader parameters!
2014/11/24 00:08:57 776024F8 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/24 00:08:57 77600588 r s02_sky [irdeto] ready for requests
2014/11/24 00:08:58 776024F8 r hd02 [internal] Reset internal cardreader!
2014/11/24 00:08:59 776024F8 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/24 00:08:59 776024F8 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/24 00:08:59 776024F8 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/24 00:08:59 776024F8 r hd02 [internal] Calculated work ETU is 82.67 us reader mhz = 450
2014/11/24 00:08:59 776024F8 r hd02 [internal] Sent reader settings T=0 fs=6 ETU=372 WWT=0 CWT=139 BWT=15371 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/24 00:09:00 776024F8 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 4.50 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/24 00:09:01 776024F8 r hd02 [internal] Warning: Card returned error on setting ifsd value to 160
2014/11/24 00:09:02 776024F8 r hd02 [internal] detect native nagra card
2014/11/24 00:09:03 776024F8 r hd02 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2014/11/24 00:09:05 776024F8 r hd02 [internal] T1 Resync command error, trying to reactivate!
2014/11/24 00:09:05 776024F8 r hd02 [internal] Card is present in readerslot!
2014/11/24 00:09:05 776024F8 r hd02 [internal] Set reader parameters!
2014/11/24 00:09:05 776024F8 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/24 00:09:05 776024F8 r hd02 [internal] Reset internal cardreader!
2014/11/24 00:09:07 776024F8 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/24 00:09:07 776024F8 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/24 00:09:07 776024F8 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/24 00:09:07 776024F8 r hd02 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/11/24 00:09:07 776024F8 r hd02 [internal] Sent reader settings T=0 fs=5 ETU=32 WWT=0 CWT=139 BWT=178571 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/24 00:09:07 776024F8 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/24 00:09:07 776024F8 r hd02 [internal] Card responded ok for ifsd request of 160
2014/11/24 00:09:09 776024F8 r hd02 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2014/11/24 00:09:10 776024F8 r hd02 [internal] T1 Resync command error, trying to reactivate!
2014/11/24 00:09:10 776024F8 r hd02 [internal] Card is present in readerslot!
2014/11/24 00:09:10 776024F8 r hd02 [internal] Set reader parameters!
2014/11/24 00:09:10 776024F8 r hd02 [internal] Sent reader setting at cardinit T=0 fs=27 ETU=372 WWT=0 CWT=0 BWT=0 EGT=0 clock=0 check=0 P=0 I=0 U=0
2014/11/24 00:09:11 776024F8 r hd02 [internal] Reset internal cardreader!
2014/11/24 00:09:12 776024F8 r hd02 [internal] ATR: 3F FF 95 00 FF 91 81 71 A0 47 00 44 4E 41 53 50 31 38 30 20 4D 65 72 30 30 30 28
2014/11/24 00:09:12 776024F8 r hd02 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/11/24 00:09:12 776024F8 r hd02 [internal] TEST tempo mhz check = 500 mhz
2014/11/24 00:09:12 776024F8 r hd02 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/11/24 00:09:12 776024F8 r hd02 [internal] Sent reader settings T=0 fs=5 ETU=32 WWT=0 CWT=139 BWT=178571 EGT=0 clock=0 check=0 P=5 I=25 U=0
2014/11/24 00:09:13 776024F8 r hd02 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/11/24 00:09:13 776024F8 r hd02 [internal] Card responded ok for ifsd request of 160
2014/11/24 00:09:13 776024F8 r hd02 [internal] card system not supported
2014/11/24 00:09:13 776024F8 r hd02 [internal] THIS WAS A FAILED START ATTEMPT No 1 out of max alloted of 1
2014/11/24 00:09:13 776024F8 r hd02 [internal] card initializing error
2014/11/24 00:09:13 0 s init for all local cards done
2014/11/24 00:09:13 0 s anti cascading disabled
2014/11/24 00:09:13 77605748 c plain dvbapi-client granted (serverbox, au=auto (3 reader))
2014/11/24 00:09:13 77605748 c [DVBAPI] Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1
2014/11/24 00:09:13 776146D8 c anonymous disconnected from 79.204.52.142
2014/11/24 00:09:13 7760CE18 c anonymous disconnected from 84.173.38.35
2014/11/24 00:09:13 77610A78 c anonymous disconnected from 80.149.99.10
2014/11/24 00:09:13 77616508 c anonymous disconnected from 84.173.38.35
2014/11/24 00:09:13 7761A168 c anonymous disconnected from 80.149.99.10
2014/11/24 00:09:13 776091B8 c anonymous disconnected from 79.204.52.142
2014/11/24 00:09:13 7760EC48 c anonymous disconnected from 217.91.171.164
2014/11/24 00:09:13 776128A8 c anonymous disconnected from 79.204.52.142
2014/11/24 00:09:13 0 --- Skipped 1 duplicated log lines ---
2014/11/24 00:09:13 77618338 c anonymous disconnected from 217.91.171.164
2014/11/24 00:09:15 77605748 c [ADD PID 0] CAID: 1830 ECM_PID: 1CEA PROVID: 000000
2014/11/24 00:09:15 77605748 c [ADD PID 1] CAID: 1843 ECM_PID: 19EA PROVID: 000000
2014/11/24 00:09:15 77605748 c [ADD PID 2] CAID: 09C4 ECM_PID: 1BEA PROVID: 000000
2014/11/24 00:09:15 77605748 c [ADD PID 3] CAID: 098C ECM_PID: 1AEA PROVID: 000000
2014/11/24 00:09:15 77605748 c [ADD PID 4] CAID: 1860 ECM_PID: 1EEA PROVID: 000000
2014/11/24 00:09:15 77605748 c Found 5 ECMpids and 5 STREAMpids in PMT
2014/11/24 00:09:15 77605748 c [DVBAPI] Receiver wants to demux srvid EF74 on adapter 0000 camask 0008 index 0003 pmtpid 0060
2014/11/24 00:09:15 77605748 c New program number: EF74 (SAT.1 HD) [pmt_list_management 3]
2014/11/24 00:09:15 77605748 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:09:15 77605748 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:09:16 77605748 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/11/24 00:09:16 7761BF98 c encrypted cccam-client 79.204.52.142 granted (Silke, au=off)
2014/11/24 00:09:16 7761DDC8 c encrypted cccam-client 79.204.52.142 granted (Ronny, au=off)
2014/11/24 00:09:16 77605748 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/11/24 00:09:16 77605748 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!