Fehlermeldung Logfile UPnP Error Invalid Action - nach Fritzbox-Neustart

Begonnen von swsmily, 26 Juli 2023, 21:23:15

Vorheriges Thema - Nächstes Thema

swsmily

Hallo!

Meine Eltern haben eine Fritzbox 6591 Cable. Die aktuellste Firmware ist darauf installiert (161.07.56 laut FHEM).
Leider verliert die Fritzbox immer mal die Internetverbindung, bzw Cable ist nicht mehr synchron. Erst ein Neustart der Box hilft da weiter.
Wir haben daher eine Tasmota-Steckdose vor die Fritzbox gehängt und FHEM pingt immer wieder Google an. Wird Google für 1800 Sekunden nicht erreicht, wird die Steckdose abgeschaltet. Die Steckdose selbst ist per Rule aber so eingerichtet, dass sie 30 Sekunden später selbst wieder anschaltet.
Allerdings kommen ab dann immer Fehlermeldungen im Logfile von FHEM (auch wenn man die Box händisch neustartet, zb. über die Weboberfläche):

2023.07.26 19:26:29.443 2: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.3438] - ERROR: VDSL up/down rate GetInfo ->
$VAR1 = {
          'UPnPError' => {
                           'errorCode' => '401',
                           'errorDescription' => 'Invalid Action'
                         }
        };

2023.07.26 19:27:29.515 2: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.3438] - ERROR: VDSL up/down rate GetInfo ->
$VAR1 = {
          'UPnPError' => {
                           'errorDescription' => 'Invalid Action',
                           'errorCode' => '401'
                         }
        };

2023.07.26 19:28:29.460 2: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.3438] - ERROR: VDSL up/down rate GetInfo ->
$VAR1 = {
          'UPnPError' => {
                           'errorCode' => '401',
                           'errorDescription' => 'Invalid Action'
                         }
        };

Diese Fehlermeldungen kommen jede Minute und verschwinden erst nach einem Neustart von FHEM.
Woran kann das liegen, und was kann ich dagegen tun?


RalfRog

Strom aus ist aber ne harte Methode.
Wenn Du es sowieso über FHEM machst ginge doch bestimmt auch ein Neustart.
set <name> reboot <Minuten>

Startet die FRITZ!BOX in <Minuten> neu. Wird dieses 'set' ausgeführt, so wird ein einmaliges 'at' im Raum 'Unsorted' erzeugt, über das dann der Reboot ausgeführt wird. Das neue 'at' hat den Devicenamen: act_Reboot_<Name FB Device>.

Zum beeschriebenen Problem kann JoWiemann bestimmt was sagen. Zumindest sieht es aber so aus, als würde FHEM dein Modell nicht erkennen "[FritzBox | 0000 | 161.07.56"..."
Da sollte statt 0000 eigentlich 6591 stehen.


Gruß
FHEM auf Raspi 2B mit nanoCUL, HM-MOD-RPI-PCB und über LAN MAX!Cube mit a-culFW (Stack 868 + 433)
HM- Fensterkontakte, UP-Schalter, Bewegungsmelder und ein Rauchmelder

JoWiemann

Hallo,

hilfreich wäre ein aktuelles List und ein Log mit mindestens verbose 4. Also Device auf verbose 4 stellen, Cable stromlos machen, warten, wieder unter Spannung setzen. Dann etwa 3 Minuten warten. Danach kann verbose wieder auf 3 gesetzt werden. Den gesamten Log-Abschnitt, von verbose 4 bis verbose 3 setzen, bitte hier posten.

Grüße Jörg
Jörg Wiemann

Slave: RPi B+ mit 512 MB, COC (868 MHz), CUL V3 (433.92MHz SlowRF); FHEMduino, Aktuelles FHEM

Master: CubieTruck; Debian; Aktuelles FHEM

swsmily

Zitat von: RalfRog am 27 Juli 2023, 01:28:17Strom aus ist aber ne harte Methode.
Wenn Du es sowieso über FHEM machst ginge doch bestimmt auch ein Neustart.


Ich muss zugeben, diese Option hab ich tatsächlich gestern Abend erst gesehen. Wusste gar nicht, dass es diese Möglichkeit gibt  ;D

Zitat von: JoWiemann am 27 Juli 2023, 07:47:58Hallo,

hilfreich wäre ein aktuelles List und ein Log mit mindestens verbose 4. Also Device auf verbose 4 stellen, Cable stromlos machen, warten, wieder unter Spannung setzen. Dann etwa 3 Minuten warten. Danach kann verbose wieder auf 3 gesetzt werden. Den gesamten Log-Abschnitt, von verbose 4 bis verbose 3 setzen, bitte hier posten.

Grüße Jörg

Dazu werde ich heute Abend erst kommen.

swsmily

Ich konnte das Problem nun ein weniger weiter eingrenzen. Es passiert nur, wenn der Raspi und die Fritzbox beide stromlos waren, bzw gleichzeitig starten.
Der Raspi mit FHEM ist dann schneller hochgefahren als dass die Fritzbox erreichbar ist. Dann kommt es zu diesem Fehler.
Durch Aufbau einer Solaranlage und weiteren Umbauten in dem Haus musste öfter mal der komplette Strom abgeschaltet werden. Dann sind diese Fehler auftreteten. Wenn nur die Fritzbox neugestartet wird und FHEM aber weiterläuft tritt der Fehler nicht auf.

Ich habe es jetzt mal simuliert, indem ich den Raspi rebootet habe und direkt danach die Steckdose der Fritzbox abgeschaltet habe.

Logfile habe ich mit Verbose 4 erstellt.

