Nov 05 17:06:49 archvdr oscam[25247]: 00000000 s >> OSCam << cardserver log switched, version 1.20-unstable_svn, build r11279 (x86_64-pc-linux-gnu-libusb-pcsc)
Nov 05 17:06:49 archvdr oscam[25247]: 00000000 s (main) System name = Linux
Nov 05 17:06:49 archvdr oscam[25247]: 00000000 s (main) Host name = archvdr
Nov 05 17:06:49 archvdr oscam[25247]: 00000000 s (main) Release = 4.8.4-1-ARCH
Nov 05 17:06:49 archvdr oscam[25247]: 00000000 s (main) Version = #1 SMP PREEMPT Sat Oct 22 18:26:57 CEST 2016
Nov 05 17:06:49 archvdr oscam[25247]: 00000000 s (main) Machine = x86_64
Nov 05 17:06:49 archvdr oscam[25247]: 00000000 s (main) creating pidfile /run/oscam.pid with pid 25247
Nov 05 17:06:49 archvdr oscam[25247]: 00000000 s (config) userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
Nov 05 17:06:49 archvdr oscam[25247]: 00000000 s (main) signal handling initialized
Nov 05 17:06:49 archvdr oscam[25247]: 00000000 s (reader) V14 [mouse] creating thread for device /dev/ttyUSB0
Nov 05 17:06:49 archvdr oscam[25247]: 00000000 s (stat) loadbalancer: could not open /tmp/.oscam/stat for reading (errno=2 No such file or directory)
Nov 05 17:06:49 archvdr oscam[25247]: 00000000 s (main) waiting for local card init
Nov 05 17:06:49 archvdr oscam[25247]: 698FF604 h (webif) webif: decompressed 174481 bytes back into 426760 bytes
Nov 05 17:06:49 archvdr oscam[25247]: 698FF604 h (webif) HTTP Server running. ip=:: port=8080
Nov 05 17:06:49 archvdr systemd[1]: oscam.service: Supervising process 25247 which is not our child. We'll most likely not notice when it exits.
Nov 05 17:06:49 archvdr systemd[1]: Started The Open Source Conditional Access Module daemon.
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Buffers readed 0 bytes total time_us 75134
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 1 value 03 time_us 7233
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 2 value 40 time_us 2039
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 3 value 57 time_us 33031
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 4 value 5b time_us 2044
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 5 value bf time_us 11
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 6 value f5 time_us 2064
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 7 value fe time_us 2012
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 8 value 0f time_us 2053
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 9 value 7d time_us 2050
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 10 value f2 time_us 4
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 11 value af time_us 2046
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 12 value 69 time_us 2042
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 13 value 00 time_us 2039
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 14 value ad time_us 2065
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 15 value f5 time_us 11
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 16 value f0 time_us 1997
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 17 value ff time_us 2087
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 18 value ff time_us 2047
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 19 value f5 time_us 1995
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 20 value 73 time_us 12
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Flush readed byte Nr 21 value 3f time_us 2028
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Buffers readed 21 bytes total time_us 146315
Nov 05 17:06:49 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Reader initialized (device=/dev/ttyUSB0, detect=cd, mhz=357, cardmhz=357)
Nov 05 17:06:50 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] card detected
Nov 05 17:06:50 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Buffers readed 0 bytes total time_us 75132
Nov 05 17:06:51 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] ATR: 3F FD 15 25 02 50 80 0F 41 B0 0A 69 FF 4A 50 F0 00 00 50 31 03
Nov 05 17:06:51 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Init card protocol T0, FI=1, F=372, D=16, N=2
Nov 05 17:06:51 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Setting baudrate to 153600 bps
Nov 05 17:06:51 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Calculated work ETU is 6.51 us reader mhz = 357
Nov 05 17:06:51 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Buffers readed 0 bytes total time_us 75113
Nov 05 17:06:51 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] ATR Fsmax is 5 MHz, clocking card to wanted user cardspeed off 3.57 MHz (specified in reader->mhz)
Nov 05 17:06:52 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Card type: P1TV
Nov 05 17:06:52 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Rom version: 20AA
Nov 05 17:06:52 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Credit available on card: 0 euro
Nov 05 17:06:52 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Extended 4C detected
Nov 05 17:06:52 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] FuseByte: 00
Nov 05 17:06:52 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Region Code:
Nov 05 17:06:52 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Country Code: DEU
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] Pincode read: 4277
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] PCB settings: FF FF FF FF
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] type: VideoGuard Sky Austria/Germany (098C), caid: 098C
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] serial: ########, BoxID: ########, baseyear: 2004
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] ready for requests
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [mouse] found card system videoguard2
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] card detected
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] type: VideoGuard Sky Austria/Germany (098C)
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] ------------------------------------------------------------------
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] |- class -|-- tier --|----- valid to ------|--- package name ----|
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] +---------+----------+---------------------+---------------------+
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] |------- This card is not active, so no package available! ------|
Nov 05 17:06:53 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] ------------------------------------------------------from-ins70--
Nov 05 17:06:53 archvdr oscam[25247]: 00000000 s (main) init for all local cards done
Nov 05 17:06:53 archvdr oscam[25247]: 00000000 s (emmcache) loaded 0 emmcache records from /tmp/.oscam/oscam.emmcache in 0 ms
Nov 05 17:06:53 archvdr oscam[25247]: 00000000 s (emmcache) loaded 0 emmstat records from /tmp/.oscam/oscam.emmstat in 0 ms
Nov 05 17:06:53 archvdr oscam[25247]: 00000000 s (anticasc) anti cascading disabled
Nov 05 17:06:53 archvdr oscam[25247]: 519EE897 c (client) plain dvbapi-client granted (vdr, au=on (1 reader))
Nov 05 17:06:53 archvdr oscam[25247]: 519EE897 c (dvbapi) dvbapi channelcache loaded from /etc/oscam/oscam.ccache
Nov 05 17:06:53 archvdr oscam[25247]: 519EE897 c (dvbapi) Using TCP listen socket, API forced to DVBAPIv3 (0), userconfig boxtype: 11
Nov 05 17:07:12 archvdr oscam[25247]: 519EE897 c (dvbapi) Client connected: 'vdr-plugin-dvbapi 2.2.2 / VDR 2.2.0' (protocol version = 2)
Nov 05 17:07:12 archvdr oscam[25247]: 519EE897 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 09C4 ECM_PID: 1B11 PROVID: 000000
Nov 05 17:07:12 archvdr oscam[25247]: 519EE897 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 09AF ECM_PID: 1F11 PROVID: 000000
Nov 05 17:07:12 archvdr oscam[25247]: 519EE897 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 098C ECM_PID: 1A11 PROVID: 000000
Nov 05 17:07:12 archvdr oscam[25247]: 519EE897 c (dvbapi) Demuxer 0 found 3 ECMpids and 3 STREAMpids in caPMT
Nov 05 17:07:12 archvdr oscam[25247]: 519EE897 c (dvbapi) Demuxer 0 trying to descramble PID 2 CAID 098C PROVID 000000 ECMPID 1A11 ANY CHID PMTPID 0000 VPID 03FF
Nov 05 17:07:13 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Card appears in error
Nov 05 17:07:13 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Card isn't active
Nov 05 17:07:13 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Card is not paired (Debug-ECM-Info: 0F_06 02 31 20 00 00 11)
Nov 05 17:07:13 archvdr oscam[25247]: 519EE897 c (ecm) vdr (098C@000000/0B58/0074/9D:E8C40DD2920320D8CFE90CD7D63905BC:0F06023120000011): not found (63 ms) by V14
Nov 05 17:07:13 archvdr oscam[25247]: 519EE897 c (ecm) vdr (098C@000000/0B58/0074/9D:E8C40DD2920320D8CFE90CD7D63905BC:0F06023120000011): not found (0 ms) by V14
Nov 05 17:07:14 archvdr oscam[25247]: 519EE897 c (-) -- Skipped 5 duplicated log lines --
Nov 05 17:07:14 archvdr oscam[25247]: 519EE897 c (ecm) vdr (098C@000000/0B58/0074/9D:E8C40DD2920320D8CFE90CD7D63905BC:0F06023120000011): not found (1 ms) by V14
Nov 05 17:07:15 archvdr oscam[25247]: 519EE897 c (-) -- Skipped 1 duplicated log lines --
Nov 05 17:07:15 archvdr oscam[25247]: 519EE897 c (ecm) vdr (098C@000000/0B58/0074/9D:E8C40DD2920320D8CFE90CD7D63905BC:0F06023120000011): not found (0 ms) by V14
Nov 05 17:07:16 archvdr oscam[25247]: 519EE897 c (-) -- Skipped 2 duplicated log lines --
Nov 05 17:07:16 archvdr oscam[25247]: 519EE897 c (dvbapi) Demuxer 0 stop descrambling program number 0074 (09C4@000000:0074 unknown)
Nov 05 17:07:16 archvdr oscam[25247]: 519EE897 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 09C4 ECM_PID: 1B11 PROVID: 000000
Nov 05 17:07:16 archvdr oscam[25247]: 519EE897 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 09AF ECM_PID: 1F11 PROVID: 000000
Nov 05 17:07:16 archvdr oscam[25247]: 519EE897 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 098C ECM_PID: 1A11 PROVID: 000000
Nov 05 17:07:16 archvdr oscam[25247]: 519EE897 c (dvbapi) Demuxer 0 found 3 ECMpids and 3 STREAMpids in caPMT
Nov 05 17:07:16 archvdr oscam[25247]: 519EE897 c (dvbapi) Demuxer 0 trying to descramble PID 2 CAID 098C PROVID 000000 ECMPID 1A11 ANY CHID PMTPID 0000 VPID 03FF
Nov 05 17:07:16 archvdr oscam[25247]: 519EE897 c (ecm) vdr (098C@000000/0B58/0074/9D:E8C40DD2920320D8CFE90CD7D63905BC:0F06023120000011): not found (0 ms) by V14
Nov 05 17:07:17 archvdr oscam[25247]: 519EE897 c (-) -- Skipped 2 duplicated log lines --
Nov 05 17:07:17 archvdr oscam[25247]: 519EE897 c (ecm) vdr (098C@000000/0B58/0074/9D:E8C40DD2920320D8CFE90CD7D63905BC:0F06023120000011): not found (1 ms) by V14
Nov 05 17:07:17 archvdr oscam[25247]: 519EE897 c (ecm) vdr (098C@000000/0B58/0074/9D:E8C40DD2920320D8CFE90CD7D63905BC:0F06023120000011): not found (0 ms) by V14
Nov 05 17:07:18 archvdr oscam[25247]: 3F26C736 r (-) -- Skipped 3 duplicated log lines --
Nov 05 17:07:18 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Card appears in error
Nov 05 17:07:18 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Card isn't active
Nov 05 17:07:18 archvdr oscam[25247]: 3F26C736 r (reader) V14 [videoguard2] classD3 ins54: no cw --> Card is not paired (Debug-ECM-Info: 0F_06 02 31 20 00 00 11)
Nov 05 17:07:18 archvdr oscam[25247]: 519EE897 c (ecm) vdr (098C@000000/0B58/0074/9D:CCF51509C15918E331929B33642AA024:0F06023120000011): not found (53 ms) by V14