ECONNREFUSED nach vis-HTML-Logaufruf
-
@hollywoot
Ich hab mal an die Code Stelle geschaut wo der Fehler entstanden istAn der Stelle wird eine id mittels Regex geprüft.
Die Fehlermeldung sagt das die zu lang ist
Dem Code nach erwartet es eine id (ich vermute im Kontext das hier ein datenpunktname gemeint ist)Kannst du mal prüfen, ob bei Änderungen von datenpunkten durch ein Skript durch falsche Verwendung eher der Inhalt als der datenpunktname angegeben wird?
Trotzdem muss hier durch eine iobroker eine fehlerbehandlung oder Vorprüfung der Daten hin das dadurch kein harter Abbruch erzeugt wird.
-
@oliverio
Danke für Deine Mühe und Deine Antwort!
Ich habe an diesem Javascript nichts verändert, ebenso an den Datenpunkten nicht.
Auch habe ich das Logging schon über eine andere Art und Weise ausprobiert.Dass es an der Länge des Inhaltes vom Datenpunkt liegt, ist ziemlich sicher.
Die Frage ist ja aber, warum meckert er das erst jetzt nach dem js-Update an und vorher nicht? Da muss sich doch was verändert haben
Das Logging, bzw. die Erstellung der Datenpunkte habe ich übrigens nach folgendem Schema gemacht:
https://www.smarthome-tricks.de/software-iobroker/eigenes-logging-in-iobroker/
Vielleicht ist es dadurch etwas leichter nachzuvollziehen, was ich da überhaupt gebastelt habe.Der Inhalt des Logging-Datenpunkt wird mittels HTML-Widged im vis dargestellt. Bei Aufruf dessen: boom.
-
ich kann dir nur indizienbasiert hinweise geben.
was du im skript oder in der vis eingetragen hast, weiß ich nichtwenn du dir sicher bist, das du alles richtig gemacht hast, dann müssen wir auf den Entwickler warten.
da allerdings diese Fehlermeldung nicht sehr häufig im Forum vorkommt,
habe ich eine Vermutung auf welcher Seite der Fehler liegt und es sich lohnt stück für stück alles nochmal zu überprüfen. -
@oliverio
Höflich ausgedrückt
Also. Wenn in dem Datenpunkt bspw. 30 Einträge sind, funktioniert es. Sobald der über irgendeine Länge hinausgeht, knallt es.
Gerne versuche ich mal eben zu erläutern, wie ich diesen Datenpunkt mit Daten füttere.Das Javaskript läuft unter
globalund sieht so aus:
Um in diesen Logging-Datenpunkt nun Werte bzw. Logeinträge zu schießen, mache ich mit Blockly folgendes:
Javascript-Funktion:
PowerProtokoll(anausinfo, nachricht);
Daten in Datenpunkt schießen:
Anzeige im vis:
basic-HTML - Widget mit HTML-Inhalt:{javascript.0.Ereignisprotokoll.Power}
baut mir optisch den Log in dieser Optik:
Mehr kann ich nun auch nicht mehr dazu sagen
Außer es gibt noch spezielle Fragen. -
@hollywoot sagte in ECONNREFUSED nach vis-HTML-Logaufruf:
Das Javaskript läuft unter global
Da laufen eigentlich keine skripte (bzw. nur in ganz bestimmten Sonderfällen). So ein Sonderfall liegt hier aber eher nicht vor.
-
@thomas-braun
Ich versuche es mal wenn ich es normal "lagere". In den Anleitungen zu diesem Logging wird halt immer drauf hingewiesen - daher hab ich das auch gemacht
Meld mich gleich.
So:
Wenn ich das richtig verstanden habe, muss das Skript ingloballaufen weil ich ansonsten nicht auf die darin deklarierten Variablen zugreifen kann (von überall). Lege ich es woanders ab, funktioniert das Logging nicht mehr.
Wenn es dafür eine andere Möglichkeit gibt - ich bin da ganz offen.
Ich glaube allerdings auch nicht, dass das was mit meinen Abstürzen zu tun hat. -
Skript sieht für mich ok aus.
Ich denke da muss @AlCalzone mal reinschauen. -
Also ich glaube nicht das das irgendwas mit jsonl oder file zu tun hat ...
Zeig bitte mal die Konfig im Vis genau ... also die Geschweiften Klammern sehen mir nach einem "Binding" aus ... Je nachdem in welchem Feld das steht dann kann das so ncht gehen weil es dann als objekt ID interpretiert wird unddie wird versuch zu subscriben .... und dann knallts ...
-
@hollywoot sagte in ECONNREFUSED nach vis-HTML-Logaufruf:
Anzeige im vis:
basic-HTML - Widget mit HTML-Inhalt: {javascript.0.Ereignisprotokoll.Power}
baut mir optisch den Log in dieser Optik:was im vis ist, hat er schon geschrieben.
das seltsame ist, das es erst dann Probleme hat, wenn der datenpunktinhalt (html) größer wird.evtl kann er auch mal ein neues leeres projekt anlegen und nur das eine hinzufügen um die problemquelle weiter zu isolieren.
-
@oliverio sagte in ECONNREFUSED nach vis-HTML-Logaufruf:
was im vis ist, hat er schon geschrieben.
Ich will es bitte SEHEN
Weil es darum geht in welchem Feld das Binding drin ist
-
@apollon77
Moin! Ich versteh nicht ganz was du meinst.
Das Binding ist in dem Widget im HTML-Feld eingetragen.
Ich mache sonst morgen früh gerne eben einen Screenshot. -
@hollywoot
Am besten du fügst unter setup
Ein neues Projekt hinzu
Fügst das Widget in der gleichen Einstellung
Hinzu und testest dannDie Vermutung ist, du hast das Bindung in irgendein id feld eingetragen. Das würde für diese Fehlermeldung sprechen.
Das muss nicht in dem Widget sein in dem du denkst das der Fehler auftritt
Wenn der Fehler dann noch Auftritt, könntest du das Widget exportieren. Da gibt es einen Knopf dafür.
Dann kommen Alle Einstellungen mit.
Aber wie gesagt es sollte ein isoliertes Beispiel sein mit nur einem Widget im alle Rand Effekte erst einmal auszuschliessen -
@oliverio
@apollon77
So, guten morgen!Gesagt, getan.
Ich habe ein Test-Projekt angelegt und das Binding genau so durchgeführt wie auch im main-Projekt.
Es passiert ... genau nichts. Vorerst.
Beim Switchen im vis-Edit von Test auf Main, bekam ich wieder die "regular expression" Meldung und es knallte. Das ist jedoch nicht reproduzierbar.
Ich habe dann, um den ioBroker zu provozieren, den alten Log mit 10k Einträgen in einen Datenpunkt geschrieben.
Promt flog er mir um die Ohren beim Aufruf vom Test-vis. Auch das ist nicht reproduzierbar.
Das main-vis scheint genau heute mal ohne Meckern durchzulaufen ... ich packs nicht! Ich habe nichts Gravierendes verändert.Ich hab dann also den alten 10k Log mal wieder ins Main-vis gebracht. Ergebnis: Es passiert nichts. Der ioBroker bleibt stabil. Ich fall wirklich vom Glauben ab. Ich kann es nicht verstehen.
Ich möchte jetzt den Tag allerdings auch nicht vor dem Abend loben. Ich warte den heutigen Tag und ggf. das Wochenende nochmal ab und würde mich spätestens am Montag nochmal melden. Wenn er bis Montag stabil bleibt, hat sich das Problem wohl wie von Geisterhand gelöst.
Noch ist im Betrieb allerdings auch nicht viel los. Mal abwarten.Nichts desto trotz schulde ich euch noch den Screenshot vom vis:
EDIT:
Quasi kurz nach dem Verfassen dieses Beitrags hier, war auch schon wieder vorbei mit der Euphorie.2022-03-25 07:15:38.059 - error: host.iobroker uncaught exception: Invalid regular expression: /^25\.03\.22 06:56:09<span style="display:inline\-block;width:25px;margin\-left:10 px;color:#FFFFFF">ⓘ<\/span>-------[kompletter Inhalt des Objektes]-------: Regular expression too large at /opt/iobroker/node_modules/@iobroker/db-states-jsonl/lib/states/statesInMemServerRedis.js:135:47 at Array.find (<anonymous>) at StatesInMemoryServer.publishToClients (/opt/iobroker/node_modules/@iobroker/db-states-jsonl/lib/states/statesInMemServerRedis.js:135:25) at StatesInMemoryServer.publishAll (/opt/iobroker/node_modules/@iobroker/db-base/lib/inMemFileDB.js:459:38) at Immediate.<anonymous> (/opt/iobroker/node_modules/@iobroker/db-states-file/lib/states/statesInMemFileDB.js:213:22) at processImmediate (node:internal/timers:466:21) 2022-03-25 07:17:03.324 - error: admin.0 (19471) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:03.385 - error: web.0 (20106) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:03.392 - error: backitup.0 (19667) Objects database error: connect ECONNREFUSED 0.0.0.0:9001 2022-03-25 07:17:03.440 - error: info.0 (19694) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:03.453 - error: wireguard.0 (19652) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:03.456 - error: javascript.0 (19366) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:03.461 - error: web.0 (20106) Objects database error: connect ECONNREFUSED 0.0.0.0:9001 2022-03-25 07:17:03.460 - error: simple-api.0 (19713) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:03.467 - error: info.0 (19694) Objects database error: connect ECONNREFUSED 0.0.0.0:9001 2022-03-25 07:17:03.475 - error: wireguard.0 (19652) Objects database error: connect ECONNREFUSED 0.0.0.0:9001 2022-03-25 07:17:03.473 - error: ping.0 (19625) Objects database error: connect ECONNREFUSED 0.0.0.0:9001 2022-03-25 07:17:03.483 - error: javascript.0 (19366) Objects database error: connect ECONNREFUSED 0.0.0.0:9001 2022-03-25 07:17:03.481 - error: backitup.0 (19667) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:03.486 - error: telegram.0 (19423) Objects database error: connect ECONNREFUSED 0.0.0.0:9001 2022-03-25 07:17:03.489 - error: pushover.0 (19537) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:03.492 - error: text2command.0 (19788) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:03.495 - error: ping.0 (19625) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:03.499 - error: pushover.0 (19537) Objects database error: connect ECONNREFUSED 0.0.0.0:9001 2022-03-25 07:17:03.502 - error: telegram.0 (19423) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:08.292 - error: admin.0 (19471) Objects database error: connect ECONNREFUSED 0.0.0.0:9001 2022-03-25 07:17:08.306 - error: simple-api.0 (19713) Objects database error: connect ECONNREFUSED 0.0.0.0:9001 2022-03-25 07:17:08.320 - error: text2command.0 (19788) Objects database error: connect ECONNREFUSED 0.0.0.0:9001 2022-03-25 07:17:08.327 - error: admin.0 (19471) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:08.329 - warn: admin.0 (19471) get state error: Connection is closed. 2022-03-25 07:17:08.330 - warn: admin.0 (19471) get state error: DB closed ... ... ... 2022-03-25 07:17:08.340 - warn: admin.0 (19471) get state error: DB closed 2022-03-25 07:17:08.357 - warn: admin.0 (19471) REAUTHENTICATE! 2022-03-25 07:17:08.387 - error: web.0 (20106) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:08.394 - error: backitup.0 (19667) Objects database error: connect ECONNREFUSED 0.0.0.0:9001 2022-03-25 07:17:08.390 - warn: web.0 (20106) get state error: DB closed ... ... ... 2022-03-25 07:17:08.443 - error: info.0 (19694) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:08.449 - error: web.0 (20106) uncaught exception: write EPIPE 2022-03-25 07:17:08.450 - error: web.0 (20106) Error: write EPIPE at afterWriteDispatched (node:internal/stream_base_commons:160:15) at writeGeneric (node:internal/stream_base_commons:151:3) at Socket._writeGeneric (node:net:795:11) at Socket._write (node:net:807:8) at writeOrBuffer (node:internal/streams/writable:389:12) at _write (node:internal/streams/writable:330:10) at Socket.Writable.write (node:internal/streams/writable:334:10) at console.value (node:internal/console/constructor:286:16) at console.warn (node:internal/console/constructor:365:26) at Function.logerror (/opt/iobroker/node_modules/express/lib/application.js:630:43) 2022-03-25 07:17:08.450 - error: web.0 (20106) Exception-Code: EPIPE: write EPIPE 2022-03-25 07:17:08.452 - error: web.0 (20106) uncaught exception: write EPIPE 2022-03-25 07:17:08.452 - error: web.0 (20106) Error: write EPIPE at afterWriteDispatched (node:internal/stream_base_commons:160:15) at writeGeneric (node:internal/stream_base_commons:151:3) at Socket._writeGeneric (node:net:795:11) at Socket._write (node:net:807:8) at writeOrBuffer (node:internal/streams/writable:389:12) at _write (node:internal/streams/writable:330:10) at Socket.Writable.write (node:internal/streams/writable:334:10) at console.value (node:internal/console/constructor:286:16) at console.warn (node:internal/console/constructor:365:26) at Function.logerror (/opt/iobroker/node_modules/express/lib/application.js:630:43) 2022-03-25 07:17:08.452 - error: web.0 (20106) Exception-Code: EPIPE: write EPIPE 2022-03-25 07:17:08.457 - error: javascript.0 (19366) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:08.458 - error: wireguard.0 (19652) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:08.463 - error: simple-api.0 (19713) States database error: connect ECONNREFUSED 0.0.0.0:9000 2022-03-25 07:17:08.466 - error: web.0 (20106) Objects database error: connect ECONNREFUSED 0.0.0.0:9001 und das geht so weiter mit jedem Adapter.Das war im main-vis.
Ich hab das Logging im Main-vis nun abgeschaltet und werde einige Tage mit dem Test-vis arbeiten.EDIT2:
Auch im Test-vis fliegt mir alles auseinander.
Hier mal der Export:
Es fliegt mir sogar im vis-Edit um die Ohren.Noch was: wir betreiben hier einen Multi-Host-Betrieb. Ist vielleicht nicht unwichtig.
Dazu habe ich gerade folgendes im Log entdecken können:2022-03-25 08:01:35.996 - error: sql.0 (1507) Connection is closed. 2022-03-25 08:01:35.997 - error: sql.0 (1507) Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). 2022-03-25 08:01:35.998 - error: sql.0 (1507) unhandled promise rejection: Objects DB is not allowed to start in the current Multihost environment 2022-03-25 08:01:35.999 - error: sql.0 (1507) Error: Objects DB is not allowed to start in the current Multihost environment at Redis.<anonymous> (/opt/iobroker/node_modules/@iobroker/db-objects-redis/lib/objects/objectsInRedisClient.js:632:23) at runMicrotasks (<anonymous>) at processTicksAndRejections (node:internal/process/task_queues:96:5 -
@hollywoot sagte in ECONNREFUSED nach vis-HTML-Logaufruf:
2022-03-25 07:15:38.059 - error: host.iobroker uncaught exception: Invalid regular expression: /^25.03.22 06:56:09<span style="display:inline-block;width:25px;margin-left:10
Also ich wäre imme rnoch bei"Bitte zeig doch mal GENAU wie es aussieht bzw machnen vis export von dem testprojekt. Irgedwie versucht "jemand"/"etwas" mit dem Inhalt deines Logstates einen Subscribe zu machen und das endet in einer ungültigen bzw zu grossen regex für den Check ... Also es geht darum rauszufinden WARUM etwas versucht mit dem inhalt zu subscriben. Das kann an sich nur passieren wenn du den Inhalt über Binding in einem Feld hast wo Vis eine Objekt-ID erwartet !!
Ist also entweder ein Bug in einem Widget oder ein Konfigurationsproblem.
(Dafür das der Controller solche Fälle, die bisher noch nie aufgetereten sind, abfängt habe ich auch ein GitHub Issue beim Controller gemacht, das würde aber dann dennoch das Log zuspammen oder subscribes "knallen" lassen. Also es gilt rauszufinden was der Auslöser ist) -
Also am besten brauchen wir neben ggf nem Screenshot um "offensichtliche Missconfig" auszuschliessen einen Export einer Vis wo das Problem auftritt zusammen mit nem beispielinhalt eines solchen States wo es passiert. Hier posten oder mir per E-Mail zusenden bitte (iobroker@fischer-ka.de + info@iobroker.net)
-
-
Ok, also "Fehlkonfig" in meiner Welt mit meinen Limitierten Bis-Kenntnissen eher ausgeschlossen) ... Bitte Vis GitHub issue anlegen und hierauf verweisen oder nochmal anhängen. Ich habe auch Bluefox bereits informiert und er schaut es sich an
-
@apollon77
Vielen Dank!
Ich lege ein issue an. -
@hollywoot Ich kann nicht reproduzieren
-
@hollywoot Kannst du folgende Seite im Browser aufmachen?
F12 drucken und dann sehe das Bild.
Und uns zeigen, was da kommt?
