FRITZBox nach Firmwareupdate - Web_Query.4656 Error: 403 Forbidden - Readout_Run

[HomeAuto_User]

Hallo,

seit dem gestrigen Abend hat meine FritzBox von Vodafone keine Verbindung mehr.
Ich vermute, der Betreiber hat ein Update gemacht was ich versuche zu verifizieren.

Ich durfte die FritzBox vom Netz trennen weil ich die Steckdose benötigte und seither ist der Fehler.
Die Annahme, das der Kabelbetreiber dannach das Update einspielte liegt nahe.


Ich versuche schon alles aber es erscheint immer

Code Auswählen Erweitern

2018.10.19 07:10:26 3: FRITZBOX FritzBox: Web_Query.4656 Error: 403 Forbidden
2018.10.19 07:10:26 2: FRITZBOX FritzBox: Readout_Run_Web.1376 Error: 403 Forbidden
2018.10.19 07:15:26 3: FRITZBOX FritzBox: Web_Query.4656 Error: 403 Forbidden
2018.10.19 07:15:26 2: FRITZBOX FritzBox: Readout_Run_Web.1376 Error: 403 Forbidden
2018.10.19 07:20:26 3: FRITZBOX FritzBox: Web_Query.4656 Error: 403 Forbidden
2018.10.19 07:20:26 2: FRITZBOX FritzBox: Readout_Run_Web.1376 Error: 403 Forbidden
2018.10.19 07:25:26 3: FRITZBOX FritzBox: Web_Query.4656 Error: 403 Forbidden
2018.10.19 07:25:26 2: FRITZBOX FritzBox: Readout_Run_Web.1376 Error: 403 Forbidden

Da die Meldung sogar mein komplettes System lahm legte, so habe ich nun das Modul abgeschalten.

Meldung in der FritzBox:

Code Auswählen Erweitern

Anmeldung an der FRITZ!Box-Benutzeroberfläche von IP-Adresse xxx gescheitert (ungültige Sitzungskennung). Zur Sicherheit werden alle noch gültigen Sitzungen zur IP-Adresse xxx beendet.

Daten der FritzBox:
FRITZ!OS: 6.87
FRITZ!Box 6490 Cable (kdg)

MfG

[tupol]

Hast Du schon mal FHEM und Fritzbox gleichzeitig neu gestartet?

[HomeAuto_User]

Hast Du schon mal FHEM und Fritzbox gleichzeitig neu gestartet?

Den Versuch habe ich soeben unternommen aber es brachte kein Erfolg.

EDIT: nach dem 2. Versuch klappte es. WORAN liegt das bzw. wie kam es zu dem Fehler?

[tupol]

Keine Ahnung. Ich konnte den Fehler bisher nicht nachbauen.

[carlos]

Den Fehler hatte ich auch schon öfter-.
Passwort neu setzen hat geholfen.
Gruß

Carlos

[Markus Bloch]

Klingt für mich, als wenn nach dem Firmwareupdate die Session-Id für die TR064/Web-Anfragen nicht mehr gültig ist (Box hat ja neugestartet) und da ja hier eine Session-ID fortwährend weitergenutzt wird für folgende HTTP-Requests diese dann nach dem Neustart natürlich abgewiesen wird.

Bei einem FHEM Neustart wird ja eine neue Authentifizierung gestartet und damit eine neue Session-Id generiert die dann auch wieder funktioniert.

[tupol]

Nein. Das hatte ich schon versucht. Durch Ausschalten der Box konnte ich den Fehler nicht erzeugen.
Bei dem Fehler wird eigentlich immer eine neue SID geholt. Vielleicht gibt es noch eine zeitliche Blockade. Aber im Beispiel erfolgt die Abfrage alle 5 Minuten.


Zur Analyse brauche ich einen Log-Auszug vom Zeitpunkt der Abfrage bei verbose 5 und einen aus der Fritzbox. Aber die konnte mir noch keiner schicken, da es nach dem Reset wieder lief.

[Pseudex]

ich hab auf verbose 5 umgestellt. aber leider ist nicht viel im log drin
Meine FB ist eine 7580 mit FW 7.01

