-------------------------------------------------------------------------------
>> OSCam << cardserver log switched at Wed Dec 23 17:03:05 2015
-------------------------------------------------------------------------------
2015/12/23 17:03:05 3953DFCD h >> OSCam << cardserver log switched, version 1.20-unstable_svn, build r10892 (mipsel-oe-linux-ssl-libusb)
2015/12/23 17:03:05 3953DFCD h (webif) Refresh Server requested by WebIF from 192.168.178.28
2015/12/23 17:03:07 316DBA33 c (ecm) dvbapi_local (0648@000000/000D/132F/44:A6E4F2F2D2C4875A6AC26FF989E398B9): found (97 ms) by ORF_HD_ICE
2015/12/23 17:03:10 3953DFCD h (webif) Restart requested by WebIF from 192.168.178.28
2015/12/23 17:03:10 3953DFCD h (main) restart oscam requested
2015/12/23 17:03:11 00000000 [Emu] error: accept() failed
2015/12/23 17:03:11 3953DFCD h (webif) HTTP Server stopped
2015/12/23 17:03:11 00000000 s (dvbapi) dvbapi channelcache saved to /etc/tuxbox/config/oscam.ccache
2015/12/23 17:03:11 00000000 s (emmcache) saved 136 emmcache records to /etc/tuxbox/config/oscam.emmcache in 26 ms
2015/12/23 17:03:11 00000000 s (emmcache) reader ORF_HD_ICE skipped since emmcache save is disabled
2015/12/23 17:03:11 00000000 s (emmcache) saved 101 emmstat records to /etc/tuxbox/config/oscam.emmstat in 6 ms
2015/12/23 17:03:11 00000000 s (client) killing client dvbapi_local
2015/12/23 17:03:11 00000000 s (reader) HDPLUS_DE_HD0X [nagra] Killing reader
2015/12/23 17:03:11 00000000 s (reader) ORF_HD_ICE [irdeto] Killing reader
2015/12/23 17:03:11 00000000 s (reader) emulator [emu] Killing reader
2015/12/23 17:03:11 00000000 s (config) userdb 3 accounts freed
2015/12/23 17:03:11 00000000 s (config) readerdb 3 readers freed
2015/12/23 17:03:11 00000000 s (main) cardserver down
-------------------------------------------------------------------------------
>> OSCam << cardserver log switched at Wed Dec 23 17:03:13 2015
-------------------------------------------------------------------------------
2015/12/23 17:03:13 00000000 s >> OSCam << cardserver log switched, version 1.20-unstable_svn, build r10892 (mipsel-oe-linux-ssl-libusb)
2015/12/23 17:03:13 00000000 s (main) System name = Linux
2015/12/23 17:03:13 00000000 s (main) Host name = vusolo2
2015/12/23 17:03:13 00000000 s (main) Release = 3.13.5
2015/12/23 17:03:13 00000000 s (main) Version = #1 SMP Thu Mar 12 13:39:07 CET 2015
2015/12/23 17:03:13 00000000 s (main) Machine = mips
2015/12/23 17:03:13 00000000 s (main) Stb model = dm8000
2015/12/23 17:03:13 00000000 s (main) Stb vumodel = vusolo2
2015/12/23 17:03:13 00000000 s (main) Stb boxtype = vusolo2
2015/12/23 17:03:13 00000000 s (main) creating pidfile /var/LOGFILES/oscam.pid with pid 25736
2015/12/23 17:03:13 00000000 s [Emu] oscam-emu version 716
2015/12/23 17:03:13 00000000 s (config) userdb reloaded: 3 accounts loaded, 0 expired, 0 disabled
2015/12/23 17:03:13 00000000 s (main) signal handling initialized
2015/12/23 17:03:13 00000000 s (net) monitor: initialized (fd=6, port=988)
2015/12/23 17:03:13 00000000 s (net) cccam: initialized (fd=7, port=11111)
2015/12/23 17:03:13 00000000 s (reader) HDPLUS_DE_HD0X [internal] creating thread for device /dev/sci1
2015/12/23 17:03:13 00000000 s (reader) ORF_HD_ICE [internal] creating thread for device /dev/sci0
2015/12/23 17:03:13 00000000 s (reader) emulator [emu] creating thread for device emulator
2015/12/23 17:03:13 6D7C5ED3 r (reader) ORF_HD_ICE [internal] Reader initialized (device=/dev/sci0, detect=cd, pll max=27.00 MHz, wanted mhz=4.50 MHz)
2015/12/23 17:03:13 00000000 s (stat) loadbalancer: could not open /tmp/.oscam/stat for reading (errno=2 No such file or directory)
2015/12/23 17:03:13 00000000 s (main) waiting for local card init
2015/12/23 17:03:13 6D7C5ED3 r (reader) ORF_HD_ICE [internal] Reader sci internal, detected box type: vusolo2
2015/12/23 17:03:13 2CD41F4C r (reader) HDPLUS_DE_HD0X [internal] Reader initialized (device=/dev/sci1, detect=cd, pll max=27.00 MHz, wanted mhz=4.50 MHz)
2015/12/23 17:03:13 2CD41F4C r (reader) HDPLUS_DE_HD0X [internal] Reader sci internal, detected box type: vusolo2
2015/12/23 17:03:13 17E0E0E1 h (webif) webif: decompressed 164535 bytes back into 393232 bytes
2015/12/23 17:03:13 17E0E0E1 h (webif) HTTP Server running. ip=0.0.0.0 port=83
2015/12/23 17:03:13 1D7A5771 r key file not found in: /etc/tuxbox/config
2015/12/23 17:03:13 1D7A5771 r key file not found in: /var/keys
2015/12/23 17:03:13 1D7A5771 r (reader) emulator [emu] Reader initialized (device=emulator, detect=cd, mhz=357, cardmhz=357)
2015/12/23 17:03:14 1D7A5771 r (reader) emulator [emu] card detected
2015/12/23 17:03:14 2CD41F4C r (reader) HDPLUS_DE_HD0X [internal] card detected
2015/12/23 17:03:14 6D7C5ED3 r (reader) ORF_HD_ICE [internal] card detected
2015/12/23 17:03:15 2CD41F4C r (reader) HDPLUS_DE_HD0X [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
2015/12/23 17:03:15 2CD41F4C r (reader) HDPLUS_DE_HD0X [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2015/12/23 17:03:15 2CD41F4C r (reader) HDPLUS_DE_HD0X [internal] Calculated work ETU is 7.11 us reader mhz = 450
2015/12/23 17:03:15 1D7A5771 r (reader) emulator [emu] found card system emu
2015/12/23 17:03:15 1D7A5771 r (reader) emulator [emu] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2015/12/23 17:03:15 1D7A5771 r key file not found in: /etc/tuxbox/config
2015/12/23 17:03:15 1D7A5771 r key file not found in: /var/keys
2015/12/23 17:03:15 6D7C5ED3 r (reader) ORF_HD_ICE [internal] ATR: 3B 78 12 00 00 54 C4 03 00 8F F1 90 00
2015/12/23 17:03:19 2CD41F4C r (reader) HDPLUS_DE_HD0X [internal] Buffers readed 0 bytes total time_us 4829344
2015/12/23 17:03:20 6D7C5ED3 r (reader) ORF_HD_ICE [internal] Buffers readed 0 bytes total time_us 4499833
2015/12/23 17:03:20 6D7C5ED3 r (reader) ORF_HD_ICE [internal] Init card protocol T0, FI=1, F=372, D=2, N=0
2015/12/23 17:03:20 6D7C5ED3 r (reader) ORF_HD_ICE [internal] Calculated work ETU is 41.33 us reader mhz = 450
2015/12/23 17:03:20 2CD41F4C r (reader) HDPLUS_DE_HD0X [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 4.50 Mhz (nearest possible mhz specified reader->mhz)
2015/12/23 17:03:20 2CD41F4C r (reader) HDPLUS_DE_HD0X [internal] Card responded ok for ifsd request of 251
2015/12/23 17:03:21 2CD41F4C r (reader) HDPLUS_DE_HD0X [internal] detect native nagra card
2015/12/23 17:03:23 6D7C5ED3 r (reader) ORF_HD_ICE [internal] Buffers readed 0 bytes total time_us 3103827
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [internal] ready for requests
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [internal] found card system nagra
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] ROM: D N A S P 1 4 2
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] REV: R e v G C 6
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] SER: ############
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] CAID: 1830
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] Prv.ID: 00 00 34 11 (sysid)
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] Prv.ID: 00 00 00 00
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] IRD ID: ############
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] active to: 2016/02/13 11:59
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] -----------------------------------------
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] |id |tier |valid from |valid to |
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] +----+--------+------------+------------+
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] |8011|0064 |2011/01/05 |2012/01/06 |
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] |8011|0065 |1992/01/01 |1993/01/01 |
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] |8011|0BEA |2014/11/29 |2016/12/31 |
2015/12/23 17:03:23 2CD41F4C r (reader) HDPLUS_DE_HD0X [nagra] -----------------------------------------
2015/12/23 17:03:23 6D7C5ED3 r (reader) ORF_HD_ICE [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 4.50 Mhz (nearest possible mhz specified reader->mhz)
2015/12/23 17:03:24 6D7C5ED3 r (reader) ORF_HD_ICE [internal] Hist. Bytes: TÄ
2015/12/23 17:03:24 6D7C5ED3 r (reader) ORF_HD_ICE [internal] detect irdeto card
2015/12/23 17:03:24 6D7C5ED3 r (reader) ORF_HD_ICE [internal] caid: 0648, acs: 0.05, country code: AUT
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [internal] providers: 4, ascii serial: ##########, hex serial: ######, hex base: ##
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [internal] WARNING: For Irdeto cards you will have to set 'mhz= 600' in oscam.server
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [internal] active providers: 4 (e1c1ff,002500,002600,002700)
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [internal] found card system irdeto
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [irdeto] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max alloted of 1
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [irdeto] entitlements for provider: 1, id: E1C1FF
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [irdeto] chid: 000D, date: 2015/12/23 - 2016/01/22
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [irdeto] chid: 0001, date: 2015/12/23 - 2016/08/29
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [irdeto] chid: 7FF7, date: 2015/12/23 - 2016/01/02
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [irdeto] chid: 0002, date: 2015/12/23 - 2016/08/29
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [irdeto] entitlements for provider: 2, id: 002500
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [irdeto] chid: 001D, date: 2015/12/23 - 2016/01/22
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [irdeto] entitlements for provider: 4, id: 002700
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [irdeto] chid: 0031, date: 2015/12/23 - 2016/01/22
2015/12/23 17:03:25 6D7C5ED3 r (reader) ORF_HD_ICE [irdeto] ready for requests
2015/12/23 17:03:26 00000000 s (main) init for all local cards done
2015/12/23 17:03:26 00000000 s (emmcache) loaded 136 emmcache records from /etc/tuxbox/config/oscam.emmcache in 4 ms
2015/12/23 17:03:26 00000000 s (emmcache) loaded 101 emmstat records from /etc/tuxbox/config/oscam.emmstat in 2 ms
2015/12/23 17:03:26 00000000 s (anticasc) anti cascading disabled
2015/12/23 17:03:26 597D63F3 c (client) plain dvbapi-client granted (dvbapi_local, au=auto (3 reader))
2015/12/23 17:03:26 597D63F3 c (dvbapi) dvbapi channelcache loaded from /etc/tuxbox/config/oscam.ccache
2015/12/23 17:03:26 597D63F3 c (dvbapi) Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1
2015/12/23 17:03:28 597D63F3 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 0648 ECM_PID: 0078 PROVID: 000000
2015/12/23 17:03:28 597D63F3 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 0650 ECM_PID: 007A PROVID: 000000
2015/12/23 17:03:28 597D63F3 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 0D95 ECM_PID: 010E PROVID: 000000
2015/12/23 17:03:28 597D63F3 c (dvbapi) Demuxer 0 ecmpid 3 CAID: 0D98 ECM_PID: 0110 PROVID: 000000
2015/12/23 17:03:28 597D63F3 c (dvbapi) Demuxer 0 ecmpid 4 CAID: 0500 ECM_PID: 01CD PROVID: 051900
2015/12/23 17:03:28 597D63F3 c (dvbapi) Demuxer 0 ecmpid 5 CAID: 09C4 ECM_PID: 01E0 PROVID: 000000
2015/12/23 17:03:28 597D63F3 c (dvbapi) Demuxer 0 ecmpid 6 CAID: 098C ECM_PID: 01EA PROVID: 000000
2015/12/23 17:03:28 597D63F3 c (dvbapi) Demuxer 0 found 7 ECMpids and 6 STREAMpids in PMT
2015/12/23 17:03:28 597D63F3 c (dvbapi) Demuxer 0 serving srvid 132F (0648@000000:132F unknown) on adapter 0000 camask 0001 index 0000 pmtpid 006B
2015/12/23 17:03:28 597D63F3 c (dvbapi) Demuxer 0 found channel in cache and matching prio -> start descrambling ecmpid 0
2015/12/23 17:03:28 597D63F3 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 0648 PROVID 000000 ECMPID 0078 ANY CHID PMTPID 006B VPID 0780
2015/12/23 17:03:29 597D63F3 c (ecm) dvbapi_local (0648@000000/000D/132F/44:62A847CB08CE5B95C42923A1D75DF160): found (97 ms) by ORF_HD_ICE
2015/12/23 17:03:37 597D63F3 c (ecm) dvbapi_local (0648@000000/000D/132F/44:6F5A1DF2DABB012A437D9BADF8D83EC5): found (96 ms) by ORF_HD_ICE
2015/12/23 17:03:47 597D63F3 c (ecm) dvbapi_local (0648@000000/000D/132F/44:606CC0F2579EF2732D6EF2D4986BB151): found (96 ms) by ORF_HD_ICE