>> OSCam << cardserver log switched at Sat Mar 6 15:36:09 2021
-------------------------------------------------------------------------------
2021/03/06 15:36:09 00000000 s >> OSCam << cardserver log switched, version 1543-11577, build r-798 (arm-oe-linux-gnueabi)
2021/03/06 15:36:09 00000000 s (main) System name = Linux
2021/03/06 15:36:09 00000000 s (main) Host name =
dm900
2021/03/06 15:36:09 00000000 s (main) Release = 3.14-1.17-
dm900
2021/03/06 15:36:09 00000000 s (main) Version = #1 SMP Mon Oct 30 17:37:52 CET 2017
2021/03/06 15:36:09 00000000 s (main) Machine = armv7l
2021/03/06 15:36:09 00000000 s (main) Stb model =
dm900
2021/03/06 15:36:09 00000000 s (main) creating pidfile /var/run/oscam.pid with pid 563
2021/03/06 15:36:09 00000000 s (emu) OSCam-Emu version 798
2021/03/06 15:36:09 00000000 s (config) userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2021/03/06 15:36:09 00000000 s (main) signal handling initialized
2021/03/06 15:36:09 00000000 s (config) 2 provid's loaded
2021/03/06 15:36:09 00000000 s (config) 4 service-id's loaded in 0 ms
2021/03/06 15:36:09 00000000 s (led) LED support is not active. Can't detect machine type.
2021/03/06 15:36:09 00000000 s (reader) lowerSlot [internal] creating thread for device /dev/sci0
2021/03/06 15:36:09 00000000 s (reader) upperSlot [internal] creating thread for device /dev/sci1
2021/03/06 15:36:09 00000000 s (reader) emulator [emu] creating thread for device emulator
2021/03/06 15:36:09 00000000 s (anticasc) anti cascading disabled
2021/03/06 15:36:09 5AF8981C r (reader) upperSlot [internal] ERROR: Opening device /dev/sci1 (errno=2 No such file or directory)
2021/03/06 15:36:09 5AF8981C r (reader) upperSlot [internal] Cannot open device: /dev/sci1
2021/03/06 15:36:09 75563CD0 c (client) plain dvbapi-client granted (DVBApi, au=auto (3 reader))
2021/03/06 15:36:09 22042945 h (webif) webif: decompressed 193093 bytes back into 465344 bytes
2021/03/06 15:36:09 22042945 h (webif) HTTP Server couldn't bind on port 8888 (errno=98 Address already in use). Not starting HTTP!
2021/03/06 15:36:09 75563CD0 c (dvbapi) dvbapi channelcache loaded from /etc/tuxbox/config/oscam.ccache
2021/03/06 15:36:09 6C2619BC r (reader) lowerSlot [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2021/03/06 15:36:09 6C2619BC r (reader) lowerSlot [internal] Cannot open device: /dev/sci0
2021/03/06 15:36:09 670C3692 r (emu) Stream key delayer initialized
2021/03/06 15:36:09 670C3692 r (emu) Stream relay server initialized
2021/03/06 15:36:09 670C3692 r (reader) emulator [emu] Reader initialized (device=emulator, detect=cd, mhz=357, cardmhz=357)
2021/03/06 15:36:09 00000000 (emu) INFO: FFDecsa parallel mode = 32
2021/03/06 15:36:09 00000000 (emu) ERROR: cannot bind to stream server socket
2021/03/06 15:36:09 75563CD0 c (dvbapi) Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1 maximum number of filters is 64 (oscam limit is 64)
2021/03/06 15:36:09 75563CD0 c (dvbapi) Detected /dev/dvb/adapter0/ca0 device, total available descramblers: 8
2021/03/06 15:36:09 229E654B c (dvbapi) Demuxer 0 stopped descrambling for program 006B (Sky Cinema Best Of HD)
2021/03/06 15:36:10 670C3692 r (reader) emulator [emu] card detected
2021/03/06 15:36:11 670C3692 r (reader) emulator [emu] found card system emu
2021/03/06 15:36:11 670C3692 r (reader) emulator [emu] THIS WAS A SUCCESSFUL START ATTEMPT No 1 out of max allotted of 1
2021/03/06 15:36:11 670C3692 r (emu) Key file not found in: /etc/tuxbox/config
2021/03/06 15:36:11 670C3692 r (emu) Key file not found in: /var/keys
2021/03/06 15:36:11 670C3692 r (emu) Total keys in memory: W:0 V:0 N:0 I:0 F:0 G:0 P:0 T:0 A:0
2021/03/06 15:36:11 5AF8981C r (reader) upperSlot [internal] ERROR: Opening device /dev/sci1 (errno=2 No such file or directory)
2021/03/06 15:36:11 5AF8981C r (reader) upperSlot [internal] Cannot open device: /dev/sci1
2021/03/06 15:36:11 6C2619BC r (reader) lowerSlot [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2021/03/06 15:36:11 6C2619BC r (reader) lowerSlot [internal] Cannot open device: /dev/sci0
2021/03/06 15:36:11 229E654B c (ecm) DVBApi (1861@000000/0000/006B/89:B7B7EE45A0E8B1334E1B379F04FE8B0D): timeout (5001 ms) by lowerSlot - Sky Cinema Best Of HD
2021/03/06 15:36:12 229E654B c (ecm) DVBApi (1861@000000/0000/006B/89:726FADBB5D98E6701C93F34FC3C7159C): timeout (5000 ms) by lowerSlot - Sky Cinema Best Of HD
2021/03/06 15:36:13 376DAC7F r (reader) lowerSlot [nagra] Warning: needed try nr 2, next ECM has some delay
2021/03/06 15:36:13 5AF8981C r (reader) upperSlot [internal] ERROR: Opening device /dev/sci1 (errno=2 No such file or directory)
2021/03/06 15:36:13 5AF8981C r (reader) upperSlot [internal] Cannot open device: /dev/sci1
2021/03/06 15:36:13 6C2619BC r (reader) lowerSlot [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2021/03/06 15:36:13 6C2619BC r (reader) lowerSlot [internal] Cannot open device: /dev/sci0
2021/03/06 15:36:14 75563CD0 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 1834 ECM_PID: 1C0B PROVID: 000000
2021/03/06 15:36:14 75563CD0 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 09FD ECM_PID: 1E0B PROVID: 000000
2021/03/06 15:36:14 75563CD0 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 09C7 ECM_PID: 1D0B PROVID: 000000
2021/03/06 15:36:14 75563CD0 c (dvbapi) Demuxer 0 ecmpid 3 CAID: 1861 ECM_PID: 190B PROVID: 000000
2021/03/06 15:36:14 75563CD0 c (dvbapi) Demuxer 0 ecmpid 4 CAID: 1854 ECM_PID: 1B0B PROVID: 000000
2021/03/06 15:36:14 75563CD0 c (dvbapi) Demuxer 0 found 5 ECM pids and 2 STREAM pids in CA PMT
2021/03/06 15:36:14 75563CD0 c (dvbapi) Demuxer 0 no suitable readers found that can be used for decoding!
2021/03/06 15:36:15 5AF8981C r (reader) upperSlot [internal] ERROR: Opening device /dev/sci1 (errno=2 No such file or directory)
2021/03/06 15:36:15 5AF8981C r (reader) upperSlot [internal] Cannot open device: /dev/sci1
2021/03/06 15:36:15 6C2619BC r (reader) lowerSlot [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2021/03/06 15:36:15 6C2619BC r (reader) lowerSlot [internal] Cannot open device: /dev/sci0
2021/03/06 15:36:17 376DAC7F r (reader) lowerSlot [nagra] Warning: needed try nr 2, next ECM has some delay
2021/03/06 15:36:17 5AF8981C r (reader) upperSlot [internal] ERROR: Opening device /dev/sci1 (errno=2 No such file or directory)
2021/03/06 15:36:17 5AF8981C r (reader) upperSlot [internal] Cannot open device: /dev/sci1
2021/03/06 15:36:17 6C2619BC r (reader) lowerSlot [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2021/03/06 15:36:17 6C2619BC r (reader) lowerSlot [internal] Cannot open device: /dev/sci0
2021/03/06 15:36:19 5AF8981C r (reader) upperSlot [internal] ERROR: Opening device /dev/sci1 (errno=2 No such file or directory)
2021/03/06 15:36:19 5AF8981C r (reader) upperSlot [internal] Cannot open device: /dev/sci1
2021/03/06 15:36:19 6C2619BC r (reader) lowerSlot [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2021/03/06 15:36:19 6C2619BC r (reader) lowerSlot [internal] Cannot open device: /dev/sci0
2021/03/06 15:36:20 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:36:21 5AF8981C r (reader) upperSlot [internal] ERROR: Opening device /dev/sci1 (errno=2 No such file or directory)
2021/03/06 15:36:21 5AF8981C r (reader) upperSlot [internal] Cannot open device: /dev/sci1
2021/03/06 15:36:21 6C2619BC r (reader) lowerSlot [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2021/03/06 15:36:21 6C2619BC r (reader) lowerSlot [internal] Cannot open device: /dev/sci0
2021/03/06 15:36:23 5AF8981C r (reader) upperSlot [internal] ERROR: Opening device /dev/sci1 (errno=2 No such file or directory)
2021/03/06 15:36:23 5AF8981C r (reader) upperSlot [internal] Cannot open device: /dev/sci1
2021/03/06 15:36:23 6C2619BC r (reader) lowerSlot [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2021/03/06 15:36:23 6C2619BC r (reader) lowerSlot [internal] Cannot open device: /dev/sci0
2021/03/06 15:36:25 5AF8981C r (reader) upperSlot [internal] ERROR: Opening device /dev/sci1 (errno=2 No such file or directory)
2021/03/06 15:36:25 5AF8981C r (reader) upperSlot [internal] Cannot open device: /dev/sci1
2021/03/06 15:36:25 6C2619BC r (reader) lowerSlot [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2021/03/06 15:36:25 6C2619BC r (reader) lowerSlot [internal] Cannot open device: /dev/sci0
2021/03/06 15:36:26 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:36:27 5AF8981C r (reader) upperSlot [internal] ERROR: Opening device /dev/sci1 (errno=2 No such file or directory)
2021/03/06 15:36:27 5AF8981C r (reader) upperSlot [internal] Cannot open device: /dev/sci1
2021/03/06 15:36:27 6C2619BC r (reader) lowerSlot [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2021/03/06 15:36:27 6C2619BC r (reader) lowerSlot [internal] Cannot open device: /dev/sci0
2021/03/06 15:36:29 5AF8981C r (reader) upperSlot [internal] ERROR: Opening device /dev/sci1 (errno=2 No such file or directory)
2021/03/06 15:36:29 5AF8981C r (reader) upperSlot [internal] Cannot open device: /dev/sci1
2021/03/06 15:36:29 5AF8981C r (reader) upperSlot [internal] Deactivating card
2021/03/06 15:36:29 5AF8981C r (reader) upperSlot [internal] Error:Sci_Deactivate ioctl(IOCTL_GET_IS_CARD_PRESENT) failed.(9:Bad file descriptor)
2021/03/06 15:36:29 6C2619BC r (reader) lowerSlot [internal] ERROR: Opening device /dev/sci0 (errno=16 Device or resource busy)
2021/03/06 15:36:29 6C2619BC r (reader) lowerSlot [internal] Cannot open device: /dev/sci0
2021/03/06 15:36:29 6C2619BC r (reader) lowerSlot [internal] Deactivating card
2021/03/06 15:36:29 6C2619BC r (reader) lowerSlot [internal] Error:Sci_Deactivate ioctl(IOCTL_GET_IS_CARD_PRESENT) failed.(9:Bad file descriptor)
2021/03/06 15:36:32 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:36:36 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:36:41 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:36:46 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:36:51 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:36:56 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:37:01 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:37:06 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:37:11 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:37:16 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:37:21 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:37:26 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:37:31 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:37:36 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:37:41 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:37:46 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:37:51 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:37:56 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:38:01 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:38:06 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:38:11 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:38:16 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:38:21 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:38:26 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:38:31 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:38:36 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2021/03/06 15:38:41 75563CD0 c (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!