jonesi100
30-03-14, 17:15
I have an ET9000, running Vix Zeus 061 (kernel 3.8.7). I am trying to decode Sky Channels using a valid Sky card from my Sky Plus HD box, with all valid entitlements. Using OSCAM, I can decode several Sky Channels, such as Sky 1, but not any Premium channels like Movies or Sports.
So OSCAM in the main is fine, I am running DVBAPI locally with the latest OSCAM r9606 (I have tried several other verisions too).
Can OSCAM actually decode the Sky Premium channels with a local card? Should I switch back to CCCam?
I have observed strange notifications in the OSCAM logs, where the CAID 0963 for the sports and movies sometimes is received as 0961 or 0962 therefore my CAM is rejecting the packets as my card is not entitled to decode those CAID's.
OSCAM configs and logs are shown below (PS I have also tried betatunnel in OSCAN.USER and masking in OSCAM.DVBAPI neither of which have worked to translate 0961/2 to 0963, if indeed that is one of the problems.)
Any help apreciated, as I have been unable to fix for days (PS I have tried removing whitelists, idents, CAIDs etc, none have worked)
# oscam.conf
[global]
logfile = /tmp/oscam.log
nice = -1
maxlogsize = 256
preferlocalcards = 1
[cache]
[dvbapi]
enabled = 1
au = 1
user = dvbapiuser
boxtype = dreambox
[webif]
httpport = 8888
httpuser = username
httppwd = password
httprefresh = 5
httpallowed = 127.0.0.1,192.168.0.1-192.168.0.255
hideclient_to = 15
# oscam.user
[account]
user = dvbapiuser
caid = 0963
monlevel = 4
au = skyuk
group = 1
ident = 0963:000000
# oscam.server
[reader]
label = skyuk
protocol = internal
device = /dev/sci1
caid = 0963
boxid = XXXXXXX
ecmwhitelist = 0963@000000:3B,3E,42,44,45,47,4B,4E,4F,5E,5F,53,54 ,56,61,62,65,66,67,68,69,6A,6B,6C,6D,6F,70,71,72,7 3,74,76,77,78,79,7A,7C,7D,7E,80,82,84,85,88,8B,9A
mhz = 357
cardmhz = 357
ident = 0963:000000
group = 1
emmcache = 1,3,2
blockemm-unknown = 1
blockemm-g = 1
saveemm-u = 1
saveemm-s = 1
#OSCAM (Partial Live Log from WebIF - Full debug on - full log is in attachment)
2014/03/30 16:49:23 558C08 c dvbapiuser (0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671): rejected group (7 ms) - Sky Sports HD1 (no matching reader)
2014/03/30 16:49:23 558C08 c cw:
2014/03/30 16:49:23 558C08 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 request cw for ecm 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 has 3 ecmpids, 13 streampids, 0 ecmfilters and 0 emmfilters
2014/03/30 16:49:23 558C08 c caid 0961 not found in caidlist reader skyuk
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 impossible to descramble PID #1 CAID 0961 PROVID 000000 ECMPID 0503 PMTPID 0100 (NO MATCHING READER)
2014/03/30 16:49:23 558C08 c caid 0960 not found in caidlist reader skyuk
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 impossible to descramble PID #2 CAID 0960 PROVID 000000 ECMPID 0503 PMTPID 0100 (NO MATCHING READER)
2014/03/30 16:49:23 77500468 h WebIf: Origin checked. Result: access from 192.168.0.21 => allowed
2014/03/30 16:49:23 0 --- Skipped 5 duplicated log lines ---
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 3 ecmpids!
2014/03/30 16:49:23 54BD90 r skyuk [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/03/30 16:49:23 558C08 c [PRIORITIZE PID 0] 0963:000000:0503 (found caid/provid in cache - weight: 1)
2014/03/30 16:49:23 558C08 c [DVBAPI] found in channel cache: 0963&000000/FFFF/0EDA/00:(null)
2014/03/30 16:49:23 558C08 c [PRIORITIZE PID 0] 0963:000000:0503 (found caid/provid/srvid in cache - weight: 2)
2014/03/30 16:49:23 558C08 c [PRIORITIZE PID 0] 0963:000000:0503:0000 (localrdr: skyuk weight: 8)
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 trying to descramble PID #0 CAID 0963 PROVID 000000 ECMPID 0503 ANY CHID PMTPID 0100 VPID 0202
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 try to start new filter for caid: 0963, provid: 000000, pid: 0503
2014/03/30 16:49:23 558C08 c DEVICE open (/dev/dvb/adapter0/demux0) fd 16
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 Filter #1 started successfully (caid 0963 provid 000000 pid 0503)
2014/03/30 16:49:24 558C08 c loadbalancer: NO VALID MATCHING READER FOUND!
2014/03/30 16:49:24 558C08 c loadbalancer: reader skyuk blocked for 30 seconds (fail_factor 1), retrying in 19 seconds
2014/03/30 16:49:24 558C08 c loadbalancer: --------------------------------------------
2014/03/30 16:49:24 558C08 c loadbalancer: client dvbapiuser for 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671: n=0 selected readers:
2014/03/30 16:49:24 558C08 c [GET_CW] wait_time 0 caid 0963 prov 000000 srvid 0EDA rc 100 cacheex cl mode 0 ex1rdr 0
2014/03/30 16:49:24 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [get_cw] wait_time 0 - client cacheex mode 0, reader avail for ecm 1, hitcache 0
2014/03/30 16:49:24 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [get_cw] NO Readers and NO wait_time... not_found!
2014/03/30 16:49:24 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [send_dcw] rc 4 from reader -
2014/03/30 16:49:24 558C08 c Client dvbapiuser csphash 72292318 cw 00000000000000000000000000000000 rc 4 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 no controlword received for PID #0 CAID 0963 PROVID 000000 ECMPID 0503 CHID FFFF VPID 0202
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 requested controlword for ecm 13CA6B12B5DBCF77729C7D9774EDD671 on fd 16
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 stop Filter #1 (fd: 16 api: 0, caid: 0963, provid: 000000, ecmpid: 0503)
2014/03/30 16:49:24 558C08 c dvbapiuser (0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671): rejected group (7 ms) - Sky Sports HD1 (no matching reader)
2014/03/30 16:49:24 558C08 c cw:
2014/03/30 16:49:24 558C08 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 request cw for ecm 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 has 3 ecmpids, 13 streampids, 0 ecmfilters and 0 emmfilters
2014/03/30 16:49:24 558C08 c caid 0961 not found in caidlist reader skyuk
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 impossible to descramble PID #1 CAID 0961 PROVID 000000 ECMPID 0503 PMTPID 0100 (NO MATCHING READER)
2014/03/30 16:49:24 558C08 c caid 0960 not found in caidlist reader skyuk
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 impossible to descramble PID #2 CAID 0960 PROVID 000000 ECMPID 0503 PMTPID 0100 (NO MATCHING READER)
2014/03/30 16:49:24 54BD90 r skyuk [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 3 ecmpids!
2014/03/30 16:49:25 558C08 c [PRIORITIZE PID 0] 0963:000000:0503 (found caid/provid in cache - weight: 1)
2014/03/30 16:49:25 558C08 c [DVBAPI] found in channel cache: 0963&000000/FFFF/0EDA/00:(null)
2014/03/30 16:49:25 558C08 c [PRIORITIZE PID 0] 0963:000000:0503 (found caid/provid/srvid in cache - weight: 2)
2014/03/30 16:49:25 558C08 c [PRIORITIZE PID 0] 0963:000000:0503:0000 (localrdr: skyuk weight: 8)
2014/03/30 16:49:25 558C08 c [DVBAPI] Demuxer #0 trying to descramble PID #0 CAID 0963 PROVID 000000 ECMPID 0503 ANY CHID PMTPID 0100 VPID 0202
2014/03/30 16:49:25 558C08 c [DVBAPI] Demuxer #0 try to start new filter for caid: 0963, provid: 000000, pid: 0503
2014/03/30 16:49:25 558C08 c DEVICE open (/dev/dvb/adapter0/demux0) fd 16
2014/03/30 16:49:25 558C08 c [DVBAPI] Demuxer #0 Filter #1 started successfully (caid 0963 provid 000000 pid 0503)
2014/03/30 16:49:26 558C08 45 F3 42 3E
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 Filter #1 fetched ecm data
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 ECMTYPE 80 CAID 0963 PROVID 000000 ECMPID 0503 FAKECHID FFFF (unique part in ecm)
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 Filter #1 set ecmtable to ODD (CAID 0963 PROVID 000000 FD 16)
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 Filter #1 set chid to ANY CHID on fd 16
2014/03/30 16:49:26 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [get_cw] NEW REQUEST!
2014/03/30 16:49:26 558C08 c loadbalancer: client dvbapiuser for 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671: n=1 valid readers: skyukL
2014/03/30 16:49:26 558C08 c loadbalancer: --------------------------------------------
2014/03/30 16:49:26 558C08 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2014/03/30 16:49:26 558C08 c loadbalancer: NO VALID MATCHING READER FOUND!
2014/03/30 16:49:26 558C08 c loadbalancer: reader skyuk blocked for 30 seconds (fail_factor 1), retrying in 18 seconds
2014/03/30 16:49:26 558C08 c loadbalancer: --------------------------------------------
2014/03/30 16:49:26 558C08 c loadbalancer: client dvbapiuser for 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671: n=0 selected readers:
2014/03/30 16:49:26 558C08 c [GET_CW] wait_time 0 caid 0963 prov 000000 srvid 0EDA rc 100 cacheex cl mode 0 ex1rdr 0
2014/03/30 16:49:26 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [get_cw] wait_time 0 - client cacheex mode 0, reader avail for ecm 1, hitcache 0
2014/03/30 16:49:26 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [get_cw] NO Readers and NO wait_time... not_found!
2014/03/30 16:49:26 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [send_dcw] rc 4 from reader -
2014/03/30 16:49:26 558C08 c Client dvbapiuser csphash 72292318 cw 00000000000000000000000000000000 rc 4 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 no controlword received for PID #0 CAID 0963 PROVID 000000 ECMPID 0503 CHID FFFF VPID 0202
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 requested controlword for ecm 13CA6B12B5DBCF77729C7D9774EDD671 on fd 16
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 stop Filter #1 (fd: 16 api: 0, caid: 0963, provid: 000000, ecmpid: 0503)
2014/03/30 16:49:26 558C08 c dvbapiuser (0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671): rejected group (7 ms) - Sky Sports HD1 (no matching reader)
2014/03/30 16:49:26 558C08 c cw:
2014/03/30 16:49:26 558C08 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 request cw for ecm 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 has 3 ecmpids, 13 streampids, 0 ecmfilters and 0 emmfilters
2014/03/30 16:49:26 558C08 c caid 0961 not found in caidlist reader skyuk
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 impossible to descramble PID #1 CAID 0961 PROVID 000000 ECMPID 0503 PMTPID 0100 (NO MATCHING READER)
2014/03/30 16:49:26 558C08 c caid 0960 not found in caidlist reader skyuk
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 impossible to descramble PID #2 CAID 0960 PROVID 000000 ECMPID 0503 PMTPID 0100 (NO MATCHING READER)
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 3 ecmpids!
2014/03/30 16:49:27 558C08 c loadbalancer: NO VALID MATCHING READER FOUND!
So OSCAM in the main is fine, I am running DVBAPI locally with the latest OSCAM r9606 (I have tried several other verisions too).
Can OSCAM actually decode the Sky Premium channels with a local card? Should I switch back to CCCam?
I have observed strange notifications in the OSCAM logs, where the CAID 0963 for the sports and movies sometimes is received as 0961 or 0962 therefore my CAM is rejecting the packets as my card is not entitled to decode those CAID's.
OSCAM configs and logs are shown below (PS I have also tried betatunnel in OSCAN.USER and masking in OSCAM.DVBAPI neither of which have worked to translate 0961/2 to 0963, if indeed that is one of the problems.)
Any help apreciated, as I have been unable to fix for days (PS I have tried removing whitelists, idents, CAIDs etc, none have worked)
# oscam.conf
[global]
logfile = /tmp/oscam.log
nice = -1
maxlogsize = 256
preferlocalcards = 1
[cache]
[dvbapi]
enabled = 1
au = 1
user = dvbapiuser
boxtype = dreambox
[webif]
httpport = 8888
httpuser = username
httppwd = password
httprefresh = 5
httpallowed = 127.0.0.1,192.168.0.1-192.168.0.255
hideclient_to = 15
# oscam.user
[account]
user = dvbapiuser
caid = 0963
monlevel = 4
au = skyuk
group = 1
ident = 0963:000000
# oscam.server
[reader]
label = skyuk
protocol = internal
device = /dev/sci1
caid = 0963
boxid = XXXXXXX
ecmwhitelist = 0963@000000:3B,3E,42,44,45,47,4B,4E,4F,5E,5F,53,54 ,56,61,62,65,66,67,68,69,6A,6B,6C,6D,6F,70,71,72,7 3,74,76,77,78,79,7A,7C,7D,7E,80,82,84,85,88,8B,9A
mhz = 357
cardmhz = 357
ident = 0963:000000
group = 1
emmcache = 1,3,2
blockemm-unknown = 1
blockemm-g = 1
saveemm-u = 1
saveemm-s = 1
#OSCAM (Partial Live Log from WebIF - Full debug on - full log is in attachment)
2014/03/30 16:49:23 558C08 c dvbapiuser (0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671): rejected group (7 ms) - Sky Sports HD1 (no matching reader)
2014/03/30 16:49:23 558C08 c cw:
2014/03/30 16:49:23 558C08 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 request cw for ecm 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 has 3 ecmpids, 13 streampids, 0 ecmfilters and 0 emmfilters
2014/03/30 16:49:23 558C08 c caid 0961 not found in caidlist reader skyuk
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 impossible to descramble PID #1 CAID 0961 PROVID 000000 ECMPID 0503 PMTPID 0100 (NO MATCHING READER)
2014/03/30 16:49:23 558C08 c caid 0960 not found in caidlist reader skyuk
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 impossible to descramble PID #2 CAID 0960 PROVID 000000 ECMPID 0503 PMTPID 0100 (NO MATCHING READER)
2014/03/30 16:49:23 77500468 h WebIf: Origin checked. Result: access from 192.168.0.21 => allowed
2014/03/30 16:49:23 0 --- Skipped 5 duplicated log lines ---
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 3 ecmpids!
2014/03/30 16:49:23 54BD90 r skyuk [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/03/30 16:49:23 558C08 c [PRIORITIZE PID 0] 0963:000000:0503 (found caid/provid in cache - weight: 1)
2014/03/30 16:49:23 558C08 c [DVBAPI] found in channel cache: 0963&000000/FFFF/0EDA/00:(null)
2014/03/30 16:49:23 558C08 c [PRIORITIZE PID 0] 0963:000000:0503 (found caid/provid/srvid in cache - weight: 2)
2014/03/30 16:49:23 558C08 c [PRIORITIZE PID 0] 0963:000000:0503:0000 (localrdr: skyuk weight: 8)
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 trying to descramble PID #0 CAID 0963 PROVID 000000 ECMPID 0503 ANY CHID PMTPID 0100 VPID 0202
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 try to start new filter for caid: 0963, provid: 000000, pid: 0503
2014/03/30 16:49:23 558C08 c DEVICE open (/dev/dvb/adapter0/demux0) fd 16
2014/03/30 16:49:23 558C08 c [DVBAPI] Demuxer #0 Filter #1 started successfully (caid 0963 provid 000000 pid 0503)
2014/03/30 16:49:24 558C08 c loadbalancer: NO VALID MATCHING READER FOUND!
2014/03/30 16:49:24 558C08 c loadbalancer: reader skyuk blocked for 30 seconds (fail_factor 1), retrying in 19 seconds
2014/03/30 16:49:24 558C08 c loadbalancer: --------------------------------------------
2014/03/30 16:49:24 558C08 c loadbalancer: client dvbapiuser for 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671: n=0 selected readers:
2014/03/30 16:49:24 558C08 c [GET_CW] wait_time 0 caid 0963 prov 000000 srvid 0EDA rc 100 cacheex cl mode 0 ex1rdr 0
2014/03/30 16:49:24 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [get_cw] wait_time 0 - client cacheex mode 0, reader avail for ecm 1, hitcache 0
2014/03/30 16:49:24 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [get_cw] NO Readers and NO wait_time... not_found!
2014/03/30 16:49:24 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [send_dcw] rc 4 from reader -
2014/03/30 16:49:24 558C08 c Client dvbapiuser csphash 72292318 cw 00000000000000000000000000000000 rc 4 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 no controlword received for PID #0 CAID 0963 PROVID 000000 ECMPID 0503 CHID FFFF VPID 0202
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 requested controlword for ecm 13CA6B12B5DBCF77729C7D9774EDD671 on fd 16
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 stop Filter #1 (fd: 16 api: 0, caid: 0963, provid: 000000, ecmpid: 0503)
2014/03/30 16:49:24 558C08 c dvbapiuser (0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671): rejected group (7 ms) - Sky Sports HD1 (no matching reader)
2014/03/30 16:49:24 558C08 c cw:
2014/03/30 16:49:24 558C08 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 request cw for ecm 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 has 3 ecmpids, 13 streampids, 0 ecmfilters and 0 emmfilters
2014/03/30 16:49:24 558C08 c caid 0961 not found in caidlist reader skyuk
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 impossible to descramble PID #1 CAID 0961 PROVID 000000 ECMPID 0503 PMTPID 0100 (NO MATCHING READER)
2014/03/30 16:49:24 558C08 c caid 0960 not found in caidlist reader skyuk
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 impossible to descramble PID #2 CAID 0960 PROVID 000000 ECMPID 0503 PMTPID 0100 (NO MATCHING READER)
2014/03/30 16:49:24 54BD90 r skyuk [videoguard2] cardreader_do_checkhealth: reader->card_status = 2, ret = 1
2014/03/30 16:49:24 558C08 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 3 ecmpids!
2014/03/30 16:49:25 558C08 c [PRIORITIZE PID 0] 0963:000000:0503 (found caid/provid in cache - weight: 1)
2014/03/30 16:49:25 558C08 c [DVBAPI] found in channel cache: 0963&000000/FFFF/0EDA/00:(null)
2014/03/30 16:49:25 558C08 c [PRIORITIZE PID 0] 0963:000000:0503 (found caid/provid/srvid in cache - weight: 2)
2014/03/30 16:49:25 558C08 c [PRIORITIZE PID 0] 0963:000000:0503:0000 (localrdr: skyuk weight: 8)
2014/03/30 16:49:25 558C08 c [DVBAPI] Demuxer #0 trying to descramble PID #0 CAID 0963 PROVID 000000 ECMPID 0503 ANY CHID PMTPID 0100 VPID 0202
2014/03/30 16:49:25 558C08 c [DVBAPI] Demuxer #0 try to start new filter for caid: 0963, provid: 000000, pid: 0503
2014/03/30 16:49:25 558C08 c DEVICE open (/dev/dvb/adapter0/demux0) fd 16
2014/03/30 16:49:25 558C08 c [DVBAPI] Demuxer #0 Filter #1 started successfully (caid 0963 provid 000000 pid 0503)
2014/03/30 16:49:26 558C08 45 F3 42 3E
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 Filter #1 fetched ecm data
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 ECMTYPE 80 CAID 0963 PROVID 000000 ECMPID 0503 FAKECHID FFFF (unique part in ecm)
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 Filter #1 set ecmtable to ODD (CAID 0963 PROVID 000000 FD 16)
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 Filter #1 set chid to ANY CHID on fd 16
2014/03/30 16:49:26 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [get_cw] NEW REQUEST!
2014/03/30 16:49:26 558C08 c loadbalancer: client dvbapiuser for 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671: n=1 valid readers: skyukL
2014/03/30 16:49:26 558C08 c loadbalancer: --------------------------------------------
2014/03/30 16:49:26 558C08 c loadbalancer: mode 1, nbest 1, nfb 1, max_reopen ALL, retrylimit 0ms
2014/03/30 16:49:26 558C08 c loadbalancer: NO VALID MATCHING READER FOUND!
2014/03/30 16:49:26 558C08 c loadbalancer: reader skyuk blocked for 30 seconds (fail_factor 1), retrying in 18 seconds
2014/03/30 16:49:26 558C08 c loadbalancer: --------------------------------------------
2014/03/30 16:49:26 558C08 c loadbalancer: client dvbapiuser for 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671: n=0 selected readers:
2014/03/30 16:49:26 558C08 c [GET_CW] wait_time 0 caid 0963 prov 000000 srvid 0EDA rc 100 cacheex cl mode 0 ex1rdr 0
2014/03/30 16:49:26 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [get_cw] wait_time 0 - client cacheex mode 0, reader avail for ecm 1, hitcache 0
2014/03/30 16:49:26 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [get_cw] NO Readers and NO wait_time... not_found!
2014/03/30 16:49:26 558C08 c {client dvbapiuser, caid 0963, prid 000000, srvid 0EDA} [send_dcw] rc 4 from reader -
2014/03/30 16:49:26 558C08 c Client dvbapiuser csphash 72292318 cw 00000000000000000000000000000000 rc 4 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 no controlword received for PID #0 CAID 0963 PROVID 000000 ECMPID 0503 CHID FFFF VPID 0202
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 requested controlword for ecm 13CA6B12B5DBCF77729C7D9774EDD671 on fd 16
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 stop Filter #1 (fd: 16 api: 0, caid: 0963, provid: 000000, ecmpid: 0503)
2014/03/30 16:49:26 558C08 c dvbapiuser (0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671): rejected group (7 ms) - Sky Sports HD1 (no matching reader)
2014/03/30 16:49:26 558C08 c cw:
2014/03/30 16:49:26 558C08 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 request cw for ecm 0963&000000/FFFF/0EDA/84:13CA6B12B5DBCF77729C7D9774EDD671
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 has 3 ecmpids, 13 streampids, 0 ecmfilters and 0 emmfilters
2014/03/30 16:49:26 558C08 c caid 0961 not found in caidlist reader skyuk
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 impossible to descramble PID #1 CAID 0961 PROVID 000000 ECMPID 0503 PMTPID 0100 (NO MATCHING READER)
2014/03/30 16:49:26 558C08 c caid 0960 not found in caidlist reader skyuk
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 impossible to descramble PID #2 CAID 0960 PROVID 000000 ECMPID 0503 PMTPID 0100 (NO MATCHING READER)
2014/03/30 16:49:26 558C08 c [DVBAPI] Demuxer #0 (re)starting decodingrequests on all 3 ecmpids!
2014/03/30 16:49:27 558C08 c loadbalancer: NO VALID MATCHING READER FOUND!