logmeldung no-cache, no-store, must-revalidate Bedeutung?

riker1 · 12 Februar 2019, 08:29:58

Hallo,

ich habe öfters diese Meldung im Log.

Teilweise ist die connection auch weg.

no-cache, no-store, must-revalidate

was bedeutet das und wie kann ich es ggf. abstellen?

Danke
T

amenomade · 12 Februar 2019, 17:56:43

Nur so einfach diese Zeile ohne weiteres in der Log?

Das sieht so aus wie ein typisches "Cache-Control: no-cache, no-store, must-revalidate", aber das es so einfach in die Luft, ohne was vorher oder nachher und ohne Timestamp hängt, ist für einen Log-Eintrag komisch.

riker1 · 12 Februar 2019, 18:34:00

Hallo

ja da ist mehr,
scheinbar ist es durch den Zeilenumbruch in die eigene Zeile gerutscht.

Code Auswählen

2019.02.12 06:43:23.778 4: WEB8086_192.168.0.10_49466 POST /fhem&fw_id=6498&cmd=list+TYPE%3DCUL_HM%3AFILTER%3Droom%3D1_%5BWKD%5D.*Licht+%3AFILTER%3Dmodel%3DHM-L.*; BUFLEN:0
2019.02.12 06:43:23.780 4: authorize WEB8086/cmd/list: allowed returned dont care
2019.02.12 06:43:23.797 4: authorize WEB8086/devicename/HM_1DCC51: allowed returned dont care
2019.02.12 06:43:23.798 4: authorize WEB8086/devicename/HM_29553A: allowed returned dont care
2019.02.12 06:43:23.798 4: authorize WEB8086/devicename/HM_2C5AA7_Dim: allowed returned dont care
2019.02.12 06:43:23.798 4: authorize WEB8086/devicename/HM_2E3200: allowed returned dont care
2019.02.12 06:43:23.799 4: authorize WEB8086/devicename/HM_4A29F9: allowed returned dont care
2019.02.12 06:43:23.799 4: authorize WEB8086/devicename/HM_4A2F49: allowed returned dont care
2019.02.12 06:43:23.799 4: authorize WEB8086/devicename/HM_4A3089: allowed returned dont care
2019.02.12 06:43:23.803 4: WEB8086_192.168.0.10_49466 GET /fhem?fw_id=6498; BUFLEN:0
2019.02.12 06:43:23.904 4: WEB8086: /fhem?fw_id=6498 / RL:3052 / text/html; charset=UTF-8 / Content-Encoding: gzip
 / Cache-Control: no-cache, no-store, must-revalidate

2019.02.12 06:43:23.946 4: WEB8086_192.168.0.10_49466 GET /fhem/pgm2/style.css?v=1549894839; BUFLEN:0
2019.02.12 06:43:23.953 4: WEB8086_192.168.0.10_49466 => 304 Not Modified
2019.02.12 06:43:23.984 4: Connection closed for WEB8086_192.168.0.10_49294: EOF
2019.02.12 06:43:23.986 4: Connection accepted from WEB8086_192.168.0.10_49468
2019.02.12 06:43:23.994 4: Connection accepted from WEB8086_192.168.0.10_49470

Hilft das etwas mehr?

danke
t

riker1 · 12 Februar 2019, 18:38:52

Hallo

eventuell noch ein wichtiger Hintergrund, Bin mir nicht sicher ob das hiermit zusammenhängt.

hatte diverse neustarts . Keine Logmeldungen die ich sehen konnte.

Neustarts sehen dann so im Log aus.

Code Auswählen

2019.02.12 07:44:25.191 4: WEB8086: /fhem?cmd=list%20-r%20MAX_Mode&XHR=1&fw_id=287460 / RL:120 / text/plain; charset=UTF-8 / Content-Encoding: gzip
 / Cache-Control: no-cache, no-store, must-revalidate