Hier das Logfile (ich hoffe ich hab alle privaten Daten wie MAC-Adressen, IP-Adressen gelöscht):
2023.07.27 21:10:56.505 0: Featurelevel: 6.2
2023.07.27 21:10:56.506 0: Server started with 103 defined entities (fhem.pl:27750/2023-07-11 perl:5.032001 os:linux user:fhem pid:568)
2023.07.27 21:10:56.709 4: [FritzBox | 0000 | 161.07.56 | Readout_Start.1611] - INFO: Fork process FRITZBOX_API_Check_Run
2023.07.27 21:10:56.852 3: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1666] - INFO: API luaQuery found but responded with: 500 Can't connect to xxx.xxx.xxx.xxx:80 (Network is unreachable)
2023.07.27 21:10:56.856 3: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1683] - INFO: API luaData found but responded with: 500 Can't connect to xxx.xxx.xxx.xxx:80 (Network is unreachable)
2023.07.27 21:10:56.859 3: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1709] - INFO: API TR-064 does not exist: 500 Can't connect to xxx.xxx.xxx.xxx:49000 (Network is unreachable)
2023.07.27 21:10:56.864 2: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1822] - ERROR: 500 Can't connect to xxx.xxx.xxx.xxx:80 (Network is unreachable)
2023.07.27 21:10:56.864 4: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1832] - INFO: Captured 6 values
2023.07.27 21:11:06.708 4: [FritzBox | 0000 | 161.07.56 | Readout_Start.1611] - INFO: Fork process FRITZBOX_Readout_Run_Web
2023.07.27 21:11:06.725 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.1878] - INFO: Prepare query string for luaQuery.
2023.07.27 21:11:06.728 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.1992] - ReadOut gestartet: &radio=configd:settings/WEBRADIO/list(Name)&box_dect=dect:settings/enabled&handsetCount=dect:settings/Handset/count&handset=dect:settings/Handset/list(User,Manufacturer,Model,FWVersion,Productname)&wlanList=wlan:settings/wlanlist/list(mac,speed,speed_rx,rssi,is_guest)&wlanListNew=wlan:settings/wlanlist/list(mac,speed,rssi)&lanDevice=landevice:settings/landevice/list(mac,ip,ethernet,ethernet_port,ethernetport,guest,name,active,online,wlan,speed,UID)&lanDeviceNew=landevice:settings/landevice/list(mac,ip,ethernet,guest,name,active,online,wlan,speed,UID)&init=telcfg:settings/Foncontrol&box_stdDialPort=telcfg:settings/DialPort&dectUser=telcfg:settings/Foncontrol/User/list(Id,Name,Intern,IntRingTone,AlarmRingTone0,RadioRingID,ImagePath,G722RingTone,G722RingToneName,NoRingTime,RingAllowed,NoRingTimeFlags,NoRingWithNightSetting)&fonPort=telcfg:settings/MSN/Port/list(Name,MSN)&diversity=telcfg:settings/Diversity/list(MSN,Active,Destination)&box_moh=telcfg:settings/MOHType&box_uptimeHours=uimodlogic:status/uptime_hours&box_uptimeMinutes=uimodlogic:status/uptime_minutes&box_fwVersion=logic:status/nspver&box_fwVersion_neu=uimodlogic:status/nspver&box_powerRate=power:status/rate_sumact&tam=tam:settings/TAM/list(Name,Display,Active,NumNewMessages,NumOldMessages)&box_cpuTemp=power:status/act_temperature&box_tr064=tr064:settings/enabled&box_tr069=tr069:settings/enabled&box_upnp=box:settings/upnp_activated&box_upnpCtrl=box:settings/upnp_control_activated&box_fwUpdate=updatecheck:status/update_available_hint&is_double_wlan=wlan:settings/feature_flags/DBDC&box_wlan_24GHz=wlan:settings/ap_enabled&box_wlan_5GHz=wlan:settings/ap_enabled_scnd&box_guestWlan=wlan:settings/guest_ap_enabled&box_guestWlanRemain=wlan:settings/guest_time_remain&box_macFilter_active=wlan:settings/is_macfilter_active&TodayBytesReceivedHigh=inetstat:status/Today/BytesReceivedHigh&TodayBytesReceivedLow=inetstat:status/Today/BytesReceivedLow&TodayBytesSentHigh=inetstat:status/Today/BytesSentHigh&TodayBytesSentLow=inetstat:status/Today/BytesSentLow&GSM_RSSI=gsm:settings/RSSI&GSM_NetworkState=gsm:settings/NetworkState&GSM_AcT=gsm:settings/AcT&UMTS_enabled=umts:settings/enabled&userTicket=userticket:settings/ticket/list(id)&dslStatGlobalIn=dslstatglobal:status/in&dslStatGlobalOut=dslstatglobal:status/out
2023.07.27 21:11:11.749 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5788] - INFO: Host xxx.xxx.xxx.xxx not available
2023.07.27 21:11:11.750 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.1997] - INFO: Device is offline
2023.07.27 21:11:11.755 4: [FritzBox | 0000 | 161.07.56 | Readout_Process.3711] - DEBUG: Reset SID
2023.07.27 21:12:06.717 4: [FritzBox | 0000 | 161.07.56 | Readout_Start.1611] - INFO: Fork process FRITZBOX_Readout_Run_Web
2023.07.27 21:12:06.748 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.1878] - INFO: Prepare query string for luaQuery.
2023.07.27 21:12:06.752 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.1992] - ReadOut gestartet: &radio=configd:settings/WEBRADIO/list(Name)&box_dect=dect:settings/enabled&handsetCount=dect:settings/Handset/count&handset=dect:settings/Handset/list(User,Manufacturer,Model,FWVersion,Productname)&wlanList=wlan:settings/wlanlist/list(mac,speed,speed_rx,rssi,is_guest)&wlanListNew=wlan:settings/wlanlist/list(mac,speed,rssi)&lanDevice=landevice:settings/landevice/list(mac,ip,ethernet,ethernet_port,ethernetport,guest,name,active,online,wlan,speed,UID)&lanDeviceNew=landevice:settings/landevice/list(mac,ip,ethernet,guest,name,active,online,wlan,speed,UID)&init=telcfg:settings/Foncontrol&box_stdDialPort=telcfg:settings/DialPort&dectUser=telcfg:settings/Foncontrol/User/list(Id,Name,Intern,IntRingTone,AlarmRingTone0,RadioRingID,ImagePath,G722RingTone,G722RingToneName,NoRingTime,RingAllowed,NoRingTimeFlags,NoRingWithNightSetting)&fonPort=telcfg:settings/MSN/Port/list(Name,MSN)&diversity=telcfg:settings/Diversity/list(MSN,Active,Destination)&box_moh=telcfg:settings/MOHType&box_uptimeHours=uimodlogic:status/uptime_hours&box_uptimeMinutes=uimodlogic:status/uptime_minutes&box_fwVersion=logic:status/nspver&box_fwVersion_neu=uimodlogic:status/nspver&box_powerRate=power:status/rate_sumact&tam=tam:settings/TAM/list(Name,Display,Active,NumNewMessages,NumOldMessages)&box_cpuTemp=power:status/act_temperature&box_tr064=tr064:settings/enabled&box_tr069=tr069:settings/enabled&box_upnp=box:settings/upnp_activated&box_upnpCtrl=box:settings/upnp_control_activated&box_fwUpdate=updatecheck:status/update_available_hint&is_double_wlan=wlan:settings/feature_flags/DBDC&box_wlan_24GHz=wlan:settings/ap_enabled&box_wlan_5GHz=wlan:settings/ap_enabled_scnd&box_guestWlan=wlan:settings/guest_ap_enabled&box_guestWlanRemain=wlan:settings/guest_time_remain&box_macFilter_active=wlan:settings/is_macfilter_active&TodayBytesReceivedHigh=inetstat:status/Today/BytesReceivedHigh&TodayBytesReceivedLow=inetstat:status/Today/BytesReceivedLow&TodayBytesSentHigh=inetstat:status/Today/BytesSentHigh&TodayBytesSentLow=inetstat:status/Today/BytesSentLow&GSM_RSSI=gsm:settings/RSSI&GSM_NetworkState=gsm:settings/NetworkState&GSM_AcT=gsm:settings/AcT&UMTS_enabled=umts:settings/enabled&userTicket=userticket:settings/ticket/list(id)&dslStatGlobalIn=dslstatglobal:status/in&dslStatGlobalOut=dslstatglobal:status/out
2023.07.27 21:12:09.093 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5788] - INFO: Host xxx.xxx.xxx.xxx not available
2023.07.27 21:12:09.095 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.1997] - INFO: Device is offline
2023.07.27 21:12:09.103 4: [FritzBox | 0000 | 161.07.56 | Readout_Process.3711] - DEBUG: Reset SID
2023.07.27 21:13:06.727 4: [FritzBox | 0000 | 161.07.56 | Readout_Start.1611] - INFO: Fork process FRITZBOX_Readout_Run_Web
2023.07.27 21:13:06.758 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.1878] - INFO: Prepare query string for luaQuery.
2023.07.27 21:13:06.764 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.1992] - ReadOut gestartet: &radio=configd:settings/WEBRADIO/list(Name)&box_dect=dect:settings/enabled&handsetCount=dect:settings/Handset/count&handset=dect:settings/Handset/list(User,Manufacturer,Model,FWVersion,Productname)&wlanList=wlan:settings/wlanlist/list(mac,speed,speed_rx,rssi,is_guest)&wlanListNew=wlan:settings/wlanlist/list(mac,speed,rssi)&lanDevice=landevice:settings/landevice/list(mac,ip,ethernet,ethernet_port,ethernetport,guest,name,active,online,wlan,speed,UID)&lanDeviceNew=landevice:settings/landevice/list(mac,ip,ethernet,guest,name,active,online,wlan,speed,UID)&init=telcfg:settings/Foncontrol&box_stdDialPort=telcfg:settings/DialPort&dectUser=telcfg:settings/Foncontrol/User/list(Id,Name,Intern,IntRingTone,AlarmRingTone0,RadioRingID,ImagePath,G722RingTone,G722RingToneName,NoRingTime,RingAllowed,NoRingTimeFlags,NoRingWithNightSetting)&fonPort=telcfg:settings/MSN/Port/list(Name,MSN)&diversity=telcfg:settings/Diversity/list(MSN,Active,Destination)&box_moh=telcfg:settings/MOHType&box_uptimeHours=uimodlogic:status/uptime_hours&box_uptimeMinutes=uimodlogic:status/uptime_minutes&box_fwVersion=logic:status/nspver&box_fwVersion_neu=uimodlogic:status/nspver&box_powerRate=power:status/rate_sumact&tam=tam:settings/TAM/list(Name,Display,Active,NumNewMessages,NumOldMessages)&box_cpuTemp=power:status/act_temperature&box_tr064=tr064:settings/enabled&box_tr069=tr069:settings/enabled&box_upnp=box:settings/upnp_activated&box_upnpCtrl=box:settings/upnp_control_activated&box_fwUpdate=updatecheck:status/update_available_hint&is_double_wlan=wlan:settings/feature_flags/DBDC&box_wlan_24GHz=wlan:settings/ap_enabled&box_wlan_5GHz=wlan:settings/ap_enabled_scnd&box_guestWlan=wlan:settings/guest_ap_enabled&box_guestWlanRemain=wlan:settings/guest_time_remain&box_macFilter_active=wlan:settings/is_macfilter_active&TodayBytesReceivedHigh=inetstat:status/Today/BytesReceivedHigh&TodayBytesReceivedLow=inetstat:status/Today/BytesReceivedLow&TodayBytesSentHigh=inetstat:status/Today/BytesSentHigh&TodayBytesSentLow=inetstat:status/Today/BytesSentLow&GSM_RSSI=gsm:settings/RSSI&GSM_NetworkState=gsm:settings/NetworkState&GSM_AcT=gsm:settings/AcT&UMTS_enabled=umts:settings/enabled&userTicket=userticket:settings/ticket/list(id)&dslStatGlobalIn=dslstatglobal:status/in&dslStatGlobalOut=dslstatglobal:status/out
2023.07.27 21:13:06.797 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5802] - DEBUG renewing SID while: SID:  timed out
2023.07.27 21:13:06.798 4: [FritzBox | 0000 | 161.07.56 | readPassword.7101] - INFO: Read FritzBox password from file
2023.07.27 21:13:06.800 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5813] - INFO: Open Web connection to xxx.xxx.xxx.xxx : fritz-user-name
2023.07.27 21:13:06.800 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5814] - INFO: getting new SID
2023.07.27 21:13:06.975 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5818] - INFO: Web session opened with sid xxxxxxxxxx
2023.07.27 21:13:06.975 4: [FritzBox | 0000 | 161.07.56 | Web_Query.5850] - DEBUG: Request data via API luaQuery
2023.07.27 21:13:07.251 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5796] - DEBUG: using old SID from 21:13:06
2023.07.27 21:13:07.251 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5924] - INFO: Request data via API dataQuery.
2023.07.27 21:13:07.252 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5928] - INFO: URL: http://xxx.xxx.xxx.xxx/data.lua?sid=xxxxxxxxxx
2023.07.27 21:13:07.615 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5933] - DEBUG: Response: 200 OK
{"pid":"alarm","hide":{"shareUsb":true,"tvsd":true,"dectRdio":true,"rrd":true,"ssoSet":true,"dvbSig":true,"liveImg":true,"liveTv":true,"dvbradio":true,"dectMoniEx":true,"rss":true,"mobile":true,"tvhd":true,"dectMail":true,"faxSet":true,"dectMoni":true,"dvbSet":true},"timeTillLogout":"1199","time":[],"data":{"number":"1","active":false,"option":"daily","weekdays":"255","minutes":"00","name":"Wecker 1","day":{"sun":false,"wed":false,"sat":false,"tue":false,"thu":false,"fri":false,"mon":false},"time":"0000","hours":"00","phonoptions":[{"value":"1","text":"Telefon"},{"value":"2","text":"Telefon"},{"value":"50","text":"ISDN- und Schnurlostelefone"},{"value":"9","text":"alle Telefone"}],"phonselected":"1"},"sid":"xxxxxxxxxx"}

