[gelöst]FHEMWEB nur 8083 "hängt sich auf"

Otto123 · 29 Januar 2018, 14:06:07

Hi,

ich habe durch rumspielen einen komischen Effekt gefunden.

Ausgangslage
Ich habe FHEM auf dem Port 8083 im Browser offen.
Dieser Befehl in der Kommandozeile, schreibt eine Datei /opt/fhem/willi.txt mit dem Inhalt "echo test"

Code Auswählen

{system ("echo 'echo Test' > willi.txt")}
Jetzt in der gleichen Kommandozeile eingeben.

Code Auswählen

"cat willi.txt"
Ergebnis Das Web auf 8083 hängt endlos. Web 8084 und 8085 gehen weiterhin problemlos.
Dort in der Kommandozeile letzteren Befehl eingegeben: tut was er soll: Im Log steht einfach echo Test

shutdown restart löst das Problem.

Gibt man jetzt den Befehl in dem WEB 8084 oder 8085 ein geht das ohne Problem. Auch WEB 8083 bleibt am Leben.

FHEM hat aktuelles update:
01_FHEMWEB.pm 16016 2018-01-27 22:05:12Z rudolfkoenig

Bei einer älteren Version tritt das Problem nicht auf.
01_FHEMWEB.pm 15176 2017-10-02 14:50:03Z rudolfkoenig

Gruß Otto

rudolfkoenig · 29 Januar 2018, 14:36:21

Kann ich nicht nachstellen / bzw. nachvollziehen. Bei mir steht "echo Test" in fhem.log, und alles geht weiter.
Dein Problem muss an einer weiteren, mir noch unbekannten Einstellung liegen.

Otto123 · 29 Januar 2018, 14:47:27

Ok Danke Rudi, ich schaue mal was ich finde. Das Problem ist bei einer relativ kleinen Testinstanz...

Es ist auch nicht so, das etwas auf eine Schleife hindeutet, keine erhöhte Last oder Prozesse ...

Otto123 · 29 Januar 2018, 15:40:40

Ich habe jetzt ne völlig neue Instanz aufgesetzt. Leer und unverändert.

Es hat nichts mit meinen Befehlen zu tun. Nach einem Neustart bekommt man jedes FHEMWEB einzeln zum Abflug.

Einfach 5-6 mal in der Reihenfolge klicken, langsam mit einer Denk Sekunde dazwischen.
unsorted
Everything
Logfile
Edit files
unsorted
- meist hängt das Web ab dem Moment, manchmal erst nach
Everything

Manchmal kommt nach langer Wartezeit das Web wieder, der nächste Klick führt wieder in die Schleife...

Ich habe das reproduzierbar in drei FHEM Instanzen, eine davon 15182/2017-10-03, die anderen beiden aktuell.

CoolTux · 29 Januar 2018, 15:43:57

Otto mach Deine Tests mal bitte mit Verbose 5, eventuell kann Rudi das was erkennen.

rudolfkoenig · 29 Januar 2018, 15:47:00

ZitatOtto mach Deine Tests mal bitte mit Verbose 5, eventuell kann Rudi das was erkennen.

Genau.

Ich kann auch mit der "Denk Sekunde Methode" keinen Verklemmer produzieren. Haett mich auch gewundert, dann waer hier schon laengst der Teufel los.

Otto123 · 29 Januar 2018, 15:52:53

Sorry, ich weiß auch nicht was ich da falsch mache, dies ist die Instanz "ganz frisch ohne alles"

Code Auswählen

