Client freezer - Log "dvbapi: Demuxer trying to discramble PID"

[shooter79]

Hi zusammen,

ich habe zu hause einen Raspberry als Server und aktuell eine VU zero als client. Ich habe auf meinem Client immer wieder freezer, im Log kann ich folgendes sehen:

Spoiler

• 2015/03/21 09:38:03 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:F299482F126556D9ECBAFCD109152CE5): found (861 ms) by debian
• 2015/03/21 09:38:12 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:C71087622C5CBB30E7F331CF36F33602): found (2792 ms) by debian
• 2015/03/21 09:38:36 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:37 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:5C328C46A8E9EFF01249E9B8C5A836D2): not found (20 ms) (wait_time over)
• 2015/03/21 09:38:37 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 7 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:37 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:37 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:5C328C46A8E9EFF01249E9B8C5A836D2): not found (21 ms) (wait_time over)
• 2015/03/21 09:38:37 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 5 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:37 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:38 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:5C328C46A8E9EFF01249E9B8C5A836D2): not found (21 ms) (wait_time over)
• 2015/03/21 09:38:38 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 6 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:38 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:38 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:7699D682875D1BBC65570B17DA7B130D): not found (20 ms) (wait_time over)
• 2015/03/21 09:38:39 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 6 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:39 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:39 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:7699D682875D1BBC65570B17DA7B130D): not found (21 ms) (wait_time over)
• 2015/03/21 09:38:39 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 5 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:39 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:40 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:7699D682875D1BBC65570B17DA7B130D): not found (20 ms) (wait_time over)
• 2015/03/21 09:38:40 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 6 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:40 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:40 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:7699D682875D1BBC65570B17DA7B130D): not found (21 ms) (wait_time over)
• 2015/03/21 09:38:40 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 6 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:40 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:41 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:7699D682875D1BBC65570B17DA7B130D): not found (21 ms) (wait_time over)
• 2015/03/21 09:38:41 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 6 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:41 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:41 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:7699D682875D1BBC65570B17DA7B130D): not found (21 ms) (wait_time over)
• 2015/03/21 09:38:47 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:47 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:53782C04BECB8EF5F0621F9E63BF8962): not found (20 ms) (wait_time over)
• 2015/03/21 09:38:47 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 6 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:47 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:48 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:53782C04BECB8EF5F0621F9E63BF8962): not found (20 ms) (wait_time over)
• 2015/03/21 09:38:48 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 6 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:48 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:48 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:53782C04BECB8EF5F0621F9E63BF8962): not found (20 ms) (wait_time over)
• 2015/03/21 09:38:48 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 6 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:48 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:49 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:53782C04BECB8EF5F0621F9E63BF8962): not found (21 ms) (wait_time over)
• 2015/03/21 09:38:49 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 6 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:49 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:49 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:53782C04BECB8EF5F0621F9E63BF8962): not found (21 ms) (wait_time over)
• 2015/03/21 09:38:50 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 5 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:50 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:50 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:53782C04BECB8EF5F0621F9E63BF8962): not found (20 ms) (wait_time over)
• 2015/03/21 09:38:50 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 7 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:50 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:51 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:53782C04BECB8EF5F0621F9E63BF8962): not found (20 ms) (wait_time over)
• 2015/03/21 09:38:51 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 6 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:51 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:51 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:53782C04BECB8EF5F0621F9E63BF8962): not found (20 ms) (wait_time over)
• 2015/03/21 09:38:51 7744B0E0 c (dvbapi) Demuxer 0 restarting decodingrequests after 6 ms with 1 enabled and 2 disabled ecmpids!
• 2015/03/21 09:38:51 7744B0E0 c (dvbapi) Demuxer 0 trying to descramble PID 0 CAID 1833 PROVID 000000 ECMPID 188B ANY CHID PMTPID 0064 VPID 04FF
• 2015/03/21 09:38:53 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:865E8EC9D8D710A18DBDDDEE7BBE5196): found (1118 ms) by debian
• 2015/03/21 09:38:59 7744B0E0 c (ecm) local (1833&000000/0000/008A/89:A7EE2ABB65EE0FB67A769138FA1A9E48): found (824 ms) by debian