2023.07.27 21:13:07.628 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.2291] - INFO: sip for box-model: 6591
2023.07.27 21:13:07.652 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5796] - DEBUG: using old SID from 21:13:06
2023.07.27 21:13:07.653 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5924] - INFO: Request data via API dataQuery.
2023.07.27 21:13:07.653 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5928] - INFO: URL: http://xxx.xxx.xxx.xxx/data.lua?sid=xxxxxxxxxx
2023.07.27 21:13:07.939 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5933] - DEBUG: Response: 200 OK
{"pid":"wlanmesh","hide":{"shareUsb":true,"tvsd":true,"dectRdio":true,"rrd":true,"ssoSet":true,"dvbSig":true,"liveImg":true,"liveTv":true,"dvbradio":true,"dectMoniEx":true,"rss":true,"mobile":true,"tvhd":true,"dectMail":true,"faxSet":true,"dectMoni":true,"dvbSet":true},"timeTillLogout":"1200","time":[],"data":{"scrollToCB":false,"text":{"laninfo":{"list":["Verbinden Sie einen LAN-Anschluss (gelb) dieser Box mit einem LAN-Anschluss (gelb) der anderen FRITZ!Box.","Klicken Sie auf Übernehmen, um diese FRITZ!Box mit der anderen FRITZ!Box zu verbinden.","Mesh aktivieren: Drücken Sie auf der anderen FRITZ!Box und dieser FRITZ!Box die Taste, die WPS auslöst, sobald diese miteinander verbunden sind."],"description":"Wenn Sie Ihre FRITZ!Box per LAN als Mesh Repeater mit einer anderen FRITZ!Box verbinden möchten, gehen Sie wie folgt vor:","headline":"Per LAN verbinden"},"role":{"slave":"FRITZ!Box als Mesh Repeater","master":"FRITZ!Box als Mesh Master","description":"Stellen Sie hier ein, wie sich die FRITZ!Box im Mesh verhalten soll.","slave_explain":"Diese FRITZ!Box ergänzt das Mesh und übernimmt die Einstellungen des Mesh Masters.","master_explain":"Die Einstellungen dieser FRITZ!Box gelten automatisch im ganzen Mesh.","headline":"Mesh Betriebsart der FRITZ!Box ändern"},"description":"Richten Sie Ihre FRITZ!Box als Mesh Repeater ein, um die WLAN-Abdeckung in Ihrem Heimnetz zu verbessern und ein WLAN Mesh aufzubauen. Der Vorteil von Mesh liegt in einem einheitlichen WLAN-Netz mit gleichen Eigenschaften und optimaler Leistung - zentral gesteuert von der FRITZ!Box. Stellen Sie dazu die Betriebsart \"Mesh Repeater\" ein und verbinden Sie diese FRITZ!Box mit einer anderen mesh-fähigen FRITZ!Box, die als Basis für WLAN und Mesh dient.","owndata":{"description":"Die FRITZ!Box verfügt über die folgenden Adressen im Heimnetz:","label":"WLAN-MAC-Adresse (2,4 GHz):","label_scnd":"WLAN-MAC-Adresse (5 GHz):","explain":"Wenn Sie für die Anmeldung an der Basisstation eine MAC-Adresse eingeben müssen, geben Sie die hier angegebene Adresse für das Frequenzband, das genutzt werden soll, ein.","headline":"Eigene WLAN-Netzwerkdaten"},"wlaninfo":{"description":"Nachdem Sie auf Übernehmen geklickt haben, wird diese FRITZ!Box per WLAN mit der anderen FRITZ!Box verbunden. Um die Einrichtung im WLAN Mesh abzuschließen, drücken Sie auf der anderen FRITZ!Box und dieser FRITZ!Box die Taste, die WPS auslöst, sobald diese miteinander verbunden sind.","headline":"Zum WLAN Mesh hinzufügen"},"rephint":{"txt":"Einen FRITZ!Repeater oder einen FRITZ!Powerline können Sie hier nicht einrichten. Wie Sie diese Produkte mit Ihrem Mesh verbinden, erfahren Sie in der %1%linkstart%FRITZ!Box-Hilfe%\/1%linkend%.","url":"\/secure_link.lua?sid=xxxxxxxxxx&lnk=https%3A%2F%2Ffritzhelp.avm.de%2Fhelp%2F%3Fhardware%3D233%26oem%3Davm%26language%3Dde%26country%3D049%26version%3D161.07.56%26subversion%3D%26set%3D021%26topic%3Dhilfe_connect_push%26userSettings%3D0100"}},"vars":{"netopmode":{"scan":{"isBusy":true,"busytext":"Bitte warten..."},"wds":{"mac":{"name":"mac","value":"00:00:00:00:00:00"},"pskvalue":{"name":"pskvalue","value":""},"ssid":{"name":"ssid","value":""},"wpamode":{"value":"none"}},"suitable":{"wpa3":{"default":"wpa2mixed","modes":["wpa2mixed"]},"wpamixed":{"default":"wpamixed","modes":["wpamixed","wpa2"]},"wpa2mixed":{"default":"wpa2mixed","modes":["wpa2","wpa2mixed"]},"wpa2":{"default":"wpa2mixed","modes":["wpa2","wpa2mixed"]}},"optype":{"value":"router","auto":true,"name":"optype","values":["client","router"]},"routerlink":"docSet","wds_scnd":{"mac":{"name":"mac_scnd","value":"00:00:00:00:00:00"},"ssid":{"name":"ssid_scnd","value":""},"wpamode":{"value":"none"}},"connect":{"value":"wlan","wlan_available":true,"name":"connect","values":["wlan","lan"]}},"role":{"value":"master","meshed":false,"name":"role","values":["master","slave"]},"own_mac":"EE:15:C8:F6:53:AA","own_mac_scnd":"EE:15:C8:F6:53:A9"},"scan":{"isBusy":true,"busytext":"Bitte warten..."}},"sid":"xxxxxxxxxx"}

2023.07.27 21:13:07.947 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5796] - DEBUG: using old SID from 21:13:06
2023.07.27 21:13:07.948 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5924] - INFO: Request data via API dataQuery.
2023.07.27 21:13:07.948 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5928] - INFO: URL: http://xxx.xxx.xxx.xxx/data.lua?sid=xxxxxxxxxx
2023.07.27 21:13:08.148 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5933] - DEBUG: Response: 200 OK
{"pid":"log","hide":{"shareUsb":true,"tvsd":true,"dectRdio":true,"rrd":true,"ssoSet":true,"dvbSig":true,"liveImg":true,"liveTv":true,"dvbradio":true,"dectMoniEx":true,"rss":true,"mobile":true,"tvhd":true,"dectMail":true,"faxSet":true,"dectMoni":true,"dvbSet":true},"timeTillLogout":"1200","time":[],"data":{"show":{"usb":true,"wlan":{"has_wpa2_support":true,"has_wpa3_support":false},"net":true,"all":true,"fon":true,"sys":true},"log":[{"helplink":"\/help\/help.lua?sid=xxxxxxxxxx&helppage=hilfe_syslog_756.html","time":"00:01:44","group":"wlan","id":756,"msg":"WLAN-Gerät hat sich neu angemeldet (2,4 GHz), 72 Mbit\/s, xxxxxxxxxxxxxxxxx.","date":"01.01.70","nohelp":0}],"filter":"wlan","wlanGuestPushmail":false,"wlan":true},"sid":"xxxxxxxxxx"}

2023.07.27 21:13:08.154 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5796] - DEBUG: using old SID from 21:13:06
2023.07.27 21:13:08.154 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5924] - INFO: Request data via API dataQuery.
2023.07.27 21:13:08.155 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5928] - INFO: URL: http://xxx.xxx.xxx.xxx/data.lua?sid=xxxxxxxxxx
2023.07.27 21:13:08.348 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5933] - DEBUG: Response: 200 OK
{"pid":"log","hide":{"shareUsb":true,"tvsd":true,"dectRdio":true,"rrd":true,"ssoSet":true,"dvbSig":true,"liveImg":true,"liveTv":true,"dvbradio":true,"dectMoniEx":true,"rss":true,"mobile":true,"tvhd":true,"dectMail":true,"faxSet":true,"dectMoni":true,"dvbSet":true},"timeTillLogout":"1200","time":[],"data":{"show":{"usb":true,"wlan":{"has_wpa2_support":true,"has_wpa3_support":false},"net":true,"all":true,"fon":true,"sys":true},"log":[{"helplink":"\/help\/help.lua?sid=xxxxxxxxxx&helppage=hilfe_syslog_500.html","time":"00:01:49","group":"sys","id":500,"msg":"Anmeldung an der FRITZ!Box-Benutzeroberfläche von IP-Adresse xxx.xxx.xxx.xxx.","date":"01.01.70","nohelp":0}],"filter":"sys","wlanGuestPushmail":false,"wlan":true},"sid":"xxxxxxxxxx"}

2023.07.27 21:13:08.353 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5796] - DEBUG: using old SID from 21:13:06
2023.07.27 21:13:08.353 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5924] - INFO: Request data via API dataQuery.
2023.07.27 21:13:08.354 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5928] - INFO: URL: http://xxx.xxx.xxx.xxx/data.lua?sid=xxxxxxxxxx
2023.07.27 21:13:08.546 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5933] - DEBUG: Response: 200 OK
{"pid":"log","hide":{"shareUsb":true,"tvsd":true,"dectRdio":true,"rrd":true,"ssoSet":true,"dvbSig":true,"liveImg":true,"liveTv":true,"dvbradio":true,"dectMoniEx":true,"rss":true,"mobile":true,"tvhd":true,"dectMail":true,"faxSet":true,"dectMoni":true,"dvbSet":true},"timeTillLogout":"1200","time":[],"data":{"show":{"usb":true,"wlan":{"has_wpa2_support":true,"has_wpa3_support":false},"net":true,"all":true,"fon":true,"sys":true},"log":[],"filter":"fon","wlanGuestPushmail":false,"wlan":true},"sid":"xxxxxxxxxx"}