Code Auswählen Erweitern

Nov 12 15:28:03 localhost fhem[1043]: 2018.11.12 15:28:03 3: FRITZBOX: set FritzBox update
Nov 12 15:28:03 localhost fhem[1043]: 2018.11.12 15:28:03 4: FRITZBOX FritzBox: Readout_Start.718 Fork process FRITZBOX_Readout_Run_Web
Nov 12 15:28:03 localhost fhem[1043]: 2018.11.12 15:28:03 4: FRITZBOX FritzBox: Readout_Run_Web.1302 Prepare query string for luaQuery.
Nov 12 15:28:03 localhost fhem[1043]: 2018.11.12 15:28:03 5: FRITZBOX FritzBox: readPassword.4737 Read FritzBox password from file
Nov 12 15:28:03 localhost fhem[1043]: 2018.11.12 15:28:03 4: FRITZBOX FritzBox: Web_OpenCon.4521 Open Web connection to fritz.box
Nov 12 15:28:03 localhost fhem[1043]: 2018.11.12 15:28:03 4: FRITZBOX FritzBox: Web_OpenCon.4525 Web session opened with sid 614124d7d443b725
Nov 12 15:28:03 localhost fhem[1043]: 2018.11.12 15:28:03 5: FRITZBOX FritzBox: Web_Query.4644 Request data via API luaQuery.
Nov 12 15:28:03 localhost fhem[1043]: 2018.11.12 15:28:03 5: FRITZBOX FritzBox: Web_Query.4652 Response: 403 Forbidden
Nov 12 15:28:03 localhost fhem[1043]: 2018.11.12 15:28:03 3: FRITZBOX FritzBox: Web_Query.4656 Error: 403 Forbidden
Nov 12 15:28:03 localhost fhem[1043]: 2018.11.12 15:28:03 2: FRITZBOX FritzBox: Readout_Run_Web.1376 Error: 403 Forbidden
Nov 12 15:28:03 localhost fhem[1043]: 2018.11.12 15:28:03 4: FRITZBOX FritzBox: Readout_Done.1770 Back at main process
Nov 12 15:28:03 localhost fhem[1043]: 2018.11.12 15:28:03 4: FRITZBOX FritzBox: Readout_Process.1792 Processing 2 readouts.
Nov 12 15:28:03 localhost fhem[1043]: 2018.11.12 15:28:03 4: FRITZBOX FritzBox: Readout_Process.1801 Reset SID


[tupol]

Wurde bei der nächsten Anfrage die gleiche SID verwendet?
Was steht zu diesem Zeitpunkt in den System-Ereignissen auf der Fritzbox?

[kaihs]

Wurde bei der nächsten Anfrage die gleiche SID verwendet?
Was steht zu diesem Zeitpunkt in den System-Ereignissen auf der Fritzbox?

Da ich aktuell das gleiche Problem habe versuche ich mal diese Fragen zu beantworten.
Im fhem Log:

Code Auswählen Erweitern


2021.01.11 18:21:30.563 3: FRITZBOX: set FritzBox update
2021.01.11 18:21:30.612 4: FRITZBOX FritzBox: Readout_Start.718 Fork process FRITZBOX_Readout_Run_Web
2021.01.11 18:21:31.270 4: FRITZBOX FritzBox: Readout_Run_Web.1302 Prepare query string for luaQuery.
2021.01.11 18:21:31.273 5: FRITZBOX FritzBox: readPassword.4737 Read FritzBox password from file
2021.01.11 18:21:31.277 4: FRITZBOX FritzBox: Web_OpenCon.4521 Open Web connection to fritz.box
2021.01.11 18:21:31.948 4: FRITZBOX FritzBox: Web_OpenCon.4525 Web session opened with sid e88be6ee863ab785
2021.01.11 18:21:31.950 5: FRITZBOX FritzBox: Web_Query.4644 Request data via API luaQuery.
2021.01.11 18:21:32.909 5: FRITZBOX FritzBox: Web_Query.4652 Response: 403 Forbidden

