-------------------------------------------------------------------------------
>> OSCam << cardserver log switched at Fri Sep 6 11:56:26 2019
-------------------------------------------------------------------------------
2019/09/06 11:56:26 00000000 s >> OSCam << cardserver log switched, version 1540(11522), build r-796 (aarch64-oe-linux)
2019/09/06 11:56:26 00000000 s (main) System name = Linux
2019/09/06 11:56:26 00000000 s (main) Host name = dreamone
2019/09/06 11:56:26 00000000 s (main) Release = 4.9
2019/09/06 11:56:26 00000000 s (main) Version = #1 SMP PREEMPT Thu Aug 22 19:26:20 UTC 2019
2019/09/06 11:56:26 00000000 s (main) Machine = aarch64
2019/09/06 11:56:26 00000000 s (main) Stb model = one
2019/09/06 11:56:26 00000000 s (main) creating pidfile /tmp/.oscam/oscam.pid with pid 1487
2019/09/06 11:56:26 00000000 s (config) services reloaded: 0 services freed, 0 services loaded, rejected 0
2019/09/06 11:56:26 00000000 s (emu) OSCam-Emu version 796
2019/09/06 11:56:26 00000000 s (config) userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2019/09/06 11:56:26 00000000 s (main) signal handling initialized
2019/09/06 11:56:26 00000000 s (config) 3 provid's loaded
2019/09/06 11:56:26 00000000 s (config) 6 service-id's loaded in 0 ms
2019/09/06 11:56:26 00000000 s (reader) SRG_V5 [internal] creating thread for device /dev/sci0
2019/09/06 11:56:26 00000000 s (reader) keyfile [unknown] Protocol Support missing. (typ=37)
2019/09/06 11:56:26 5E380032 r (reader) SRG_V5 [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2019/09/06 11:56:26 5E380032 r (reader) SRG_V5 [internal] Cannot open device: /dev/sci0
2019/09/06 11:56:26 00000000 s (emmcache) loaded 0 emmcache records from /tmp/.oscam/oscam.emmcache in 0 ms
2019/09/06 11:56:26 00000000 s (emmcache) loaded 0 emmstat records from /tmp/.oscam/oscam.emmstat in 0 ms
2019/09/06 11:56:26 4D88B301 c (client) plain dvbapi-client granted (root, au=off)
2019/09/06 11:56:26 6C387151 h (webif) webif: decompressed 206504 bytes back into 455144 bytes
2019/09/06 11:56:26 6C387151 h (webif) HTTP Server running. ip=:: port=8888
2019/09/06 11:56:26 71998C91 r (emu) Stream relay server initialized
2019/09/06 11:56:26 71998C91 r (reader) emulator [emu] Reader initialized (device=emulator, detect=cd, mhz=357, cardmhz=357)
2019/09/06 11:56:26 00000000 (emu) INFO: FFDecsa parallel mode = 32
2019/09/06 11:56:26 4D88B301 c (dvbapi) dvbapi channelcache loaded from /etc/tuxbox/config/oscam.ccache
2019/09/06 11:56:26 4D88B301 c (dvbapi) Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1 maximum number of filters is 16 (oscam limit is 64)
2019/09/06 11:56:26 4D88B301 c (dvbapi) Detected /dev/dvb/adapter0/ca0 device, total available descramblers: 8
2019/09/06 11:56:26 4D88B301 c (dvbapi) Demuxer 0 found 0 ECMpids and 11 STREAMpids in caPMT
2019/09/06 11:56:26 4D88B301 c (dvbapi) Demuxer 0 found 0 ECMpids and 11 STREAMpids in PMT
2019/09/06 11:56:27 71998C91 r (reader) emulator [emu] card detected
2019/09/06 11:56:28 71998C91 r (reader) emulator [emu] found card system emu
2019/09/06 11:56:28 71998C91 r (reader) emulator [emu] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max allotted of 1
2019/09/06 11:56:28 71998C91 r (emu) Key file not found in: /etc/tuxbox/config
2019/09/06 11:56:28 71998C91 r (emu) Reading key file: /var/keys/SoftCam.Key
2019/09/06 11:56:28 5E380032 r (reader) SRG_V5 [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2019/09/06 11:56:28 5E380032 r (reader) SRG_V5 [internal] Cannot open device: /dev/sci0
2019/09/06 11:56:28 71998C91 r (emu) WARNING: non-hex value in SoftCam.Key at I 00000604 06 99766164E057EВС3F374C747D45924F9
2019/09/06 11:56:28 71998C91 r (emu) Total keys in memory: W:0 V:7 N:0 I:5 F:0 G:0 P:687 T:60 A:0
2019/09/06 11:56:30 5E380032 r (reader) SRG_V5 [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2019/09/06 11:56:30 5E380032 r (reader) SRG_V5 [internal] Cannot open device: /dev/sci0
2019/09/06 11:56:32 5E380032 r (reader) SRG_V5 [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2019/09/06 11:56:32 5E380032 r (reader) SRG_V5 [internal] Cannot open device: /dev/sci0
2019/09/06 11:56:34 5E380032 r (reader) SRG_V5 [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2019/09/06 11:56:34 5E380032 r (reader) SRG_V5 [internal] Cannot open device: /dev/sci0
2019/09/06 11:56:36 5E380032 r (reader) SRG_V5 [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2019/09/06 11:56:36 5E380032 r (reader) SRG_V5 [internal] Cannot open device: /dev/sci0
2019/09/06 11:56:38 5E380032 r (reader) SRG_V5 [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2019/09/06 11:56:38 5E380032 r (reader) SRG_V5 [internal] Cannot open device: /dev/sci0
2019/09/06 11:56:40 5E380032 r (reader) SRG_V5 [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2019/09/06 11:56:40 5E380032 r (reader) SRG_V5 [internal] Cannot open device: /dev/sci0
2019/09/06 11:56:42 5E380032 r (reader) SRG_V5 [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2019/09/06 11:56:42 5E380032 r (reader) SRG_V5 [internal] Cannot open device: /dev/sci0
2019/09/06 11:56:44 5E380032 r (reader) SRG_V5 [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2019/09/06 11:56:44 5E380032 r (reader) SRG_V5 [internal] Cannot open device: /dev/sci0
2019/09/06 11:56:46 5E380032 r (reader) SRG_V5 [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2019/09/06 11:56:46 5E380032 r (reader) SRG_V5 [internal] Cannot open device: /dev/sci0
2019/09/06 11:56:46 5E380032 r (reader) SRG_V5 [internal] Deactivating card
2019/09/06 11:56:46 5E380032 r (reader) SRG_V5 [internal] Error:Sci_Deactivate ioctl(IOCTL_GET_IS_CARD_PRESENT) failed.(9:Bad file descriptor)
2019/09/06 11:57:11 4D88B301 c (dvbapi) Demuxer 0 stop descrambling program number 283D (Das Erste HD)
2019/09/06 11:57:11 4D88B301 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 0500 ECM_PID: 02D9 PROVID: 040810
2019/09/06 11:57:11 4D88B301 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 0500 ECM_PID: 02E3 PROVID: 050800
2019/09/06 11:57:11 4D88B301 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 0500 ECM_PID: 02ED PROVID: 060200
2019/09/06 11:57:11 4D88B301 c (dvbapi) Demuxer 0 found 3 ECMpids and 8 STREAMpids in caPMT
2019/09/06 11:57:11 4D88B301 c (dvbapi) Demuxer 0 no suitable readers found that can be used for decoding!
2019/09/06 11:57:11 4D88B301 c (dvbapi) Demuxer 0 found 3 ECMpids and 8 STREAMpids in PMT
2019/09/06 11:57:15 4D88B301 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/09/06 11:57:18 4D88B301 c (dvbapi) Demuxer 0 stop descrambling program number 4332 (SRF zwei HD)
2019/09/06 11:57:18 4D88B301 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 0500 ECM_PID: 02ED PROVID: 060200
2019/09/06 11:57:18 4D88B301 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 0500 ECM_PID: 02E3 PROVID: 050800
2019/09/06 11:57:18 4D88B301 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 0500 ECM_PID: 02D9 PROVID: 040810
2019/09/06 11:57:18 4D88B301 c (dvbapi) Demuxer 0 found 3 ECMpids and 8 STREAMpids in caPMT
2019/09/06 11:57:18 4D88B301 c (dvbapi) Demuxer 0 no suitable readers found that can be used for decoding!
2019/09/06 11:57:18 4D88B301 c (dvbapi) Demuxer 0 found 3 ECMpids and 8 STREAMpids in PMT
2019/09/06 11:57:22 4D88B301 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/09/06 11:57:27 4D88B301 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/09/06 11:57:32 4D88B301 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/09/06 11:57:34 4D88B301 c (dvbapi) Demuxer 0 stop descrambling program number 4331 (SRF 1 HD)
2019/09/06 11:57:35 4D88B301 c (dvbapi) Demuxer 0 found 0 ECMpids and 11 STREAMpids in caPMT
2019/09/06 11:57:35 4D88B301 c (dvbapi) Demuxer 0 found 0 ECMpids and 11 STREAMpids in PMT
2019/09/06 11:57:40 4D88B301 c (dvbapi) Demuxer 0 stop descrambling program number 283D (Das Erste HD)
2019/09/06 11:57:41 4D88B301 c (dvbapi) Demuxer 0 found 0 ECMpids and 9 STREAMpids in caPMT
2019/09/06 11:57:41 4D88B301 c (dvbapi) Demuxer 0 found 0 ECMpids and 9 STREAMpids in PMT
2019/09/06 11:57:48 4D88B301 c (dvbapi) Demuxer 0 stop descrambling program number 2B66 (ZDF HD)
2019/09/06 13:24:22 4D88B301 c (dvbapi) Demuxer 0 found 0 ECMpids and 9 STREAMpids in caPMT
2019/09/06 13:24:22 4D88B301 c (dvbapi) Demuxer 0 found 0 ECMpids and 9 STREAMpids in PMT
2019/09/06 13:24:42 4D88B301 c (dvbapi) Demuxer 0 stop descrambling program number 2B66 (ZDF HD)
2019/09/06 13:24:42 4D88B301 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 0500 ECM_PID: 02D9 PROVID: 040810
2019/09/06 13:24:42 4D88B301 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 0500 ECM_PID: 02E3 PROVID: 050800
2019/09/06 13:24:42 4D88B301 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 0500 ECM_PID: 02ED PROVID: 060200
2019/09/06 13:24:42 4D88B301 c (dvbapi) Demuxer 0 found 3 ECMpids and 8 STREAMpids in caPMT
2019/09/06 13:24:42 4D88B301 c (dvbapi) Demuxer 0 no suitable readers found that can be used for decoding!
2019/09/06 13:24:43 4D88B301 c (dvbapi) Demuxer 0 found 3 ECMpids and 8 STREAMpids in PMT
2019/09/06 13:24:46 4D88B301 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/09/06 13:24:49 4D88B301 c (dvbapi) Demuxer 0 stop descrambling program number 4332 (SRF zwei HD)
2019/09/06 13:24:49 4D88B301 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 0500 ECM_PID: 02ED PROVID: 060200
2019/09/06 13:24:49 4D88B301 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 0500 ECM_PID: 02E3 PROVID: 050800
2019/09/06 13:24:49 4D88B301 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 0500 ECM_PID: 02D9 PROVID: 040810
2019/09/06 13:24:49 4D88B301 c (dvbapi) Demuxer 0 found 3 ECMpids and 8 STREAMpids in caPMT
2019/09/06 13:24:49 4D88B301 c (dvbapi) Demuxer 0 no suitable readers found that can be used for decoding!
2019/09/06 13:24:49 4D88B301 c (dvbapi) Demuxer 0 found 3 ECMpids and 8 STREAMpids in PMT
2019/09/06 13:24:53 4D88B301 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/09/06 13:24:54 4D88B301 c (dvbapi) Demuxer 0 stop descrambling program number 4331 (SRF 1 HD)
2019/09/06 13:24:55 4D88B301 c (dvbapi) Demuxer 0 found 0 ECMpids and 11 STREAMpids in caPMT
2019/09/06 13:24:55 4D88B301 c (dvbapi) Demuxer 0 found 0 ECMpids and 11 STREAMpids in PMT
2019/09/06 13:25:28 4D88B301 c (dvbapi) Demuxer 0 stop descrambling program number 283D (Das Erste HD)