Freezer bei allen Clients (seit 4 Tagen)

[n0x]

Hallo

ich habe seit ca. 4 Tagen Probleme mit meinem CS.

Vermutlich alle Clients haben seitdem freezer in unregelmäßigen Abständen.
Die freezer dauern teilweise 30sec bis 1 minute. In der Zeit sind die Clients auf der OScam Webgui nicht mehr online (zwar connected aber nicht online).

Hier das was ich an Logfiles finden konnte:

Spoiler

Client:

Spoiler

2016/10/15 10:55:48 550400 c local (098C&000000/0B58/0074/9D:CCD6C1D78F894D513B5518D90F6F06DF): timeout (5002 ms) by client
2016/10/15 10:55:55 0 --- Skipped 1 duplicated log lines ---
2016/10/15 10:55:55 550400 c local (098C&000000/0B58/0074/9D:355A0C407EC4E1D8FB7B3EFCB5ED7F9F): timeout (5002 ms) by client
2016/10/15 10:55:55 550400 c local (098C&000000/0B58/0074/9D:355A0C407EC4E1D8FB7B3EFCB5ED7F9F): not found (1504 ms) by client
2016/10/15 10:56:00 550400 c local (098C&000000/0B58/0074/9D:355A0C407EC4E1D8FB7B3EFCB5ED7F9F): timeout (5002 ms) by client
2016/10/15 10:56:02 550400 c local (098C&000000/0B58/0074/9DABAFFA931C47C4E14C9DAD4CA046A8B): timeout (5002 ms) by client
2016/10/15 10:56:02 550400 c local (098C&000000/0B58/0074/9DABAFFA931C47C4E14C9DAD4CA046A8B): not found (1504 ms) by client
2016/10/15 10:56:07 550400 c local (098C&000000/0B58/0074/9DABAFFA931C47C4E14C9DAD4CA046A8B): timeout (5002 ms) by client
2016/10/15 10:56:09 550400 c local (098C&000000/0B58/0074/9D:E9D7338259C003E53B57E62E4CEA2D3E): timeout (5002 ms) by client
2016/10/15 10:56:09 550400 c local (098C&000000/0B58/0074/9D:E9D7338259C003E53B57E62E4CEA2D3E): not found (1504 ms) by client
2016/10/15 10:56:14 550400 c local (098C&000000/0B58/0074/9D:E9D7338259C003E53B57E62E4CEA2D3E): timeout (5002 ms) by client
2016/10/15 10:56:16 550400 c local (098C&000000/0B58/0074/9D:76F1DDF5CCC5A1E6FBF5B5086478B1C6): timeout (5002 ms) by client
2016/10/15 10:56:16 550400 c local (098C&000000/0B58/0074/9D:76F1DDF5CCC5A1E6FBF5B5086478B1C6): not found (1509 ms) by client
2016/10/15 10:56:18 53DF28 p client [cs378x] disconnected: reason rto
2016/10/15 10:56:21 550400 c local (098C&000000/0B58/0074/9D:76F1DDF5CCC5A1E6FBF5B5086478B1C6): timeout (5003 ms) by client
2016/10/15 10:56:23 550400 c local (098C&000000/0B58/0074/9D:7077CCB4EC77A2038ADCF7D9C03E4CA7): timeout (5002 ms) by client

Server:

Auf dem Server stimmt die Zeit nicht. Deswegen denke ich mal, dass dieser Abschnitt zu dem disconnect des Clients passt.
anonymous (192.168.1.102) ist übrigens mein Portmapper über den die Clients kommen (IPv6 DSlight).

Spoiler

