Tvheadend

Hi,
because of this Ticket https://tvheadend.org/issues/5595 , i make this new.

I have the problem that a lot of services can not mapped.

From 990 Muxes were only 258 Services found, i could be a newcamed and oscam Problem, my oscam Server works fine with Oscam Clients, but not with TVH newcamd.

The Oscam Log shows me this:

2019/04/10 20:13:53 00000000 s     (main) System name    = Linux
2019/04/10 20:13:53 00000000 s     (main) Host name      = cubietruck
2019/04/10 20:13:53 00000000 s     (main) Release        = 4.20.7-sunxi
2019/04/10 20:13:53 00000000 s     (main) Version        = #5.75 SMP Fri Feb 8 09:02:10 CET 2019
2019/04/10 20:13:53 00000000 s     (main) Machine        = armv7l
2019/04/10 20:13:53 00000000 s     (main) creating pidfile /tmp/.oscam/oscam.pid with pid 12969
2019/04/10 20:13:53 00000000 s   (config) userdb reloaded: 4 accounts loaded, 0 expired, 0 disabled
2019/04/10 20:13:53 00000000 s     (main) signal handling initialized
2019/04/10 20:13:53 00000000 s      (net) cs357x: initialized (fd=4, port=10000, prio=1 [ SO_PRIORITY IP_TOS ])
2019/04/10 20:13:53 00000000 s      (net) newcamd: initialized (fd=5, port=24241, prio=1 [ SO_PRIORITY IP_TOS ])
2019/04/10 20:13:53 00000000 s      (net) -> CAID: 1834 PROVID: 1F1F1F
2019/04/10 20:13:53 00000000 s   (reader) KD_HD_D02_Sky [mouse] creating thread for device /dev/Easymouse2
2019/04/10 20:13:53 00000000 s     (main) waiting for local card init
2019/04/10 20:13:53 401E10E1 h    (webif) webif: decompressed 180016 bytes back into 444204 bytes
2019/04/10 20:13:53 401E10E1 h    (webif) HTTP Server running. ip=0.0.0.0 port=2000
2019/04/10 20:13:53 739FC3C0 r   (reader) KD_HD_D02_Sky [mouse] Reader initialized (device=/dev/Easymouse2, detect=cd, mhz=600, cardmhz=600)
2019/04/10 20:13:54 739FC3C0 r   (reader) KD_HD_D02_Sky [mouse] card detected
2019/04/10 20:13:55 739FC3C0 r   (reader) KD_HD_D02_Sky [mouse] ATR: 3B 9F 21 0E 49 52 44 45 54 4F 20 41 43 53 03 84 55 FF 80 6D
2019/04/10 20:13:57 739FC3C0 r   (reader) KD_HD_D02_Sky [mouse] detect irdeto tunneled nagra card
2019/04/10 20:13:57 739FC3C0 r   (reader) KD_HD_D02_Sky [mouse] no rsa key configured -> using irdeto mode
2019/04/10 20:13:57 739FC3C0 r   (reader) KD_HD_D02_Sky [mouse] detect irdeto card
2019/04/10 20:13:57 739FC3C0 r   (reader) KD_HD_D02_Sky [mouse] caid: 1722, acs: 3.84, country code: TEL
2019/04/10 20:13:57 739FC3C0 r   (reader) KD_HD_D02_Sky [mouse] providers: 4, ascii serial: ##########, hex serial: ######, hex base: ##
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [mouse] active providers: 2 (000000,000000)
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [mouse] found card system irdeto
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] THIS WAS A SUCCESSFUL START ATTEMPT No  1 out of max alloted of 1
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] entitlements for provider: 2, id: 000000
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 05E2, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 05E6, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 010A, date: 2010/06/20 - 2011/03/01
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 00F0, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 0064, date: 2013/09/11 - 2014/05/23
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 0147, date: 2013/09/11 - 2014/05/23
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 7D27, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 7D23, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 04CE, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 05E1, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 0608, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 05E0, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 0607, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 000F, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 05E4, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 05E5, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] chid: 05E3, date: 2019/01/21 - 2019/06/02
2019/04/10 20:14:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] ready for requests
2019/04/10 20:14:01 00000000 s     (main) init for all local cards done
2019/04/10 20:14:01 00000000 s (emmcache) loaded 85 emmcache records from /tmp/.oscam/oscam.emmcache in 2 ms
2019/04/10 20:14:01 00000000 s (emmcache) loaded 85 emmstat records from /tmp/.oscam/oscam.emmstat in 1 ms
2019/04/10 20:14:01 00000000 s (anticasc) anti cascading disabled
2019/04/10 20:14:01 4E76310D c  (newcamd) client connected to 24241 port
2019/04/10 20:14:01 4E76310D c   (client) anonymous disconnected from 127.0.0.1
2019/04/10 20:14:01 165EFE80 c   (client) plain dvbapi-client granted (anonymous, au=off)
2019/04/10 20:14:01 165EFE80 c   (dvbapi) dvbapi channelcache loaded from /var/etc/oscam.ccache
2019/04/10 20:14:01 165EFE80 c   (dvbapi) Using TCP listen socket, API forced to DVBAPIv3 (0), userconfig boxtype: 11
2019/04/10 20:14:04 4EFAE14A c  (newcamd) client connected to 24241 port
2019/04/10 20:14:04 4EFAE14A c   (client) encrypted newcamd:24241-client 127.0.0.1 granted (LibreElec_Wohnzimmer, au=on (1 reader))
2019/04/10 20:14:04 4EFAE14A c  (newcamd) user LibreElec_Wohnzimmer authenticated successfully (Tvheadend)
2019/04/10 20:14:04 4EFAE14A c  (newcamd) AU disabled for user LibreElec_Wohnzimmer
2019/04/10 20:14:17 70E6663C c   (client) encrypted cs357x-client 192.168.188.53 granted (Ultimo, au=on (1 reader))
2019/04/10 20:14:18 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] Ultimo emmtype=shared, len=139 (hex: 0x8B), cnt=2: written (486 ms)
2019/04/10 20:47:53 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/C47F/89:917FFCEA46BB7593E1DBE079EDA2306E): rejected group (1 ms) (no matching reader)
2019/04/10 20:47:55 70E6663C c      (ecm) Ultimo (1722@000000/0000/002A/93:78C5B6A11E051A9A03CA44CD0FF89EEE): found (513 ms) by KD_HD_D02_Sky
2019/04/10 20:47:57 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/C3BF/89:91CA9C201D52D88ED7B1237597AC1B0D): rejected group (0 ms) (no matching reader)
2019/04/10 20:47:59 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/C3BF/89:7746BBF621748C7FF994AA7DDD00F083): rejected group (0 ms) (no matching reader)
2019/04/10 20:48:03 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/C3BA/89:92CA3598FCEA0403653EF50440642454): rejected group (0 ms) (no matching reader)
2019/04/10 20:48:04 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/C3BA/89:92130408205CD8594DB38F9D7EF9A2A1): rejected group (0 ms) (no matching reader)
2019/04/10 20:48:05 70E6663C c      (ecm) Ultimo (1722@000000/0000/002A/93:6C86D86640364441BFC357DADA5DAF2E): found (511 ms) by KD_HD_D02_Sky
2019/04/10 20:48:09 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/0141/89:BD2086AAD858F657822DCAFE8A68E1C6): rejected group (0 ms) (no matching reader)
2019/04/10 20:48:14 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/0141/89:663539B3FA84E9EBDA012D9956A60818): rejected group (0 ms) (no matching reader)
2019/04/10 20:48:15 70E6663C c      (ecm) Ultimo (1722@000000/0000/002A/93:55EDE5DFFAB06DB095CA6A8701C776F4): found (518 ms) by KD_HD_D02_Sky
2019/04/10 20:48:17 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] Ultimo emmtype=shared, len=139 (hex: 0x8B), cnt=2: written (517 ms)
2019/04/10 20:48:24 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/0141/89:302A4F9F475FD0D7FF0FA3CEB3CC3E14): rejected group (0 ms) (no matching reader)
2019/04/10 20:48:25 70E6663C c      (ecm) Ultimo (1722@000000/0000/002A/93:ED6A06EC2F12095A4D32925E471EF946): found (523 ms) by KD_HD_D02_Sky
2019/04/10 20:48:34 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/0141/89:DB928CC248B85C4F014576E2F993ACB4): rejected group (0 ms) (no matching reader)
2019/04/10 20:48:35 70E6663C c      (ecm) Ultimo (1722@000000/0000/002A/93:49C52D160416FB8C422195B859589E57): found (527 ms) by KD_HD_D02_Sky
2019/04/10 20:48:44 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/0137/89:F3664D76E53437C580764F2C5D6E8019): rejected group (0 ms) (no matching reader)
2019/04/10 20:48:45 70E6663C c      (ecm) Ultimo (1722@000000/0000/002A/93:BAEF40CBC5455836D1D54D8A1B005395): found (511 ms) by KD_HD_D02_Sky
2019/04/10 20:48:51 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/012D/89:99CD3AD1AC428A83413206B22F5899AA): rejected group (0 ms) (no matching reader)
2019/04/10 20:48:55 70E6663C c      (ecm) Ultimo (1722@000000/0000/002A/93:E1BB7A826528F7845D9415023CC2A08E): found (523 ms) by KD_HD_D02_Sky
2019/04/10 20:48:57 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/0123/89:F9C06547F737EF4C32985D221E57B889): rejected group (0 ms) (no matching reader)
2019/04/10 20:49:00 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] Ultimo emmtype=shared, len=139 (hex: 0x8B), cnt=2: written (517 ms)
2019/04/10 20:49:04 010D0039 c      (ecm) LibreElec_Wohnzimmer (1722@000000/0000/0201/93:AC2356B9E7D0F5767E442519E45829A6): found (484 ms) by KD_HD_D02_Sky(btun 1834)
2019/04/10 20:49:05 70E6663C c      (ecm) Ultimo (1722@000000/0000/002A/93:370C578544AE3C9819A39BE90DAE473C): found (537 ms) by KD_HD_D02_Sky
2019/04/10 20:49:05 010D0039 c      (ecm) LibreElec_Wohnzimmer (1722@000000/0000/0201/93:999536A60A5B950AF0CC5F74AF2C0423): found (976 ms) by KD_HD_D02_Sky(btun 1834)
2019/04/10 20:49:06 010D0039 c      (ecm) LibreElec_Wohnzimmer (1722@000000/0000/00DD/93:CD44404070A403AB60D097E2A6286812): found (1183 ms) by KD_HD_D02_Sky(btun 1834)
2019/04/10 20:49:06 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/0029/89:3D85F0E7C9EFDE99C7C6DEEDCA65C7D1): rejected group (0 ms) (no matching reader)
2019/04/10 20:49:12 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/0019/89:EF2E35480208756AF5619283059DB844): rejected group (0 ms) (no matching reader)
2019/04/10 20:49:14 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/0019/89:48225FC5D58C9DE47911EC7804D79559): rejected group (0 ms) (no matching reader)
2019/04/10 20:49:15 70E6663C c      (ecm) Ultimo (1722@000000/0000/002A/93:05BFB29FF5C2F56FD029A412894501BC): found (556 ms) by KD_HD_D02_Sky
2019/04/10 20:49:19 010D0039 c      (ecm) LibreElec_Wohnzimmer (1722@000000/0000/C355/93:B668AE1887E53AFEC89D79715B216FEB): not found (495 ms) by KD_HD_D02_Sky(btun 1834) (KD_HD_D02_Sky unsubscribed)
2019/04/10 20:49:20 010D0039 c      (ecm) LibreElec_Wohnzimmer (1722@000000/0000/C355/93:A541A2A454F4C5EB560EE478D572C468): not found (601 ms) by KD_HD_D02_Sky(btun 1834) (KD_HD_D02_Sky unsubscribed)
2019/04/10 20:49:20 00000000       (stat) loadbalancer: statistic saved 195 records to /tmp/.oscam/stat in 3 ms
2019/04/10 20:49:24 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] Ultimo emmtype=global, len=137 (hex: 0x89), cnt=3: written (506 ms)
2019/04/10 20:49:25 70E6663C c      (ecm) Ultimo (1722@000000/0000/002A/93:415CA28FEC62FCE759E05ADC5EBFB3EE): found (540 ms) by KD_HD_D02_Sky
2019/04/10 20:49:25 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] Ultimo emmtype=shared, len=139 (hex: 0x8B), cnt=2: written (510 ms)
2019/04/10 20:49:26 010D0039 c      (ecm) LibreElec_Wohnzimmer (1722@000000/0000/C362/93:EEB44C907D46462E2254702FF96280F2): found (675 ms) by KD_HD_D02_Sky(btun 1834)
2019/04/10 20:49:26 010D0039 c      (ecm) LibreElec_Wohnzimmer (1834@1F1F1F/0000/C367/89:A32EFE075AF9967AF885FE24CC5F533E): rejected group (0 ms) (no matching reader)
2019/04/10 20:49:28 739FC3C0 r   (reader) KD_HD_D02_Sky [irdeto] Ultimo emmtype=global, len=137 (hex: 0x89), cnt=3: written (487 ms)

