2015/10/05 11:32:29 00000000 s >> OSCam << cardserver log switched, version 1.20-unstable_svn, build r10998 (mipsel-openpli40-linux-gnu-libusb)
2015/10/05 11:32:29 00000000 s (main) System name = Linux
2015/10/05 11:32:29 00000000 s (main) Host name = optimussos2plus
2015/10/05 11:32:29 00000000 s (main) Release = 3.9.7
2015/10/05 11:32:29 00000000 s (main) Version = #1 SMP Sat Sep 5 08:15:41 CEST 2015
2015/10/05 11:32:29 00000000 s (main) Machine = mips
2015/10/05 11:32:30 00000000 s (main) Stb model = dm8000
2015/10/05 11:32:30 00000000 s (main) Stb vumodel = vusolo2
2015/10/05 11:32:30 00000000 s (main) Stb boxtype = dm8000
2015/10/05 11:32:30 00000000 s (main) creating pidfile /tmp/.oscam/oscam.pid with pid 495
2015/10/05 11:32:30 00000000 s (config) services reloaded: 0 services freed, 1 services loaded, rejected 0
2015/10/05 11:32:30 00000000 s (config) userdb reloaded: 1 accounts loaded, 0 expired, 0 disabled
2015/10/05 11:32:30 00000000 s (main) signal handling initialized
2015/10/05 11:32:30 00000000 s (config) 155 service-id's loaded in 3 ms
2015/10/05 11:32:30 00000000 s (net) cccam: initialized (fd=5, port=12000)
2015/10/05 11:32:30 00000000 s (reader) reader0_hd+_hd01 [internal] creating thread for device /dev/sci0
2015/10/05 11:32:30 00000000 s (reader)
easymouse [cccam] creating thread for device 192.168.178.48
2015/10/05 11:32:30 00000000 s (stat) loadbalancer: could not open /tmp/.oscam/stat for reading (errno=2 No such file or directory)
2015/10/05 11:32:30 00000000 s (main) waiting for local card init
2015/10/05 11:32:30 14BBB928 r (reader) reader0_hd+_hd01 [internal] Reader initialized (device=/dev/sci0, detect=cd, pll max=27.00 MHz, wanted mhz=3.68 MHz)
2015/10/05 11:32:30 14BBB928 r (reader) reader0_hd+_hd01 [internal] Reader sci internal, detected box type: dm8000
2015/10/05 11:32:30 4296D733 p (reader) 192.168.178.48: resolved ip=192.168.178.48
2015/10/05 11:32:30 4296D733 p (reader)
easymouse [cccam] connecting to 192.168.178.48:13468
2015/10/05 11:32:30 4296D733 p (reader)
easymouse [cccam] proxy initialized, server 192.168.178.48:13468
2015/10/05 11:32:30 6E40C9F1 h (webif) webif: decompressed 164060 bytes back into 392536 bytes
2015/10/05 11:32:30 6E40C9F1 h (webif) HTTP Server running. ip=0.0.0.0 port=16002
2015/10/05 11:32:31 14BBB928 r (reader) reader0_hd+_hd01 [internal] card detected
2015/10/05 11:32:32 14BBB928 r (reader) reader0_hd+_hd01 [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/10/05 11:32:32 14BBB928 r (reader) reader0_hd+_hd01 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2015/10/05 11:32:32 14BBB928 r (reader) reader0_hd+_hd01 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2015/10/05 11:32:32 14BBB928 r (reader) reader0_hd+_hd01 [internal] Buffers readed 0 bytes total time_us 973
2015/10/05 11:32:32 14BBB928 r (reader) reader0_hd+_hd01 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->mhz)
2015/10/05 11:32:33 14BBB928 r (reader) reader0_hd+_hd01 [internal] Warning: Card returned error on setting ifsd value to 251
2015/10/05 11:32:34 14BBB928 r (reader) reader0_hd+_hd01 [internal] detect native nagra card
2015/10/05 11:32:35 14BBB928 r (reader) reader0_hd+_hd01 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2015/10/05 11:32:37 14BBB928 r (reader) reader0_hd+_hd01 [internal] T1 Resync command error, trying to reactivate!
2015/10/05 11:32:37 14BBB928 r (reader) reader0_hd+_hd01 [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/10/05 11:32:37 14BBB928 r (reader) reader0_hd+_hd01 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2015/10/05 11:32:37 14BBB928 r (reader) reader0_hd+_hd01 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2015/10/05 11:32:37 14BBB928 r (reader) reader0_hd+_hd01 [internal] Buffers readed 0 bytes total time_us 48
2015/10/05 11:32:38 14BBB928 r (reader) reader0_hd+_hd01 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->mhz)
2015/10/05 11:32:39 14BBB928 r (reader) reader0_hd+_hd01 [internal] Warning: Card returned error on setting ifsd value to 251
2015/10/05 11:32:40 14BBB928 r (reader) reader0_hd+_hd01 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2015/10/05 11:32:41 14BBB928 r (reader) reader0_hd+_hd01 [internal] T1 Resync command error, trying to reactivate!
2015/10/05 11:32:42 14BBB928 r (reader) reader0_hd+_hd01 [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/10/05 11:32:42 14BBB928 r (reader) reader0_hd+_hd01 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2015/10/05 11:32:42 14BBB928 r (reader) reader0_hd+_hd01 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2015/10/05 11:32:42 14BBB928 r (reader) reader0_hd+_hd01 [internal] Buffers readed 0 bytes total time_us 56
2015/10/05 11:32:43 14BBB928 r (reader) reader0_hd+_hd01 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->mhz)
2015/10/05 11:32:44 14BBB928 r (reader) reader0_hd+_hd01 [internal] Warning: Card returned error on setting ifsd value to 251
2015/10/05 11:32:44 14BBB928 r (reader) reader0_hd+_hd01 [internal] card system not supported
2015/10/05 11:32:44 14BBB928 r (reader) reader0_hd+_hd01 [internal] Normal mode failed, reverting to Deprecated Mode
2015/10/05 11:32:45 14BBB928 r (reader) reader0_hd+_hd01 [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/10/05 11:32:45 14BBB928 r (reader) reader0_hd+_hd01 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2015/10/05 11:32:45 14BBB928 r (reader) reader0_hd+_hd01 [internal] Calculated work ETU is 82.67 us reader mhz = 450
2015/10/05 11:32:45 14BBB928 r (reader) reader0_hd+_hd01 [internal] Buffers readed 0 bytes total time_us 48
2015/10/05 11:32:46 14BBB928 r (reader) reader0_hd+_hd01 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 4.50 Mhz (nearest possible mhz specified reader->mhz)
2015/10/05 11:32:46 14BBB928 r (reader) reader0_hd+_hd01 [internal] Warning: Card returned error on setting ifsd value to 251
2015/10/05 11:32:47 14BBB928 r (reader) reader0_hd+_hd01 [internal] detect native nagra card
2015/10/05 11:32:49 14BBB928 r (reader) reader0_hd+_hd01 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2015/10/05 11:32:50 14BBB928 r (reader) reader0_hd+_hd01 [internal] T1 Resync command error, trying to reactivate!
2015/10/05 11:32:51 14BBB928 r (reader) reader0_hd+_hd01 [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/10/05 11:32:51 14BBB928 r (reader) reader0_hd+_hd01 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2015/10/05 11:32:51 14BBB928 r (reader) reader0_hd+_hd01 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2015/10/05 11:32:51 14BBB928 r (reader) reader0_hd+_hd01 [internal] Buffers readed 0 bytes total time_us 46
2015/10/05 11:32:51 14BBB928 r (reader) reader0_hd+_hd01 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->mhz)
2015/10/05 11:32:52 14BBB928 r (reader) reader0_hd+_hd01 [internal] Warning: Card returned error on setting ifsd value to 251
2015/10/05 11:32:54 14BBB928 r (reader) reader0_hd+_hd01 [internal] Resync error: readtimeouts 0/0 (max/min) us, writetimeouts 0/0 (max/min) us
2015/10/05 11:32:55 14BBB928 r (reader) reader0_hd+_hd01 [internal] T1 Resync command error, trying to reactivate!
2015/10/05 11:32:56 14BBB928 r (reader) reader0_hd+_hd01 [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/10/05 11:32:56 14BBB928 r (reader) reader0_hd+_hd01 [internal] Init card protocol T1, FI=9, F=512, D=16, N=255
2015/10/05 11:32:56 14BBB928 r (reader) reader0_hd+_hd01 [internal] Calculated work ETU is 5.93 us reader mhz = 540
2015/10/05 11:32:56 14BBB928 r (reader) reader0_hd+_hd01 [internal] Buffers readed 0 bytes total time_us 47
2015/10/05 11:32:56 14BBB928 r (reader) reader0_hd+_hd01 [internal] PLL Reader: ATR Fsmax is 5 MHz, clocking card to 5.40 Mhz (nearest possible mhz specified reader->mhz)
2015/10/05 11:32:57 14BBB928 r (reader) reader0_hd+_hd01 [internal] Warning: Card returned error on setting ifsd value to 251
2015/10/05 11:32:57 14BBB928 r (reader) reader0_hd+_hd01 [internal] card system not supported
2015/10/05 11:32:57 14BBB928 r (reader) reader0_hd+_hd01 [internal] THIS WAS A FAILED START ATTEMPT No 1 out of max alloted of 1
2015/10/05 11:32:57 14BBB928 r (reader) reader0_hd+_hd01 [internal] card initializing error
2015/10/05 11:32:58 00000000 s (main) init for all local cards done
2015/10/05 11:32:58 00000000 s (anticasc) anti cascading disabled
2015/10/05 11:32:58 5D0A2508 c (client) plain dvbapi-client granted (dvbapiau, au=auto (2 reader))
2015/10/05 11:32:58 5D0A2508 c (dvbapi) dvbapi channelcache loaded from /usr/keys/oscam_atv/oscam.ccache
2015/10/05 11:32:58 5D0A2508 c (dvbapi) Detected /dev/dvb/adapter0/demux0 Api: 0, userconfig boxtype: 1
2015/10/05 11:32:58 5D0A2508 c (dvbapi) Demuxer 0 ecmpid 0 CAID: 1830 ECM_PID: 1CCC PROVID: 000000
2015/10/05 11:32:58 5D0A2508 c (dvbapi) Demuxer 0 ecmpid 1 CAID: 1843 ECM_PID: 19CC PROVID: 000000
2015/10/05 11:32:58 5D0A2508 c (dvbapi) Demuxer 0 ecmpid 2 CAID: 1860 ECM_PID: 1ECC PROVID: 000000
2015/10/05 11:32:58 5D0A2508 c (dvbapi) Demuxer 0 ecmpid 3 CAID: 098C ECM_PID: 1ACC PROVID: 000000
2015/10/05 11:32:58 5D0A2508 c (dvbapi) Demuxer 0 ecmpid 4 CAID: 09C4 ECM_PID: 1BCC PROVID: 000000
2015/10/05 11:32:58 5D0A2508 c (dvbapi) Demuxer 0 ecmpid 5 CAID: 186A ECM_PID: 1FCC PROVID: 000000
2015/10/05 11:32:58 5D0A2508 c (dvbapi) Demuxer 0 found 6 ECMpids and 7 STREAMpids in PMT
2015/10/05 11:32:58 5D0A2508 c (dvbapi) Demuxer 0 serving srvid EF10 (RTL HD) on adapter 0000 camask 0001 index 0000 pmtpid 0060
2015/10/05 11:32:58 5D0A2508 c (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 09C4 PROVID 000000 ECMPID 1BCC ANY CHID PMTPID 0060 VPID 00FF
2015/10/05 11:32:58 5D0A2508 c (ecm) dvbapiau (09C4@000000/0641/EF10/B3:161D8F870743CA80B484234F9CDC790F): not found (150 ms) by
easymouse
2015/10/05 11:32:59 5D0A2508 c (dvbapi) Demuxer 0 restarting decodingrequests after 0 ms with 1 enabled and 5 disabled ecmpids!
2015/10/05 11:32:59 5D0A2508 c (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 09C4 PROVID 000000 ECMPID 1BCC ANY CHID PMTPID 0060 VPID 00FF
2015/10/05 11:32:59 5D0A2508 c (ecm) dvbapiau (09C4@000000/0641/EF10/B3:161D8F870743CA80B484234F9CDC790F): not found (2 ms) by
easymouse
2015/10/05 11:33:00 5D0A2508 c (dvbapi) Demuxer 0 restarting decodingrequests after 1 ms with 1 enabled and 5 disabled ecmpids!
2015/10/05 11:33:00 5D0A2508 c (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 09C4 PROVID 000000 ECMPID 1BCC ANY CHID PMTPID 0060 VPID 00FF
2015/10/05 11:33:00 5D0A2508 c (ecm) dvbapiau (09C4@000000/0641/EF10/B3:161D8F870743CA80B484234F9CDC790F): not found (1 ms) by
easymouse
2015/10/05 11:33:01 5D0A2508 c (dvbapi) Demuxer 0 restarting decodingrequests after 1 ms with 1 enabled and 5 disabled ecmpids!
2015/10/05 11:33:01 5D0A2508 c (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 09C4 PROVID 000000 ECMPID 1BCC ANY CHID PMTPID 0060 VPID 00FF
2015/10/05 11:33:01 5D0A2508 c (ecm) dvbapiau (09C4@000000/0641/EF10/B3:CB7C5B8B4FF449A759D8C3481CAA87E5): rejected (2 ms) by
easymouse
2015/10/05 11:33:02 5D0A2508 c (ecm) dvbapiau (09C4@000000/0641/EF10/B3:CB7C5B8B4FF449A759D8C3481CAA87E5): rejected (1 ms) by
easymouse
2015/10/05 11:33:02 5D0A2508 c (dvbapi) Demuxer 0 restarting decodingrequests after 1 ms with 1 enabled and 5 disabled ecmpids!
2015/10/05 11:33:02 5D0A2508 c (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 09C4 PROVID 000000 ECMPID 1BCC ANY CHID PMTPID 0060 VPID 00FF
2015/10/05 11:33:03 5D0A2508 c (ecm) dvbapiau (09C4@000000/0641/EF10/B3:CB7C5B8B4FF449A759D8C3481CAA87E5): rejected (1 ms) by
easymouse
2015/10/05 11:33:03 5D0A2508 c (-) -- Skipped 1 duplicated log lines --
2015/10/05 11:33:03 5D0A2508 c (dvbapi) Demuxer 0 restarting decodingrequests after 0 ms with 1 enabled and 5 disabled ecmpids!
2015/10/05 11:33:03 5D0A2508 c (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 09C4 PROVID 000000 ECMPID 1BCC ANY CHID PMTPID 0060 VPID 00FF
2015/10/05 11:33:04 5D0A2508 c (ecm) dvbapiau (09C4@000000/0641/EF10/B3:CB7C5B8B4FF449A759D8C3481CAA87E5): rejected (1 ms) by
easymouse
2015/10/05 11:33:05 5D0A2508 c (-) -- Skipped 1 duplicated log lines --
2015/10/05 11:33:05 5D0A2508 c (dvbapi) Demuxer 0 restarting decodingrequests after 1 ms with 1 enabled and 5 disabled ecmpids!
2015/10/05 11:33:05 5D0A2508 c (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 09C4 PROVID 000000 ECMPID 1BCC ANY CHID PMTPID 0060 VPID 00FF
2015/10/05 11:33:05 5D0A2508 c (ecm) dvbapiau (09C4@000000/0641/EF10/B3:CB7C5B8B4FF449A759D8C3481CAA87E5): rejected (1 ms) by
easymouse
2015/10/05 11:33:06 5D0A2508 c (-) -- Skipped 1 duplicated log lines --
2015/10/05 11:33:06 5D0A2508 c (dvbapi) Demuxer 0 restarting decodingrequests after 1 ms with 1 enabled and 5 disabled ecmpids!
2015/10/05 11:33:06 5D0A2508 c (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 09C4 PROVID 000000 ECMPID 1BCC ANY CHID PMTPID 0060 VPID 00FF
2015/10/05 11:33:06 5D0A2508 c (ecm) dvbapiau (09C4@000000/0641/EF10/B3:CB7C5B8B4FF449A759D8C3481CAA87E5): rejected (1 ms) by
easymouse
2015/10/05 11:33:07 5D0A2508 c (-) -- Skipped 1 duplicated log lines --
2015/10/05 11:33:07 5D0A2508 c (dvbapi) Demuxer 0 restarting decodingrequests after 0 ms with 1 enabled and 5 disabled ecmpids!
2015/10/05 11:33:07 5D0A2508 c (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 09C4 PROVID 000000 ECMPID 1BCC ANY CHID PMTPID 0060 VPID 00FF
2015/10/05 11:33:08 5D0A2508 c (ecm) dvbapiau (09C4@000000/0641/EF10/B3:CB7C5B8B4FF449A759D8C3481CAA87E5): rejected (1 ms) by
easymouse
2015/10/05 11:33:08 5D0A2508 c (-) -- Skipped 1 duplicated log lines --
2015/10/05 11:33:08 5D0A2508 c (dvbapi) Demuxer 0 restarting decodingrequests after 1 ms with 1 enabled and 5 disabled ecmpids!
2015/10/05 11:33:08 5D0A2508 c (dvbapi) Demuxer 0 trying to descramble PID 4 CAID 09C4 PROVID 000000 ECMPID 1BCC ANY CHID PMTPID 0060 VPID 00FF
2015/10/05 11:33:09 5D0A2508 c (ecm) dvbapiau (09C4@000000/0641/EF10/B3:CB7C5B8B4FF449A759D8C3481CAA87E5): rejected (2 ms) by
easymouse
2015/10/05 11:33:09 5D0A2508 c (ecm) dvbapiau (09C4@000000/0641/EF10/B3:CB7C5B8B4FF449A759D8C3481CAA87E5): rejected (1 ms) by
easymouse
2015/10/05 11:33:10 5D0A2508 c (dvbapi) Demuxer 0 restarting decodingrequests after 0 ms with 1 enabled and 5 disabled ecmpids!