Meine oscam.conf

Spoiler

[global]
logfile                       = /var/log/oscam.log
fallbacktimeout               = 500
bindwait                      = 40
unlockparental                = 1
nice                          = -1
maxlogsize                    = 100
usrfile                       = /tmp/user.log
cwlogdir                      = /var/log/
lb_mode                       = 1
lb_save                       = 1000
lb_nbest_readers              = 3
lb_nfb_readers                = 3
lb_auto_betatunnel            = 0
lb_auto_betatunnel_mode       = 2
failbantime                   = 30
failbancount                  = 3

[cache]
max_time                      = 8
wait_time                     = 17:20:1200,18:20:600,09:50:200,0B:50:650,0100:50:650,0500:800
csp_allow_request             = 0
cacheex_cw_check              = 0:0:2,1702:0:3,09:0:3,1833:0:3
cwcycle_check_enable          = 1
cwcycle_check_caid            = 1702,1830,1843,183D,1810,0500,1722,1831,1835,1838,0100,0B00,0B01,1802,1803,1861,0604
cwcycle_maxlist               = 4000
cwcycle_sensitive             = 2
cwcycle_usecwcfromce          = 1

[cccam]
port                          = 12000
nodeid                        = ****
version                       = 2.3.0
reshare                       = 2
recv_timeout               = 4000

[dvbapi]
enabled                       = 1
au                            = 1
user                          = local

[webif]
httpport                      = 17000
httpuser                      = 
httppwd                       = 
httphelplang                  = de
httprefresh                   = 10
httpallowed                   = 192.168.2.1-192.168.2.255
http_status_log               = 1

Meine User:

Spoiler

[account]
user                          = local
au                            = 1
group                         = 1

Meine Server:

Spoiler

[reader]
label                         = debian
protocol                      = cccam
device                        = 192.168.x.x,xxxxx
user                          = **
password                      = **
inactivitytimeout             = 30
group                         = 1
cccversion                    = 2.3.0
cccmaxhops                    = 2
cccwantemu                    = 1
ccckeepalive                  = 1
audisabled                    = 1

Der Fehler tritt unregelmäßig auf. Jemand eine Idee?

Gruß

 

[supraracer]

AW: Client freezer - Log "dvbapi: Demuxer trying to discramble PID"

Zeig auch mal das Log des Server zum Zeitpunkt des Freezer.
Werf mal den ganzen lb_* Kram und [cache] Abschnitt raus aus deiner oscam.conf
Den [cccam] Abschnitt kannst du beim Client auch löschen, oder macht der Share an andere Clients?

Danach OScam komplett neu starten.

-supraracer

 

[shooter79]

Im Server Log ist zu dem Zeitpunkt nichts auffälliges, zumindest konnte ich nichts feststellen, ausser, dass der Client nicht da ist. Ich warte den nächsten aussetzer ab, logge beide nochmal mit.

Habe die Config bereinigt, die Einträge waren in der Tat sinnfrei

Jetzt konnte ich den Fehler auch auf dem Server beobachten, ich bekomme als Client einen Timeout:

2015/03/21 13:31:59  13753E8 c      (ecm) vu (1833&000000/0000/008A/89:5BD56EB4C2BA1DE74FECA8B0A1D24EEB): timeout (5001 ms) by ****,***** (F/7/7/7) - Disney Junior HD (wait_time over)

 

[supraracer]

AW: Client freezer - Log "dvbapi: Demuxer trying to discramble PID"

Es wird zum Ratespiel, vielleicht ahnst du ja was jetzt kommt: Poste doch mal die OScam Config Files des Server.

