-------------------------------------------------------------------------------
>> OSCam << cardserver log switched at Fri Jul 8 10:00:53 2016
-------------------------------------------------------------------------------
2016/07/08 10:00:53 00000000 s >> OSCam << cardserver log switched, version 1.20-unstable_svn, build r11271 (x86_64-linux-gnu)
2016/07/08 10:00:53 00000000 s (main) System name = Linux
2016/07/08 10:00:53 00000000 s (main) Host name = yavdr
2016/07/08 10:00:53 00000000 s (main) Release = 3.13.0-91-generic
2016/07/08 10:00:53 00000000 s (main) Version = #138-Ubuntu SMP Fri Jun 24 17:00:34 UTC 2016
2016/07/08 10:00:53 00000000 s (main) Machine = x86_64
2016/07/08 10:00:53 00000000 s (main) creating pidfile /tmp/.oscam/oscam.pid with pid 14711
2016/07/08 10:00:53 00000000 s (config) services reloaded: 0 services freed, 7 services loaded, rejected 0
2016/07/08 10:00:53 00000000 s (config) userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2016/07/08 10:00:53 00000000 s (main) signal handling initialized
2016/07/08 10:00:53 00000000 s (config) 297 service-id's loaded in 0 ms
2016/07/08 10:00:53 00000000 s (net) cccam: initialized (fd=6, port=22765)
2016/07/08 10:00:53 00000000 s (reader) V14 [mouse] creating thread for device /dev/ttyUSB0
2016/07/08 10:00:53 00000000 s (stat) loadbalancer: could not open /tmp/.oscam/stat for reading (errno=2 No such file or directory)
2016/07/08 10:00:53 00000000 s (main) waiting for local card init
2016/07/08 10:00:53 3F9840A9 h (webif) webif: decompressed 174283 bytes back into 424504 bytes
2016/07/08 10:00:53 3F9840A9 h (webif) HTTP Server running. ip=0.0.0.0 port=8083
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Buffers readed 0 bytes total time_us 75092
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 1 value 03 time_us 6042
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 2 value 40 time_us 1844
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 3 value 57 time_us 39980
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 4 value 5b time_us 979
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 5 value bf time_us 1978
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 6 value f5 time_us 1979
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 7 value fe time_us 980
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 8 value 0f time_us 1984
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 9 value 7d time_us 1974
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 10 value f2 time_us 865
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 11 value af time_us 1968
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 12 value 69 time_us 1978
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 13 value 00 time_us 982
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 14 value ad time_us 1978
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 15 value f5 time_us 1980
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 16 value f0 time_us 978
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 17 value ff time_us 1980
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 18 value ff time_us 1980
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 19 value f5 time_us 985
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 20 value 73 time_us 1973
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Flush readed byte Nr 21 value 3f time_us 1972
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Buffers readed 21 bytes total time_us 152901
2016/07/08 10:00:53 19F46706 r (reader) V14 [mouse] Reader initialized (device=/dev/ttyUSB0, detect=cd, mhz=357, cardmhz=357)
2016/07/08 10:00:54 19F46706 r (reader) V14 [mouse] card detected
2016/07/08 10:00:54 19F46706 r (reader) V14 [mouse] Buffers readed 0 bytes total time_us 75099
2016/07/08 10:00:55 19F46706 r (reader) V14 [mouse] ATR: ********************************
2016/07/08 10:00:55 19F46706 r (reader) V14 [mouse] Init card protocol T0, FI=1, F=372, D=16, N=2
2016/07/08 10:00:55 19F46706 r (reader) V14 [mouse] Setting baudrate to 153600 bps
2016/07/08 10:00:55 19F46706 r (reader) V14 [mouse] Calculated work ETU is 6.51 us reader mhz = 357
2016/07/08 10:00:55 19F46706 r (reader) V14 [mouse] Buffers readed 0 bytes total time_us 75090
2016/07/08 10:00:55 19F46706 r (reader) V14 [mouse] ATR Fsmax is 5 MHz, clocking card to wanted user cardspeed off 3.57 MHz (specified in reader->mhz)
2016/07/08 10:00:56 19F46706 r (reader) V14 [mouse] Card type: P1TV
2016/07/08 10:00:56 19F46706 r (reader) V14 [mouse] Rom version: 20AA
2016/07/08 10:00:56 19F46706 r (reader) V14 [mouse] Credit available on card: 0 euro
2016/07/08 10:00:56 19F46706 r (reader) V14 [mouse] Extended 4C detected
2016/07/08 10:00:56 19F46706 r (reader) V14 [mouse] FuseByte: 05
2016/07/08 10:00:56 19F46706 r (reader) V14 [mouse] Region Code: *******
2016/07/08 10:00:56 19F46706 r (reader) V14 [mouse] Country Code: DEU
2016/07/08 10:00:56 19F46706 r (reader) V14 [mouse] Pincode read: ****
2016/07/08 10:00:56 19F46706 r (reader) V14 [mouse] PCB settings: FF FF FF FF
2016/07/08 10:00:56 19F46706 r (reader) V14 [mouse] type: VideoGuard Sky Austria/Germany (098C), caid: 098C
2016/07/08 10:00:56 19F46706 r (reader) V14 [mouse] serial: ########, BoxID: ########, baseyear: 2004
2016/07/08 10:00:56 19F46706 r (reader) V14 [mouse] ready for requests
2016/07/08 10:00:56 19F46706 r (reader) V14 [mouse] found card system videoguard2
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] card detected
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] type: VideoGuard Sky Austria/Germany (098C)
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] ------------------------------------------------------------------
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] |- class -|-- tier --|----- valid to ------|--- package name ----|
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] +---------+----------+---------------------+---------------------+
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] |-- 00 ---|-- 007b --| 2016/03/25-23:57:52 |
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] |-- 00 ---|-- 008e --| 2016/03/25-23:57:52 |
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] |-- 00 ---|-- 00c0 --| 2016/03/25-23:57:52 |
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] |-- 00 ---|-- 00c8 --| 2016/03/25-23:57:52 |
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] |-- 00 ---|-- 00c9 --| 2016/03/25-23:57:52 |
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] |-- 00 ---|-- 00ca --| 2016/03/25-23:57:52 |
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] |-- 00 ---|-- 00c7 --| 2016/03/25-23:57:52 |
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] |-- 00 ---|-- 00f0 --| 2016/03/25-23:57:52 |
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] |-- 00 ---|-- 00fa --| 2016/03/25-23:57:52 |
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] |-- 00 ---|-- 00f3 --| 2016/03/25-23:57:52 |
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] |-- 00 ---|-- 00ff --| 2016/03/25-23:57:52 |
2016/07/08 10:00:56 19F46706 r (reader) V14 [videoguard2] ------------------------------------------------------from-ins70--
2016/07/08 10:00:57 00000000 s (main) init for all local cards done
2016/07/08 10:00:57 00000000 s (emmcache) loaded 0 emmcache records from /etc/oscam/oscam.emmcache in 0 ms
2016/07/08 10:00:57 00000000 s (emmcache) loaded 0 emmstat records from /etc/oscam/oscam.emmstat in 0 ms
2016/07/08 10:00:57 00000000 s (anticasc) anti cascading disabled
2016/07/08 10:00:57 52048538 c (client) plain dvbapi-client granted (vdr, au=on (1 reader))
2016/07/08 10:00:57 52048538 c (dvbapi) dvbapi channelcache loaded from /etc/oscam/oscam.ccache
2016/07/08 10:00:57 52048538 c (dvbapi) Using TCP listen socket, API forced to DVBAPIv3 (0), userconfig boxtype: 11
2016/07/08 10:01:12 52048538 c (dvbapi) Client connected: 'vdr-plugin-dvbapi 2.2.3 / VDR 2.2.0' (protocol version = 2)
2016/07/08 10:01:12 52048538 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 09C4 ECM_PID: 1BD0 PROVID: 000000
2016/07/08 10:01:12 52048538 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 098C ECM_PID: 1AD0 PROVID: 000000
2016/07/08 10:01:12 52048538 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 09AF ECM_PID: 1FD0 PROVID: 000000
2016/07/08 10:01:12 52048538 c (dvbapi) Demuxer 0 found 3 ECMpids and 2 STREAMpids in caPMT
2016/07/08 10:01:12 52048538 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 098C PROVID 000000 ECMPID 1AD0 ANY CHID PMTPID 0000 VPID 07FF
2016/07/08 10:01:13 19F46706 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Card appears in error
2016/07/08 10:01:13 19F46706 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Card needs pairing/extra data
2016/07/08 10:01:13 19F46706 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Tier expired
2016/07/08 10:01:13 19F46706 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Card is not paired (Debug-ECM-Info: 0F_06 00 11 20 00 00 11)
2016/07/08 10:01:13 52048538 c (ecm) vdr (098C@000000/01A1/0011/9D:6CAB24C1312849A25BA6B016B7190785:0F06001120000011): not found (54 ms) by V14 - Sky Sport News
2016/07/08 10:01:13 52048538 c (ecm) vdr (098C@000000/01A1/0011/9D:6CAB24C1312849A25BA6B016B7190785:0F06001120000011): not found (0 ms) by V14 - Sky Sport News
2016/07/08 10:01:15 52048538 c (-) -- Skipped 7 duplicated log lines --
2016/07/08 10:01:15 52048538 c (ecm) vdr (098C@000000/01A1/0011/9D:6CAB24C1312849A25BA6B016B7190785:0F06001120000011): not found (1 ms) by V14 - Sky Sport News
2016/07/08 10:01:16 52048538 c (-) -- Skipped 1 duplicated log lines --
2016/07/08 10:01:16 52048538 c (dvbapi) Demuxer 0 stop descrambling program number 0011 (Sky Sport News)
2016/07/08 10:01:39 52048538 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 09C4 ECM_PID: 1BD0 PROVID: 000000
2016/07/08 10:01:39 52048538 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 098C ECM_PID: 1AD0 PROVID: 000000
2016/07/08 10:01:39 52048538 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 09AF ECM_PID: 1FD0 PROVID: 000000
2016/07/08 10:01:39 52048538 c (dvbapi) Demuxer 0 found 3 ECMpids and 2 STREAMpids in caPMT
2016/07/08 10:01:39 52048538 c (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 098C PROVID 000000 ECMPID 1AD0 ANY CHID PMTPID 0000 VPID 07FF
2016/07/08 10:01:39 19F46706 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Card appears in error
2016/07/08 10:01:39 19F46706 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Card needs pairing/extra data
2016/07/08 10:01:39 19F46706 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Tier expired
2016/07/08 10:01:39 19F46706 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Card is not paired (Debug-ECM-Info: 0F_06 00 11 20 00 00 11)
2016/07/08 10:01:39 52048538 c (ecm) vdr (098C@000000/01A1/0011/9D:F1A9CDE9403D6BAE7EF8FDBA78187263:0F06001120000011): not found (44 ms) by V14 - Sky Sport News
2016/07/08 10:01:39 52048538 c (ecm) vdr (098C@000000/01A1/0011/9D:F1A9CDE9403D6BAE7EF8FDBA78187263:0F06001120000011): not found (1 ms) by V14 - Sky Sport News
2016/07/08 10:01:41 52048538 c (-) -- Skipped 5 duplicated log lines --
2016/07/08 10:01:41 52048538 c (ecm) vdr (098C@000000/01A1/0011/9D:F1A9CDE9403D6BAE7EF8FDBA78187263:0F06001120000011): not found (0 ms) by V14 - Sky Sport News
2016/07/08 10:01:43 52048538 c (-) -- Skipped 6 duplicated log lines --