2019.02.12 07:44:28.102 1: checkFritzMACpresent (TR7272): mac_D4_61_DA_4E_8E_72 ist >inactive<, also abwesend.
2019.02.12 07:44:28.685 1: checkFritzMACpresent (FB3390_32): mac_FC_53_9E_A6_BB_B1 nicht gefunden, abwesend.
2019.02.12 07:44:31.344 4: Connection closed for WEB8086_192.168.0.10_50352: EOF
2019.02.12 07:44:37.080 4: Connection accepted from WEB8086_192.168.0.10_50380
2019.02.12 07:44:39.256 1: checkFritzMACpresent (FB3390_32): mac_FC_53_9E_A6_BB_B1 nicht gefunden, abwesend.
2019.02.12 07:44:51.035 1: checkFritzMACpresent (FB3390_32): mac_FC_53_9E_A6_BB_B1 nicht gefunden, abwesend.
2019.02.12 07:45:02.502 4: WEB8086_192.168.0.10_50320 POST /fhem?cmd.MAX_Mode=defmod%20MAX_Mode%20readingsGroup%20%3C%20%3E%2C%20%3C%20%3E%2C%3CTemp%3E%2C%3CDesiredTemp%3E%2C%3Cmode%3E%2C%3Ctime%3E%20MAX.*%3Atemperature%2Cstate%2Cmode%2CReadingsVal(%24Name%2C%27temperature%27%2C%27%27)&XHR=1&fw_id=287460; BUFLEN:0
2019.02.12 07:45:02.504 4: authorize WEB8086/cmd/defmod: allowed returned dont care
2019.02.12 07:45:03.153 4: WEB8086: /fhem?cmd.MAX_Mode=defmod%20MAX_Mode%20readingsGroup%20%3C%20%3E%2C%20%3C%20%3E%2C%3CTemp%3E%2C%3CDesiredTemp%3E%2C%3Cmode%3E%2C%3Ctime%3E%20MAX.*%3Atemperature%2Cstate%2Cmode%2CReadingsVal(%24Name%2C%27temperature%27%2C%27%27)&XHR=1&fw_id=287460 / RL:20 / text/plain; charset=UTF-8 / Content-Encoding: gzip
 / Cache-Control: no-cache, no-store, must-revalidate

2019.02.12 07:45:10.137 1: checkFritzMACpresent (FB3390_32): mac_FC_53_9E_A6_BB_B1 nicht gefunden, abwesend.
2019.02.12 07:45:10.295 4: WEB8086_192.168.0.10_50320 POST /fhem?cmd.MAX_Mode=attr%20MAX_Mode%20verbose%200&XHR=1&fw_id=287460; BUFLEN:0
2019.02.12 07:45:10.301 4: authorize WEB8086/cmd/attr: allowed returned dont care
2019.02.12 07:45:10.301 4: authorize WEB8086/devicename/MAX_Mode: allowed returned dont care
2019.02.12 07:45:10.362 4: WEB8086: /fhem?cmd.MAX_Mode=attr%20MAX_Mode%20verbose%200&XHR=1&fw_id=287460 / RL:20 / text/plain; charset=UTF-8 / Content-Encoding: gzip
 / Cache-Control: no-cache, no-store, must-revalidate

2019.02.12 07:45:13.487 4: WEB8086_192.168.0.10_50320 GET /fhem?detail=MAX_Mode; BUFLEN:0
2019.02.12 07:45:13.616 4: WEB8086: /fhem?detail=MAX_Mode / RL:5526 / text/html; charset=UTF-8 / Content-Encoding: gzip
 / Cache-Control: no-cache, no-store, must-revalidate