-supraracer

 

[shooter79]

AW: Client freezer - Log "dvbapi: Demuxer trying to discramble PID"

Nach den Timeouts kommt jetzt nur noch sowas im log des Clients:

(dvbapi) Demuxer 0 no enabled matching ecmpids -> decoding is waiting for matching readers!

Server conf:

Spoiler

[global]
logfile                       = /var/log/ipc/oscam.log
nice                          = -20
maxlogsize                    = 2480
preferlocalcards              = 2
dropdups                      = 1
lb_mode                       = 1
lb_save                       = 100
lb_nbest_readers              = 3
lb_nfb_readers                = 2
lb_reopen_seconds             = 15
lb_force_reopen_always        = 1
lb_auto_betatunnel_prefer_beta= 105

[cache]
max_time                      = 8
wait_time                     = 17:20:1200,18:20:600,09:50:200,0B:50:650,0100:50:650,0500:800
csp_allow_request             = 0
cacheex_cw_check              = 0:0:2,1702:0:3,09:0:3,1833:0:3
cwcycle_check_enable          = 1
cwcycle_check_caid            = 1702,1830,1843,183D,1810,0500,1722,1831,1835,1838,0100,0B00,0B01,1802,1803,1861,0604
cwcycle_maxlist               = 4000
cwcycle_sensitive             = 2
cwcycle_usecwcfromce          = 1

[cccam]
port                          = ****
nodeid                        = ****
version                       = 2.3.0
reshare                       = 1
ignorereshare                 = 1
recv_timeout                  = 4000

[dvbapi]
enabled                       = 1
au                            = 1
user                          = serverbox

[webif]
httpport                      = 17000
httpuser                      = ****
httppwd                       = ****
httphelplang                  = de
httprefresh                   = 10
httpallowed                   = 192.168.2.1-192.168.2.255
http_status_log               = 1

User:

Spoiler

[account]
user                          = vu
pwd                           = vu
group                         = 1

Server (exemplarisch):

Spoiler

[reader]
label                         = HD+
protocol                      = mouse
device                        = /dev/ttyUSB0
caid                          = 1843
boxkey                        = A7**7C
rsakey                        = BF**D5
detect                        = cd
cardmhz                       = 368
ident                         = 1843:000000,003411,008011
group                         = 1
emmcache                      = 1,3,2,0
lb_weight                     = 900

[reader]
label                         = label
protocol                      = cccam
device                        = dyn,port
user                          = ***
password                      = ***
inactivitytimeout             = 30
group                         = 1
cccversion                    = 2.3.0
cccmaxhops                    = 2
cccwantemu                    = 1
ccckeepalive                  = 1
audisabled                    = 1

Gruß

 

[supraracer]

AW: Client freezer - Log "dvbapi: Demuxer trying to discramble PID"

Geht es jetzt um den CCcam Proxy Reader? Dann ist es recht einfach, frag deinen Sharepartner warum du dauernd Freezer hast.

-supraracer

 

[DarkStarXxX]

AW: Client freezer - Log "dvbapi: Demuxer trying to discramble PID"

Das ganze wird wohl von CEX ausgelöst.

 

[shooter79]

AW: Client freezer - Log "dvbapi: Demuxer trying to discramble PID"

blöde frage, was ist CEX?

 

[supraracer]

AW: Client freezer - Log "dvbapi: Demuxer trying to discramble PID"

CacheEX, lösche einfach mal auch beim Server dein ganzen lb* und cache Krams.

-supraracer

 

[shooter79]

AW: Client freezer - Log "dvbapi: Demuxer trying to discramble PID"

Ich habe das Thema erstmals mit einem betatunnel in den Griff gekriegt, in der tat hatte ich Probleme mit der caid 1833.

Zu meinem Verständnis, CacheEx hat doch nichts mit dem eingestelltem Cache in der config zu tun. Cache Ex an sich ist bei mir deaktiviert.