2019-04-10 20:49:12.616 subscription: 0849: No input source available for subscription "service_mapper" to service "Kevag/362MHz/Sky Cinema Hits" in mux "362MHz in Kevag" 
2019-04-10 20:49:12.616 subscription: 0849: "service_mapper" unsubscribing, client="service_mapper" 
2019-04-10 20:49:12.616 service-mapper: Kevag/362MHz/Sky Cinema Hits: failed [reason: No access]
2019-04-10 20:49:12.616 service-mapper: checking Kevag/362MHz/Disney Cinemagic
2019-04-10 20:49:12.616 service-mapper: waiting for input
2019-04-10 20:49:12.622 subscription: 084D: "service_mapper" subscribing to service "Kevag/362MHz/Disney Cinemagic", weight: 7, adapter: "Silicon Labs Si2168 #0 : DVB-C #0", network: "Kevag", mux: "362MHz", provider: "SKY", client="service_mapper" 
2019-04-10 20:49:12.803 cwc: 192.168.188.47:24241: Can not descramble service "Disney Cinemagic", access denied (seqno: 547 Req delay: 4 ms) from newcamd-192.168.188.47:24241-1834
2019-04-10 20:49:14.840 cwc: 192.168.188.47:24241: Can not descramble service "Disney Cinemagic", access denied (seqno: 548 Req delay: 4 ms) from newcamd-192.168.188.47:24241-1834
2019-04-10 20:49:16.622 subscription: 084D: service instance is bad, reason: No access

The trace LOg shows this