2019.02.12 07:45:13.761 4: WEB8086_192.168.0.10_50322 GET /fhem/pgm2/doif.js; BUFLEN:0
2019.02.12 07:45:13.762 4: WEB8086_192.168.0.10_50322 => 304 Not Modified
2019.02.12 07:45:13.763 4: WEB8086_192.168.0.10_50318 GET /fhem/pgm2/fhemweb_readingsGroup.js; BUFLEN:0
2019.02.12 07:45:13.763 4: WEB8086_192.168.0.10_50318 => 304 Not Modified
2019.02.12 07:45:13.765 4: WEB8086_192.168.0.10_50328 GET /fhem/pgm2/jquery-ui.min.js; BUFLEN:0
2019.02.12 07:45:13.765 4: WEB8086_192.168.0.10_50328 => 304 Not Modified
2019.02.12 07:45:13.766 4: WEB8086_192.168.0.10_50326 GET /fhem/codemirror/fhem_codemirror.js; BUFLEN:0
2019.02.12 07:45:13.767 4: WEB8086_192.168.0.10_50326 => 304 Not Modified
2019.02.12 07:45:13.768 4: WEB8086_192.168.0.10_50324 GET /fhem/pgm2/fhemweb.js; BUFLEN:0
2019.02.12 07:45:13.769 4: WEB8086_192.168.0.10_50324 => 304 Not Modified
2019.02.12 07:45:13.825 4: Connection closed for WEB8086_192.168.0.10_50378: EOF
2019.02.12 07:45:13.827 4: WEB8086_192.168.0.10_50320 GET /fhem/pgm2/jquery.min.js; BUFLEN:0
2019.02.12 07:45:13.827 4: WEB8086_192.168.0.10_50320 => 304 Not Modified
2019.02.12 07:45:13.863 4: WEB8086_192.168.0.10_50326 GET /fhem/images/default/icoEverything.png; BUFLEN:0
2019.02.12 07:45:13.863 4: WEB8086_192.168.0.10_50326 => 304 Not Modified
2019.02.12 07:45:13.864 4: WEB8086_192.168.0.10_50322 GET /fhem/pgm2/defaultCommon.css; BUFLEN:0
2019.02.12 07:45:13.865 4: WEB8086_192.168.0.10_50322 => 304 Not Modified
2019.02.12 07:45:13.964 4: WEB8086_192.168.0.10_50322 GET /fhem/pgm2/dashboard_style.css; BUFLEN:0
2019.02.12 07:45:13.965 4: WEB8086_192.168.0.10_50322 => 304 Not Modified
2019.02.12 07:45:14.107 4: WEB8086_192.168.0.10_50326 GET /fhem?cmd=%7BReadingsVal(%22MAX_Mode%22%2C%22visibility%22%2C%22%22)%7D&XHR=1; BUFLEN:0
2019.02.12 07:45:14.108 4: authorize WEB8086/cmd/perl: allowed returned dont care
2019.02.12 07:45:14.109 4: WEB8086: /fhem?cmd=%7BReadingsVal(%22MAX_Mode%22%2C%22visibility%22%2C%22%22)%7D&XHR=1 / RL:21 / text/plain; charset=UTF-8 / Content-Encoding: gzip
 / Cache-Control: no-cache, no-store, must-revalidate

2019.02.12 07:45:14.110 4: WEB8086_192.168.0.10_50322 GET /fhem/images/default/fhemicon.png; BUFLEN:0
2019.02.12 07:45:14.110 4: WEB8086_192.168.0.10_50322 => 304 Not Modified
2019.02.12 07:45:14.111 4: WEB8086_192.168.0.10_50320 GET /fhem?cmd=%7BAttrVal(%22MAX_Mode%22%2C%22room%22%2C%22%22)%7D&XHR=1; BUFLEN:0
2019.02.12 07:45:14.112 4: authorize WEB8086/cmd/perl: allowed returned dont care
2019.02.12 07:45:14.113 4: WEB8086: /fhem?cmd=%7BAttrVal(%22MAX_Mode%22%2C%22room%22%2C%22%22)%7D&XHR=1 / RL:21 / text/plain; charset=UTF-8 / Content-Encoding: gzip
 / Cache-Control: no-cache, no-store, must-revalidate