2023.07.27 21:13:08.548 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.3297] - DEBUG: wrong Fritz!OS: 07.56 or AVM-Model: FRITZ!Box for docsis informations.
2023.07.27 21:13:08.549 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.3644] - DEBUG: TR064: 0 or secure Port:none not available or wrong Fritz!OS: 07.56.
2023.07.27 21:13:08.550 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.3656] - INFO: Captured 289 values
2023.07.27 21:13:08.611 4: [FritzBox | 0000 | 161.07.56 | Readout_Process.3867] - INFO: TR-064 is switched on
2023.07.27 21:13:08.612 4: [FritzBox | 0000 | 161.07.56 | TR064_Init.5716] - INFO: Open TR-064 connection and ask for security port
2023.07.27 21:13:08.724 4: [FritzBox | 0000 | 161.07.56 | TR064_Init.5725] - INFO: SecPort-Result $VAR1 = '49443';

2023.07.27 21:14:09.714 4: [FritzBox | 0000 | 161.07.56 | Readout_Start.1611] - INFO: Fork process FRITZBOX_Readout_Run_Web
2023.07.27 21:14:09.872 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.1878] - INFO: Prepare query string for luaQuery.
2023.07.27 21:14:09.875 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.1992] - ReadOut gestartet: &radio=configd:settings/WEBRADIO/list(Name)&box_dect=dect:settings/enabled&handsetCount=dect:settings/Handset/count&handset=dect:settings/Handset/list(User,Manufacturer,Model,FWVersion,Productname)&wlanList=wlan:settings/wlanlist/list(mac,speed,speed_rx,rssi,is_guest)&wlanListNew=wlan:settings/wlanlist/list(mac,speed,rssi)&lanDevice=landevice:settings/landevice/list(mac,ip,ethernet,ethernet_port,ethernetport,guest,name,active,online,wlan,speed,UID)&lanDeviceNew=landevice:settings/landevice/list(mac,ip,ethernet,guest,name,active,online,wlan,speed,UID)&init=telcfg:settings/Foncontrol&box_stdDialPort=telcfg:settings/DialPort&dectUser=telcfg:settings/Foncontrol/User/list(Id,Name,Intern,IntRingTone,AlarmRingTone0,RadioRingID,ImagePath,G722RingTone,G722RingToneName,NoRingTime,RingAllowed,NoRingTimeFlags,NoRingWithNightSetting)&fonPort=telcfg:settings/MSN/Port/list(Name,MSN)&diversity=telcfg:settings/Diversity/list(MSN,Active,Destination)&box_moh=telcfg:settings/MOHType&box_uptimeHours=uimodlogic:status/uptime_hours&box_uptimeMinutes=uimodlogic:status/uptime_minutes&box_fwVersion=logic:status/nspver&box_fwVersion_neu=uimodlogic:status/nspver&box_powerRate=power:status/rate_sumact&tam=tam:settings/TAM/list(Name,Display,Active,NumNewMessages,NumOldMessages)&box_cpuTemp=power:status/act_temperature&box_tr064=tr064:settings/enabled&box_tr069=tr069:settings/enabled&box_upnp=box:settings/upnp_activated&box_upnpCtrl=box:settings/upnp_control_activated&box_fwUpdate=updatecheck:status/update_available_hint&is_double_wlan=wlan:settings/feature_flags/DBDC&box_wlan_24GHz=wlan:settings/ap_enabled&box_wlan_5GHz=wlan:settings/ap_enabled_scnd&box_guestWlan=wlan:settings/guest_ap_enabled&box_guestWlanRemain=wlan:settings/guest_time_remain&box_macFilter_active=wlan:settings/is_macfilter_active&TodayBytesReceivedHigh=inetstat:status/Today/BytesReceivedHigh&TodayBytesReceivedLow=inetstat:status/Today/BytesReceivedLow&TodayBytesSentHigh=inetstat:status/Today/BytesSentHigh&TodayBytesSentLow=inetstat:status/Today/BytesSentLow&GSM_RSSI=gsm:settings/RSSI&GSM_NetworkState=gsm:settings/NetworkState&GSM_AcT=gsm:settings/AcT&UMTS_enabled=umts:settings/enabled&userTicket=userticket:settings/ticket/list(id)&dslStatGlobalIn=dslstatglobal:status/in&dslStatGlobalOut=dslstatglobal:status/out
2023.07.27 21:14:09.891 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5796] - DEBUG: using old SID from 21:13:08
2023.07.27 21:14:09.892 4: [FritzBox | 0000 | 161.07.56 | Web_Query.5850] - DEBUG: Request data via API luaQuery
2023.07.27 21:14:10.117 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5796] - DEBUG: using old SID from 21:13:08
2023.07.27 21:14:10.118 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5924] - INFO: Request data via API dataQuery.
2023.07.27 21:14:10.118 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5928] - INFO: URL: http://xxx.xxx.xxx.xxx/data.lua?sid=xxxxxxxxxx
2023.07.27 21:14:10.314 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5933] - DEBUG: Response: 200 OK
{"pid":"alarm","hide":{"shareUsb":true,"tvsd":true,"dectRdio":true,"rrd":true,"ssoSet":true,"dvbSig":true,"liveImg":true,"liveTv":true,"dvbradio":true,"dectMoniEx":true,"rss":true,"mobile":true,"tvhd":true,"dectMail":true,"faxSet":true,"dectMoni":true,"dvbSet":true},"timeTillLogout":"1200","time":[],"data":{"number":"1","active":false,"option":"daily","weekdays":"255","minutes":"00","name":"Wecker 1","day":{"sun":false,"wed":false,"sat":false,"tue":false,"thu":false,"fri":false,"mon":false},"time":"0000","hours":"00","phonoptions":[{"value":"1","text":"Telefon"},{"value":"2","text":"Telefon"},{"value":"50","text":"ISDN- und Schnurlostelefone"},{"value":"9","text":"alle Telefone"}],"phonselected":"1"},"sid":"xxxxxxxxxx"}

2023.07.27 21:14:10.322 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.2291] - INFO: sip for box-model: 6591
2023.07.27 21:14:10.335 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5796] - DEBUG: using old SID from 21:13:08
2023.07.27 21:14:10.336 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5924] - INFO: Request data via API dataQuery.
2023.07.27 21:14:10.336 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5928] - INFO: URL: http://xxx.xxx.xxx.xxx/data.lua?sid=xxxxxxxxxx
2023.07.27 21:14:10.589 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5933] - DEBUG: Response: 200 OK
{"pid":"wlanmesh","hide":{"shareUsb":true,"tvsd":true,"dectRdio":true,"rrd":true,"ssoSet":true,"dvbSig":true,"liveImg":true,"liveTv":true,"dvbradio":true,"dectMoniEx":true,"rss":true,"mobile":true,"tvhd":true,"dectMail":true,"faxSet":true,"dectMoni":true,"dvbSet":true},"timeTillLogout":"1200","time":[],"data":{"scrollToCB":false,"text":{"laninfo":{"list":["Verbinden Sie einen LAN-Anschluss (gelb) dieser Box mit einem LAN-Anschluss (gelb) der anderen FRITZ!Box.","Klicken Sie auf Übernehmen, um diese FRITZ!Box mit der anderen FRITZ!Box zu verbinden.","Mesh aktivieren: Drücken Sie auf der anderen FRITZ!Box und dieser FRITZ!Box die Taste, die WPS auslöst, sobald diese miteinander verbunden sind."],"description":"Wenn Sie Ihre FRITZ!Box per LAN als Mesh Repeater mit einer anderen FRITZ!Box verbinden möchten, gehen Sie wie folgt vor:","headline":"Per LAN verbinden"},"role":{"slave":"FRITZ!Box als Mesh Repeater","master":"FRITZ!Box als Mesh Master","description":"Stellen Sie hier ein, wie sich die FRITZ!Box im Mesh verhalten soll.","slave_explain":"Diese FRITZ!Box ergänzt das Mesh und übernimmt die Einstellungen des Mesh Masters.","master_explain":"Die Einstellungen dieser FRITZ!Box gelten automatisch im ganzen Mesh.","headline":"Mesh Betriebsart der FRITZ!Box ändern"},"description":"Richten Sie Ihre FRITZ!Box als Mesh Repeater ein, um die WLAN-Abdeckung in Ihrem Heimnetz zu verbessern und ein WLAN Mesh aufzubauen. Der Vorteil von Mesh liegt in einem einheitlichen WLAN-Netz mit gleichen Eigenschaften und optimaler Leistung - zentral gesteuert von der FRITZ!Box. Stellen Sie dazu die Betriebsart \"Mesh Repeater\" ein und verbinden Sie diese FRITZ!Box mit einer anderen mesh-fähigen FRITZ!Box, die als Basis für WLAN und Mesh dient.","owndata":{"description":"Die FRITZ!Box verfügt über die folgenden Adressen im Heimnetz:","label":"WLAN-MAC-Adresse (2,4 GHz):","label_scnd":"WLAN-MAC-Adresse (5 GHz):","explain":"Wenn Sie für die Anmeldung an der Basisstation eine MAC-Adresse eingeben müssen, geben Sie die hier angegebene Adresse für das Frequenzband, das genutzt werden soll, ein.","headline":"Eigene WLAN-Netzwerkdaten"},"wlaninfo":{"description":"Nachdem Sie auf Übernehmen geklickt haben, wird diese FRITZ!Box per WLAN mit der anderen FRITZ!Box verbunden. Um die Einrichtung im WLAN Mesh abzuschließen, drücken Sie auf der anderen FRITZ!Box und dieser FRITZ!Box die Taste, die WPS auslöst, sobald diese miteinander verbunden sind.","headline":"Zum WLAN Mesh hinzufügen"},"rephint":{"txt":"Einen FRITZ!Repeater oder einen FRITZ!Powerline können Sie hier nicht einrichten. Wie Sie diese Produkte mit Ihrem Mesh verbinden, erfahren Sie in der %1%linkstart%FRITZ!Box-Hilfe%\/1%linkend%.","url":"\/secure_link.lua?sid=xxxxxxxxxx&lnk=https%3A%2F%2Ffritzhelp.avm.de%2Fhelp%2F%3Fhardware%3D233%26oem%3Davm%26language%3Dde%26country%3D049%26version%3D161.07.56%26subversion%3D%26set%3D021%26topic%3Dhilfe_connect_push%26userSettings%3D0100"}},"vars":{"netopmode":{"scan":{"isBusy":true,"busytext":"Bitte warten..."},"wds":{"mac":{"name":"mac","value":"00:00:00:00:00:00"},"pskvalue":{"name":"pskvalue","value":""},"ssid":{"name":"ssid","value":""},"wpamode":{"value":"none"}},"suitable":{"wpa3":{"default":"wpa2mixed","modes":["wpa2mixed"]},"wpamixed":{"default":"wpamixed","modes":["wpamixed","wpa2"]},"wpa2mixed":{"default":"wpa2mixed","modes":["wpa2","wpa2mixed"]},"wpa2":{"default":"wpa2mixed","modes":["wpa2","wpa2mixed"]}},"optype":{"value":"router","auto":true,"name":"optype","values":["client","router"]},"routerlink":"docSet","wds_scnd":{"mac":{"name":"mac_scnd","value":"00:00:00:00:00:00"},"ssid":{"name":"ssid_scnd","value":""},"wpamode":{"value":"none"}},"connect":{"value":"wlan","wlan_available":true,"name":"connect","values":["wlan","lan"]}},"role":{"value":"master","meshed":false,"name":"role","values":["master","slave"]},"own_mac":"EE:15:C8:F6:53:AA","own_mac_scnd":"EE:15:C8:F6:53:A9"},"scan":{"isBusy":true,"busytext":"Bitte warten..."}},"sid":"xxxxxxxxxx"}

