-------------------------------------------------------------------------------
>> OSCam << cardserver log switched at Thu Jan 1 01:00:09 1970
-------------------------------------------------------------------------------
1970/01/01 01:00:09 00000000 s >> OSCam << cardserver log switched, version 1.20-unstable_svn, build r11415 (arm-oe-linux-gnueabi)
1970/01/01 01:00:09 00000000 s (main) System name = Linux
1970/01/01 01:00:09 00000000 s (main) Host name = vuultimo4k
1970/01/01 01:00:09 00000000 s (main) Release = 3.14.28-1.12
1970/01/01 01:00:09 00000000 s (main) Version = #1 SMP Fri Mar 2 19:18:16 CET 2018
1970/01/01 01:00:09 00000000 s (main) Machine = armv7l
1970/01/01 01:00:09 00000000 s (main) Stb model = dm8000
1970/01/01 01:00:09 00000000 s (main) Stb vumodel = vuultimo4k
1970/01/01 01:00:09 00000000 s (main) Stb boxtype = vuultimo4k
1970/01/01 01:00:09 00000000 s (main) The current system time is smaller than the build date (Apr 10 2018). Waiting up to 60 seconds for time to correct
2018/06/07 18:48:11 00000000 s (main) creating pidfile /tmp/oscam.pid with pid 1079
2018/06/07 18:48:12 00000000 s (config) services reloaded: 0 services freed, 0 services loaded, rejected 0
2018/06/07 18:48:12 00000000 s (config) userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2018/06/07 18:48:12 00000000 s (main) signal handling initialized
2018/06/07 18:48:12 00000000 s (reader) SKY_DE_V1X [internal] creating thread for device /dev/sci0
2018/06/07 18:48:12 00000000 s (stat) loadbalancer: could not open /tmp/.oscam/stat for reading (errno=2 No such file or directory)
2018/06/07 18:48:12 00000000 s (anticasc) anti cascading disabled
2018/06/07 18:48:12 59C26339 r (reader) SKY_DE_V1X [internal] Reader initialized (device=/dev/sci0, detect=cd, pll max=27.00 MHz, wanted mhz=4.50 MHz)
2018/06/07 18:48:12 59C26339 r (reader) SKY_DE_V1X [internal] Reader sci internal, detected box type: vuultimo4k
2018/06/07 18:48:12 109277ED c (client) plain dvbapi-client granted (dvbapi_local, au=auto (2 reader))
2018/06/07 18:48:12 0D6514BC h (webif) webif: decompressed 177583 bytes back into 437728 bytes
2018/06/07 18:48:12 0D6514BC h (webif) HTTP Server running. ip=0.0.0.0 port=83
2018/06/07 18:48:12 109277ED c (dvbapi) dvbapi channelcache loaded from /etc/tuxbox/config/oscam.ccache
2018/06/07 18:48:12 109277ED c (dvbapi) Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1 maximum amount of possible filters is 32 (oscam limit is 32)
2018/06/07 18:48:13 59C26339 r (reader) SKY_DE_V1X [internal] card detected
2018/06/07 18:48:13 109277ED c (dvbapi) Demuxer 0 ecmpid 0 CAID: 098C ECM_PID: 1AB3 PROVID: 000000
2018/06/07 18:48:13 109277ED c (dvbapi) Demuxer 0 ecmpid 1 CAID: 098D ECM_PID: 1CB3 PROVID: 000000
2018/06/07 18:48:13 109277ED c (dvbapi) Demuxer 0 found 2 ECMpids and 3 STREAMpids in caPMT
2018/06/07 18:48:13 109277ED c (dvbapi) Demuxer 0 no suitable readers found that can be used for decoding!
2018/06/07 18:48:13 109277ED c (dvbapi) Demuxer 0 found 2 ECMpids and 3 STREAMpids in PMT
2018/06/07 18:48:13 109277ED c (dvbapi) Demuxer 1 ecmpid 0 CAID: 09C4 ECM_PID: 1B80 PROVID: 000000
2018/06/07 18:48:13 109277ED c (dvbapi) Demuxer 1 ecmpid 1 CAID: 098C ECM_PID: 1A80 PROVID: 000000
2018/06/07 18:48:13 109277ED c (dvbapi) Demuxer 1 ecmpid 2 CAID: 09AF ECM_PID: 1F80 PROVID: 000000
2018/06/07 18:48:13 109277ED c (dvbapi) Demuxer 1 ecmpid 3 CAID: 098D ECM_PID: 1C80 PROVID: 000000
2018/06/07 18:48:13 109277ED c (dvbapi) Demuxer 1 found 4 ECMpids and 2 STREAMpids in caPMT
2018/06/07 18:48:13 109277ED c (dvbapi) Demuxer 1 no suitable readers found that can be used for decoding!
2018/06/07 18:48:13 59C26339 r (reader) SKY_DE_V1X [internal] ATR: 3F FF 14 25 03 10 80 41 B0 07 69 FF 4A 50 70 00 00 50 31 01 00 14
2018/06/07 18:48:13 59C26339 r (reader) SKY_DE_V1X [internal] Init card protocol T0, FI=1, F=372, D=8, N=3
2018/06/07 18:48:13 59C26339 r (reader) SKY_DE_V1X [internal] Calculated work ETU is 10.33 us reader mhz = 450
2018/06/07 18:48:16 109277ED c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2018/06/07 18:48:16 59C26339 r (reader) SKY_DE_V1X [internal] Buffers readed 0 bytes total time_us 3099518
2018/06/07 18:48:17 59C26339 r (reader) SKY_DE_V1X [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 4.50 Mhz (nearest possible mhz specified reader->mhz)
2018/06/07 18:48:17 109277ED c (dvbapi) Demuxer 1 no enabled matching ecmpids -> decoding is waiting for matching readers!
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [internal] Card type: P1AV
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [internal] Rom version: 10A7
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [internal] Unable to get smartcard credit
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [internal] FuseByte: 25
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [internal] Region Code: 00BO0102
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [internal] Country Code: DEU
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [internal] Pincode read: 1234
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [internal] PCB settings: FF FF FF FF
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [internal] Parental control disabled
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [internal] type: VideoGuard Sky Austria/Germany (09C4) FastMode, caid: 09C4
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [internal] serial: ########, BoxID: ########, baseyear: 2004
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [internal] ready for requests
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [internal] found card system videoguard2
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] card detected
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] type: VideoGuard Sky Austria/Germany (09C4) FastMode
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] ------------------------------------------------------------------
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |- class -|-- tier --|----- valid to ------|--- package name ----|
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] +---------+----------+---------------------+---------------------+
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 0068 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 006a --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 006b --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 0065 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 0066 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 0067 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 006f --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 0070 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 0071 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 0072 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 0073 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 007b --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 0075 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 0081 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 008e --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 00c0 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 00c8 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 00c9 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 00ca --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 00cb --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 00c7 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 00f0 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 00f3 --| 2018/08/06-01:00:00 |
2018/06/07 18:48:18 59C26339 r (reader) SKY_DE_V1X [videoguard2] |-- 00 ---|-- 00ff --| 2018/08/06-01:00:00 |
2018/06/07 18:48:19 59C26339 r (reader) SKY_DE_V1X [videoguard2] ------------------------------------------------------from-ins70--
2018/06/07 18:48:19 109277ED c (dvbapi) Demuxer 1 restarting decodingrequests after 6006 ms with 1 enabled and 3 disabled ecmpids!
2018/06/07 18:48:19 109277ED c (dvbapi) Demuxer 1 trying to descramble PID 0 CAID 09C4 PROVID 000000 ECMPID 1B80 ANY CHID PMTPID 0067 VPID 07FF
2018/06/07 18:48:20 59C26339 r (reader) SKY_DE_V1X [videoguard2] classD3 ins54: no cw --> Tier expired
2018/06/07 18:48:20 109277ED c (ecm) dvbapi_local (09C4@000000/00EC/001E/A2

24654EE672CEF38CF4B2429B47268CE:0F06000020000000): not found (164 ms) by SKY_DE_V1X
2018/06/07 18:48:20 109277ED c (dvbapi) Demuxer 1 restarting decodingrequests after 1 ms with 1 enabled and 3 disabled ecmpids!
2018/06/07 18:48:20 109277ED c (dvbapi) Demuxer 1 trying to descramble PID 0 CAID 09C4 PROVID 000000 ECMPID 1B80 ANY CHID PMTPID 0067 VPID 07FF
2018/06/07 18:48:21 109277ED c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2018/06/07 18:48:21 109277ED c (ecm) dvbapi_local (09C4@000000/00EC/001E/A2

24654EE672CEF38CF4B2429B47268CE:0F06000020000000): not found (1 ms) by SKY_DE_V1X
2018/06/07 18:48:21 109277ED c (dvbapi) Demuxer 1 restarting decodingrequests after 1 ms with 1 enabled and 3 disabled ecmpids!
2018/06/07 18:48:21 109277ED c (dvbapi) Demuxer 1 trying to descramble PID 0 CAID 09C4 PROVID 000000 ECMPID 1B80 ANY CHID PMTPID 0067 VPID 07FF
2018/06/07 18:48:22 59C26339 r (reader) SKY_DE_V1X [videoguard2] classD3 ins54: no cw --> Tier expired
2018/06/07 18:48:22 109277ED c (ecm) dvbapi_local (09C4@000000/00EC/001E/A2:8A6ED6BAAC4CB4EB44AA6640976294C6:0F06000020000000): not found (139 ms) by SKY_DE_V1X
2018/06/07 18:48:22 109277ED c (dvbapi) Demuxer 1 restarting decodingrequests after 1 ms with 1 enabled and 3 disabled ecmpids!
2018/06/07 18:48:22 109277ED c (dvbapi) Demuxer 1 trying to descramble PID 0 CAID 09C4 PROVID 000000 ECMPID 1B80 ANY CHID PMTPID 0067 VPID 07FF
2018/06/07 18:48:23 109277ED c (ecm) dvbapi_local (09C4@000000/00EC/001E/A2:8A6ED6BAAC4CB4EB44AA6640976294C6:0F06000020000000): not found (0 ms) by SKY_DE_V1X
2018/06/07 18:48:23 109277ED c (dvbapi) Demuxer 1 restarting decodingrequests after 0 ms with 1 enabled and 3 disabled ecmpids!
2018/06/07 18:48:23 109277ED c (dvbapi) Demuxer 1 trying to descramble PID 0 CAID 09C4 PROVID 000000 ECMPID 1B80 ANY CHID PMTPID 0067 VPID 07FF
2018/06/07 18:48:24 109277ED c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!