2015/06/23 15:17:33 0 s >> OSCam << cardserver started, version 1.20-unstable_svn, build r10768 (i486-linux-gnu-ssl)
2015/06/23 15:17:33 0 s (main) System name = Linux
2015/06/23 15:17:33 0 s (main) Host name = S400S014
2015/06/23 15:17:33 0 s (main) Release = 3.2.0-4-486
2015/06/23 15:17:33 0 s (main) Version = #1 Debian 3.2.63-2+deb7u1
2015/06/23 15:17:33 0 s (main) Machine = i686
2015/06/23 15:17:33 0 s (main) creating pidfile /tmp/.oscam/oscam.pid with pid 27306
2015/06/23 15:17:33 0 s (config) services reloaded: 0 services freed, 0 services loaded, rejected 0
2015/06/23 15:17:33 0 s (config) userdb reloaded: 13 accounts loaded, 0 expired, 0 disabled
2015/06/23 15:17:33 0 s (main) signal handling initialized
2015/06/23 15:17:33 0 s (config) 249 service-id's loaded in 2 ms
2015/06/23 15:17:33 0 s (config) 37 tier-id's loaded
2015/06/23 15:17:33 0 s (net) cs357x: initialized (fd=5, port=40402)
2015/06/23 15:17:33 0 s (net) cccam: initialized (fd=6, port=15414)
2015/06/23 15:17:33 0 s (reader) KEY-SERVER [cs357x] creating thread for device 127.0.0.1
2015/06/23 15:17:33 0 s (reader)
HD+ [mouse] creating thread for device /dev/READER2
2015/06/23 15:17:33 0 s (reader) sky [mouse] creating thread for device /dev/READER1
2015/06/23 15:17:33 0 s (stat) loadbalancer: could not open /tmp/.oscam/stat for reading (errno=2 No such file or directory)
2015/06/23 15:17:33 0 s (main) waiting for local card init
2015/06/23 15:17:33 97E0600 p (reader) KEY-SERVER [cs357x] proxy 127.0.0.1:33455
2015/06/23 15:17:33 97E0600 p (reader) KEY-SERVER [cs357x] proxy initialized, server 127.0.0.1:33455
2015/06/23 15:17:33 97E26A8 h (webif) webif: decompressed 154636 bytes back into 371276 bytes
2015/06/23 15:17:33 97E26A8 h (webif) load ssl certificate file /usr/local/etc/oscam1/oscam.pem
2015/06/23 15:17:33 97E26A8 h (webif) HTTP Server running. ip=:: port=17414 (SSL)
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Buffers readed 0 bytes total time_us 75143
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Buffers readed 0 bytes total time_us 75120
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 1 value 03 time_us 6032
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 1 value 03 time_us 3023
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 2 value 40 time_us 1945
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 2 value 00 time_us 13952
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 3 value 56 time_us 8960
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 4 value ff time_us 10963
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 3 value 37 time_us 33962
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 4 value 5b time_us 1954
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 5 value bf time_us 1007
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 6 value f5 time_us 1914
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 7 value fe time_us 1961
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 8 value 0f time_us 961
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 5 value 00 time_us 8968
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 9 value 7d time_us 1964
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 10 value f2 time_us 1960
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 11 value af time_us 962
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 12 value 69 time_us 1962
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 13 value 00 time_us 1961
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 6 value 76 time_us 8980
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 14 value ad time_us 965
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 15 value f5 time_us 1965
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 16 value f0 time_us 1961
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 17 value ff time_us 961
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 18 value ff time_us 1962
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 7 value 7e time_us 8933
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 19 value f5 time_us 1967
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 20 value 73 time_us 956
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Flush readed byte Nr 21 value 3f time_us 1963
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 8 value 71 time_us 8962
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 9 value 80 time_us 11957
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 10 value 1d time_us 11961
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 11 value ff time_us 10955
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 12 value dd time_us 11961
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 13 value 8d time_us 11956
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Buffers readed 21 bytes total time_us 147168
2015/06/23 15:17:33 97E1130 r (reader) sky [mouse] Reader initialized (device=/dev/READER1, detect=cd, mhz=357, cardmhz=357)
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 14 value 7d time_us 10994
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 15 value 35 time_us 11925
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 16 value f5 time_us 11954
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 17 value 73 time_us 10957
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 18 value d3 time_us 11958
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 19 value b3 time_us 11962
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 20 value fb time_us 10958
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 21 value b5 time_us 11955
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 22 value 59 time_us 11965
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 23 value 91 time_us 10956
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 24 value 1d time_us 11958
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 25 value 3d time_us 11961
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 26 value 93 time_us 10960
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Flush readed byte Nr 27 value 79 time_us 11960
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Buffers readed 27 bytes total time_us 370171
2015/06/23 15:17:33 97E0B50 r (reader)
HD+ [mouse] Reader initialized (device=/dev/READER2, detect=cd, mhz=600, cardmhz=368)
2015/06/23 15:17:34 97E0B50 r (reader)
HD+ [mouse] card detected
2015/06/23 15:17:34 97E1130 r (reader) sky [mouse] card detected
2015/06/23 15:17:34 97E1130 r (reader) sky [mouse] Buffers readed 0 bytes total time_us 75121
2015/06/23 15:17:34 97E0B50 r (reader)
HD+ [mouse] Buffers readed 0 bytes total time_us 75114
2015/06/23 15:17:35 97E1130 r (reader) sky [mouse] ATR: 3F FD 13 25 02 50 80 0F 41 B0 0A 69 FF 4A 50 F0 00 00 50 31 03
2015/06/23 15:17:35 97E1130 r (reader) sky [mouse] Init card protocol T0, FI=1, F=372, D=4, N=2
2015/06/23 15:17:35 97E1130 r (reader) sky [mouse] Setting baudrate to 38400 bps
2015/06/23 15:17:35 97E1130 r (reader) sky [mouse] Calculated work ETU is 26.05 us reader mhz = 357
2015/06/23 15:17:35 97E1130 r (reader) sky [mouse] Buffers readed 0 bytes total time_us 75117
2015/06/23 15:17:35 97E1130 r (reader) sky [mouse] ATR Fsmax is 5 MHz, clocking card to wanted user cardspeed off 3.57 MHz (specified in reader->mhz)
2015/06/23 15:17:35 97E0B50 r (reader)
HD+ [mouse] 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
2015/06/23 15:17:35 97E0B50 r (reader)
HD+ [mouse] Init card protocol T1, FI=9, F=512, D=16, N=255
2015/06/23 15:17:35 97E0B50 r (reader)
HD+ [mouse] Setting baudrate to 115200 bps
2015/06/23 15:17:35 97E0B50 r (reader)
HD+ [mouse] Calculated work ETU is 5.33 us reader mhz = 600
2015/06/23 15:17:35 97E0B50 r (reader)
HD+ [mouse] Buffers readed 0 bytes total time_us 75118
2015/06/23 15:17:35 97E0B50 r (reader)
HD+ [mouse] ATR Fsmax is 5 MHz, clocking card to wanted user cardspeed off 6.00 MHz (specified in reader->mhz)
2015/06/23 15:17:35 97E0B50 r (reader)
HD+ [mouse] Card responded ok for ifsd request of 251
2015/06/23 15:17:36 97E0B50 r (reader)
HD+ [mouse] detect native nagra card
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [mouse] ready for requests
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [mouse] found card system nagra
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] ROM: D N A S P 1 4 2
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] REV: R e v G C 6
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] SER: ############
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] CAID: 1830
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] Prv.ID: 00 00 34 11 (sysid)
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] Prv.ID: 00 00 00 00
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] IRD ID: ############
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] active to: 2015/08/14 12:59
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] -----------------------------------------
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] |id |tier |valid from |valid to |
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] +----+--------+------------+------------+
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] |8011|0064 |2010/12/03 |2011/12/04 |
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] |8011|0065 |1992/01/01 |1993/01/01 |
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] |8011|0BEA |2011/12/29 |2016/02/01 |
2015/06/23 15:17:37 97E0B50 r (reader)
HD+ [nagra] -----------------------------------------
2015/06/23 15:17:39 97E1130 r (reader) sky [mouse] card system not supported
2015/06/23 15:17:39 97E1130 r (reader) sky [mouse] Normal mode failed, reverting to Deprecated Mode
2015/06/23 15:17:39 97E1130 r (reader) sky [mouse] Buffers readed 0 bytes total time_us 75126
2015/06/23 15:17:40 97E1130 r (reader) sky [mouse] ATR: 3F FD 13 25 02 50 80 0F 41 B0 0A 69 FF 4A 50 F0 00 00 50 31 03
2015/06/23 15:17:40 97E1130 r (reader) sky [mouse] Init card protocol T0, FI=1, F=372, D=4, N=2
2015/06/23 15:17:40 97E1130 r (reader) sky [mouse] Calculated work ETU is 104.20 us reader mhz = 357
2015/06/23 15:17:41 97E1130 r (reader) sky [mouse] Buffers readed 0 bytes total time_us 75118
2015/06/23 15:17:41 97E1130 r (reader) sky [mouse] ATR Fsmax is 5 MHz, clocking card to wanted user cardspeed off 3.57 MHz (specified in reader->mhz)
2015/06/23 15:17:45 97E1130 r (reader) sky [mouse] card system not supported
2015/06/23 15:17:45 97E1130 r (reader) sky [mouse] THIS WAS A FAILED START ATTEMPT No 1 out of max alloted of 1
2015/06/23 15:17:45 97E1130 r (reader) sky [mouse] card initializing error
2015/06/23 15:17:45 0 s (main) init for all local cards done
2015/06/23 15:17:45 0 s (emmcache) loaded 657 emmcache records from /usr/local/etc/oscam1/oscam.emmcache in 18 ms
2015/06/23 15:17:45 0 s (emmcache) loaded 42 emmstat records from /usr/local/etc/oscam1/oscam.emmstat in 1 ms
2015/06/23 15:17:45 0 s (anticasc) anti cascading log initialized