Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

[2nice4u]

Habe seit ein paar Tagen ein gravierendes Problem mit den ECM Zeiten auf meinem Oscam-Server.
(nur eine Instanz und kein CacheEX / AC und LB tesweise deaktiviert aber keine Besserung)
Was ich gesehen habe, betrifft es nur V13 Karten. Wenn ich über diese externen V13 Karten schauen mag, dann Freezt es gewaltig.
In der Log ist dann das hier zu finden:

2015/01/21 23:24:58 DD7C30 c Receiver_01 (09C4&000000/0065/0029/B3:7AD7B7C434B549AA8E1D588A9B0DA469): found (2657 ms) by V13_1 (F/3/3/5) - Sky Hits (real 157 ms)
2015/01/21 22:49:24 BC0A47E0 c Receiver_02 (09C4&000000/0066/0019/B3:CEBC3ADBF8729AD3D237B716E4228BBC): found (2530 ms) by V13_2 (F/3/3/3) - Disney Cinemagic (real 30 ms)
2015/01/21 22:49:29 BC082520 c Receiver_02 (09C4&000000/0065/0029/B3:B7B8C120E6FC6E820613BC38409B7133): found (2530 ms) by V13_2 (F/3/3/3) - Sky Hits (real 29 ms)


Also es sind mehrere Karten betroffen. Was bedeutet das nun für mich? Sind diese Spenderkarten überlastet?
Es wurde bisher auch nichts an den Einstellungen geändert weil alles super lief. Es kam quasi aus heiterem Himmel.
Deswegen bin ich nun ratlos.

 

[DarkStarXxX]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

Das sieht mir aber ganz nach verconfter OSCam aus.
Bestimmt falscher Fallback Wert.

 

[2nice4u]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

Ich teste jetzt erstmal ne Zeit lang ohne Loadbalancing und Co.
Wenn es daran liegt, muss ich mir nochmal jungfräuliche Configs besorgen und nochmal von Grund auf anfangen.
Was soll dieser Fallback Wert sein?

 

[jekahr]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

Poste uns doch einfach mal bitte deine config, dann wird sich bestimmt was finden

 

[2nice4u]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

Also auch mit jungfräulichen Configs die gleichen Probleme ==> found (2657 ms) by V13_01 (F/3/3/5) - Sky Hits (real 157 ms)
Taucht wieder bei den V13 Karten in meinem Share auf.

Mein Setup:
oscam-1.20-unstable_svn-r10178

oscam.conf

Spoiler

[global]
logfile = /tmp/oscam.log
nice = -1
maxlogsize = 256
lb_mode = 1
lb_save = 150
lb_auto_betatunnel_mode = 2
lb_auto_betatunnel_prefer_beta= 0
lb_savepath = /tmp/.oscam/stat
failbantime = 5
failbancount = 3

[cccam]
port = xxxx
nodeid = xxxx
version = 2.3.0
reshare = 0
ignorereshare = 1

[dvbapi]
enabled = 1
au = 1
user = DVBApi
boxtype = coolstream

[webif]
httpport = xxx
httpuser = xxxx
httppwd = xxxxx
httphelplang = de
httprefresh = 20
httphideidleclients = 1
httpallowed = 0.0.0.0-255.255.255.255
hideclient_to = 15

oscam.user

Spoiler

[account]
user = DVBApi
au = 1
group = 1,2,3,4

[account]
user = Receiver_01
pwd = xxx
group = 1,2,3,4
cccmaxhops = 2

[account]
user = Receiver_02
pwd = xxx
group = 1,2,3,4
cccmaxhops = 2

oscam.server

Spoiler

[reader]
label = V13_01
protocol = cccam
device = xxx.xxx.xx,12345
user = xxxx
password = xxxx
services = !sky3d,!bluemovie,!skyselect,!hdplus_skyde
caid = 09C4
group = 1
ccckeepalive = 1
cccreshare = 2
audisabled = 1