2019.02.12 07:45:14.132 4: WEB8086_192.168.0.10_50322 GET /fhem/icons/favicon; BUFLEN:0
2019.02.12 07:45:14.195 4: Connection accepted from WEB8086_192.168.0.10_50386
2019.02.12 07:45:18.614 1: checkFritzMACpresent (TR3390_35): mac_B0_55_08_FC_D0_C5 nicht gefunden, abwesend.
2019.02.12 07:45:18.648 1: checkFritzMACpresent (TR3390_35): mac_44_91_60_F0_85_B3 nicht gefunden, abwesend.
2019.02.12 07:45:18.894 1: checkFritzMACpresent (TR3390_35): mac_5C_51_81_30_1E_37 nicht gefunden, abwesend.
2019.02.12 07:45:18.931 1: checkFritzMACpresent (TR3390_36): mac_88_BD_45_E0_34_BA nicht gefunden, abwesend.
2019.02.12 07:45:19.061 1: checkFritzMACpresent (TR7272): mac_E8_9E_B4_C4_03_9B nicht gefunden, abwesend.
2019.02.12 07:45:20.957 1: checkFritzMACpresent (FB3390_32): mac_FC_53_9E_A6_BB_B1 nicht gefunden, abwesend.
2019.02.12 07:45:28.488 1: checkFritzMACpresent (TR7272): mac_D4_61_DA_4E_8E_72 ist >inactive<, also abwesend.
2019.02.12 07:45:31.423 4: Connection closed for WEB8086_192.168.0.10_50372: EOF
2019.02.12 07:45:31.480 1: checkFritzMACpresent (FB3390_32): mac_FC_53_9E_A6_BB_B1 nicht gefunden, abwesend.
Unmatched ( in regex; marked by <-- HERE in m/^ReadingsVal( <-- HERE $Name$/ at ./FHEM/33_readingsGroup.pm line 1383.
2019.02.12 07:45:32 1: reload: Error:Modul 99_myJson deactivated:
 Illegal declaration of subroutine main::myUtils_Initialize at ./FHEM/99_myJson.pm line 15.

2019.02.12 07:45:32 1: PERL WARNING: Subroutine myUtils_Initialize redefined at ./FHEM/99_myUtils.pm line 15.
2019.02.12 07:45:33.145 1: Including fhem.cfg
2019.02.12 07:45:33.159 1: PERL WARNING: Subroutine myUtils_Initialize redefined at ./FHEM/99_myHeizung.pm line 15, <$fh> line 17.
2019.02.12 07:45:33.165 1: reload: Error:Modul 99_myJson deactivated:
 Illegal declaration of subroutine main::myUtils_Initialize at ./FHEM/99_myJson.pm line 15, <$fh> line 17.

2019.02.12 07:45:33.168 1: Including ./fhemtr/includes/Telegram_bot.cfg
2019.02.12 07:45:41.096 1: cul_ub10_ser2net: Can't connect to 192.168.0.10:2022: Connection refused
2019.02.12 07:45:41.494 1: nanoCul868: Can't open /dev/ttyUSB1: No such file or directory
2019.02.12 07:45:41.497 1: cul_nas_ser2net: Can't connect to 192.168.0.22:2022: Connection refused
2019.02.12 07:45:47.747 1: cul_HM_ser2net: Can't connect to 192.168.0.97:2022: Connection timed out
2019.02.12 07:45:51.890 1: PERL WARNING: Use of uninitialized value $evcode in concatenation (.) or string at ./FHEM/10_IT.pm line 775, <$fh> line 1990.
2019.02.12 07:45:55.147 1: cul_rpi_remote_ser2net_lan: Can't connect to 192.168.0.99:2022: Connection timed out
2019.02.12 07:45:58.157 1: cul_wohn_ser2net_rpi_wlan: Can't connect to 192.168.0.55:2022: Connection timed out
2019.02.12 07:46:01.165 1: cul_rpi_91_ser2net_lan: Can't connect to 192.168.0.91:2022: Connection timed out
2019.02.12 07:46:04.174 1: cul_LAPTOP_ser2net: Can't connect to 192.168.0.25:2022: Connection timed out
2019.02.12 07:46:07.027 1: PERL WARNING: Unescaped left brace in regex is deprecated here (and will be fatal in Perl 5.30), passed through in regex; marked by <-- HERE in m/^Value("osmc_tagesschau").{ <-- HERE .*}$/ at ./FHEM/98_expandJSON.pm line 64, <$fh> line 7684.
2019.02.12 07:46:07.028 1: PERL WARNING: Unescaped left brace in regex is deprecated here (and will be fatal in Perl 5.30), passed through in regex; marked by <-- HERE in m/^ReadingsVal("osmc_tagesschau","state","").{ <-- HERE .fil*}$/ at ./FHEM/98_expandJSON.pm line 64, <$fh> line 7686.
2019.02.12 07:46:08.326 1: PERL WARNING: can't getattr: Input/output error at FHEM/DevIo.pm line 420.
2019.02.12 07:46:08.327 1: NAD_T773SER: Can't open /dev/ttyS20: Input/output error
2019.02.12 07:46:09.358 1: Including ./fhem.save
2019.02.12 07:46:10.280 5: CUL_HM HM_29553A queue configRead, register incomplete
2019.02.12 07:46:10.562 5: Update structure 'WKD_Licht_Stuct' to undefined because device HM_2E3200 has changed
2019.02.12 07:46:10.607 5: Update structure 'WKD_Licht_Stuct1' to undefined because device HM_2E3200 has changed
2019.02.12 07:46:13.520 1: PERL WARNING: ^* matches null string many times in regex; marked by <-- HERE in m/^* <-- HERE $/ at ./FHEM/33_readingsGroup.pm line 154.
2019.02.12 07:46:13.520 1: PERL WARNING: ^* matches null string many times in regex; marked by <-- HERE in m/^* <-- HERE $/ at ./FHEM/33_readingsGroup.pm line 160.
2019.02.12 07:46:14.540 5: HM_Wo_

Eventuell hängt das mit der readinggroup Max_Mode zusammen.

noch ein Cache Beispiel:

Code Auswählen

2019.02.12 07:45:14.111 4: WEB8086_192.168.0.10_50320 GET /fhem?cmd=%7BAttrVal(%22MAX_Mode%22%2C%22room%22%2C%22%22)%7D&XHR=1; BUFLEN:0
2019.02.12 07:45:14.112 4: authorize WEB8086/cmd/perl: allowed returned dont care
2019.02.12 07:45:14.113 4: WEB8086: /fhem?cmd=%7BAttrVal(%22MAX_Mode%22%2C%22room%22%2C%22%22)%7D&XHR=1 / RL:21 / text/plain; charset=UTF-8 / Content-Encoding: gzip
 / Cache-Control: no-cache, no-store, must-revalidate

2019.02.12 07:45:14.132 4: WEB8086_192.168.0.10_50322 GET /fhem/icons/favicon; BUFLEN:0
2019.02.12 07:45:14.195 4: Connection accepted from WEB8086_192.168.0.10_50386
2019.02.12 07:45:18.614 1: checkFritzMACpresent (TR3390_35): mac_B0_55_08_FC_D0_C5 nicht gefunden, abwesend.
2019.02.12 07:45:18.648 1: checkFritzMACpresent (TR3390_35): mac_44_91_60_F0_85_B3 nicht gefunden, abwesend.
2019.02.12 07:45:18.894 1: checkFritzMACpresent (TR3390_35): mac_5C_51_81_30_1E_37 nicht gefunden, abwesend.

riker1 · 12 Februar 2019, 18:47:55

Hallo

fhem process zeigt massiv viele restarts:

Code Auswählen

   Loaded: loaded (/etc/systemd/system/fhem.service; enabled; vendor preset: enabled)
   Active: active (running) since Tue 2019-02-12 18:39:17 CET; 5s ago
  Process: 9930 ExecStart=/usr/bin/perl fhem.pl fhem.cfg (code=exited, status=0/SUCCESS)
 Main PID: 9940 (perl)
    Tasks: 1 (limit: 2319)
   CGroup: /system.slice/fhem.service
           └─9940 /usr/bin/perl fhem.pl fhem.cfg

Feb 12 18:39:17 ub9 systemd[1]: fhem.service: Scheduled restart job, restart counter is at 40.
Feb 12 18:39:17 ub9 systemd[1]: Stopped FHEM Home Automation.
Feb 12 18:39:17 ub9 systemd[1]: Starting FHEM Home Automation...
Feb 12 18:39:17 ub9 systemd[1]: Started FHEM Home Automation.

Finde dazu aber im Log nichts richtiges.

dachte das cache Thema hängt damit zusammen....

danke

amenomade · 12 Februar 2019, 18:53:42

Was ist das Gerät mit IP Adresse 192.168.0.10 ?

riker1 · 12 Februar 2019, 18:57:36

Mein Desktop
Webclient ubuntu

amenomade · 12 Februar 2019, 23:45:24

Ich vermute, Du hast auf WEB8086 irgendwelche "allowed" Regel, die einige Kommandos (u.a. perl) unterbindet.

Die Nachricht Cache-control gehört zu vorherige Zeile. Mit attr WEB8086 verbose 3 sollte es schon verschwinden. Aber vielleicht wäre es besser diese "allowed" Regel an deinem Bedarf anzupassen

99_myJson wird deaktiviert, da Du dort eine Funktion myUtils_Initialize hast, die eher myJson_Initialize heißen sollte
Genauso in 99_myHeizung

Du hast ein Problem mit einem ReadingsGroup
Und noch andere Problemen mit cul_ Devices.
Und er kann /dev/ttyS20 nicht lesen.

Hat irgendwann schon dein Fhem ordentlich funktioniert??? Mit so viele Problemen wundert es mich nicht, dass er sich ab und zu verabschiedet... Das sieht so aus, wie ob Du eine config Datei hättest, die gar nix mit deiner Konfiguration zu tun hat.

riker1 · 13 Februar 2019, 08:09:01

Hallo

danke für die Tipps:

allowed ist eigentlich disabled bei mir habe da keine Web instanz angeklickt und keine Regeln drinnen.
war ein alter versuch.

Code Auswählen

defmod allowed allowed
attr allowed comment defmod allowed allowed\
attr allowed verbose 0\
\
setstate allowed validFor:\
setstate allowed 2019-02-09 07:34:03 state validFor:
attr allowed disable 1

Bezüglich der MyUtils Probleme, die führen da zur Deaktivierung, habe sie aber nun gefixt. Danke dafür . dies waren alte Gehversuche mit myUtils.

ich habe aber eigentlich nirgends die vielen tty devices definiert. Wo kann ich denn einstellen welche tty er versucht zu öffnen?

Ich nutze mehrere Culs 1 mit USB, und 3 mit Ser2Net, die gehen aber.

Das Problem mit der Readinggroup habe ich noch nicht verstanden. Die Readinggroups waren aber schon lange drinnen. Habe sie aber mal disabled .

Ja es hat funktioniert. Es gab immer mal paar Probleme, aber sonst recht stabil.

Kann ich denn irgendetwas ab Caching einstellen?
Wenn es nur Meldungen wegen Verbose >3 sind und nur Infos darstellen. Ist es ja ok. Hatte Verbose wegen diesem Problem hochgesetzt.
https://forum.fhem.de/index.php/topic,97325.0.html

Vielen Danke fürs Schauen.

riker1 · 13 Februar 2019, 09:33:58

Zitat von: amenomade am 12 Februar 2019, 23:45:24

Und er kann /dev/ttyS20 nicht lesen.

das ist auch gelöst. der Port ist nicht mehr verwendet

Danke

amenomade · 13 Februar 2019, 19:03:14

Also eigentlich bedeutet "allowed returned dont care", das es für ihn erlaubt ist. Dann ist es nur informativ.

Ja, m.M.n. sind die "cache" Meldungen nur da, weil verbose =4

riker1 · 13 Februar 2019, 19:38:29

Hallo

ok danke.

dann ist es ja alles ok

oder kann man am cache was optimieren konfigurienen?

danke