1970/01/02 16:02:37 10135708 c user Usr1 reached 120 sec idle limit.
1970/01/02 16:04:14 10135708 c client(30079B50) duplicate user 'Usr2' from 192.168.1.102 (prev 192.168.1.102) set to fake (uniq=3)
1970/01/02 16:04:14 10135708 c encrypted cccam-client 192.168.1.102 granted (Usr2, au=off)
1970/01/02 16:09:38 101294D0 c client(300E0B50) duplicate user 'Usr3' from 192.168.1.102 (prev 192.168.1.102) set to fake (uniq=3)
1970/01/02 16:09:38 101294D0 c encrypted cccam-client 192.168.1.102 granted (Usr3, au=off)
1970/01/02 16:09:39 10138E30 c anonymous disconnected from 192.168.1.102
1970/01/02 16:09:41 10135708 c Usr2 disconnected from 192.168.1.102
1970/01/02 16:09:46 1013C558 c encrypted cccam-client 192.168.1.102 granted (Usr2, au=off)
1970/01/02 16:09:49 1013F478 c anonymous disconnected from 192.168.1.102
1970/01/02 16:13:38 101294D0 c Usr3 disconnected from 192.168.1.102
1970/01/02 16:13:39 10135708 c client(300ECB50) duplicate user 'Usr4' from 192.168.1.102 (prev 192.168.1.102) set to fake (uniq=3)
1970/01/02 16:13:39 10135708 c encrypted cccam-client 192.168.1.102 granted (Usr4, au=off)
1970/01/02 16:13:39 1012FBA0 c client(300F8B50) duplicate user 'Usr2' from 192.168.1.102 (prev 192.168.1.102) set to fake (uniq=3)
1970/01/02 16:13:39 1012FBA0 c encrypted cccam-client 192.168.1.102 granted (Usr2, au=off)
1970/01/02 16:13:40 10138E30 c anonymous disconnected from 192.168.1.102
1970/01/02 16:13:42 1013F478 c encrypted cccam-client 192.168.1.102 granted (Usr3, au=off)
1970/01/02 16:13:43 10142398 c anonymous disconnected from 192.168.1.102
1970/01/02 16:15:09 10135708 c Usr4 disconnected from 192.168.1.102
1970/01/02 16:15:09 1012FBA0 c Usr2 disconnected from 192.168.1.102
1970/01/02 16:15:11 1013F478 c Usr3 disconnected from 192.168.1.102
1970/01/02 16:15:13 101319A0 c encrypted cccam-client 192.168.1.102 granted (Usr2, au=off)
1970/01/02 16:15:13 101294D0 c anonymous disconnected from 192.168.1.102
1970/01/02 16:15:15 0 --- Skipped 1 duplicated log lines ---
1970/01/02 16:15:15 1013BD50 c encrypted cccam-client 192.168.1.102 granted (Usr3, au=off)
1970/01/02 16:15:16 10142398 c anonymous disconnected from 192.168.1.102
1970/01/02 16:15:27 10135588 c encrypted cccam-client 192.168.1.102 granted (Usr4, au=off)
1970/01/02 16:16:39 1012FBA0 c anonymous disconnected from 192.168.1.102
1970/01/02 16:16:42 0 --- Skipped 1 duplicated log lines ---
1970/01/02 16:16:42 101319A0 c Usr2 disconnected from 192.168.1.102
1970/01/02 16:16:44 1013BD50 c Usr3 disconnected from 192.168.1.102
1970/01/02 16:16:47 10138E30 c encrypted cccam-client 192.168.1.102 granted (Usr2, au=off)
1970/01/02 16:16:48 1013EC70 c encrypted cccam-client 192.168.1.102 granted (Usr3, au=off)
1970/01/02 16:30:20 1013BD50 c encrypted cs378x-client 192.168.1.102 granted (Usr45, au=on (1 reader))
1970/01/02 16:30:20 1013BD50 c Usr45 emm-request sent (reader=SkyGermanyV14, caid=098C, auprovid=000000)

Jemand eine Idee?

Meine Konfig falls nötig:

Spoiler

Server:

Spoiler

.conf:

Spoiler

[global]
logfile = /tmp/oscam.log
maxlogsize = 2000
cachedelay = 120
nice = -1
preferlocalcards = 1
dropdups=1