[reader]
label = V13_02
protocol = cccam
device = xxx.xxx.xx,12345
user = xxx
password = xxx
services = !sky3d,!bluemovie,!skyselect,!hdplus_skyde
caid = 09C4
group = 1
ccckeepalive = 1
cccreshare = 2
audisabled = 1

Werde jetzt mal wieder eine ältere OscamVersion (OSCam r10068) probieren.

Für eure Hilfe und Tips wäre ich euch sehr dankbar...denn aktuell habe ich alle V13 Karten deaktivieren müssen.

 

[jekahr]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

also ich gehe davon aus das du oder der andere server irgendwo nen Timeout von 2500ms gesetzt hast.
in verbindung mit wait_until_ctimeout = 1 könnte ich mir dann sowas vorstellen.

 

[lullu08]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

ein delay 2500 drin irgendwo unter [ cache] ?

 

[hwmmc]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

Auch bei dir gilt es die Fallbacktimeout per CAID zu beachten!
Dein Default Wert ist für NDS viel zu hoch.

 

[2nice4u]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

Einzige Einstellung mit 2500ms ist die unter CONFIG --> GLOBAL --> Timeouts / Times
Fallback timeout: 2500 ms to switch to fallback reader

Bei gleicher Config und alter Oscam keine Probleme bisher...sehr mysteriös

 

[xyndra]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

Was würdet ihr nehmen bei fallbacktimeout_per_caid bei einer v14? Können die Probleme eventuell entstehen, weil dieser Wert bei neueren Revisionen auch beim User definiert werden kann?

 

[2nice4u]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

Zu früh gefreut.
Hab den ganzen Server blank gemacht und neuste Oscam kompiliert und alles von Hand neu eingerichtet ohne alte Configs zu kopieren...aber es passiert immer noch. Teste jetzt nochmal ohne Loadbalancer und AntiCasc.
Und wo kann man diese FallbackWerte individuell für jeden Reader/Karte einstellen?
Ich werd nämlich noch verrückt denn es sind wirklich immer diese 2500ms Differenz.

Und gerade wieder einige...

1527200 c (ecm) Receiver_01 (09C4&000000/0259/0081/B3:blablabla): found (2658 ms) by V13_FullHD (F/2/2/5) - Sky Sport HD 1 (real 157 ms)

Ich verstehs nicht. Warum addiert er 2500ms aus heiterem Himmel dazu wenn das ECM doch gültig ist?!


Das Problem tritt auch nur bei SKY auf. (Hauptsächlich auf 09C4/098C aber auch seltener auf 09C7 und 1702)
Mit HD+ via 1830/1843 und anderen Caids wie z.B. die ganze Hoppelei auf 0500 gibt es keine Probleme.

 

[jekahr]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

Die Fallbacktimeout per caid kannst du einstellen unter Config --> global---> Timeouts...

 

[2nice4u]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

Und wieder ne ganze Menge ECMs mit dem Anhang (real xxx ms) am Ende.
Hatte jetzt schon testweise alle V13 Karten deaktiviert...deswegen tauchen sie auch nicht mehr auf.

Spoiler