2023.07.27 21:14:10.599 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5796] - DEBUG: using old SID from 21:13:08
2023.07.27 21:14:10.600 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5924] - INFO: Request data via API dataQuery.
2023.07.27 21:14:10.600 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5928] - INFO: URL: http://xxx.xxx.xxx.xxx/data.lua?sid=xxxxxxxxxx
2023.07.27 21:14:10.804 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5933] - DEBUG: Response: 200 OK
{"pid":"log","hide":{"shareUsb":true,"tvsd":true,"dectRdio":true,"rrd":true,"ssoSet":true,"dvbSig":true,"liveImg":true,"liveTv":true,"dvbradio":true,"dectMoniEx":true,"rss":true,"mobile":true,"tvhd":true,"dectMail":true,"faxSet":true,"dectMoni":true,"dvbSet":true},"timeTillLogout":"1200","time":[],"data":{"show":{"usb":true,"wlan":{"has_wpa2_support":true,"has_wpa3_support":false},"net":true,"all":true,"fon":true,"sys":true},"log":[{"helplink":"\/help\/help.lua?sid=xxxxxxxxxx&helppage=hilfe_syslog_748.html","time":"21:14:02","group":"wlan","id":748,"msg":"WLAN-Gerät angemeldet (2,4 GHz), 72 Mbit\/s, xxxxxxxxxxxxxxxxxxxxxxxxx","date":"27.07.23","nohelp":0},{"helplink":"\/help\/help.lua?sid=xxxxxxxxxx&helppage=hilfe_syslog_756.html","time":"21:13:36","group":"wlan","id":756,"msg":"WLAN-Gerät hat sich neu angemeldet (2,4 GHz), 72 Mbit\/s, xxxxxxxxxxxxxxxxxxxxx.","date":"27.07.23","nohelp":0}],"filter":"wlan","wlanGuestPushmail":false,"wlan":true},"sid":"xxxxxxxxxx"}

2023.07.27 21:14:10.808 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5796] - DEBUG: using old SID from 21:13:08
2023.07.27 21:14:10.809 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5924] - INFO: Request data via API dataQuery.
2023.07.27 21:14:10.809 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5928] - INFO: URL: http://xxx.xxx.xxx.xxx/data.lua?sid=xxxxxxxxxx
2023.07.27 21:14:10.990 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5933] - DEBUG: Response: 200 OK
{"pid":"log","hide":{"shareUsb":true,"tvsd":true,"dectRdio":true,"rrd":true,"ssoSet":true,"dvbSig":true,"liveImg":true,"liveTv":true,"dvbradio":true,"dectMoniEx":true,"rss":true,"mobile":true,"tvhd":true,"dectMail":true,"faxSet":true,"dectMoni":true,"dvbSet":true},"timeTillLogout":"1200","time":[],"data":{"show":{"usb":true,"wlan":{"has_wpa2_support":true,"has_wpa3_support":false},"net":true,"all":true,"fon":true,"sys":true},"log":[{"helplink":"\/help\/help.lua?sid=xxxxxxxxxx&helppage=hilfe_syslog_2104.html","time":"21:14:05","group":"sys","id":2104,"msg":"Die Systemzeit wurde erfolgreich aktualisiert von Zeitserver 159.69.69.50.","date":"27.07.23","nohelp":0},{"helplink":"\/help\/help.lua?sid=xxxxxxxxxx&helppage=hilfe_syslog_500.html","time":"21:13:41","group":"sys","id":500,"msg":"Anmeldung an der FRITZ!Box-Benutzeroberfläche von IP-Adresse xxx.xxx.xxx.xxx.","date":"27.07.23","nohelp":0}],"filter":"sys","wlanGuestPushmail":false,"wlan":true},"sid":"xxxxxxxxxx"}

2023.07.27 21:14:10.994 4: [FritzBox | 0000 | 161.07.56 | Web_OpenCon.5796] - DEBUG: using old SID from 21:13:08
2023.07.27 21:14:10.995 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5924] - INFO: Request data via API dataQuery.
2023.07.27 21:14:10.995 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5928] - INFO: URL: http://xxx.xxx.xxx.xxx/data.lua?sid=xxxxxxxxxx
2023.07.27 21:14:11.196 4: [FritzBox | 0000 | 161.07.56 | Function_Lua.5933] - DEBUG: Response: 200 OK
{"pid":"log","hide":{"shareUsb":true,"tvsd":true,"dectRdio":true,"rrd":true,"ssoSet":true,"dvbSig":true,"liveImg":true,"liveTv":true,"dvbradio":true,"dectMoniEx":true,"rss":true,"mobile":true,"tvhd":true,"dectMail":true,"faxSet":true,"dectMoni":true,"dvbSet":true},"timeTillLogout":"1199","time":[],"data":{"show":{"usb":true,"wlan":{"has_wpa2_support":true,"has_wpa3_support":false},"net":true,"all":true,"fon":true,"sys":true},"log":[],"filter":"fon","wlanGuestPushmail":false,"wlan":true},"sid":"xxxxxxxxxx"}

2023.07.27 21:14:11.208 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.3297] - DEBUG: wrong Fritz!OS: 07.56 or AVM-Model: FRITZ!Box for docsis informations.
2023.07.27 21:14:11.209 4: [FritzBox | 0000 | 161.07.56 | readPassword.7101] - INFO: Read FritzBox password from file
2023.07.27 21:14:11.731 4: [FritzBox | 0000 | 161.07.56 | TR064_Cmd.5570] - DEBUG: TR064 error 401:Invalid Action (service='WANDSLInterfaceConfig:1', control='wandslifconfig1', action='GetInfo')
2023.07.27 21:14:11.733 2: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.3438] - ERROR: VDSL up/down rate GetInfo ->
$VAR1 = {
          'UPnPError' => {
                           'errorDescription' => 'Invalid Action',
                           'errorCode' => '401'
                         }
        };

2023.07.27 21:14:11.733 4: [FritzBox | 0000 | 161.07.56 | readPassword.7101] - INFO: Read FritzBox password from file
2023.07.27 21:14:11.902 4: [FritzBox | 0000 | 161.07.56 | TR064_Cmd.5570] - DEBUG: TR064 error 401:Invalid Action (service='WANPPPConnection:1', control='wanpppconn1', action='GetInfo')
2023.07.27 21:14:11.903 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.3469] - INFO: wanpppconn GetInfo ->
$VAR1 = {
          'UPnPError' => {
                           'errorDescription' => 'Invalid Action',
                           'errorCode' => '401'
                         }
        };