[cs378x]
port = 12345

[cccam]
port = 23456
reshare = 1
version = 2.3.0
keepconnected = 1
stealth = 1

[monitor]
port = 988
aulow = 120
monlevel = 1
hideclient_to = 15

[webif]
httpport = 99999
httphelplang = de
httpuser = usr
httppwd = xxx
httprefresh = 15
httpallowed = 0.0.0.0-255.255.255.255
aulow = 120
appendchaninfo = 1

.server:

Spoiler

[reader]
label = SkyGermanyV14
protocol = internal
device = /dev/sci0
autospeed = 1
caid = 098C
boxid = 12345678
ins7e11 = 15
detect = CD
mhz = 450
cardmhz = 2700
group = 1
emmcache = 1,3,10
blockemm-unknown = 1
blockemm-u = 1
blockemm-s = 1
blockemm-g = 1
saveemm-unknown = 1
saveemm-u = 1
saveemm-s = 1
ndsversion = 2

.user:

Spoiler

[account]
user = Usr1
pwd = xxx
caid = 098C
uniq = 3
au = SkyGermanyV14
group = 1
cccmaxhops = 0
cccreshare = 0

[account]
user = Usr2
pwd = xxx
caid = 098C
uniq = 3
group = 1,2
cccmaxhops = 0
cccreshare = 0

Client:

Spoiler

.server:

Spoiler

[reader]
label = client
protocol = cs378x
device = server,port
user = Usr1
password = xxx
group = 1,2

 

[Derek Buegel]

Was ist Server (Gerät). Es fehlt der locale User (dvbapi) - Absicht?

Spoiler

192.168.1.102 granted (Usr2, au=off)
192.168.1.102 granted (Usr3, au=off)

Usr2 und Usr3 haben die selbe IP. Das gibt einen Konflickt.

MfG

 

[n0x]

Die .102 ist mein Portmapper. Alle User kommen über diese IP. Und das hat jetzt schon über ein Jahr problemlos so funktioniert.

Der Server ist eine DM500.

Das der lokale User fehlt ist keine Absicht. Muss ich mal anlegen.

 

[DarkStarXxX]

uniq = 3 <--- Das kann so niemals gelaufen sein wenn alle über die selbe IP reinkommen.
Das also beim User löschen.

 

[n0x]

Wie gesagt, mit genau dieser Konfig hats jetzt über ein Jahr funktioniert.
Habe die Einträge aber jetzt gelöscht und einen lokalen User angelegt.
Ob es was bringt muss ich sehen.

Habt ihr irgendwelche Tipps wie ich sehen kann wo das Problem liegt?
Damit man Internetleitung oder sowas ausschließen kann?!

Was mir gerade noch aufgefallen ist.
Wenn es ein freez gibt stoppt auch das Livelog auf der OScam Webgui:

Spoiler

• 1970/01/01 01:15:24 30200850 c Usr1 (098C&000000/0D60/0088/9D:92E47B9A8D5E89D035E10A8419A528B9): found (74 ms) by SkyGermanyV14
• 1970/01/01 01:16:21 30202510 c encrypted cccam-client 192.168.1.102 granted (Usr2, au=off)
• 1970/01/01 01:16:21 302041D0 c encrypted cccam-client 192.168.1.102 granted (Usr3, au=off)
• 1970/01/01 01:16:22 30205E90 c anonymous disconnected from 192.168.1.102

Falls dAs jemandem was sagt?!

 

[Tengri3108]

Hi

Auf meinem Server habe ich auch keinen lokalen User warum auch ist ja der Server. Wenn die Karte überlastet ist gibt es natürlich auch Freezer.

Gruß Ralf

 

[webman2]

Wenn die freezer erst seit 4 Tagen auftreten, ohne dass sich am System und Anzahl der clients etwas geändert hat, vermute ich Probleme mit der Internetanbindung Deines Servers. Hast Du Paketverluste in ICMP ping Tests bei gut erreichbaren nationalen Servern ?

 

