-------------------------------------------------------------------------------
>> OSCam << cardserver log switched at Tue Jun 28 13:07:33 2016
-------------------------------------------------------------------------------
2016/06/28 13:07:33 00000000 s >> OSCam << cardserver log switched, version 1.20-unstable_svn, build r11209 (mipsel-unknown-linux-gnu)
2016/06/28 13:07:33 00000000 s (main) System name = Linux
2016/06/28 13:07:33 00000000 s (main) Host name = dm8000
2016/06/28 13:07:33 00000000 s (main) Release = 3.2-dm8000
2016/06/28 13:07:33 00000000 s (main) Version = #1 SMP Sun Jun 21 17:23:43 CEST 2015
2016/06/28 13:07:33 00000000 s (main) Machine = mips
2016/06/28 13:07:33 00000000 s (main) Stb model = dm8000
2016/06/28 13:07:33 00000000 s (main) creating pidfile /tmp/.oscam/oscam.pid with pid 590
2016/06/28 13:07:33 00000000 s (config) services reloaded: 0 services freed, 17 services loaded, rejected 0
2016/06/28 13:07:33 00000000 s [Emu] oscam-emu version 728
2016/06/28 13:07:34 00000000 s (config) userdb reloaded: 18 accounts loaded, 0 expired, 0 disabled
2016/06/28 13:07:34 00000000 s (main) signal handling initialized
2016/06/28 13:07:34 00000000 s (config) 986 provid's loaded
-------------------------------------------------------------------------------
>> OSCam << cardserver log switched at Tue Jun 28 13:07:34 2016
-------------------------------------------------------------------------------
2016/06/28 13:07:34 00000000 s >> OSCam << cardserver log switched, version 1.20-unstable_svn, build r11209 (mipsel-unknown-linux-gnu)
2016/06/28 13:07:34 00000000 s (main) System name = Linux
2016/06/28 13:07:34 00000000 s (main) Host name = dm8000
2016/06/28 13:07:34 00000000 s (main) Release = 3.2-dm8000
2016/06/28 13:07:34 00000000 s (main) Version = #1 SMP Sun Jun 21 17:23:43 CEST 2015
2016/06/28 13:07:34 00000000 s (main) Machine = mips
2016/06/28 13:07:34 00000000 s (main) Stb model = dm8000
2016/06/28 13:07:34 00000000 s (config) 521 service-id's loaded in 59 ms
2016/06/28 13:07:34 00000000 s (main) creating pidfile /tmp/.oscam/oscam.pid with pid 601
2016/06/28 13:07:34 00000000 s (config) 85 tier-id's loaded
2016/06/28 13:07:34 00000000 s (config) 1 entries read from oscam.whitelist
2016/06/28 13:07:34 00000000 s (net) cs357x: initialized (fd=5, port=xxxxx)
2016/06/28 13:07:34 00000000 s (net) cccam: initialized (fd=6, port=xxxxx)
2016/06/28 13:07:34 00000000 s (config) services reloaded: 0 services freed, 17 services loaded, rejected 0
2016/06/28 13:07:34 00000000 s (reader) sci0 [internal] creating thread for device /dev/sci0
2016/06/28 13:07:34 00000000 s (reader) sci1 [internal] creating thread for device /dev/sci1
2016/06/28 13:07:34 00000000 s (reader) emulator [emu] creating thread for device emulator
2016/06/28 13:07:34 00000000 s (stat) loadbalancer: could not open /tmp/.oscam/stat for reading (errno=2 No such file or directory)
2016/06/28 13:07:34 00000000 s (main) waiting for local card init
2016/06/28 13:07:34 00000000 s [Emu] oscam-emu version 728
2016/06/28 13:07:34 00000000 s (config) userdb reloaded: 18 accounts loaded, 0 expired, 0 disabled
2016/06/28 13:07:34 00000000 s (main) signal handling initialized
2016/06/28 13:07:34 5382BAF7 r (reader) sci1 [internal] Reader initialized (device=/dev/sci1, detect=cd, pll max=27.00 MHz, wanted mhz=3.85 MHz)
2016/06/28 13:07:34 5382BAF7 r (reader) sci1 [internal] Reader sci internal, detected box type: dm8000
2016/06/28 13:07:34 40D055F2 r (reader) sci0 [internal] Reader initialized (device=/dev/sci0, detect=cd, pll max=27.00 MHz, wanted mhz=4.50 MHz)
2016/06/28 13:07:34 40D055F2 r (reader) sci0 [internal] Reader sci internal, detected box type: dm8000
2016/06/28 13:07:34 00000000 s (config) 986 provid's loaded
2016/06/28 13:07:34 5216A4D2 r key file not found in: /usr/keys
2016/06/28 13:07:34 5216A4D2 r key file not found in: /var/keys
2016/06/28 13:07:34 5216A4D2 r (reader) emulator [emu] Reader initialized (device=emulator, detect=cd, mhz=357, cardmhz=357)
2016/06/28 13:07:34 00000000 [Emu] info: FFDecsa parallel mode = 64
2016/06/28 13:07:34 00000000 s (config) 521 service-id's loaded in 29 ms
2016/06/28 13:07:34 00000000 s (config) 85 tier-id's loaded
2016/06/28 13:07:34 00000000 s (config) 1 entries read from oscam.whitelist
2016/06/28 13:07:34 00000000 s (net) cs357x: initialized (fd=5, port=xxxxx)
2016/06/28 13:07:34 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 119 seconds
2016/06/28 13:07:34 43EDBBA5 h (webif) webif: decompressed 166047 bytes back into 394992 bytes
2016/06/28 13:07:34 43EDBBA5 h (webif) HTTP Server running. ip=0.0.0.0 port=16001
2016/06/28 13:07:35 5216A4D2 r (reader) emulator [emu] card detected
2016/06/28 13:07:35 40D055F2 r (reader) sci0 [internal] card detected
2016/06/28 13:07:35 5382BAF7 r (reader) sci1 [internal] card detected
2016/06/28 13:07:35 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 118 seconds
2016/06/28 13:07:36 5216A4D2 r (reader) emulator [emu] found card system emu
2016/06/28 13:07:36 5216A4D2 r (reader) emulator [emu] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2016/06/28 13:07:36 5216A4D2 r key file not found in: /usr/keys
2016/06/28 13:07:36 5216A4D2 r key file not found in: /var/keys
2016/06/28 13:07:36 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 117 seconds
2016/06/28 13:07:36 40D055F2 r (reader) sci0 [internal] ATR: 3F FD 15 25 02 50 80 0F 41 B0 0A 69 FF 4A 50 F0 00 00 50 31 03
2016/06/28 13:07:36 40D055F2 r (reader) sci0 [internal] Init card protocol T0, FI=1, F=372, D=16, N=2
2016/06/28 13:07:36 40D055F2 r (reader) sci0 [internal] Calculated work ETU is 5.17 us reader mhz = 450
2016/06/28 13:07:36 40D055F2 r (reader) sci0 [internal] Buffers readed 0 bytes total time_us 75219
2016/06/28 13:07:36 5382BAF7 r (reader) sci1 [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
2016/06/28 13:07:36 5382BAF7 r (reader) sci1 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2016/06/28 13:07:36 5382BAF7 r (reader) sci1 [internal] Calculated work ETU is 8.31 us reader mhz = 385
2016/06/28 13:07:37 5382BAF7 r (reader) sci1 [internal] Buffers readed 0 bytes total time_us 75206
2016/06/28 13:07:37 40D055F2 r (reader) sci0 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 4.50 Mhz (nearest possible mhz specified reader->mhz)
2016/06/28 13:07:37 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 116 seconds
2016/06/28 13:07:37 5382BAF7 r (reader) sci1 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 3.85 Mhz (nearest possible mhz specified reader->mhz)
2016/06/28 13:07:37 5382BAF7 r (reader) sci1 [internal] Card responded ok for ifsd request of 251
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [internal] Card type: P1TV
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [internal] Rom version: 20AA
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [internal] Credit available on card: 0 euro
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [internal] Extended 4C detected
2016/06/28 13:07:38 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 115 seconds
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [internal] FuseByte: 25
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [internal] Region Code: 00BO0102
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [internal] Country Code: DEU
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [internal] Pincode read: 1204
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [internal] PCB settings: FF FF FF FF
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [internal] type: VideoGuard Sky Austria/Germany (098C), caid: 098C
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [internal] serial: ########, BoxID: ########, baseyear: 2004
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [internal] ready for requests
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [internal] found card system videoguard2
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] card detected
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] type: VideoGuard Sky Austria/Germany (098C)
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] ------------------------------------------------------------------
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |- class -|-- tier --|----- valid to ------|--- package name ----|
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] +---------+----------+---------------------+---------------------+
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 0038 --| 2016/07/17-01:00:00 |
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 003a --| 2016/07/17-01:00:00 |
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 003b --| 2016/07/17-01:00:00 |
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 0037 --| 2016/07/17-01:00:00 |
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 007b --| 2016/07/17-01:00:00 | Sky AT/DE / 19.2E / de
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 007d --| 2016/07/17-01:00:00 | Sky Sport SD
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 0081 --| 2016/07/17-01:00:00 | Sky Bundesliga SD
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 008e --| 2016/07/17-01:00:00 | Beate-Uhse.tv
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 00c0 --| 2016/07/17-01:00:00 | Sky Welt Extra
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 00c8 --| 2016/07/17-01:00:00 | Sky Film SD
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 00c9 --| 2016/07/17-01:00:00 | Sky Welt HD
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 00ca --| 2016/07/17-01:00:00 | Sky Film HD
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 00cb --| 2016/07/17-01:00:00 | Sky Sport HD
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 00c7 --| 2016/07/17-01:00:00 | Sky Welt SD
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 00fa --| 2016/07/17-01:00:00 | Sky AT/DE / 19.2E / de
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] |-- 00 ---|-- 00f3 --| 2016/07/17-01:00:00 | Sky Blue Movie Info
2016/06/28 13:07:38 5382BAF7 r (reader) sci1 [internal] detect native nagra card
2016/06/28 13:07:38 40D055F2 r (reader) sci0 [videoguard2] ------------------------------------------------------from-ins70--
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [internal] ready for requests
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [internal] found card system nagra
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] ROM: D N A S P 1 4 2
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] REV: R e v G C 6
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] SER: ############
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] CAID: 1830
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] Prv.ID: 00 00 34 11 (sysid)
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] Prv.ID: 00 00 00 00
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] IRD ID: ############
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] active to: 2016/08/19 12:59
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] -----------------------------------------
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] |id |tier |valid from |valid to |
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] +----+--------+------------+------------+
2016/06/28 13:07:39 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 114 seconds
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] |8011|0064 |2011/10/15 |2012/10/15 |
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] |8011|0065 |1992/01/01 |1993/01/01 |
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] |8011|0BEA |2012/10/23 |2017/04/09 |
2016/06/28 13:07:39 5382BAF7 r (reader) sci1 [nagra] -----------------------------------------
2016/06/28 13:07:40 00000000 s (main) init for all local cards done
2016/06/28 13:07:40 00000000 s (anticasc) anti cascading disabled
2016/06/28 13:07:40 3387A712 c (client) plain dvbapi-client granted (local, au=on (2 reader))
2016/06/28 13:07:40 27883D32 c (client) encrypted cccam-client granted (schalfzimmer, au=off)
2016/06/28 13:07:40 3387A712 c (dvbapi) dvbapi channelcache loaded from /usr/keys/oscam.ccache
2016/06/28 13:07:40 65B3E29E c (client) anonymous disconnected from
2016/06/28 13:07:40 3387A712 c (dvbapi) Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1 maximum amount of possible filters is 32 (oscam limit is 32)
2016/06/28 13:07:40 607CB728 c (client) anonymous disconnected from
2016/06/28 13:07:40 05BB19EC c (client) encrypted cccam-client granted (, au=off)
2016/06/28 13:07:40 0CEA1EBF c (client) encrypted cccam-client granted (, au=off)
2016/06/28 13:07:40 22056570 c (client) encrypted cccam-client granted (, au=off)
2016/06/28 13:07:40 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 113 seconds
2016/06/28 13:07:41 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 112 seconds
2016/06/28 13:07:41 79EFF8DE c (client) encrypted cccam-client XXXXXXXXXXXX granted (Raul, au=off)
2016/06/28 13:07:42 0CEA1EBF c (ecm) Edmund (1830@000000/0000/EF10/92:F835C03403AA82C794029DE085F0A01F): found (303 ms) by sci1 - RTL HD
2016/06/28 13:07:42 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 111 seconds
2016/06/28 13:07:43 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 110 seconds
2016/06/28 13:07:43 40D055F2 r (reader) sci0 [videoguard2] classD3 ins54: no cw --> Tier expired
2016/06/28 13:07:43 40D055F2 r (reader) sci0 [videoguard2] classD3 ins54: no cw --> Card is prepaired / Card is paired, but the pairing is deactivated (Debug-ECM-Info: 0F_06 00 00 20 00 00 02)
2016/06/28 13:07:43 79EFF8DE c (ecm) Raul (098C@000000/076E/1334/98:B29E5A53D44BD8B8BDED9C9F89F7A594:0F06000020): not found (63 ms) by sci0 - ORF2N HD
2016/06/28 13:07:44 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 109 seconds
2016/06/28 13:07:44 27883D32 c (ecm) schalfzimmer (098C@000000/0C1E/006B/9D:886E8400680D233C26643F222F95C2C9:0F06000000:Sky Film HD): found (78 ms) by sci0 - Sky Hits HD
2016/06/28 13:07:45 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 108 seconds
2016/06/28 13:07:45 79EFF8DE c (ecm) (1830@000000/0000/2777/92:F691247C051A0CD2C4B09A7EBC01A35B): found (287 ms) by sci1 - MTV HD
2016/06/28 13:07:45 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:07:45 79EFF8DE c (ecm) (090F@000000/016D/1162/A6:B98D44247B5121297A0F96C869426E1D): not found (4 ms) by emulator
2016/06/28 13:07:46 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 107 seconds
2016/06/28 13:07:47 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:07:47 79EFF8DE c (ecm) (090F@000000/017B/0D70/A6:930F5D094AFEF032A190C263260BA1C5): not found (3 ms) by emulator
2016/06/28 13:07:47 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 106 seconds
2016/06/28 13:07:48 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 105 seconds
2016/06/28 13:07:48 79EFF8DE c (ecm) (1830@000000/0000/126E/92:B9717DCFD797BAF3FB2F99ECF4B619B2): not found (256 ms) by sci1 - .1 Testkanal
2016/06/28 13:07:49 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 104 seconds
2016/06/28 13:07:49 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:07:49 79EFF8DE c (ecm) (090F@000000/00AB/1F68/95:93B4805B78B828115C3D21776C5EF955): not found (1 ms) by emulator
2016/06/28 13:07:50 50853639 c (client) encrypted cccam-clientXXXXXXXXX granted (Holger, au=off)
2016/06/28 13:07:50 366118DB c (client) encrypted cccam-client XXXXXXXXXX granted (Honda, au=off)
2016/06/28 13:07:50 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 103 seconds
2016/06/28 13:07:51 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 102 seconds
2016/06/28 13:07:51 27883D32 c (ecm) schalfzimmer (098C@000000/0C1E/006B/9D:1A150D3C07E8AF6241763E5FE5B21BBC:0F06000000:Sky Film HD): found (77 ms) by sci0 - Sky Hits HD
2016/06/28 13:07:52 0CEA1EBF c (ecm) Edmund (1830@000000/0000/EF10/92:E9328C03455F9F0C3D68212FB8CD7B8A): found (280 ms) by sci1 - RTL HD
2016/06/28 13:07:52 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 101 seconds
2016/06/28 13:07:53 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 100 seconds
2016/06/28 13:07:54 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 99 seconds
2016/06/28 13:07:54 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:07:54 79EFF8DE c (ecm) Raul (090F@000000/00A3/0FA0/A6:0CFF3261A1865E7EA753FEE09303106D): not found (1 ms) by emulator
2016/06/28 13:07:55 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 98 seconds
2016/06/28 13:07:56 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 97 seconds
2016/06/28 13:07:57 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 96 seconds
2016/06/28 13:07:58 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 95 seconds
2016/06/28 13:07:58 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:07:58 79EFF8DE c (ecm) Raul (090F@000000/01C2/1054/A6:A968112CD5CE6A54527F47231FDF8AB1): not found (2 ms) by emulator
2016/06/28 13:07:58 27883D32 c (ecm) schalfzimmer (098C@000000/0C1E/006B/9D:5C05A1D2B5470C39164DC260BE97BBF5:0F06000000:Sky Film HD): found (77 ms) by sci0 - Sky Hits HD
2016/06/28 13:07:59 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 94 seconds
2016/06/28 13:08:00 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:00 79EFF8DE c (ecm) Raul (090F@000000/00F9/0EE2/A6:632F82FA9143F11D6C67A2AA0DF7D7E3): not found (2 ms) by emulator
2016/06/28 13:08:00 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 93 seconds
2016/06/28 13:08:01 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 92 seconds
2016/06/28 13:08:01 79EFF8DE c (ecm) Raul (4AE1@000000/3B00/792C/6C:6602C5DED3D7CDDFD1918F1C8E75FF60): rejected group (1 ms) (no matching reader)
2016/06/28 13:08:02 0CEA1EBF c (ecm) Edmund (1830@000000/0000/EF10/92:0352DF415367A4E1DBF5C46FE2BD4144): found (287 ms) by sci1 - RTL HD
2016/06/28 13:08:02 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 91 seconds
2016/06/28 13:08:02 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:02 79EFF8DE c (ecm) Raul (090F@000000/016D/1162/A6:9AFED60CE9934311C6780C138CACD023): not found (2 ms) by emulator
2016/06/28 13:08:03 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 90 seconds
2016/06/28 13:08:03 40D055F2 r (reader) sci0 [videoguard2] Not a valid ecm
2016/06/28 13:08:03 79EFF8DE c (ecm) Raul (098C@000000/019E/0022/9D:AC6A132AA65F14B9493037487813EF6E:0F06000000): rejected (2 ms) by sci0 - Sky Atlantic (Invalid ecm type for card)
2016/06/28 13:08:04 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:04 79EFF8DE c (ecm) Raul (090F@000000/00F7/13B0/A6:5E6DA184B3FDE89A0230E281E9EBDDA8): not found (2 ms) by emulator
2016/06/28 13:08:04 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 89 seconds
2016/06/28 13:08:05 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 88 seconds
2016/06/28 13:08:05 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:05 79EFF8DE c (ecm) Raul (090F@000000/018B/1B94/A6:7D29C27E1EABDDEE5BD5F67084C16DDE): not found (1 ms) by emulator
2016/06/28 13:08:05 27883D32 c (ecm) schalfzimmer (098C@000000/0C1E/006B/9D:89D90308BCE6ADEE7D2DD732D08C7900:0F06000000:Sky Film HD): found (76 ms) by sci0 - Sky Hits HD
2016/06/28 13:08:06 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 87 seconds
2016/06/28 13:08:06 79EFF8DE c (ecm) Raul (0500@023800/09E6/4332/2A:A8E5C2376943F6B2A8C8F986907DB576): rejected group (0 ms) (no matching reader)
2016/06/28 13:08:07 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 86 seconds
2016/06/28 13:08:08 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 85 seconds
2016/06/28 13:08:09 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 84 seconds
2016/06/28 13:08:10 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 83 seconds
2016/06/28 13:08:11 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 82 seconds
2016/06/28 13:08:11 79EFF8DE c (ecm) Raul (098C@000000/00EA/00A8/9D:AA1719AA837551E26585F35EA3B3077F:0F06000000:Sky Welt SD): found (77 ms) by sci0 - Motorvision TV
2016/06/28 13:08:12 0CEA1EBF c (ecm) Edmund (1830@000000/0000/EF10/92:460158B4D75D89E0B9040BA6B8403451): found (288 ms) by sci1 - RTL HD
2016/06/28 13:08:12 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 81 seconds
2016/06/28 13:08:12 27883D32 c (ecm) schalfzimmer (098C@000000/0C1E/006B/9D:0A75FBD82486508CB5760550C376794D:0F06000000:Sky Film HD): found (84 ms) by sci0 - Sky Hits HD
2016/06/28 13:08:13 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 80 seconds
2016/06/28 13:08:14 79EFF8DE c (ecm) Raul (0500@000000/4007/245D/8C:8F7D92E9CD5AE2040DA805ED4E979085): rejected group (1 ms) (no matching reader)
2016/06/28 13:08:14 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 79 seconds
2016/06/28 13:08:15 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 78 seconds
2016/06/28 13:08:15 79EFF8DE c (ecm) Raul (4AE1@000000/3B00/792C/6C:E0EA7BD556620064C8456353A440B522): rejected group (0 ms) (no matching reader)
2016/06/28 13:08:15 3387A712 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 09C4 ECM_PID: 1BB6 PROVID: 000000
2016/06/28 13:08:15 3387A712 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 09AF ECM_PID: 1FB6 PROVID: 000000
2016/06/28 13:08:15 3387A712 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 098C ECM_PID: 1AB6 PROVID: 000000
2016/06/28 13:08:15 3387A712 c (dvbapi) Demuxer 0 stream Data-/Audiostream (Subtitles/VBI and AC-3)(type: 06 pid: 0020 length: 0)
2016/06/28 13:08:15 3387A712 c (dvbapi) Demuxer 0 stream Videostream (MPEG-4)(type: 1b pid: 04ff length: 0)
2016/06/28 13:08:15 3387A712 c (dvbapi) Demuxer 0 stream Data-/Audiostream (Subtitles/VBI and AC-3)(type: 06 pid: 0503 length: 0)
2016/06/28 13:08:15 3387A712 c (dvbapi) Demuxer 0 stream Data-/Audiostream (Subtitles/VBI and AC-3)(type: 06 pid: 0504 length: 0)
2016/06/28 13:08:15 3387A712 c (dvbapi) Demuxer 0 found 3 ECMpids and 4 STREAMpids in caPMT
2016/06/28 13:08:15 3387A712 c (dvbapi) Demuxer 0 serving srvid 0083 (Sky Cinema HD) on adapter 0000 camask 0008 index 0003 pmtpid 0064
2016/06/28 13:08:15 3387A712 c (dvbapi) Demuxer 0 trying to descramble PID 2 CAID 098C PROVID 000000 ECMPID 1AB6 ANY CHID PMTPID 0064 VPID 04FF
2016/06/28 13:08:15 3387A712 c (dvbapi) ERROR: ioctl(CA_SET_DESCR_MODE): Invalid argument
2016/06/28 13:08:16 3387A712 c (ecm) local (098C@000000/025B/0083/9D:FCBCDC9FF8FE45505369A9D659711439:0F06000000:Sky Film HD): found (78 ms) by sci0 - Sky Cinema HD
2016/06/28 13:08:16 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 77 seconds
2016/06/28 13:08:16 79EFF8DE c (ecm) Raul (0500@023800/08EA/4332/2A:A0A06D41C74BF15310A0DDF5AFF8E504): rejected group (0 ms) (no matching reader)
2016/06/28 13:08:17 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 76 seconds
2016/06/28 13:08:18 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 75 seconds
2016/06/28 13:08:19 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 74 seconds
2016/06/28 13:08:19 27883D32 c (ecm) schalfzimmer (098C@000000/0C1E/006B/9D:AAC7FF18B7B0D94C5EBE0972FFF0A528:0F06000000:Sky Film HD): found (77 ms) by sci0 - Sky Hits HD
2016/06/28 13:08:20 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 73 seconds
2016/06/28 13:08:20 3387A712 c (dvbapi) ERROR: ioctl(CA_SET_DESCR_MODE): Invalid argument
2016/06/28 13:08:20 3387A712 c (ecm) local (098C@000000/025B/0083/9D
A6A3945367A26076017A4601BBF6ED6:0F06000000:Sky Film HD): found (77 ms) by sci0 - Sky Cinema HD
2016/06/28 13:08:21 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 72 seconds
2016/06/28 13:08:21 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:21 79EFF8DE c (ecm) Raul (090F@000000/01A5/0492/A6:8373BA6AC47DF439BDC6EF9A6B3A5E91): not found (2 ms) by emulator
2016/06/28 13:08:22 0CEA1EBF c (ecm) Edmund (1830@000000/0000/EF10/92:70A7F5DB546CB23C40BBDB9F38CACC53): found (287 ms) by sci1 - RTL HD
2016/06/28 13:08:22 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 71 seconds
2016/06/28 13:08:23 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:23 79EFF8DE c (ecm) Raul (090F@000000/00C2/0B54/A6:F62297F8EE4EBF2D666D0640B17E788A): not found (1 ms) by emulator
2016/06/28 13:08:23 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 70 seconds
2016/06/28 13:08:24 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 69 seconds
2016/06/28 13:08:25 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 68 seconds
2016/06/28 13:08:25 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:25 79EFF8DE c (ecm) Raul (090F@000000/0145/0B5E/A6
94AF9AE692B960697728C5C6A122438): not found (1 ms) by emulator
2016/06/28 13:08:26 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 67 seconds
2016/06/28 13:08:26 27883D32 c (ecm) schalfzimmer (098C@000000/0C1E/006B/9D:1AB4EE13D169321897785CFB0FB2BD5E:0F06000000:Sky Film HD): found (76 ms) by sci0 - Sky Hits HD
2016/06/28 13:08:27 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 66 seconds
2016/06/28 13:08:27 3387A712 c (dvbapi) ERROR: ioctl(CA_SET_DESCR_MODE): Invalid argument
2016/06/28 13:08:27 3387A712 c (ecm) local (098C@000000/025B/0083/9D:C9221AE24C1BC60E75F7DA70224812EF:0F06000000:Sky Film HD): found (78 ms) by sci0 - Sky Cinema HD
2016/06/28 13:08:28 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 65 seconds
2016/06/28 13:08:29 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 64 seconds
2016/06/28 13:08:29 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:29 79EFF8DE c (ecm) Raul (090F@000000/016D/1162/A6:A527E9BF76AA02E5F6931B9BEE1699B1): not found (1 ms) by emulator
2016/06/28 13:08:30 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 63 seconds
2016/06/28 13:08:30 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:30 79EFF8DE c (ecm) Raul (090F@000000/01BB/0668/B7:55F6E2CC8426D3ED299D604AAB503AB1): not found (2 ms) by emulator
2016/06/28 13:08:31 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 62 seconds
2016/06/28 13:08:32 0CEA1EBF c (ecm) Edmund (1830@000000/0000/EF10/92:2942622BB37EA0CAC9A4FAEC226A6241): found (287 ms) by sci1 - RTL HD
2016/06/28 13:08:32 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 61 seconds
2016/06/28 13:08:33 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 60 seconds
2016/06/28 13:08:33 27883D32 c (ecm) schalfzimmer (098C@000000/0C1E/006B/9D:37265DB62515D135CC295245EA8A439D:0F06000000:Sky Film HD): found (76 ms) by sci0 - Sky Hits HD
2016/06/28 13:08:34 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 59 seconds
2016/06/28 13:08:34 3387A712 c (dvbapi) ERROR: ioctl(CA_SET_DESCR_MODE): Invalid argument
2016/06/28 13:08:34 3387A712 c (ecm) local (098C@000000/025B/0083/9D:44EE20B546239A5A80A35B46BE02751D:0F06000000:Sky Film HD): found (77 ms) by sci0 - Sky Cinema HD
2016/06/28 13:08:35 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 58 seconds
2016/06/28 13:08:35 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:35 79EFF8DE c (ecm) Raul (090F@000000/0107/0EF6/A6:ACD5D89123908519BB80387E4FE6432C): not found (1 ms) by emulator
2016/06/28 13:08:36 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 57 seconds
2016/06/28 13:08:36 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:36 79EFF8DE c (ecm) Raul (090F@000000/0208/073A/A6:63DF12A47D6740CCC5B0787507C267CE): not found (1 ms) by emulator
2016/06/28 13:08:37 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 56 seconds
2016/06/28 13:08:38 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 55 seconds
2016/06/28 13:08:39 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 54 seconds
2016/06/28 13:08:40 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:40 79EFF8DE c (ecm) Raul (090F@000000/016D/1162/A6:7D6A2185037149CF6CE327299F824AE7): not found (1 ms) by emulator
2016/06/28 13:08:40 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 53 seconds
2016/06/28 13:08:40 27883D32 c (ecm) schalfzimmer (098C@000000/0C1E/006B/9D:12C6107BA753839FF50654EA31CCAA62:0F06000000:Sky Film HD): found (76 ms) by sci0 - Sky Hits HD
2016/06/28 13:08:41 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 52 seconds
2016/06/28 13:08:41 3387A712 c (dvbapi) ERROR: ioctl(CA_SET_DESCR_MODE): Invalid argument
2016/06/28 13:08:41 3387A712 c (ecm) local (098C@000000/025B/0083/9D:C5D60A1D7D406DC5B5915EA6B47AFF52:0F06000000:Sky Film HD): found (78 ms) by sci0 - Sky Cinema HD
2016/06/28 13:08:41 79EFF8DE c (ecm) Raul (4AE1@000000/3B00/61B2/6C:3C7484418B9108D8D5E2319FFB5450D6): rejected group (0 ms) (no matching reader)
2016/06/28 13:08:42 0CEA1EBF c (ecm) Edmund (1830@000000/0000/EF10/92:5D4A088C929CD9CD7ADDA8D783A45BD4): found (287 ms) by sci1 - RTL HD
2016/06/28 13:08:42 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 51 seconds
2016/06/28 13:08:43 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 50 seconds
2016/06/28 13:08:43 40D055F2 r (reader) sci0 [videoguard2] classD3 ins54: no cw --> Tier expired
2016/06/28 13:08:43 40D055F2 r (reader) sci0 [videoguard2] classD3 ins54: no cw --> Card is prepaired / Card is paired, but the pairing is deactivated (Debug-ECM-Info: 0F_06 00 00 20 00 00 02)
2016/06/28 13:08:43 79EFF8DE c (ecm) Raul (098C@000000/008A/012D/9C:0535BCA45725CA69D95349B09ECFE5F4:0F06000020): not found (54 ms) by sci0 - Sky Select 6
2016/06/28 13:08:44 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 49 seconds
2016/06/28 13:08:45 79EFF8DE c (ecm) (4AE1@000000/3B00/039A/6C:09D90B7E7F3AF808ED0518FF6E60ADDB): rejected group (0 ms) (no matching reader)
2016/06/28 13:08:45 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 48 seconds
2016/06/28 13:08:46 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 47 seconds
2016/06/28 13:08:46 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:46 79EFF8DE c (ecm) (090F@000000/00A3/0FA0/A6:9171428C9D18A3407B08780EB2746515): not found (2 ms) by emulator
2016/06/28 13:08:47 5216A4D2 r [Emu] ECM failed: ECM not supported
2016/06/28 13:08:47 79EFF8DE c (ecm) Raul (090F@000000/0107/0EF6/A6:2EAC3D1DFE0D17FD0C11C49336656CC0): not found (1 ms) by emulator
2016/06/28 13:08:47 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 46 seconds
2016/06/28 13:08:47 27883D32 c (ecm) schalfzimmer (098C@000000/0C1E/006B/9D:A17252214CE089E291C31FCA6323CD5B:0F06000000:Sky Film HD): found (87 ms) by sci0 - Sky Hits HD
2016/06/28 13:08:48 00000000 s (net) cccam: Bind request failed (Address already in use), waiting another 45 seconds
2016/06/28 13:08:48 3387A712 c (dvbapi) ERROR: ioctl(CA_SET_DESCR_MODE): Invalid argument
2016/06/28 13:08:48 3387A712 c (ecm) local (098C@000000/025B/0083/9D:9BC7E1A366B5F8CB9045C689DADAFD5C:0F06000000:Sky Film HD): found (78 ms) by sci0 - Sky Cinema HD
2016/06/28 13:08:48 43EDBBA5 h (webif) all debug_level=0