2023.07.27 21:14:11.982 4: [FritzBox | 0000 | 161.07.56 | SOAP_Request.5460] - DEBUG: XML_RESONSE:
<?xml version="1.0" encoding="utf-8"?>
<s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/">
<s:Body>
<u:GetStatusInfoResponse xmlns:u="urn:schemas-upnp-org:service:WANIPConnection:1">
<NewConnectionStatus>Connected</NewConnectionStatus>
<NewLastConnectionError>ERROR_NONE</NewLastConnectionError>
<NewUptime>8</NewUptime>
</u:GetStatusInfoResponse>
</s:Body>
</s:Envelope>
2023.07.27 21:14:12.057 4: [FritzBox | 0000 | 161.07.56 | SOAP_Request.5460] - DEBUG: XML_RESONSE:
<?xml version="1.0" encoding="utf-8"?>
<s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/">
<s:Body>
<u:GetExternalIPAddressResponse xmlns:u="urn:schemas-upnp-org:service:WANIPConnection:1">
<NewExternalIPAddress>xxx.xxx.xxx.xxx</NewExternalIPAddress>
</u:GetExternalIPAddressResponse>
</s:Body>
</s:Envelope>
2023.07.27 21:14:12.137 4: [FritzBox | 0000 | 161.07.56 | SOAP_Request.5460] - DEBUG: XML_RESONSE:
<?xml version="1.0" encoding="utf-8"?>
<s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/">
<s:Body>
<u:X_AVM_DE_GetExternalIPv6AddressResponse xmlns:u="urn:schemas-upnp-org:service:WANIPConnection:1">
<NewExternalIPv6Address>::</NewExternalIPv6Address>
<NewPrefixLength>0</NewPrefixLength>
<NewValidLifetime>0</NewValidLifetime>
<NewPreferedLifetime>0</NewPreferedLifetime>
</u:X_AVM_DE_GetExternalIPv6AddressResponse>
</s:Body>
</s:Envelope>
2023.07.27 21:14:12.216 4: [FritzBox | 0000 | 161.07.56 | SOAP_Request.5460] - DEBUG: XML_RESONSE:
<?xml version="1.0" encoding="utf-8"?>
<s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/">
<s:Body>
<u:X_AVM_DE_GetIPv6PrefixResponse xmlns:u="urn:schemas-upnp-org:service:WANIPConnection:1">
<NewIPv6Prefix>::</NewIPv6Prefix>
<NewPrefixLength>0</NewPrefixLength>
<NewValidLifetime>0</NewValidLifetime>
<NewPreferedLifetime>0</NewPreferedLifetime>
</u:X_AVM_DE_GetIPv6PrefixResponse>
</s:Body>
</s:Envelope>
2023.07.27 21:14:12.297 4: [FritzBox | 0000 | 161.07.56 | SOAP_Request.5460] - DEBUG: XML_RESONSE:
<?xml version="1.0" encoding="utf-8"?>
<s:Envelope xmlns:s="http://schemas.xmlsoap.org/soap/envelope/" s:encodingStyle="http://schemas.xmlsoap.org/soap/encoding/">
<s:Body>
<u:GetCommonLinkPropertiesResponse xmlns:u="urn:schemas-upnp-org:service:WANCommonInterfaceConfig:1">
<NewWANAccessType>Cable</NewWANAccessType>
<NewLayer1UpstreamMaxBitRate>4194000</NewLayer1UpstreamMaxBitRate>
<NewLayer1DownstreamMaxBitRate>13631000</NewLayer1DownstreamMaxBitRate>
<NewPhysicalLinkStatus>Up</NewPhysicalLinkStatus>
</u:GetCommonLinkPropertiesResponse>
</s:Body>
</s:Envelope>
2023.07.27 21:14:12.299 4: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.3656] - INFO: Captured 296 values
2023.07.27 21:15:11.523 2: [FritzBox | 0000 | 161.07.56 | Readout_Run_Web.3438] - ERROR: VDSL up/down rate GetInfo ->
$VAR1 = {
          'UPnPError' => {
                           'errorDescription' => 'Invalid Action',
                           'errorCode' => '401'
                         }
        };

