2019/07/12 19:16:49 00000000 s     (main) System name    = Linux
2019/07/12 19:16:49 00000000 s     (main) Host name      = dm900
2019/07/12 19:16:49 00000000 s     (main) Release        = 3.14-1.17-dm900
2019/07/12 19:16:49 00000000 s     (main) Version        = #1 SMP Mon Oct 30 17:37:52 CET 2017
2019/07/12 19:16:49 00000000 s     (main) Machine        = armv7l
2019/07/12 19:16:49 00000000 s     (main) Stb model      = dm900
2019/07/12 19:16:49 00000000 s     (main) creating pidfile /tmp/.oscam/oscam.pid with pid 503
2019/07/12 19:16:49 00000000 s      (emu) OSCam-Emu version 796
2019/07/12 19:16:49 00000000 s   (config) userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2019/07/12 19:16:49 00000000 s     (main) signal handling initialized
2019/07/12 19:16:49 00000000 s   (reader) sci0 [internal] creating thread for device /dev/sci0
2019/07/12 19:16:49 00000000 s   (reader) emulator [emu] creating thread for device emulator
2019/07/12 19:16:49 6809FBB9 r   (reader) sci0 [internal] Dreambox dm900 found! set Internal cardmhz = 2700
2019/07/12 19:16:49 042B150F r      (emu) Stream key delayer initialized
2019/07/12 19:16:49 042B150F r      (emu) Stream relay server initialized
2019/07/12 19:16:49 3D998381 c   (client) plain dvbapi-client granted (dvbapi_local, au=auto (2 reader))
2019/07/12 19:16:49 3D998381 c   (dvbapi) Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1 maximum number of filters is 64 (oscam limit is 64)
2019/07/12 19:16:49 3D998381 c   (dvbapi) Detected /dev/dvb/adapter0/ca0 device, total available descramblers: 8
2019/07/12 19:16:49 042B150F r   (reader) emulator [emu] Reader initialized (device=emulator, detect=cd, mhz=357, cardmhz=357)
2019/07/12 19:16:49 00000000        (emu) INFO: FFDecsa parallel mode = 32
2019/07/12 19:16:49 67FB59E4 h    (webif) webif: decompressed 206504 bytes back into 455144 bytes
2019/07/12 19:16:49 67FB59E4 h    (webif) HTTP Server running. ip=:: port=8888
2019/07/12 19:16:50 042B150F r   (reader) emulator [emu] card detected
2019/07/12 19:16:51 042B150F r   (reader) emulator [emu] found card system emu
2019/07/12 19:16:51 042B150F r   (reader) emulator [emu] THIS WAS A SUCCESSFUL START ATTEMPT No  1 out of max allotted of 1
2019/07/12 19:16:51 042B150F r      (emu) Key file not found in: /var/keys
2019/07/12 19:16:51 042B150F r      (emu) Key file not found in: /var/keys
2019/07/12 19:16:51 042B150F r      (emu) Total keys in memory: W:0 V:0 N:0 I:0 F:0 G:0 P:0 T:0 A:0
2019/07/12 19:16:54 3D998381 c   (dvbapi) Demuxer 0 ecmpid 0 CAID: 1868 ECM_PID: 1859 PROVID: 000000 
2019/07/12 19:16:54 3D998381 c   (dvbapi) Demuxer 0 ecmpid 1 CAID: 1850 ECM_PID: 1959 PROVID: 000000 
2019/07/12 19:16:54 3D998381 c   (dvbapi) Demuxer 0 ecmpid 2 CAID: 1835 ECM_PID: 1B59 PROVID: 000000 
2019/07/12 19:16:54 3D998381 c   (dvbapi) Demuxer 0 ecmpid 3 CAID: 1838 ECM_PID: 1C59 PROVID: 000000 
2019/07/12 19:16:54 3D998381 c   (dvbapi) Demuxer 0 ecmpid 4 CAID: 1831 ECM_PID: 1D59 PROVID: 000000 
2019/07/12 19:16:54 3D998381 c   (dvbapi) Demuxer 0 ecmpid 5 CAID: 098E ECM_PID: 1E59 PROVID: 000000 
2019/07/12 19:16:54 3D998381 c   (dvbapi) Demuxer 0 found 6 ECMpids and 4 STREAMpids in caPMT
2019/07/12 19:16:54 3D998381 c   (dvbapi) Demuxer 0 no suitable readers found that can be used for decoding!
2019/07/12 19:16:54 3D998381 c   (dvbapi) Demuxer 0 found 6 ECMpids and 4 STREAMpids in PMT
2019/07/12 19:16:58 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:17:00 3D998381 c   (config) 1 provid's loaded
2019/07/12 19:17:00 3D998381 c   (config) 1 service-id's loaded in 0 ms
2019/07/12 19:17:03 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:17:08 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:17:13 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:17:17 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:17:22 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:17:27 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:17:32 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:17:35 3D998381 c   (dvbapi) Demuxer 0 stop descrambling program number 0081 (Sky Sport 1 HD)
2019/07/12 19:17:35 3D998381 c   (dvbapi) Demuxer 0 ecmpid 0 CAID: 1868 ECM_PID: 185C PROVID: 000000 
2019/07/12 19:17:35 3D998381 c   (dvbapi) Demuxer 0 ecmpid 1 CAID: 1850 ECM_PID: 195C PROVID: 000000 
2019/07/12 19:17:35 3D998381 c   (dvbapi) Demuxer 0 ecmpid 2 CAID: 1835 ECM_PID: 1B5C PROVID: 000000 
2019/07/12 19:17:35 3D998381 c   (dvbapi) Demuxer 0 ecmpid 3 CAID: 1838 ECM_PID: 1C5C PROVID: 000000 
2019/07/12 19:17:35 3D998381 c   (dvbapi) Demuxer 0 ecmpid 4 CAID: 1831 ECM_PID: 1D5C PROVID: 000000 
2019/07/12 19:17:35 3D998381 c   (dvbapi) Demuxer 0 ecmpid 5 CAID: 098E ECM_PID: 1E5C PROVID: 000000 
2019/07/12 19:17:35 3D998381 c   (dvbapi) Demuxer 0 found 6 ECMpids and 4 STREAMpids in caPMT
2019/07/12 19:17:35 3D998381 c   (dvbapi) Demuxer 0 no suitable readers found that can be used for decoding!
2019/07/12 19:17:35 3D998381 c   (dvbapi) Demuxer 0 found 6 ECMpids and 3 STREAMpids in PMT
2019/07/12 19:17:35 3D998381 c   (dvbapi) Demuxer 0 PMT update for decoding of SRVID 0072! 
2019/07/12 19:17:35 3D998381 c   (dvbapi) Demuxer 0 continue decoding of SRVID 0072
2019/07/12 19:17:35 3D998381 c   (dvbapi) Demuxer 0 found 6 ECMpids and 3 STREAMpids in caPMT
2019/07/12 19:17:39 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:17:41 3D998381 c   (config) 2 service-id's loaded in 0 ms
2019/07/12 19:17:44 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:17:49 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:17:54 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:17:58 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:18:03 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:18:08 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:18:10 6809FBB9 r   (reader) sci0 [internal] card detected
2019/07/12 19:18:13 6809FBB9 r   (reader) sci0 [internal] ATR: 3B 9F 21 0E 49 52 44 45 54 4F 20 41 43 53 03 84 55 FF 80 6D
2019/07/12 19:18:13 6809FBB9 r   (reader) sci0 [internal]  recognized
2019/07/12 19:18:13 3D998381 c   (dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!
2019/07/12 19:18:14 6809FBB9 r   (reader) sci0 [internal] detect irdeto tunneled nagra card
2019/07/12 19:18:14 6809FBB9 r   (reader) sci0 [internal] rsa key configured -> using nagra mode
2019/07/12 19:18:17 3D998381 c   (dvbapi) Demuxer 0 stop descrambling program number 0072 (Sky Sport 2 HD)
2019/07/12 19:18:17 3D998381 c   (dvbapi) Demuxer 0 ecmpid 0 CAID: 1868 ECM_PID: 1859 PROVID: 000000 
2019/07/12 19:18:17 3D998381 c   (dvbapi) Demuxer 0 ecmpid 1 CAID: 1850 ECM_PID: 1959 PROVID: 000000 
2019/07/12 19:18:17 3D998381 c   (dvbapi) Demuxer 0 ecmpid 2 CAID: 1835 ECM_PID: 1B59 PROVID: 000000 
2019/07/12 19:18:17 3D998381 c   (dvbapi) Demuxer 0 ecmpid 3 CAID: 1838 ECM_PID: 1C59 PROVID: 000000 
2019/07/12 19:18:17 3D998381 c   (dvbapi) Demuxer 0 ecmpid 4 CAID: 1831 ECM_PID: 1D59 PROVID: 000000 
2019/07/12 19:18:17 3D998381 c   (dvbapi) Demuxer 0 ecmpid 5 CAID: 098E ECM_PID: 1E59 PROVID: 000000 
2019/07/12 19:18:17 3D998381 c   (dvbapi) Demuxer 0 found 6 ECMpids and 4 STREAMpids in caPMT
2019/07/12 19:18:17 3D998381 c   (dvbapi) Demuxer 0 no suitable readers found that can be used for decoding!
2019/07/12 19:18:18 3D998381 c   (dvbapi) Demuxer 0 found 6 ECMpids and 4 STREAMpids in PMT
2019/07/12 19:18:18 6809FBB9 r   (reader) sci0 [internal] ready for requests
2019/07/12 19:18:18 6809FBB9 r   (reader) sci0 [internal] found card system nagra
2019/07/12 19:18:18 6809FBB9 r   (reader) sci0 [nagra] THIS WAS A SUCCESSFUL START ATTEMPT No  1 out of max allotted of 1
2019/07/12 19:18:18 6809FBB9 r   (reader) sci0 [nagra] ROM:    D N A S P 1 8 1
2019/07/12 19:18:18 6809FBB9 r   (reader) sci0 [nagra] REV:    D V R L 0 0
2019/07/12 19:18:18 6809FBB9 r   (reader) sci0 [nagra] SER:    ############
2019/07/12 19:18:18 6809FBB9 r   (reader) sci0 [nagra] CAID:   1835
2019/07/12 19:18:18 6809FBB9 r   (reader) sci0 [nagra] Prv.ID: 00 00 04 01 (sysid)
2019/07/12 19:18:18 6809FBB9 r   (reader) sci0 [nagra] Prv.ID: 00 00 00 00 
2019/07/12 19:18:19 6809FBB9 r   (reader) sci0 [nagra] IRD ID: ############
2019/07/12 19:18:19 6809FBB9 r   (reader) sci0 [nagra] active to: 2019/07/09 03:00
2019/07/12 19:18:19 3D998381 c   (dvbapi) Demuxer 0 restarting decoding requests after 2018 ms with 5 enabled and 1 disabled ecmpids!
2019/07/12 19:18:19 3D998381 c   (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1868 PROVID 000000 ECMPID 1859 ANY CHID PMTPID 0062 VPID 02FF
2019/07/12 19:18:19 3D998381 c   (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 1850 PROVID 000000 ECMPID 1959 ANY CHID PMTPID 0062 VPID 02FF
2019/07/12 19:18:19 3D998381 c   (dvbapi) Demuxer 0 trying to descramble PID 2 CAID 1835 PROVID 000000 ECMPID 1B59 ANY CHID PMTPID 0062 VPID 02FF
2019/07/12 19:18:19 3D998381 c   (dvbapi) Demuxer 0 trying to descramble PID 3 CAID 1838 PROVID 000000 ECMPID 1C59 ANY CHID PMTPID 0062 VPID 02FF
2019/07/12 19:18:19 3D998381 c   (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 1831 PROVID 000000 ECMPID 1D59 ANY CHID PMTPID 0062 VPID 02FF
2019/07/12 19:18:20 3D998381 c      (ecm) dvbapi_local (1868&/0000/1859/0081/89): not found (348 ms) by sci0 - Sky Sport 1 HD
2019/07/12 19:18:23 6809FBB9 r   (reader) sci0 [nagra] Warning: needed try nr 2, next ECM has some delay
2019/07/12 19:18:25 3D998381 c      (ecm) dvbapi_local (1850&/0000/1959/0081/B7): timeout (5000 ms) by sci0 - Sky Sport 1 HD
2019/07/12 19:18:25 3D998381 c      (ecm) dvbapi_local (1831&/0000/1D59/0081/6A): timeout (5000 ms) by sci0 - Sky Sport 1 HD
2019/07/12 19:18:25 3D998381 c      (ecm) dvbapi_local (1838&/0000/1C59/0081/92): timeout (5001 ms) by sci0 - Sky Sport 1 HD
2019/07/12 19:18:25 3D998381 c      (ecm) dvbapi_local (1835&/0000/1B59/0081/89): timeout (5001 ms) by sci0 - Sky Sport 1 HD
2019/07/12 19:18:27 6809FBB9 r   (reader) sci0 [nagra] Warning: needed try nr 2, next ECM has some delay
2019/07/12 19:18:30 3D998381 c      (ecm) dvbapi_local (1835&/0000/1B59/0081/89): timeout (5000 ms) by sci0 - Sky Sport 1 HD
2019/07/12 19:18:30 3D998381 c      (ecm) dvbapi_local (1838&/0000/1C59/0081/92): timeout (5001 ms) by sci0 - Sky Sport 1 HD
2019/07/12 19:18:30 3D998381 c      (ecm) dvbapi_local (1831&/0000/1D59/0081/6A): timeout (5001 ms) by sci0 - Sky Sport 1 HD
2019/07/12 19:18:30 3D998381 c      (ecm) dvbapi_local (1850&/0000/1959/0081/B7): timeout (5001 ms) by sci0 - Sky Sport 1 HD
2019/07/12 19:18:30 3D998381 c   (dvbapi) Demuxer 0 restarting decoding requests after 0 ms with 5 enabled and 1 disabled ecmpids!
2019/07/12 19:18:30 3D998381 c   (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1868 PROVID 000000 ECMPID 1859 ANY CHID PMTPID 0062 VPID 02FF
2019/07/12 19:18:30 3D998381 c   (dvbapi) Demuxer 0 trying to descramble PID 1 CAID 1850 PROVID 000000 ECMPID 1959 ANY CHID PMTPID 0062 VPID 02FF
2019/07/12 19:18:30 3D998381 c   (dvbapi) Demuxer 0 trying to descramble PID 2 CAID 1835 PROVID 000000 ECMPID 1B59 ANY CHID PMTPID 0062 VPID 02FF
2019/07/12 19:18:30 3D998381 c   (dvbapi) Demuxer 0 trying to descramble PID 3 CAID 1838 PROVID 000000 ECMPID 1C59 ANY CHID PMTPID 0062 VPID 02FF
2019/07/12 19:18:30 3D998381 c   (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 1831 PROVID 000000 ECMPID 1D59 ANY CHID PMTPID 0062 VPID 02FF
2019/07/12 19:18:30 3D998381 c      (ecm) dvbapi_local (1831&/0000/1D59/0081/6A): timeout (5000 ms) by sci0 - Sky Sport 1 HD
2019/07/12 19:18:30 3D998381 c      (ecm) dvbapi_local (1835&/0000/1B59/0081/89): timeout (5000 ms) by sci0 - Sky Sport 1 HD
2019/07/12 19:18:30 3D998381 c      (ecm) dvbapi_local (1838&/0000/1C59/0081/92): timeout (5000 ms) by sci0 - Sky Sport 1 HD
2019/07/12 19:18:31 3D998381 c      (ecm) dvbapi_local (1850&/0000/1959/0081/B7): timeout (5000 ms) by sci0 - Sky Sport 1 HD