2021.01.11 18:21:32.911 3: FRITZBOX FritzBox: Web_Query.4656 Error: 403 Forbidden
2021.01.11 18:21:32.913 2: FRITZBOX FritzBox: Readout_Run_Web.1376 Error: 403 Forbidden
2021.01.11 18:21:32.945 4: FRITZBOX FritzBox: Readout_Done.1770 Back at main process
2021.01.11 18:21:32.948 4: FRITZBOX FritzBox: Readout_Process.1792 Processing 2 readouts.
2021.01.11 18:21:32.950 4: FRITZBOX FritzBox: Readout_Process.1801 Reset SID
2021.01.11 18:26:30.635 4: FRITZBOX FritzBox: Readout_Start.718 Fork process FRITZBOX_Readout_Run_Web
2021.01.11 18:26:30.724 4: FRITZBOX FritzBox: Readout_Run_Web.1302 Prepare query string for luaQuery.
2021.01.11 18:26:30.729 5: FRITZBOX FritzBox: readPassword.4737 Read FritzBox password from file
2021.01.11 18:26:30.735 4: FRITZBOX FritzBox: Web_OpenCon.4521 Open Web connection to fritz.box
2021.01.11 18:26:31.402 4: FRITZBOX FritzBox: Web_OpenCon.4525 Web session opened with sid 7b97269d9b8b46f2
2021.01.11 18:26:31.403 5: FRITZBOX FritzBox: Web_Query.4644 Request data via API luaQuery.
2021.01.11 18:26:32.341 5: FRITZBOX FritzBox: Web_Query.4652 Response: 403 Forbidden

2021.01.11 18:26:32.342 3: FRITZBOX FritzBox: Web_Query.4656 Error: 403 Forbidden
2021.01.11 18:26:32.345 2: FRITZBOX FritzBox: Readout_Run_Web.1376 Error: 403 Forbidden
2021.01.11 18:26:32.361 4: FRITZBOX FritzBox: Readout_Done.1770 Back at main process
2021.01.11 18:26:32.363 4: FRITZBOX FritzBox: Readout_Process.1792 Processing 2 readouts.
2021.01.11 18:26:32.365 4: FRITZBOX FritzBox: Readout_Process.1801 Reset SID
2021.01.11 18:27:25.335 3: FRITZBOX: set FritzBox update
2021.01.11 18:27:25.376 4: FRITZBOX FritzBox: Readout_Start.718 Fork process FRITZBOX_Readout_Run_Web
2021.01.11 18:27:25.512 4: FRITZBOX FritzBox: Readout_Run_Web.1302 Prepare query string for luaQuery.
2021.01.11 18:27:25.515 5: FRITZBOX FritzBox: readPassword.4737 Read FritzBox password from file
2021.01.11 18:27:25.521 4: FRITZBOX FritzBox: Web_OpenCon.4521 Open Web connection to fritz.box
2021.01.11 18:27:26.185 4: FRITZBOX FritzBox: Web_OpenCon.4525 Web session opened with sid 047bc1241b4aeb45
2021.01.11 18:27:26.187 5: FRITZBOX FritzBox: Web_Query.4644 Request data via API luaQuery.
2021.01.11 18:27:27.489 5: FRITZBOX FritzBox: Web_Query.4652 Response: 403 Forbidden

2021.01.11 18:27:27.490 3: FRITZBOX FritzBox: Web_Query.4656 Error: 403 Forbidden
2021.01.11 18:27:27.492 2: FRITZBOX FritzBox: Readout_Run_Web.1376 Error: 403 Forbidden
2021.01.11 18:27:27.535 4: FRITZBOX FritzBox: Readout_Done.1770 Back at main process
2021.01.11 18:27:27.537 4: FRITZBOX FritzBox: Readout_Process.1792 Processing 2 readouts.
2021.01.11 18:27:27.606 4: FRITZBOX FritzBox: Readout_Process.1801 Reset SID


Es wird also jedes mal eine andere sid verwendet.

In Log der Fritzbox:

Code Auswählen Erweitern