und hier das List:
[code]define FritzBox FRITZBOX xxx.xxx.xxx.xxx
attr FritzBox INTERVAL 60
attr FritzBox boxUser xxxxxxx
attr FritzBox room System->FHEM
attr FritzBox userReadings todayReceived {(ReadingsVal($name,".box_TodayBytesReceivedLow",0) + ReadingsVal($name,".box_TodayBytesReceivedHigh",0) * 2**32) / 1000000000},\
todaySent {(ReadingsVal($name,".box_TodayBytesSentLow",0) + ReadingsVal($name,".box_TodayBytesSentHigh",0) * 2**32) / 1000000000}
#   APICHECKED 1
#   DEF        xxx.xxx.xxx.xxx
#   FUUID      6442ef85-f33f-591b-9e61-590606d7725365ae
#   HOST       xxx.xxx.xxx.xxx
#   INTERVAL   60
#   LUADATA    1
#   LUAQUERY   1
#   NAME       FritzBox
#   NR         132
#   SECPORT    49443
#   STATE      WLAN: on gWLAN: off
#   TIMEOUT    55
#   TR064      1
#   TYPE       FRITZBOX
#   UPNP       1
#   VERSION    07.50.17h
#   _BETA      0
#   eventCount 11
#   READINGS:
#     2023-07-27 21:20:12   box_connect     Connected
#     2023-07-27 21:20:12   box_cpuTemp     44
#     2023-07-27 21:20:12   box_dect        off
#     2023-07-27 21:09:51   box_docsis30_Ds_corrErrors 2 4632
#     2023-07-27 21:09:51   box_docsis30_Ds_frequencys 185.000 193.000
#     2023-07-27 21:09:51   box_docsis30_Ds_latencys 0.32 0.32
#     2023-07-27 21:09:51   box_docsis30_Ds_mses -37.6 -34.5
#     2023-07-27 21:09:51   box_docsis30_Ds_nonCorrErrors 0.32 0.32
#     2023-07-27 21:09:51   box_docsis30_Ds_powerLevels -1.8 -1.4
#     2023-07-27 21:09:51   box_docsis30_Us_frequencys 55.000
#     2023-07-27 21:09:51   box_docsis30_Us_powerLevels 39.5
#     2023-07-27 21:20:12   box_dsl_downStream 13.631
#     2023-07-27 21:20:12   box_dsl_upStream 4.194
#     2023-07-27 21:20:12   box_fon_LogNewest none
#     2023-07-27 21:20:12   box_fwVersion   161.07.56
#     2023-07-27 21:20:12   box_guestWlan   off
#     2023-07-27 21:20:12   box_guestWlanCount 0
#     2023-07-27 21:20:12   box_guestWlanRemain 0
#     2023-07-27 21:20:12   box_ipv4_Extern xxx.xxx.xxx.xxx
#     2023-07-27 21:20:12   box_ipv6_Extern ::
#     2023-07-27 21:20:12   box_ipv6_Prefix ::
#     2023-07-26 21:11:38   box_lastFhemReboot 26.07.2023 21:12:38
#     2023-07-27 21:20:12   box_last_connect_err ERROR_NONE
#     2023-07-27 21:20:12   box_macFilter_active off
#     2023-07-27 21:20:12   box_meshRole    master
#     2023-07-26 21:25:34   box_model       FRITZ!Box 6591 Cable [avm]
#     2023-07-27 21:20:12   box_moh         default
#     2023-07-27 21:20:12   box_powerRate   24
#     2023-07-27 21:20:12   box_rateDown    1.400
#     2023-07-27 21:20:12   box_rateUp      1.101
#     2023-07-27 21:20:12   box_stdDialPort fon1
#     2023-07-27 21:20:12   box_sys_LogNewest 506 27.07.23 21:14:11
#     2023-07-27 21:20:12   box_tr064       on
#     2023-07-27 21:20:12   box_tr069       off
#     2023-07-27 21:20:12   box_upnp        on
#     2023-07-27 21:20:12   box_upnp_control_activated on
#     2023-07-27 21:20:12   box_uptime      no-emu
#     2023-07-27 21:20:12   box_uptimeConnect 368 sec = 0T 00:06:08
#     2023-07-27 21:20:12   box_wan_AccessType Cable
#     2023-07-27 21:20:12   box_wlan_2.4GHz on
#     2023-07-27 21:20:12   box_wlan_5GHz   on
#     2023-07-27 21:20:12   box_wlan_Count  10
#     2023-07-27 21:20:12   box_wlan_LogExtended on
#     2023-07-27 21:20:12   box_wlan_LogNewest 748 27.07.23 21:14:02
#     2023-07-27 21:20:12   fon1            Telefon[1] redundant name in FB:Telefon
#     2023-07-27 21:20:12   fon1_device     1
#     2023-07-27 21:20:12   fon1_intern     1
#     2023-07-27 21:20:12   fon2            Telefon[2] redundant name in FB:Telefon
#     2023-07-27 21:20:12   fon2_device     2
#     2023-07-27 21:20:12   fon2_intern     2
#     2023-07-27 21:20:12   fon50           ISDN- und Schnurlostelefone
#     2023-07-27 21:20:12   fon50_device    50
#     2023-07-27 21:20:12   fon9            alle Telefone
#     2023-07-27 21:20:12   fon9_device     9
#     2023-07-27 21:20:12   gsm_internet    0
#     2023-07-27 21:20:12   retStat_lastReadout 296 values captured in 2.29 s
#     2023-07-27 21:20:12   state           WLAN: on gWLAN: off
#     2023-07-27 21:20:12   tam1            Anrufbeantworter
#     2023-07-27 21:20:12   tam1_newMsg     0
#     2023-07-27 21:20:12   tam1_oldMsg     0
#     2023-07-27 21:20:12   tam1_state      off
#     2023-07-27 21:20:12   todayReceived   0.250211977
#     2023-07-27 21:20:12   todaySent       0.060203524
#     2023-07-27 21:20:12   userTicket01    246233
#   fhem:
#     LOCAL      0
#     definedHost xxx.xxx.xxx.xxx
#     fd_1       Telefon[1] redundant name in FB:Telefon
#     fd_2       Telefon[2] redundant name in FB:Telefon
#     fd_50      ISDN- und Schnurlostelefone
#     fd_9       alle Telefone
#     fdn_ISDN- und Schnurlostelefone 50
#     fdn_Telefon[1] redundant name in FB:Telefon 1
#     fdn_Telefon[2] redundant name in FB:Telefon 2
#     fdn_alle Telefone 9
#     is_double_wlan 1
#     lastHour   0
#     modulVersion $Date: 2023-06-16 09:40:38 +0200 (Fri, 16 Jun 2023) $
#     radioCount 40
#     landevice:
#     wlanDevice:
#   helper:
#     TimerCmd   FritzBox.Cmd
#     TimerReadout FritzBox.Readout
#
setstate FritzBox WLAN: on gWLAN: off
setstate FritzBox 2023-07-27 21:20:12 .box_TodayBytesReceivedHigh 0
setstate FritzBox 2023-07-27 21:20:12 .box_TodayBytesReceivedLow 250211977
setstate FritzBox 2023-07-27 21:20:12 .box_TodayBytesSentHigh 0
setstate FritzBox 2023-07-27 21:20:12 .box_TodayBytesSentLow 60203524
setstate FritzBox 2023-07-27 21:20:12 box_connect Connected
setstate FritzBox 2023-07-27 21:20:12 box_cpuTemp 44
setstate FritzBox 2023-07-27 21:20:12 box_dect off
setstate FritzBox 2023-07-27 21:09:51 box_docsis30_Ds_corrErrors 2 4632
setstate FritzBox 2023-07-27 21:09:51 box_docsis30_Ds_frequencys 185.000 193.000
setstate FritzBox 2023-07-27 21:09:51 box_docsis30_Ds_latencys 0.32 0.32
setstate FritzBox 2023-07-27 21:09:51 box_docsis30_Ds_mses -37.6 -34.5
setstate FritzBox 2023-07-27 21:09:51 box_docsis30_Ds_nonCorrErrors 0.32 0.32
setstate FritzBox 2023-07-27 21:09:51 box_docsis30_Ds_powerLevels -1.8 -1.4
setstate FritzBox 2023-07-27 21:09:51 box_docsis30_Us_frequencys 55.000
setstate FritzBox 2023-07-27 21:09:51 box_docsis30_Us_powerLevels 39.5
setstate FritzBox 2023-07-27 21:20:12 box_dsl_downStream 13.631
setstate FritzBox 2023-07-27 21:20:12 box_dsl_upStream 4.194
setstate FritzBox 2023-07-27 21:20:12 box_fon_LogNewest none
setstate FritzBox 2023-07-27 21:20:12 box_fwVersion 161.07.56
setstate FritzBox 2023-07-27 21:20:12 box_guestWlan off
setstate FritzBox 2023-07-27 21:20:12 box_guestWlanCount 0
setstate FritzBox 2023-07-27 21:20:12 box_guestWlanRemain 0
setstate FritzBox 2023-07-27 21:20:12 box_ipv4_Extern xxx.xxx.xxx.xxx
setstate FritzBox 2023-07-27 21:20:12 box_ipv6_Extern ::
setstate FritzBox 2023-07-27 21:20:12 box_ipv6_Prefix ::
setstate FritzBox 2023-07-26 21:11:38 box_lastFhemReboot 26.07.2023 21:12:38
setstate FritzBox 2023-07-27 21:20:12 box_last_connect_err ERROR_NONE
setstate FritzBox 2023-07-27 21:20:12 box_macFilter_active off
setstate FritzBox 2023-07-27 21:20:12 box_meshRole master
setstate FritzBox 2023-07-26 21:25:34 box_model FRITZ!Box 6591 Cable [avm]
setstate FritzBox 2023-07-27 21:20:12 box_moh default
setstate FritzBox 2023-07-27 21:20:12 box_powerRate 24
setstate FritzBox 2023-07-27 21:20:12 box_rateDown 1.400
setstate FritzBox 2023-07-27 21:20:12 box_rateUp 1.101
setstate FritzBox 2023-07-27 21:20:12 box_stdDialPort fon1
setstate FritzBox 2023-07-27 21:20:12 box_sys_LogNewest 506 27.07.23 21:14:11
setstate FritzBox 2023-07-27 21:20:12 box_tr064 on
setstate FritzBox 2023-07-27 21:20:12 box_tr069 off
setstate FritzBox 2023-07-27 21:20:12 box_upnp on
setstate FritzBox 2023-07-27 21:20:12 box_upnp_control_activated on
setstate FritzBox 2023-07-27 21:20:12 box_uptime no-emu
setstate FritzBox 2023-07-27 21:20:12 box_uptimeConnect 368 sec = 0T 00:06:08
setstate FritzBox 2023-07-27 21:20:12 box_wan_AccessType Cable
setstate FritzBox 2023-07-27 21:20:12 box_wlan_2.4GHz on
setstate FritzBox 2023-07-27 21:20:12 box_wlan_5GHz on
setstate FritzBox 2023-07-27 21:20:12 box_wlan_Count 10
setstate FritzBox 2023-07-27 21:20:12 box_wlan_LogExtended on
setstate FritzBox 2023-07-27 21:20:12 box_wlan_LogNewest 748 27.07.23 21:14:02
setstate FritzBox 2023-07-27 21:20:12 fon1 Telefon[1] redundant name in FB:Telefon
setstate FritzBox 2023-07-27 21:20:12 fon1_device 1
setstate FritzBox 2023-07-27 21:20:12 fon1_intern 1
setstate FritzBox 2023-07-27 21:20:12 fon2 Telefon[2] redundant name in FB:Telefon
setstate FritzBox 2023-07-27 21:20:12 fon2_device 2
setstate FritzBox 2023-07-27 21:20:12 fon2_intern 2
setstate FritzBox 2023-07-27 21:20:12 fon50 ISDN- und Schnurlostelefone
setstate FritzBox 2023-07-27 21:20:12 fon50_device 50
setstate FritzBox 2023-07-27 21:20:12 fon9 alle Telefone
setstate FritzBox 2023-07-27 21:20:12 fon9_device 9
setstate FritzBox 2023-07-27 21:20:12 gsm_internet 0
setstate FritzBox 2023-07-27 21:20:12 retStat_lastReadout 296 values captured in 2.29 s
setstate FritzBox 2023-07-27 21:20:12 state WLAN: on gWLAN: off
setstate FritzBox 2023-07-27 21:20:12 tam1 Anrufbeantworter
setstate FritzBox 2023-07-27 21:20:12 tam1_newMsg 0
setstate FritzBox 2023-07-27 21:20:12 tam1_oldMsg 0
setstate FritzBox 2023-07-27 21:20:12 tam1_state off
setstate FritzBox 2023-07-27 21:20:12 todayReceived 0.250211977
setstate FritzBox 2023-07-27 21:20:12 todaySent 0.060203524
setstate FritzBox 2023-07-27 21:20:12 userTicket01 246233



EDIT: Hab gerade gemerkt, über "set FritzBox checkAPIs" erkennt es die Fritzbox richtig und die Fehlermeldung mit dem "Invalid Action" ist verschwunden.
Würde es über ein DOIF oder Notify eine Möglichkeit geben zu erkennen, wenn dieser Fehler auftritt und dann das "set FritzBox checkAPIs" auszuführen?


JoWiemann

Hallo,

und Danke für die Analyse. Das war so im Modul nicht abgefangen. Anbei eine Beta-Version, die das in den Griff bekommen sollte zum Testen.

Grüße Jörg
Jörg Wiemann

Slave: RPi B+ mit 512 MB, COC (868 MHz), CUL V3 (433.92MHz SlowRF); FHEMduino, Aktuelles FHEM

Master: CubieTruck; Debian; Aktuelles FHEM

swsmily

Ich habe die Beta gerade eingespielt. Jedoch allein der Neustart von FHEM mit shutdown restart bewirkt, dass die Fritzbox auch neustartet. Hier bin ich gerade echt ratlos, denn ich habe danach über Update von FHEM wieder die vorherige 72_FRITZBOX.pm einspielen lassen. Selbst da passiert das nun jedesmal, dass wenn FHEM hochfährt die Fritzbox neustartet.

Dieses Verhalten hatte ich früher nicht, wenn ich mal ein Update von FHEM gemacht habe FHEM neugestartet habe. Da ich nur über Fritzbox-zu-Fritzbox-VPN Zugriff habe, habe ich immer bei einem Update von FHEM und Neustart über eine SSH-Verbindung auf den Raspi das Fhemlog mit Tail beobachtet. Früher ist die Verbindung nicht abgebrochen. Jetzt jedes mal  :o


RalfRog

FHEM auf Raspi 2B mit nanoCUL, HM-MOD-RPI-PCB und über LAN MAX!Cube mit a-culFW (Stack 868 + 433)
HM- Fensterkontakte, UP-Schalter, Bewegungsmelder und ein Rauchmelder

RalfRog

Setzt mal als erste Maßnahme das FritzBox Devive auf Disable (Attribut).

Ist nur die SSH Verbindung unterbrochen oder macht die Box lt. ihrem Log wirklich einen Neustart?

Oder liegt es vielleicht an deiner Tasmota-Steckdose?
Weil sie beim Neustart von Fhem kurz aus und wieder einschaltet.
FHEM auf Raspi 2B mit nanoCUL, HM-MOD-RPI-PCB und über LAN MAX!Cube mit a-culFW (Stack 868 + 433)
HM- Fensterkontakte, UP-Schalter, Bewegungsmelder und ein Rauchmelder

JoWiemann

Zitat von: swsmily am 28 Juli 2023, 23:25:59Ich habe die Beta gerade eingespielt. Jedoch allein der Neustart von FHEM mit shutdown restart bewirkt, dass die Fritzbox auch neustartet. Hier bin ich gerade echt ratlos, denn ich habe danach über Update von FHEM wieder die vorherige 72_FRITZBOX.pm einspielen lassen. Selbst da passiert das nun jedesmal, dass wenn FHEM hochfährt die Fritzbox neustartet.