2018.01.29 15:39:14 1: Including fhem.cfg
2018.01.29 15:39:14 3: telnetPort: port 7072 opened
2018.01.29 15:39:15 3: WEB: port 8083 opened
2018.01.29 15:39:15 3: WEBphone: port 8084 opened
2018.01.29 15:39:15 3: WEBtablet: port 8085 opened
2018.01.29 15:39:15 2: eventTypes: loaded 0 events from ./log/eventTypes.txt
2018.01.29 15:39:15 1: Including ./log/fhem.save
2018.01.29 15:39:15 1: usb create starting
2018.01.29 15:39:15 3: Probing CUL device /dev/ttyAMA0
2018.01.29 15:39:16 3: Can't open /dev/ttyAMA0: Permission denied
2018.01.29 15:39:16 1: usb create end
2018.01.29 15:39:16 0: Featurelevel: 5.8
2018.01.29 15:39:16 0: Server started with 9 defined entities (fhem.pl:16017/2018-01-27 perl:5.024001 os:linux user:fhem pid:4381)
2018.01.29 15:50:20 5: Starting notify loop for global, 1 event(s), first is ATTR global verbose 5
2018.01.29 15:50:20 5: createNotifyHash
2018.01.29 15:50:20 5: End notify loop for global
2018.01.29 15:50:20 4: Connection closed for WEB_192.168.178.54_4155: EOF
2018.01.29 15:50:20 4: WEB_192.168.178.54_4158 GET /fhem?detail=global&fw_id=; BUFLEN:0
2018.01.29 15:50:20 4: WEB: /fhem?detail=global&fw_id= / RL:3595 / text/html; charset=UTF-8 / Content-Encoding: gzip
 / 
2018.01.29 15:50:20 4: Connection closed for WEB_192.168.178.54_4154: EOF
2018.01.29 15:50:20 4: WEB_192.168.178.54_4158 GET /fhem?cmd=%7BAttrVal(%22global%22%2C%22room%22%2C%22%22)%7D&XHR=1&fwcsrf=csrf_103073561103378; BUFLEN:0
2018.01.29 15:50:20 5: Cmd: >{AttrVal("global","room","")}<
2018.01.29 15:50:20 4: WEB: /fhem?cmd=%7BAttrVal(%22global%22%2C%22room%22%2C%22%22)%7D&XHR=1&fwcsrf=csrf_103073561103378 / RL:21 / text/plain; charset=UTF-8 / Content-Encoding: gzip
 / 
2018.01.29 15:50:20 4: WEB_192.168.178.54_4158 GET /fhem?XHR=1&inform=type=status;filter=global;since=1517237419;fmt=JSON&fw_id=24×tamp=1517237421552; BUFLEN:0
2018.01.29 15:50:29 4: WEB_192.168.178.54_4157 GET /fhem?room=Unsorted; BUFLEN:0
2018.01.29 15:50:29 4: WEB: /fhem?room=Unsorted / RL:1695 / text/html; charset=UTF-8 / Content-Encoding: gzip
 / 
2018.01.29 15:50:29 4: WEB_192.168.178.54_4157 GET /fhem?XHR=1&inform=type=status;filter=room=Unsorted;since=1517237428;fmt=JSON&fw_id=23×tamp=1517237430430; BUFLEN:0
2018.01.29 15:50:31 4: Connection accepted from WEB_192.168.178.54_4160
2018.01.29 15:50:31 4: WEB_192.168.178.54_4160 GET /fhem?room=all; BUFLEN:0
2018.01.29 15:50:31 4: WEB: /fhem?room=all / RL:1772 / text/html; charset=UTF-8 / Content-Encoding: gzip
 / 
2018.01.29 15:50:31 4: WEB_192.168.178.54_4160 GET /fhem?XHR=1&inform=type=status;filter=room=all;since=1517237430;fmt=JSON&fw_id=26×tamp=1517237431949; BUFLEN:0
2018.01.29 15:50:32 4: Connection accepted from WEB_192.168.178.54_4161
2018.01.29 15:50:32 4: WEB_192.168.178.54_4161 GET /fhem/FileLog_logWrapper?dev=Logfile&type=text&file=fhem-2018-01.log; BUFLEN:0
2018.01.29 15:50:32 4: WEB_192.168.178.54_4161 GET /fhem/FileLog_logWrapper?XHR=1&inform=type=status;filter=;since=1517237431;fmt=JSON&fw_id=27×tamp=1517237433614; BUFLEN:0
2018.01.29 15:50:34 4: Connection accepted from WEB_192.168.178.54_4162
2018.01.29 15:50:34 4: WEB_192.168.178.54_4162 GET /fhem?cmd=style%20list; BUFLEN:0
2018.01.29 15:50:34 4: WEB: /fhem?cmd=style%20list / RL:3025 / text/html; charset=UTF-8 / Content-Encoding: gzip
 / 
