Strange call for nonexistent : ReadFn

Begonnen von KernSani, 07 April 2021, 14:20:07

Vorheriges Thema - Nächstes Thema

herrmannj

sorry, ich hatte den Beitrag zu früh gesendet, da fehlte die Erklärung dazu welche jetzt oben steht.

Papaloewe

https://forum.fhem.de/index.php/topic,120244.msg1147338/topicseen.html#msg1147338

Bei mir löst das Calendar-Modul diesen Fehler reproduzierbar aus.

2021.04.09 17:18:43 4: Calendar avea: Updating...
2021.04.09 17:18:43 5: SSL verify mode set to 0
2021.04.09 17:18:43 4: Calendar avea: Getting data from URL <hidden>
2021.04.09 17:18:43 1: ERROR: Another HttpUtils_NonblockingGet with the same hash is in progress
2021.04.09 17:18:43 1: stacktrace:
2021.04.09 17:18:43 1:     main::HttpUtils_NonblockingGet      called by /opt/fhem/FHEM/HttpUtils.pm (865)
2021.04.09 17:18:43 1:     main::HttpUtils_ParseAnswer         called by /opt/fhem/FHEM/HttpUtils.pm (642)
2021.04.09 17:18:43 1:     main::__ANON__                      called by fhem.pl (770)
2021.04.09 17:18:43 1: Calendar avea: retrieval failed with error message Another HttpUtils_NonblockingGet with the same hash is in progress
2021.04.09 17:18:43 1: Calendar avea: retrieved no or empty data
2021.04.09 17:18:43 4: Calendar avea: Checking times...

netwalk

Gleicher Fall bei mir im Kalender:

2021.04.09 17:48:34 1: ERROR: Another HttpUtils_NonblockingGet with the same hash is in progress
2021.04.09 17:48:34 1: stacktrace:
2021.04.09 17:48:34 1:     main::HttpUtils_NonblockingGet      called by FHEM/HttpUtils.pm (889)
2021.04.09 17:48:34 1:     main::HttpUtils_ParseAnswer         called by FHEM/HttpUtils.pm (642)
2021.04.09 17:48:34 1:     main::__ANON__                      called by fhem.pl (770)
2021.04.09 17:48:34 1: Calendar cal.Akku: retrieval failed with error message Another HttpUtils_NonblockingGet with the same hash is in progress
2021.04.09 17:48:34 1: Calendar cal.Akku: retrieved no or empty data
2021.04.09 17:48:37 1: ERROR: Another HttpUtils_NonblockingGet with the same hash is in progress


Nach Rückschritt auf eine ältere Version:
$Id: HttpUtils.pm 23979 2021-03-15 14:00:33Z rudolfkoenig $
funktioniert es wieder...
live long and prosper
netwalk
_______________________________________________
INTEL NUC7CJYH, Homematic mit 3x HMLGW, JEELINK mit 18x TX29-DTH-IT, DUOFERNSTICK, FB7590 mit FBDECT, NETATMO, Philips HUE, RFXtrx433, Ubiquiti G3 PRO/FLEX/DOME/MICRO

Supadone

Ich schließe mich dem ganzen an:

ERROR: Another HttpUtils_NonblockingGet with the same hash is in progress
2021.04.10 00:40:28 1: stacktrace:
2021.04.10 00:40:28 1:     main::HttpUtils_NonblockingGet      called by ./FHEM/98_freezemon.pm (1310)
2021.04.10 00:40:28 1:     main::freezemon_http                called by ./FHEM/98_freezemon.pm (1357)
2021.04.10 00:40:28 1:     main::__ANON__                      called by FHEM/HttpUtils.pm (889)
2021.04.10 00:40:28 1:     main::HttpUtils_ParseAnswer         called by FHEM/HttpUtils.pm (642)
2021.04.10 00:40:28 1:     main::__ANON__                      called by fhem.pl (770)
2021.04.10 00:40:28 1: Calendar DP_Chrissi: retrieval failed with error message Another HttpUtils_NonblockingGet with the same hash is in progress
2021.04.10 00:40:28 1: Calendar DP_Chrissi: retrieved no or empty data
2021.04.10 00:40:28 1: ERROR: Another HttpUtils_NonblockingGet with the same hash is in progress
2021.04.10 00:40:28 1: stacktrace:
2021.04.10 00:40:28 1:     main::HttpUtils_NonblockingGet      called by ./FHEM/98_freezemon.pm (1310)
2021.04.10 00:40:28 1:     main::freezemon_http                called by ./FHEM/98_freezemon.pm (1357)
2021.04.10 00:40:28 1:     main::__ANON__                      called by FHEM/HttpUtils.pm (889)
2021.04.10 00:40:28 1:     main::HttpUtils_ParseAnswer         called by FHEM/HttpUtils.pm (642)
2021.04.10 00:40:28 1:     main::__ANON__                      called by fhem.pl (770)
2021.04.10 00:40:28 1: Calendar DP_Andy: retrieval failed with error message Another HttpUtils_NonblockingGet with the same hash is in progress
2021.04.10 00:40:28 1: Calendar DP_Andy: retrieved no or empty data



CoolTux

Zitat von: netwalk am 09 April 2021, 18:11:50
Gleicher Fall bei mir im Kalender:

2021.04.09 17:48:34 1: ERROR: Another HttpUtils_NonblockingGet with the same hash is in progress
2021.04.09 17:48:34 1: stacktrace:
2021.04.09 17:48:34 1:     main::HttpUtils_NonblockingGet      called by FHEM/HttpUtils.pm (889)
2021.04.09 17:48:34 1:     main::HttpUtils_ParseAnswer         called by FHEM/HttpUtils.pm (642)
2021.04.09 17:48:34 1:     main::__ANON__                      called by fhem.pl (770)
2021.04.09 17:48:34 1: Calendar cal.Akku: retrieval failed with error message Another HttpUtils_NonblockingGet with the same hash is in progress
2021.04.09 17:48:34 1: Calendar cal.Akku: retrieved no or empty data
2021.04.09 17:48:37 1: ERROR: Another HttpUtils_NonblockingGet with the same hash is in progress


Nach Rückschritt auf eine ältere Version:
$Id: HttpUtils.pm 23979 2021-03-15 14:00:33Z rudolfkoenig $
funktioniert es wieder...

Bitte beachten, es ist keine Funktionseinschränkung. Die Aussage mit der alten Version funktioniert es wieder ist nicht korrekt.. Es funktioniert auch mit der neuen.
Denn es wurde lediglich eine erweiterte Ausgabe eingefügt. Siehe Rudis Kommentar.

Zitat von: rudolfkoenig am 08 April 2021, 12:29:46
Deine Analyse ist vmtl. richtig, der Verursacher ist Echodevice, der sollte nicht mit dem gleichen hash parallel mehrere NonblockingGets starten.

Ich habe HttpUtils.pm erweitert, damit man solche Parallel-Laeufer genauer identifizieren kann, mit Fehlermeldung und zusaetzlichen stacktrace im Log. Bin nicht sicher, ob das ganz ohne Nebeneffekte klappt, aber das werden wir sehen.
Du musst nicht wissen wie es geht! Du musst nur wissen wo es steht, wie es geht.
Support me to buy new test hardware for development: https://www.paypal.com/paypalme/MOldenburg
My FHEM Git: https://git.cooltux.net/FHEM/
Das TuxNet Wiki:
https://www.cooltux.net

Supadone

Zitat von: CoolTux am 10 April 2021, 10:43:36
Es funktioniert auch mit der neuen.


Sicher? Meine Calview Devices zeigen zumindest aktuell keine Termine mehr an. Ich kann jetzt leider nicht ausschließen dass es auch vor dem Update von HttpUtils.pm schon so war, aber da ich darüber die Heizung im Haus steuere denke ich mal dass es schon irgendwann aufgefallen wäre...

JudgeDredd