[DarkStarXxX]

Die Logs in Post 1 zeigen aber deutlich das es eine in diesen fall falsche "failban" Einstellung ist.
Wenn alle Clients über die selbe IP reinkommen, dann darf man sowas nicht setzen.

 

[cassandro]

Hi n0x,

das Problem hatte ich Gestern auch nachdem Ich Oscam auf die neuste Version geupdatet habe (11275)

Bin wieder zurück auf 11273 und hab keine Probleme

 

[DarkStarXxX]

Dir ist schon klar das die die letzten beiden Changes nur das Gbox Modul betroffen haben?
Das kann gar keine Auswirkungen auf andere Module haben.

 

[n0x]

@DarkStarXxX
Ich habe die uniq = 3 Einstellung bei den Usern entfernt. Bringt aber leider nichts.

@webman2
An sowas habe ich auch schon gedacht. Aber bei verschiedenen Tests mit ping und pathping gab es keine Probleme bzw. keine verlorenen Pakete.
Ich habe auch noch meinen Portmapper in verdacht. Habe auch schon den Support angeschrieben aber bisher ohne Reaktion.

@cassandro
An dem OScam Release hat sich nichts geändert. Habe kein Update gemacht.


Hier ist noch mal ein Logfile Abschnitt von gestern wo man ziemlich gut sehen kann was wann passiert:

Spoiler

1970/01/01 01:26:00 302127D0 c Usr1 (098C&000000/0C1E/006B/9D:5B6E06F8E77EAAB0A5BFBE00BB0C1B3C): found (69 ms) by SkyGermanyV14 - Sky Hits HD
1970/01/01 01:27:25 30207B50 c Usr2 disconnected from 192.168.1.102
1970/01/01 01:27:25 30205E90 c anonymous disconnected from 192.168.1.102
1970/01/01 01:27:26 302004E8 c encrypted cccam-client 192.168.1.102 granted (Usr2, au=off)
1970/01/01 01:27:26 30209810 c anonymous disconnected from 192.168.1.102
1970/01/01 01:27:26 3020B4D0 c encrypted cccam-client 192.168.1.102 granted (Usr3, au=off)
1970/01/01 01:27:27 10132F08 c Usr4 disconnected from 192.168.1.102
1970/01/01 01:27:29 3020D190 c anonymous disconnected from 192.168.1.102
1970/01/01 01:27:29 0 --- Skipped 1 duplicated log lines ---
1970/01/01 01:27:31 0 --- Skipped 2 duplicated log lines ---
1970/01/01 01:27:31 30216150 c encrypted cccam-client 192.168.1.102 granted (Usr4, au=off)
1970/01/01 01:27:31 30217E10 c anonymous disconnected from 192.168.1.102
1970/01/01 01:27:36 30219AD0 c encrypted cccam-client 192.168.1.102 granted (Usr5, au=off)
1970/01/01 01:27:36 3021B790 c encrypted cs378x-client 192.168.1.102 granted (Usr1, au=off)
1970/01/01 01:27:36 3021B790 c Usr1 (098C&000000/0C1E/006B/9D:A6241A446977B7829547B429883B7955): found (70 ms) by SkyGermanyV14 - Sky Hits HD
1970/01/01 01:27:37 302041D0 c Usr3 disconnected from 192.168.1.102
1970/01/01 01:27:38 3021B790 c Usr1 (098C&000000/0C1E/006B/9D:4B32B4503D3F6205719C872871FE7490): found (69 ms) by SkyGermanyV14 - Sky Hits HD
1970/01/01 01:27:39 30205E90 c anonymous disconnected from 192.168.1.102
1970/01/01 01:27:39 30202510 c Usr5 disconnected from 192.168.1.102
1970/01/01 01:27:39 30207B50 c anonymous disconnected from 192.168.1.102
1970/01/01 01:27:45 0 --- Skipped 4 duplicated log lines ---
1970/01/01 01:27:45 3021B790 c Usr1 (098C&000000/0C1E/006B/9D:A2E9ACE828ED68F970652B2CB529FFF5): found (69 ms) by SkyGermanyV14 - Sky Hits HD
1970/01/01 01:27:50 302041D0 c encrypted cs378x-client 192.168.1.102 granted (Usr1, au=off)
1970/01/01 01:27:50 302041D0 c packet is too small (received 0 bytes, expected 1024 bytes)
1970/01/01 01:27:52 3021B790 c Usr1 (098C&000000/0C1E/006B/9D:442FD87E97095AFDC0553C8C63B53EB7): found (70 ms) by SkyGermanyV14 - Sky Hits HD
1970/01/01 01:27:57 30217E10 c anonymous disconnected from 192.168.1.102
1970/01/01 01:27:59 3021B790 c Usr1 (098C&000000/0C1E/006B/9D:7B06C6CE4728935D1F9A8F3D1B3B717A): found (70 ms) by SkyGermanyV14 - Sky Hits HD
1970/01/01 01:28:02 302127D0 c user Usr1 reached 120 sec idle limit.
1970/01/01 01:28:06 3021B790 c Usr1 (098C&000000/0C1E/006B/9D:3FF81B23BA760B1F76C10FBDF729CADF): found (70 ms) by SkyGermanyV14 - Sky Hits HD
1970/01/01 01:28:13 3021B790 c Usr1 (098C&000000/0C1E/006B/9D:EF02A19491BC91F8713BF1399CA0C5DA): found (70 ms) by SkyGermanyV14 - Sky Hits HD
1970/01/01 01:28:20 3021B790 c Usr1 (098C&000000/0C1E/006B/9D:EA987988E5C3DC1030714E05A6A74CD6): found (70 ms) by SkyGermanyV14 - Sky Hits HD

 