2018.01.29 15:50:34 4: WEB_192.168.178.54_4162 GET /fhem?XHR=1&inform=type=status;filter=;since=1517237433;fmt=JSON&fw_id=28×tamp=1517237435272; BUFLEN:0
2018.01.29 15:50:58 4: Connection accepted from WEBtablet_192.168.178.54_4165
2018.01.29 15:50:58 4: WEBtablet_192.168.178.54_4165 GET /fhem; BUFLEN:0
2018.01.29 15:50:58 4: WEBtablet: /fhem / RL:1460 / text/html; charset=UTF-8 / Content-Encoding: gzip
 / 
2018.01.29 15:50:58 4: Connection accepted from WEBtablet_192.168.178.54_4166
2018.01.29 15:50:58 4: Connection accepted from WEBtablet_192.168.178.54_4167
2018.01.29 15:50:58 4: Connection accepted from WEBtablet_192.168.178.54_4168
2018.01.29 15:50:58 4: Connection accepted from WEBtablet_192.168.178.54_4169
2018.01.29 15:50:58 4: Connection accepted from WEBtablet_192.168.178.54_4170
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4169 GET /fhem/pgm2/fhemweb.js; BUFLEN:0
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4169 => 304 Not Modified
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4165 GET /fhem/pgm2/style.css?v=1517236755; BUFLEN:0
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4167 GET /fhem/pgm2/jquery.min.js; BUFLEN:0
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4167 => 304 Not Modified
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4168 GET /fhem/pgm2/jquery-ui.min.js; BUFLEN:0
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4168 => 304 Not Modified
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4166 GET /fhem/pgm2/jquery-ui.min.css; BUFLEN:0
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4166 => 304 Not Modified
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4166 GET /fhem/images/default/icoEverything.png; BUFLEN:0
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4166 => 304 Not Modified
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4165 GET /fhem/pgm2/defaultCommon.css; BUFLEN:0
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4165 => 304 Not Modified
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4165 GET /fhem/pgm2/dashboard_style.css; BUFLEN:0
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4165 => 304 Not Modified
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4165 GET /fhem/images/default/fhemicon.png; BUFLEN:0
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4165 => 304 Not Modified
2018.01.29 15:50:59 4: WEBtablet_192.168.178.54_4165 GET /fhem?XHR=1&inform=type=status;filter=;since=1517237457;fmt=JSON&fw_id=29×tamp=1517237460028; BUFLEN:0
2018.01.29 15:51:01 4: WEBtablet_192.168.178.54_4166 GET /fhem/FileLog_logWrapper?dev=Logfile&type=text&file=fhem-2018-01.log; BUFLEN:0
2018.01.29 15:51:01 4: WEBtablet_192.168.178.54_4166 GET /fhem/FileLog_logWrapper?XHR=1&inform=type=status;filter=;since=1517237460;fmt=JSON&fw_id=30×tamp=1517237462550; BUFLEN:0
2018.01.29 15:51:28 4: Connection closed for WEBtablet_192.168.178.54_4170: EOF
2018.01.29 15:51:28 4: WEBtablet_192.168.178.54_4168 GET /fhem/FileLog_logWrapper?dev=Logfile&type=text&file=fhem-2018-01.log; BUFLEN:0
2018.01.29 15:51:28 4: Connection accepted from WEBtablet_192.168.178.54_4178
2018.01.29 15:51:28 4: WEBtablet_192.168.178.54_4168 GET /fhem/icons/favicon; BUFLEN:0
2018.01.29 15:51:28 4: WEBtablet_192.168.178.54_4168 GET /fhem/FileLog_logWrapper?XHR=1&inform=type=status;filter=;since=1517237487;fmt=JSON&fw_id=32×tamp=1517237489508; BUFLEN:0
2018.01.29 15:51:39 4: Connection closed for WEBtablet_192.168.178.54_4178: EOF
2018.01.29 15:51:39 4: Connection accepted from WEBtablet_192.168.178.54_4180
2018.01.29 15:51:39 4: WEBtablet_192.168.178.54_4167 GET /fhem/FileLog_logWrapper?dev=Logfile&type=text&file=fhem-2018-01.log; BUFLEN:0