Zitat von: Supadone am 10 April 2021, 11:14:04
Sicher? Meine Calview Devices zeigen zumindest aktuell keine Termine mehr an.
Ich kann zwar nix sinnvolles beisteuern, aber meine Kalender haben mit der neuen HttpUtils auch keine Termine mehr angezeigt.
Router: Eigenbau (pfSense)
FHEM: Proxmox (DELL R720) | Debian 12 (VM)

CoolTux

Dann habe ich die Aussage von Rudi falsch verstanden, sorry.
Ich habe mir eben nur kurz den Patch angeschaut, anscheinend wird das ganze als Error ausgegeben. Klingt also nach Abbruch.
Du musst nicht wissen wie es geht! Du musst nur wissen wo es steht, wie es geht.
Support me to buy new test hardware for development: https://www.paypal.com/paypalme/MOldenburg
My FHEM Git: https://git.cooltux.net/FHEM/
Das TuxNet Wiki:
https://www.cooltux.net

Papaloewe

Im Log meines des Calendar-Devices:
Calendar avea: retrieved no or empty data

Es funktioniert wirklich nicht und sieht nach Abbruch aus!

rudolfkoenig

Ich stelle fest:
- die eingebaute Fehlermeldung hilft nicht bei der Ursachensuche.
- durch den Abbruch beim vermeintlichen Fehler beim Aufruf gibt es Probleme. Ob sie in HttpUtils oder im aufrufenden Modul zu suchen sind, ist mir noch unklar.

Ich habe in der Duplikats-Erkennung die Fehlermeldung geaendert, und statt Abbruch wird nur auf verbose 4 eine Meldung im Log ausgegeben, um bei der Ursachensuche zu helfen.

Da ich Calender nicht verwende, aber das Problem damit reproduzierbar ist: kann mir jemand eine Anleitung geben, um es ohne viel Installation oder Google/etc Anmeldung nachzustellen?

Papaloewe

z.B. so:
define cal_tmp calendar ical url https://www.google.com/calendar/ical/i4aeldvbflqu7u6jpn8uvv9738@group.calendar.google.com/public/basic.ics

Gisbert

Hallo Rudi,

2021.04.11 08:46:28.335 1:  ERROR: Another HttpUtils_NonblockingGet with the same hash is in progress
2021.04.11 08:46:28.335 1:  stacktrace:
2021.04.11 08:46:28.335 1:      main::HttpUtils_NonblockingGet      called by FHEM/HttpUtils.pm (889)
2021.04.11 08:46:28.336 1:      main::HttpUtils_ParseAnswer         called by FHEM/HttpUtils.pm (642)
2021.04.11 08:46:28.336 1:      main::__ANON__                      called by fhem.pl (770)
2021.04.11 08:46:28.336 1:  Radiation: URL error for ODL: Another HttpUtils_NonblockingGet with the same hash is in progress


Das Modul bfs (terrestrische und Höhenstrahlung, bei mir heißt das Device "Radiation") hat anscheinend das gleiche Problem.

Viele​ Grüße​ Gisbert​
Aktuelles FHEM | PROXMOX | Fujitsu Futro S740 | Debian 12 | UniFi | Homematic, VCCU, HMUART | ESP8266 | ATtiny85 | Wasser-, Stromzähler | Wlan-Kamera | SIGNALduino, Flamingo Rauchmelder FA21/22RF | RHASSPY

rudolfkoenig

Das ist offensichtlich mit dem veralteten HttpUtils von vorgestern erzeugt.
Bitte FHEM aktualisieren, siehe auch Antwort #24.

rudolfkoenig

define cal_tmp calendar ical url https://www.google.com/calendar/ical/i4aeldvbflqu7u6jpn8uvv9738@group.calendar.google.com/public/basic.ics


Danke!

Ich habe das redirect uebersehen, das ruft die Funktion mit dem gleichen hash und geaenderten URL neu auf.
Das habe ich jetzt gefixt. Wenn man das redirect sparen will, dann ersetzt man www durch calendar

herrmannj

Gehe ich Recht in der Annahme dass innerhalb der Module, konkret jsonmod, nichts verändert werden muss?