2015/01/25 04:04:56 137D430 c (ecm) xxx (1702&000000/0000/000D/930E70551E5A528B060C0D97D0FE56932): found (3255 ms) by 1702Full-Feeds (F/2/2/2) - National Geographic (real 755 ms)
2015/01/25 04:05:03 137D430 c (ecm) xxx (1702&000000/0000/000D/93:5EC5B7D0364AEDF9494F897C077B2572): found (3256 ms) by 1702Full-Feeds (F/2/2/2) - National Geographic (real 755 ms)
2015/01/25 04:08:46 137D430 c (ecm) xxx (1702&000000/0000/001B/93:029A1FE5F5DE1F581D2856BA42AE8C90): found (3244 ms) by 1702Full-Feeds (F/2/2/2) - RTL Crime (real 744 ms)
2015/01/25 04:08:50 137D430 c (ecm) xxx (1702&000000/0000/001B/93:67FAF7A28D04895E6F775EA66E1F459D): found (3242 ms) by 1702Full-Feeds (F/2/2/2) - RTL Crime (real 742 ms)
2015/01/25 04:08:56 137D430 c (ecm) xxx (1702&000000/0000/001B/93:BD378E0E6291233ECF24A6CDFD80C484): found (3828 ms) by 1702Full-Feeds (F/2/2/2) - RTL Crime (real 1328 ms)
2015/01/25 04:09:03 137D430 c (ecm) xxx (1702&000000/0000/001B/93:C6831818A3C6D4830E3ADF80C5F693AF): found (3839 ms) by 1702Full-Feeds (F/2/2/2) - RTL Crime (real 1338 ms)
2015/01/25 13:03:50 152B290 c (ecm) xxx (1702&000000/0000/0026/93:45DEE570C4D73999144502ABAB9B651F): found (3324 ms) by 1702Full-Feeds (F/2/2/2) - Romance TV (real 824 ms)
2015/01/25 15:38:45 17DCDF0 c (ecm) xxx (09C7&000000/0011/C363/5E:79134D85B3C037F5DF3BF9ECE311352F): found (2667 ms) by 1722_09C7_1834 (F/2/2/3) - sixx HD (real 166 ms)
2015/01/25 15:38:52 143BF00 c (ecm) xxx (09C7&000000/0699/0084/96:278824055BF8855AD4B6C919F8518D1F): found (2643 ms) by 09C7_KD-Full (F/2/2/2) - Eurosport HD (real 143 ms)
2015/01/25 15:39:02 143BF00 c (ecm) XXX (09C7&000000/0699/0084/96:42F9F38CE646337377EA2B44AEB22565): found (2649 ms) by 09C7_KD-Full (F/2/2/2) - Eurosport HD (real 148 ms)
2015/01/25 17:08:42 152B290 c (ecm) XXX (1702&000000/0000/000A/93:19C04C9DB63F443255DA1E30F77503C1): found (2531 ms) by 1702Full-Feeds (F/2/2/2) - Sky Cinema (real 31 ms)
2015/01/25 17:20:24 17DCDF0 c (ecm) XXX (09C7&000000/0016/C359/5EC3396CCEEE300AA9EC7DA34C1F61DD2): found (2600 ms) by 1722_09C7_1834 (F/2/2/3) - kabel eins HD (real 100 ms)
2015/01/25 17:20:34 17DCDF0 c (ecm) XXX (09C7&000000/0016/C359/5E64A3649AB1A5E58619B5A4890F547F4): found (2629 ms) by 1722_09C7_1834 (F/2/2/3) - kabel eins HD (real 129 ms)
2015/01/25 17:20:44 17DCDF0 c (ecm) XXX (09C7&000000/0016/C359/5E:1309DB21DC4055439E8424F74BE07DD4): found (2581 ms) by 1722_09C7_1834 (F/2/2/3) - kabel eins HD (real 81 ms)
2015/01/25 17:40:33 143BF00 c (ecm) XXX (09C7&000000/0691/006B/96:EF2633FEF22E076F2297DC858B82DCA4): found (2890 ms) by09C7_KD-Full (F/2/2/2) - Sky Hits HD (real 389 ms)
2015/01/25 17:40:35 17DCDF0 c (ecm) XXX (09C7&000000/0016/C359/5E:E241DEC7D90ACD5BFE971E6629F37590): found (2613 ms) by 1722_09C7_1834 (F/2/2/3) - kabel eins HD (real 113 ms)
2015/01/25 17:40:43 143BF00 c (ecm) XXX (09C7&000000/0691/006B/96:B51C6ED4EAA8A1D3E6400C3BE5D090D2): found (2893 ms) by 09C7_KD-Full (F/2/2/2) - Sky Hits HD (real 393 ms)
2015/01/25 17:40:45 17DCDF0 c (ecm) XXX (09C7&000000/0016/C359/5E:1938E0CA031082C57A2FA3DAD2B3A241): found (2615 ms) by 1722_09C7_1834 (F/2/2/3) - kabel eins HD (real 115 ms)
2015/01/25 17:40:53 143BF00 c (ecm) XXX (09C7&000000/0691/006B/96:04B60CAFF257D5C708CC297470794C8D): found (2894 ms) by 09C7_KD-Full (F/2/2/2) - Sky Hits HD (real 394 ms)
2015/01/25 17:40:55 17DCDF0 c (ecm) XXX (09C7&000000/0016/C359/5E:2A850539D2C879FB2470D1981A10280C): found (2602 ms) 1722_09C7_1834 (F/2/2/3) - kabel eins HD (real 102 ms)
2015/01/25 17:41:03 143BF00 c (ecm) XXX (09C7&000000/0691/006B/96:C7EFE998EBE836DA31524F0418AD4719): found (2897 ms) by 09C7_KD-Full (F/2/2/2) - Sky Hits HD (real 397 ms)
2015/01/25 17:41:05 17DCDF0 c (ecm) XXX (09C7&000000/0016/C359/5E4B52F2F284D9D4799C502B41EFDB38C): found (2649 ms) by 1722_09C7_1834 (F/2/2/3) - kabel eins HD (real 148 ms)
2015/01/25 17:41:13 143BF00 c (ecm) XXX (09C7&000000/0691/006B/96:241D964A6BF8B849A4BADC2685C467D7): found (3040 ms) by 09C7_KD-Full (F/2/2/2) - Sky Hits HD (real 540 ms)
2015/01/25 17:41:15 17DCDF0 c (ecm) XXX (09C7&000000/0016/C359/5E:CC1FA552140C4A2FCDFAC8326B1D114C): found (2792 ms) by 1722_09C7_1834 (F/2/2/3) - kabel eins HD (real 291 ms)
2015/01/25 17:41:23 143BF00 c (ecm) XXX (09C7&000000/0691/006B/96:C5C36C4F7CB9B313901AB65537C74BC6): found (2897 ms) by 09C7_KD-Full (F/2/2/2) - Sky Hits HD (real 397 ms)

