-------------------------------------------------------------------------------
>> OSCam << cardserver started at Fri Jun 13 22:11:52 2014
-------------------------------------------------------------------------------
2014/06/13 22:11:52 0 s >> OSCam << cardserver started, version 1.20-unstable_svn, build r9761 (mipsel-oe-linux)
2014/06/13 22:11:52 0 s creating pidfile /tmp/.oscam/oscam.pid with pid 26284
2014/06/13 22:11:52 0 s couldn't open statistics file: /media/usb/oscam/user.log
2014/06/13 22:11:52 0 s services reloaded: 0 services freed, 2 services loaded, rejected 0
2014/06/13 22:11:52 0 s userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2014/06/13 22:11:52 0 s signal handling initialized
2014/06/13 22:11:52 0 s hd01 [internal] creating thread for device /dev/sci0
2014/06/13 22:11:52 0 s S02 [internal] creating thread for device /dev/sci1
2014/06/13 22:11:52 0 s loadbalancer: can't read from file /tmp/.oscam/stat
2014/06/13 22:11:52 0 s waiting for local card init
2014/06/13 22:11:52 77500588 r hd01 [internal] Reader initialized (device=/dev/sci0, detect=cd, pll max=27.00 MHz, wanted mhz=3.57 MHz
2014/06/13 22:11:52 775024D0 r S02 [internal] Reader initialized (device=/dev/sci1, detect=cd, mhz=357, cardmhz=357)
2014/06/13 22:11:52 77BDA8 h webif: decompressed 151915 bytes back into 363072 bytes
2014/06/13 22:11:52 77BDA8 h HTTP Server running. ip=0.0.0.0 port=9001
2014/06/13 22:11:53 77500588 r hd01 [internal] card detected
2014/06/13 22:11:53 775024D0 r S02 [internal] card detected
2014/06/13 22:11:55 77500588 r hd01 [internal] ATR: 3F FF 95 00 FF 91 81 71 FE 47 00 44 4E 41 53 50 31 34 32 20 52 65 76 47 43 36 61
2014/06/13 22:11:55 77500588 r hd01 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/06/13 22:11:55 77500588 r hd01 [internal] TEST tempo mhz check = 500 mhz
2014/06/13 22:11:55 77500588 r hd01 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/06/13 22:11:55 77500588 r hd01 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/06/13 22:11:55 77500588 r hd01 [internal] Card responded ok for ifsd request of 251
2014/06/13 22:11:56 77500588 r hd01 [internal] detect native nagra card
2014/06/13 22:11:56 775024D0 r S02 [internal] ATR: 3B 9F 21 0E 49 52 44 45 54 4F 20 41 43 53 03 84 55 FF 80 6D
2014/06/13 22:11:56 775024D0 r S02 [internal] Init card protocol T14, FI=2, F=558, D=1, N=0
2014/06/13 22:11:56 775024D0 r S02 [internal] Calculated work ETU is 93.00 us reader mhz = 600
2014/06/13 22:11:56 775024D0 r S02 [internal] ATR Fsmax is 6 MHz, clocking card to 6.00 (specified in reader->mhz)
2014/06/13 22:11:57 77500588 r hd01 [internal] Negotiate sessionkey was not successful! Please check rsa key and boxkey
2014/06/13 22:11:57 77500588 r hd01 [internal] card system not supported
2014/06/13 22:11:57 77500588 r hd01 [internal] Normal mode failed, reverting to Deprecated Mode
2014/06/13 22:11:57 775024D0 r S02 [internal] detect irdeto tunneled nagra card
2014/06/13 22:11:57 775024D0 r S02 [internal] no rsa key configured -> using irdeto mode
2014/06/13 22:11:57 775024D0 r S02 [internal] detect irdeto card
2014/06/13 22:11:58 77500588 r hd01 [internal] ATR: 3F FF 95 00 FF 91 81 71 FE 47 00 44 4E 41 53 50 31 34 32 20 52 65 76 47 43 36 61
2014/06/13 22:11:58 77500588 r hd01 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/06/13 22:11:58 77500588 r hd01 [internal] TEST tempo mhz check = 500 mhz
2014/06/13 22:11:58 77500588 r hd01 [internal] Calculated work ETU is 82.67 us reader mhz = 450
2014/06/13 22:11:58 77500588 r hd01 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 4.50 Mhz (nearest possible mhz specified reader->cardmhz)
2014/06/13 22:11:59 77500588 r hd01 [internal] Warning: Card returned error on setting ifsd value to 251
2014/06/13 22:12:00 77500588 r hd01 [internal] detect native nagra card
2014/06/13 22:12:02 77500588 r hd01 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2014/06/13 22:12:03 77500588 r hd01 [internal] T1 Resync command error, trying to reactivate!
2014/06/13 22:12:04 775024D0 r S02 [internal] card system not supported
2014/06/13 22:12:04 775024D0 r S02 [internal] Normal mode failed, reverting to Deprecated Mode
2014/06/13 22:12:05 77500588 r hd01 [internal] ATR: 3F FF 95 00 FF 91 81 71 FE 47 00 44 4E 41 53 50 31 34 32 20 52 65 76 47 43 36 61
2014/06/13 22:12:05 77500588 r hd01 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2014/06/13 22:12:05 77500588 r hd01 [internal] TEST tempo mhz check = 500 mhz
2014/06/13 22:12:05 77500588 r hd01 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2014/06/13 22:12:05 77500588 r hd01 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->cardmhz)
2014/06/13 22:12:05 77500588 r hd01 [internal] Card responded ok for ifsd request of 251
2014/06/13 22:12:05 77500588 r hd01 [internal] Negotiate sessionkey was not successful! Please check rsa key and boxkey
2014/06/13 22:12:05 77500588 r hd01 [internal] card system not supported
2014/06/13 22:12:05 77500588 r hd01 [internal] THIS WAS A FAILED START ATTEMPT No 1 out of max alloted of 1
2014/06/13 22:12:05 77500588 r hd01 [internal] card initializing error
2014/06/13 22:12:07 775024D0 r S02 [internal] ATR: 3B 9F 21 0E 49 52 44 45 54 4F 20 41 43 53 03 84 55 FF 80 6D
2014/06/13 22:12:07 775024D0 r S02 [internal] Init card protocol T14, FI=2, F=558, D=1, N=0
2014/06/13 22:12:07 775024D0 r S02 [internal] Calculated work ETU is 62.00 us reader mhz = 600
2014/06/13 22:12:07 775024D0 r S02 [internal] ATR Fsmax is 5 MHz, clocking card to 6.00 (specified in reader->mhz)
2014/06/13 22:12:08 775024D0 r S02 [internal] detect irdeto tunneled nagra card
2014/06/13 22:12:08 775024D0 r S02 [internal] no rsa key configured -> using irdeto mode
2014/06/13 22:12:08 775024D0 r S02 [internal] detect irdeto card
2014/06/13 22:12:13 775024D0 r S02 [internal] card system not supported
2014/06/13 22:12:13 775024D0 r S02 [internal] THIS WAS A FAILED START ATTEMPT No 1 out of max alloted of 1
2014/06/13 22:12:13 775024D0 r S02 [internal] card initializing error
2014/06/13 22:12:13 0 s init for all local cards done
2014/06/13 22:12:13 0 s anti cascading disabled
2014/06/13 22:12:13 77504480 c plain dvbapi-client granted (DVBApiUser, au=auto (2 reader))
2014/06/13 22:12:13 77504480 c [DVBAPI] Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1
2014/06/13 22:12:13 77504480 c [ADD PID 0] CAID: 1843 ECM_PID: 19CC PROVID: 000000
2014/06/13 22:12:13 77504480 c [ADD PID 1] CAID: 098C ECM_PID: 1ACC PROVID: 000000
2014/06/13 22:12:13 77504480 c [ADD PID 2] CAID: 09C4 ECM_PID: 1BCC PROVID: 000000
2014/06/13 22:12:13 77504480 c [ADD PID 3] CAID: 1830 ECM_PID: 1CCC PROVID: 000000
2014/06/13 22:12:13 77504480 c [ADD PID 4] CAID: 1860 ECM_PID: 1ECC PROVID: 000000
2014/06/13 22:12:13 77504480 c Found 5 ECMpids and 7 STREAMpids in PMT
2014/06/13 22:12:13 77504480 c [DVBAPI] Receiver wants to demux srvid EF10 on adapter 0000 camask 0008 index 0003 pmtpid 0060
2014/06/13 22:12:13 77504480 c New program number: EF10 (1843:EF10 unknown) [pmt_list_management 3]
2014/06/13 22:12:13 77504480 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/06/13 22:12:13 77504480 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/06/13 22:12:14 77504480 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/06/13 22:12:14 77504480 c Found 0 ECMpids and 10 STREAMpids in PMT
2014/06/13 22:12:14 77504480 c [DVBAPI] Receiver wants to demux srvid 283D on adapter 0000 camask 0004 index 0002 pmtpid 13EC
2014/06/13 22:12:14 77504480 c New program number: 283D (FFFE:283D unknown) [pmt_list_management 3]
2014/06/13 22:12:14 77504480 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/06/13 22:12:14 77504480 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/06/13 22:12:14 77504480 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/06/13 22:12:15 77504480 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/06/13 22:12:15 77504480 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/06/13 22:12:15 77504480 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/06/13 22:12:15 77504480 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/06/13 22:12:16 77504480 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/06/13 22:12:16 77504480 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/06/13 22:12:16 77504480 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/06/13 22:12:17 77504480 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/06/13 22:12:17 77504480 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!
2014/06/13 22:12:17 77504480 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 5 ecmpids!
2014/06/13 22:12:18 77504480 c [DVBAPI] Demuxer #0 no suitable readers found that can be used for decoding!