Dieses Verhalten hatte ich früher nicht, wenn ich mal ein Update von FHEM gemacht habe FHEM neugestartet habe. Da ich nur über Fritzbox-zu-Fritzbox-VPN Zugriff habe, habe ich immer bei einem Update von FHEM und Neustart über eine SSH-Verbindung auf den Raspi das Fhemlog mit Tail beobachtet. Früher ist die Verbindung nicht abgebrochen. Jetzt jedes mal  :o

Es ist immer wieder irritierend, dass immer nur Schnipselweise alle Informationen geliefert werden. Von einer FB VPN FB Verbindung war bisher nicht die Rede. Auch ist mir noch nicht klar wo der RPi in dieser Architektur hängt. Vielleicht mal ein kleines Bildchen Deiner Architektur.

Grüße Jörg
Jörg Wiemann

Slave: RPi B+ mit 512 MB, COC (868 MHz), CUL V3 (433.92MHz SlowRF); FHEMduino, Aktuelles FHEM

Master: CubieTruck; Debian; Aktuelles FHEM

swsmily

Zitat von: JoWiemann am 29 Juli 2023, 09:53:46Es ist immer wieder irritierend, dass immer nur Schnipselweise alle Informationen geliefert werden. Von einer FB VPN FB Verbindung war bisher nicht die Rede. Auch ist mir noch nicht klar wo der RPi in dieser Architektur hängt. Vielleicht mal ein kleines Bildchen Deiner Architektur.

Sorry, irritieren wollte ich auf keinen Fall.
Es geht hier um das Haus meiner Eltern. Um dahin Zugriff zu haben, habe ich deren Fritzbox mit meiner Fritzbox bei mir zuhause über VPN verbunden.

Bei meinen Eltern hängt die besagte Cable-Fritzbox. Der Raspi, auf dem dort das FHEM läuft hängt per LAN-Kabel an der Fritzbox. Alles andere (WLAN-Steckdosen, PV-Anlage usw) ist nur über WLAN angebunden.

Zitat von: RalfRog am 29 Juli 2023, 08:34:29Ist nur die SSH Verbindung unterbrochen oder macht die Box lt. ihrem Log wirklich einen Neustart?

Das Logfile der Box ist danach leer und die öffentliche IP ist in der Zeit auch nicht pingbar.

Zitat von: RalfRog am 29 Juli 2023, 08:34:29Oder liegt es vielleicht an deiner Tasmota-Steckdose?
Weil sie beim Neustart von Fhem kurz aus und wieder einschaltet.

Die Vermutung hatte ich auch schon, aber gestern dann keine Zeit mehr gehabt dem weiter nachzugehen. Das muss ich mir nochmal alles genauer anschauen.

Merkwürdig ist der Reboot der Fritzbox aber auf jeden Fall, da dass in der Vergangenheit noch nicht passiert ist.
Ich werde nochmal bisschen testen und mich wieder melden, wenn ich mehr rausgefunden habe.


Zum eigentlichen Problem: Mit der hier angehängten Beta ist zumindest der im ersten Post erwähnte UPnP-Fehler nicht aufgetreten, wenn ich Raspi und Fritzbox gleichzeitig neugestartet habe.



EDIT: Es liegt wohl tatsächlich an der Steckdose. Ich hatte nun die Console der Tasmota-Steckdose auf und kurz bevor die Verbindung unterbrochen wurde hat sie von FHEM den Befehl bekommen auszuschalten. Nun muss ich suchen, woher das beim Starten von FHEM kommt.

EDIT2: Ich habe die "Ursache" gefunden... Mein Bruder hatte auf dem Raspi zusätzlich ioBroker installiert, da er dort ein NS-Panel einbauen wollte. Er hatte keine Möglichkeit gefunden NS-Panel mit FHEM zu nutzen, aber ein Skript wo es über ioBroker läuft. Genutzt wird das Teil aber vor Ort doch nicht. Warum auch immer hat aber ioBroker bewirkt, dass wenn FHEM neustartet es über MQTT an die Steckdose ein off sendet. Ich selbst hab gar nicht mehr daran gedacht, dass da noch was auf dem Raspi läuft, außer FHEM und NginX.

Ich habe nun ioBroker beendet und aus dem Autostart genommen, nun kann ich FHEM (oder den ganzen Raspi) neustarten, ohne dass die Steckdose der Fritzbox abgeschaltet wird. SORRY SORRY SORRY für diese ganze Verwirrung.

Ich werde nun die Beta nochmal einspielen und schauen, ob alles ordentlich läuft.

Nochmals große Entschuldigung für die Verwirrung und Irritierungen und DANKE für eure Hilfe!

swsmily

Ich habe nun die Beta nochmal eingespielt und Raspi sowie Fritzbox gleichzeitig neugestartet.

10 Minunten lang wurde die Fritzbox nicht ausgelesen, danach dann aber erfolgreich jede Minute.

Hier mal noch das Logfile mit Verbose 4 unter 10 Minuten:

2023.07.29 22:25:42.809 3: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1675] - ERROR: API luaQuery call responded with: 500 Can't connect to xxx.xxx.xxx.xxx:80 (Network is unreachable)
2023.07.29 22:25:42.813 3: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1694] - INFO: API luaData call responded with: 500 Can't connect to xxx.xxx.xxx.xxx:80 (Network is unreachable)
2023.07.29 22:25:42.815 3: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1723] - INFO: API TR-064 does not exist: 500 Can't connect to xxx.xxx.xxx.xxx:49000 (Network is unreachable)
2023.07.29 22:25:42.818 4: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1813] - DEBUG: Read 'system_status'
2023.07.29 22:25:42.820 4: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1817] - DEBUG: system_status returned: Can't connect to xxx.xxx.xxx.xxx:80 (Network is unreachable)

Network is unreachable at /usr/share/perl5/LWP/Protocol/http.pm line 50.

2023.07.29 22:25:42.820 3: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1839] - ERROR: 500 Can't connect to xxx.xxx.xxx.xxx:80 (Network is unreachable)
2023.07.29 22:25:42.821 4: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1856] - INFO: Captured 7 values
2023.07.29 22:25:52.664 4: [FritzBox | 0000 | 161.07.56 | Readout_Start.1617] - INFO: Fork process FRITZBOX_API_Check_Run
2023.07.29 22:26:02.800 4: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1675] - ERROR: API luaQuery call responded with: 500 Can't connect to xxx.xxx.xxx.xxx:80 (Connection timed out)
2023.07.29 22:26:02.803 4: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1694] - INFO: API luaData call responded with: 500 Can't connect to xxx.xxx.xxx.xxx:80 (Network is unreachable)
2023.07.29 22:26:02.805 4: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1723] - INFO: API TR-064 does not exist: 500 Can't connect to xxx.xxx.xxx.xxx:49000 (Network is unreachable)
2023.07.29 22:26:02.810 4: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1839] - ERROR: 500 Can't connect to xxx.xxx.xxx.xxx:80 (Network is unreachable)
2023.07.29 22:26:02.811 4: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1856] - INFO: Captured 7 values
2023.07.29 22:28:38.645 2: AttrTemplates: got 259 entries
2023.07.29 22:30:52.672 4: [FritzBox | 0000 | 161.07.56 | Readout_Start.1617] - INFO: Fork process FRITZBOX_API_Check_Run
2023.07.29 22:30:53.425 4: [FritzBox | 0000 | 161.07.56 | TR064_Init.5740] - INFO: Open TR-064 connection and ask for security port
2023.07.29 22:30:53.529 4: [FritzBox | 0000 | 161.07.56 | TR064_Init.5749] - INFO: SecPort-Result $VAR1 = '49443';

2023.07.29 22:30:53.546 4: [FritzBox | 0000 | 161.07.56 | API_Check_Run.1856] - INFO: Captured 11 values

Nach den 10 Minuten kamen mit Verbose 4 wieder sehr viele Einträge, am Ende mit:
2023.07.29 22:37:54.752 4: [FritzBox | 6591 | 161.07.56 | Readout_Run_Web.3680] - INFO: Captured 316 values

Falls das gesamte Logfile noch gewünscht ist mit Verbose 4, kann ich das gern zur Verfügung stellen, würde es nur eben erst wieder "schwärzen"  ;)



VIELEN VIELEN DANK!

RalfRog

Das sieht auf den ersten Blick nach Netzwerk Problemen aus.
Der Raspi arbeitet vermutlich mit fester IPv4?
Wie lange braucht denn die FritzBox, dass sie erst nach 10 Minuten auf der internen IP erreicht wird?
FHEM auf Raspi 2B mit nanoCUL, HM-MOD-RPI-PCB und über LAN MAX!Cube mit a-culFW (Stack 868 + 433)
HM- Fensterkontakte, UP-Schalter, Bewegungsmelder und ein Rauchmelder

frank

vielleicht DNS probleme?

ist das attribut dnsServer im device global gesetzt?
FHEM: 6.0(SVN) => Pi3(buster)
IO: CUL433|CUL868|HMLAN|HMUSB2|HMUART
CUL_HM: CC-TC|CC-VD|SEC-SD|SEC-SC|SEC-RHS|Sw1PBU-FM|Sw1-FM|Dim1TPBU-FM|Dim1T-FM|ES-PMSw1-Pl
IT: ITZ500|ITT1500|ITR1500|GRR3500
WebUI [HMdeviceTools.js (hm.js)]: https://forum.fhem.de/index.php/topic,106959.0.html

RalfRog

Wichtiger Aspekt.
Ist aber doch bei
define FritzBox FRITZBOX xxx.xxx.xxx.xxxfür die FritzBox sekundär,oder nicht?
FHEM auf Raspi 2B mit nanoCUL, HM-MOD-RPI-PCB und über LAN MAX!Cube mit a-culFW (Stack 868 + 433)
HM- Fensterkontakte, UP-Schalter, Bewegungsmelder und ein Rauchmelder