Im Prinzip hängt es seit 2018.01.29 15:50:58 (Webtablet)

CoolTux · 29 Januar 2018, 16:01:20

Das ganze FHEM scheint schon mal nicht zu hängen, das Log wird ja fleißig weiter geschrieben.
Wenn Du versuchst andere Seiten in FHEMWEB auf zu rufen passiert nichts? Also ausser das er schreibt "warte auf" in der Statusleiste unten.

Otto123 · 29 Januar 2018, 16:17:26

Nein es hängt nur die jeweilige WEB Instanz, der Mauszeiger/Browserseite dreht Wartekreise . Über die andere kann man weiter machen. Allerdings wenn man genau den gleichen Vorgang macht, hängt dann auch dieses WEB und irgendwann sind sie alle

b4r7 · 29 Januar 2018, 16:18:22

Zitat von: Otto123 am 29 Januar 2018, 16:17:26
Nein es hängt nur das WEB, der Mauszeiger/Browserseite dreht Wartekreise . Über die andere kann man weiter machen. Allerdings wenn man genau den gleichen Vorgang macht, hängt dann auch dieses WEB und irgendwann sind sie alle

Kann es sein das du Chrome nutzt?

kurzer verweis auf einen anderen Thread

> https://forum.fhem.de/index.php/topic,83349.0.html

Otto123 · 29 Januar 2018, 16:19:14

ja Chrome ... tritt mit iexplorer nicht auf...

CoolTux · 29 Januar 2018, 16:19:47

Und wenn Du in de r"Wartezeit" mal mit einem anderen Browser auf die Seite zu greifst? Was passiert dann?

Otto123 · 29 Januar 2018, 16:22:26

der Zugriff klappt mit iexplorer während chrome Kreise dreht. Aber eine neue connection mit chrome geht nicht.

Aber wie gesagt ich habe auch eine ältere FHEM Instanz da funktioniert alles.

Otto123 · 14 Februar 2018, 10:57:32

Die Lösung scheint wirklich das folgende Attribute zu sein. Das beendet den Spuk sogar schlagartig dann, während der Chrome Browser noch Kreise dreht und man es mit weiteren Zugriff über Microsoft Browser über die FHEM Kommandozeile eingibt

Code Auswählen

attr WEB longpoll websocket

Der Chrome Browser ist in letzter Zeit so gut wie nicht mehr zu gebrauchen. Ich habe vor allem auch das Problem, dass er häufig nach einem "Aufklappen" des Notebook (und Neustart des Browser) für viele Minuten nicht "ins Internet" geht.
Edge macht parallel dazu keine Probleme, es liegt also nicht an der Wlan Verbindung oder so.

Ich setze das damit auf auf gelöst.

Gruß und Danke
Otto

heikoh81 · 23 Februar 2018, 15:22:06

Also ich habe gestern oder vorgestern wieder ein FHEM-update gemacht, und ich habe immer noch das Problem, dass FHEMWeb nicht mehr so schnell ist wie früher.
Auf meinem Raspi3 beobachte ich, dass jeder 2. oder 3. Klick in FHEMWeb die CPU-Last auf 1 Kern für mehrere Sekunden auf 25% treibt (also voll ausgelastet).
Jeder gefühlt 3. Klick dagegen wird sofort ausgeführt.

Sowohl mit Firefox von einem anderen Win10-PC als auch mit einer älteren Chromium-Version auf dem Raspi selbst.