11.01.21
18:27:26
Anmeldung an der FRITZ!Box-Benutzeroberfläche von IP-Adresse 2003:d0:2721:500:93:2ff:fe82:7586 gescheitert (ungültige Sitzungskennung). Zur Sicherheit werden alle noch gültigen Sitzungen zur IP-Adresse 2003:d0:2721:500:93:2ff:fe82:7586 beendet.
11.01.21
18:27:26
Anmeldung des Benutzers callmonitor an der FRITZ!Box-Benutzeroberfläche von IP-Adresse 192.168.2.21.
11.01.21
18:26:32
Anmeldung an der FRITZ!Box-Benutzeroberfläche von IP-Adresse 2003:d0:2721:500:93:2ff:fe82:7586 gescheitert (ungültige Sitzungskennung). Zur Sicherheit werden alle noch gültigen Sitzungen zur IP-Adresse 2003:d0:2721:500:93:2ff:fe82:7586 beendet.
11.01.21
18:26:31
Anmeldung des Benutzers callmonitor an der FRITZ!Box-Benutzeroberfläche von IP-Adresse 192.168.2.21.
11.01.21
18:21:32
Anmeldung an der FRITZ!Box-Benutzeroberfläche von IP-Adresse 2003:d0:2721:500:93:2ff:fe82:7586 gescheitert (ungültige Sitzungskennung). Zur Sicherheit werden alle noch gültigen Sitzungen zur IP-Adresse 2003:d0:2721:500:93:2ff:fe82:7586 beendet.
11.01.21
18:21:31
Anmeldung des Benutzers callmonitor an der FRITZ!Box-Benutzeroberfläche von IP-Adresse 192.168.2.21.


Auffällig ist die Vermischung von IPV4 und IPV6 Adresse.
Kann das die Ursache sein?
Ich weiß aber nicht, wie ich das auf eine Adresskategorie fest einstellen könnte.

[kaihs]

Ich habe selber mal ein bisschen geforscht und mit 'local_address => '192.168.2.21'' eine IPV4 Adresse erzwungen (siehe https://metacpan.org/pod/LWP::UserAgent#local_address):

Code Auswählen Erweitern


my $agent    = LWP::UserAgent->new( local_address => '192.168.2.21', env_proxy => 1, keep_alive => 1, protocols_allowed => ['http'], timeout => 180);


Dann tritt das Problem nicht mehr auf.
Ist nur die Frage wie man das verallgemeinern kann.

Das Modul müsste ja erkennen, welches lokale Interface für die Anfrage verwendet wird und dann diese Adresse in der Anfrage verwendet.

Frage am Rande: Warum wird überhaupt LWP::Useragent verwendet? Sollte das mit den fhem eigenen HttpUtils nicht auch gehen?

[metaboxler]

Hallo zusammen,

hatte nach einem Update meiner FritzBoxen (7490 auf Labor) gerade auch erhebliche Probleme mit diversen Dingen:
- Netzlaufwerk war nicht erreichbar (USB-Platte an der Fritz!Box)
- Scannen auf FritzBox nicht möglich
- In FHEM keine Informationen abrufbar

Unter "System"-"Fritz!Box-Benutzer" dann den Eintrag eines "neuen" Benutzers gefunden:
fritzXXXX

Als Attribut boxUser in der Konfiguration nachgetragen und alles funktioniert unter FHEM wieder.
Bei den Fritz!Box-Benutzern müssen nun auch gewisse Mindestanforderungen bei den Passwörtern eingehalten werden, sonst gibt es auch hier Probleme.
Entsprechend die Passwörter neu gesetzt und auch das Netzlaufwerk und er Scanner funktionieren wieder 1A

Ich hoffe, das hilft auch bei Euch:

metybpxler

[kaihs]

Hallo zusammen,

hatte nach einem Update meiner FritzBoxen (7490 auf Labor) gerade auch erhebliche Probleme mit diversen Dingen:
- Netzlaufwerk war nicht erreichbar (USB-Platte an der Fritz!Box)
- Scannen auf FritzBox nicht möglich
- In FHEM keine Informationen abrufbar

Unter "System"-"Fritz!Box-Benutzer" dann den Eintrag eines "neuen" Benutzers gefunden:
fritzXXXX

Danke für die Info, aber ich bin noch auf offiziellen 7.21 von Fritz!OS und da gibt es den User nicht.