[DarkStarXxX]

user Usr1 reached 120 sec idle Limit <--- kein Keep Alive gesetzt?

 

[n0x]

Ist keepalive nicht nur für Newcamd Clients?
Habe nur CCcam und OScam Clients.

 

[n0x]

Ich habe heute noch mal mit geloggt und ein neues Log vom Client kopiert.
Vielleicht ist dieses Mal etwas dabei was auf einen Fehler hinweist:

Spoiler

2016/10/17 17:48:07 550400 c local (098C&000000/0C1E/006B/9D:25F7DF70911982B3E0B28CE7FC5850A7): found (102 ms) by client
2016/10/17 17:48:14 550400 c local (098C&000000/0C1E/006B/9D:F98CA6AD2D7CD24F60A37F43728A2913): found (102 ms) by client
2016/10/17 17:48:26 550400 c local (098C&000000/0C1E/006B/9D:BDEA8ABA7BEE91E99ECD4B351EDF4F18): timeout (5002 ms) by client
2016/10/17 17:48:31 550400 c local (098C&000000/0C1E/006B/9D:BDEA8ABA7BEE91E99ECD4B351EDF4F18): timeout (5007 ms) by client
2016/10/17 17:48:33 550400 c local (098C&000000/0C1E/006B/9D:78931697B280DD1FED3A8BC971DB13EE): timeout (5002 ms) by client
2016/10/17 17:48:33 550400 c local (098C&000000/0C1E/006B/9D:78931697B280DD1FED3A8BC971DB13EE): not found (1504 ms) by client
2016/10/17 17:48:38 550400 c local (098C&000000/0C1E/006B/9D:78931697B280DD1FED3A8BC971DB13EE): timeout (5002 ms) by client
2016/10/17 17:48:40 550400 c local (098C&000000/0C1E/006B/9D:3270039B3CCEC988CA1D210B236C879E): timeout (5005 ms) by client
2016/10/17 17:48:40 550400 c local (098C&000000/0C1E/006B/9D:3270039B3CCEC988CA1D210B236C879E): not found (1507 ms) by client
2016/10/17 17:48:40 550400 c [DVBAPI] Demuxer #0 PMT update for decoding of SRVID 006B!
2016/10/17 17:48:40 550400 c [DVBAPI] Demuxer #0 continue decoding of SRVID 006B
2016/10/17 17:48:40 550400 c [SKIP STREAM] CAID: 09C4 ECM_PID: 1B0B PROVID: 000000 (Same as ECMPID #0)
2016/10/17 17:48:40 550400 c [SKIP STREAM] CAID: 09AF ECM_PID: 1F0B PROVID: 000000 (Same as ECMPID #1)
2016/10/17 17:48:40 550400 c [SKIP STREAM] CAID: 098C ECM_PID: 1A0B PROVID: 000000 (Same as ECMPID #2)
2016/10/17 17:48:40 550400 c Found 3 ECMpids and 3 STREAMpids in PMT
2016/10/17 17:48:40 550400 c [DVBAPI] Receiver wants to demux srvid 006B on adapter 0000 camask 0008 index 0003 pmtpid 0062
2016/10/17 17:48:40 550400 c New program number: 006B (09C4:006B unknown) [pmt_list_management 5]
2016/10/17 17:48:40 0 >> OSCam << cardserver log switched, version 1.20-unstable_svn, build r10100 (mipsel-oe-linux)
2016/10/17 17:48:41 550400 c [DVBAPI] Demuxer #0 PMT update for decoding of SRVID 006B!
2016/10/17 17:48:41 550400 c [DVBAPI] Demuxer #0 continue decoding of SRVID 006B
2016/10/17 17:48:41 550400 c [SKIP STREAM] CAID: 09C4 ECM_PID: 1B0B PROVID: 000000 (Same as ECMPID #0)
2016/10/17 17:48:41 550400 c [SKIP STREAM] CAID: 09AF ECM_PID: 1F0B PROVID: 000000 (Same as ECMPID #1)
2016/10/17 17:48:41 550400 c [SKIP STREAM] CAID: 098C ECM_PID: 1A0B PROVID: 000000 (Same as ECMPID #2)
2016/10/17 17:48:41 550400 c Found 3 ECMpids and 3 STREAMpids in PMT
2016/10/17 17:48:41 550400 c [DVBAPI] Receiver wants to demux srvid 006B on adapter 0000 camask 0008 index 0003 pmtpid 0062
2016/10/17 17:48:41 550400 c New program number: 006B (09C4:006B unknown) [pmt_list_management 5]
2016/10/17 17:48:42 550400 c [DVBAPI] Demuxer #0 PMT update for decoding of SRVID 006B!
2016/10/17 17:48:42 550400 c [DVBAPI] Demuxer #0 continue decoding of SRVID 006B
2016/10/17 17:48:42 550400 c [SKIP STREAM] CAID: 09C4 ECM_PID: 1B0B PROVID: 000000 (Same as ECMPID #0)
2016/10/17 17:48:42 550400 c [SKIP STREAM] CAID: 09AF ECM_PID: 1F0B PROVID: 000000 (Same as ECMPID #1)
2016/10/17 17:48:42 550400 c [SKIP STREAM] CAID: 098C ECM_PID: 1A0B PROVID: 000000 (Same as ECMPID #2)
2016/10/17 17:48:42 550400 c Found 3 ECMpids and 3 STREAMpids in PMT
2016/10/17 17:48:42 550400 c [DVBAPI] Receiver wants to demux srvid 006B on adapter 0000 camask 0008 index 0003 pmtpid 0062
2016/10/17 17:48:42 550400 c New program number: 006B (09C4:006B unknown) [pmt_list_management 5]
2016/10/17 17:48:45 550400 c local (098C&000000/0C1E/006B/9D:3270039B3CCEC988CA1D210B236C879E): timeout (5002 ms) by client
2016/10/17 17:48:47 550400 c local (098C&000000/0C1E/006B/9D:3B2D542F900B7779EEC2539A8D1D8C85): timeout (5002 ms) by client
2016/10/17 17:48:47 550400 c local (098C&000000/0C1E/006B/9D:3B2D542F900B7779EEC2539A8D1D8C85): not found (1505 ms) by client
2016/10/17 17:48:52 550400 c local (098C&000000/0C1E/006B/9D:3B2D542F900B7779EEC2539A8D1D8C85): timeout (5002 ms) by client
2016/10/17 17:48:54 550400 c local (098C&000000/0C1E/006B/A0:27169BBD2B7C2D213E6073CD99559465): timeout (5002 ms) by client
2016/10/17 17:48:54 550400 c local (098C&000000/0C1E/006B/A0:27169BBD2B7C2D213E6073CD99559465): not found (1755 ms) by client
2016/10/17 17:48:56 53DFB8 p client [cs378x] disconnected: reason rto
2016/10/17 17:48:59 550400 c local (098C&000000/0C1E/006B/A0:27169BBD2B7C2D213E6073CD99559465): timeout (5002 ms) by client
2016/10/17 17:49:01 550400 c local (098C&000000/0C1E/006B/9D:E032D8479686710461D3B8972BFAFD5A): timeout (5002 ms) by client
2016/10/17 17:49:01 550400 c local (098C&000000/0C1E/006B/9D:E032D8479686710461D3B8972BFAFD5A): not found (1757 ms) by client
2016/10/17 17:49:01 53DFB8 p client [cs378x] connecting to myserverip:12345
2016/10/17 17:49:06 550400 c local (098C&000000/0C1E/006B/9D:E032D8479686710461D3B8972BFAFD5A): timeout (5002 ms) by client
2016/10/17 17:49:08 550400 c local (098C&000000/0C1E/006B/9D:4810BF262813C61C87E808298F5FD328): timeout (5002 ms) by client
2016/10/17 17:49:08 550400 c local (098C&000000/0C1E/006B/9D:4810BF262813C61C87E808298F5FD328): not found (1505 ms) by client
2016/10/17 17:49:13 550400 c local (098C&000000/0C1E/006B/9D:4810BF262813C61C87E808298F5FD328): timeout (5002 ms) by client
2016/10/17 17:49:15 550400 c local (098C&000000/0C1E/006B/9D:8757B6CEC2B682C70871CA2601139DBC): timeout (5002 ms) by client
2016/10/17 17:49:15 550400 c local (098C&000000/0C1E/006B/9D:8757B6CEC2B682C70871CA2601139DBC): not found (1505 ms) by client
2016/10/17 17:49:20 550400 c local (098C&000000/0C1E/006B/9D:8757B6CEC2B682C70871CA2601139DBC): timeout (5002 ms) by client
2016/10/17 17:49:22 550400 c local (098C&000000/0C1E/006B/9D:0292029560315B7643D94F245C2A9B3F): timeout (5002 ms) by client
2016/10/17 17:49:22 550400 c local (098C&000000/0C1E/006B/9D:0292029560315B7643D94F245C2A9B3F): not found (1507 ms) by client
2016/10/17 17:49:27 550400 c local (098C&000000/0C1E/006B/9D:0292029560315B7643D94F245C2A9B3F): timeout (5002 ms) by client
2016/10/17 17:49:29 550400 c local (098C&000000/0C1E/006B/9DDC7A419F8206A50CD088B74BCE6BB65): timeout (5002 ms) by client
2016/10/17 17:49:29 550400 c local (098C&000000/0C1E/006B/9DDC7A419F8206A50CD088B74BCE6BB65): not found (1504 ms) by client
2016/10/17 17:49:34 550400 c local (098C&000000/0C1E/006B/9DDC7A419F8206A50CD088B74BCE6BB65): timeout (5002 ms) by client
2016/10/17 17:49:36 550400 c local (098C&000000/0C1E/006B/9D:BAFEFBEBEBAAEDFB38028541460CDC8A): timeout (5002 ms) by client
2016/10/17 17:49:36 550400 c local (098C&000000/0C1E/006B/9D:BAFEFBEBEBAAEDFB38028541460CDC8A): not found (1504 ms) by client
2016/10/17 17:49:41 550400 c local (098C&000000/0C1E/006B/9D:BAFEFBEBEBAAEDFB38028541460CDC8A): timeout (5002 ms) by client
2016/10/17 17:49:43 550400 c local (098C&000000/0C1E/006B/9D:47CB016DCAF69DB7BA01D33F69268C57): timeout (5002 ms) by client
2016/10/17 17:49:43 550400 c local (098C&000000/0C1E/006B/9D:47CB016DCAF69DB7BA01D33F69268C57): not found (1504 ms) by client
2016/10/17 17:49:45 53DFB8 p client [cs378x] disconnected: reason rto
2016/10/17 17:49:48 550400 c local (098C&000000/0C1E/006B/9D:47CB016DCAF69DB7BA01D33F69268C57): timeout (5002 ms) by client
2016/10/17 17:49:50 550400 c local (098C&000000/0C1E/006B/9D:BA8FCCFC38C93CEE5B6EAD9444D9558B): timeout (5002 ms) by client
2016/10/17 17:49:50 550400 c local (098C&000000/0C1E/006B/9D:BA8FCCFC38C93CEE5B6EAD9444D9558B): not found (1505 ms) by client
2016/10/17 17:49:50 53DFB8 p client [cs378x] connecting to myserverip:12345
2016/10/17 17:49:50 550400 c local (098C&000000/0C1E/006B/9D:BA8FCCFC38C93CEE5B6EAD9444D9558B): found (141 ms) by client
2016/10/17 17:49:50 53DFB8 p client CMD05 AU request for caid: 098C auprovid: 000000
2016/10/17 17:49:52 550400 c local (098C&000000/0C1E/006B/9D:6CBBFED46C6E4D9A087E8631303A8576): found (99 ms) by client
2016/10/17 17:49:59 550400 c local (098C&000000/0C1E/006B/9D:E09BF2B6376B465598B240CC93F9D8E0): found (100 ms) by client
2016/10/17 17:50:06 550400 c local (098C&000000/0C1E/006B/9D:F5B3309C32B49B0F7030536E165B1E24): found (102 ms) by client
2016/10/17 17:50:13 550400 c local (098C&000000/0C1E/006B/9D:A7430F871980FD988610A12768199EFF): found (102 ms) by client
2016/10/17 17:50:20 550400 c local (098C&000000/0C1E/006B/9D:B90DE78F8AEBAD59C2166E7A5199A017): found (111 ms) by client

Und was mir noch aufgefallen ist auf dem Server Log:

Spoiler

1970/01/01 04:15:40 101459C0 c Usr2 (098C&000000/025B/0083/9D1D5A92A5C30B5B11C3A3CD90318ACE2): cache2 (72 ms) by S*yGermanyV14 - S*y Cinema HD
1970/01/01 04:15:47 1014E950 c Usr1 (098C&000000/025B/0083/9D:E31BB303B2927BB674CF90E6AF7B4970): found (69 ms) by S*yGermanyV14 - S*y Cinema HD
1970/01/01 04:15:47 101459C0 c Usr2 (098C&000000/025B/0083/9D:E31BB303B2927BB674CF90E6AF7B4970): cache2 (69 ms) by S*yGermanyV14 - S*y Cinema HD

Usr1 ist intern
Usr2 extern
Extern bekommt alles aus einem Cache. Wo kann man das einstellen? Kann man den evtl vergrößern? Habe auch schon mal was von Cacheex gelesen. Könnte mich das weiter bringen?

Update:

Es scheint, als ob das Problem mal wieder mit meinem Portmapper Service (wegen DSLite Anschluss) zusammen hängt. Gewechselt auf einen anderen Server (in einem anderen Datacenter) und Probleme haben sich fast ausschließlich erübrigt.

Danke an Alle