Und jetzt nochmal zu dem Fallbacktimeout.
Die OscamWiki sagt dieses hier:

fallbacktimeout

Sie müssen registriert sein, um Links zu sehen.

Parameter wird abhängig vom Setup/Programmversion benötigt.

Sie müssen registriert sein, um Links zu sehen.

Achtung:
Gilt nicht, wenn Loadbalancing aktiviert ist!
Bei mehreren Readern (Siehe Abschnitt [reader] in oscam.server) kann ein Reader bestimmt werden, auf den z.B. bei einer Störung der übrigen Reader der traffic zurück fällt.
Maximale Wartezeit des

Sie müssen registriert sein, um Links zu sehen.

in Millisekunden auf primäre

Sie müssen registriert sein, um Links zu sehen.

, bevor der/die

Sie müssen registriert sein, um Links zu sehen.

-Reader (falls vorhanden!) befragt werden.

Da ich aber Loadbalancing aktiviert habe und diese Fehler trotzdem auftreten, kann es ja nicht an diesem Wert liegen oder?!
Das bestätigt ja dann auch die Tatsache das die Fehler aus heiterem Himmel auftauchen ohne Änderung an den Configs.

Also mit diesem Fallbacktimeout komme ich nicht weiter und führt auch wohl zu nix denke ich.

Hilft euch vielleicht ein anderes Loglevel weiter?

 

[DarkStarXxX]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

100% hast du da was für CE geconft, anders können die einträge nicht zu erklären sein.

 

[2nice4u]

AW: Plötzlich hohe ECM Zeiten + Freezer mit Zusatz (real 158 ms) am Ende der LiveLog

Also ich habe definitiv nix mit CacheEx eingerichtet.
Habe mir jetzt aus der Datenbank eine andere Oscam als meine selbst gebaute besorgt,
um diese Fehlerquelle auch ausschließen zu können.
Die Configs bleiben immer die gleichen die ich schon gepostet habe.
Nur habe ich LoadBalancer und AntiCasc aktiviert.

Werde euch auf dem Laufenden halten und fleißig mitloggen.