NEWS
History Adapter steht auf rot
-
Beim zweiten Log fehlt der Teil mit dem "crash" (also wenn wie vorher dann die "exception" und ein paar zeilen davor. Kannst Du bitte nochmal schauen ?!
-
Die Exeption tritt leider nicht mehr auf, trotzdem wechselt der Adapter alle paar Minuten von grün nach rot und zurück.
Hier noch einige Infos aus dem Log
! history.0 2017-07-12 12:46:06.265 info enabled logging of tankerkoenig.0.stations.0.e5.short
! history.0 2017-07-12 12:46:05.936 info starting. Version 1.6.2 in C:/iobroker/node_modules/iobroker.history, node: v4.4.7
! history.0 2017-07-12 12:45:22.593 debug statesDB connected
! history.0 2017-07-12 12:45:22.453 warn Reconnection to DB.
! history.0 2017-07-12 12:45:22.453 debug statesDB connected
! history.0 2017-07-12 12:45:22.453 warn Reconnection to DB.
! history.0 2017-07-12 12:45:21.093 debug transport close
! history.0 2017-07-12 12:45:21.093 debug inMem message * hm-rega.0.65422
! history.0 2017-07-12 12:45:21.093 debug inMem message * hm-rega.0.65422
! history.0 2017-07-12 12:45:21.093 debug inMem message * hm-rega.0.25167
! history.0 2017-07-12 12:45:21.093 debug inMem message * hm-rega.0.25167
! history.0 2017-07-12 12:45:21.078 debug inMem message * hm-rega.0.25167
! history.0 2017-07-12 12:45:21.078 debug inMem message * hm-rega.0.65422
! history.0 2017-07-12 12:40:41.155 debug inMem message * hm-rega.0.25167 val=true, ack=true, ts=1499855972015, q=0, from=system.adapter.javascript.0, lc=1499453851687
! history.0 2017-07-12 12:40:41.155 debug inMem message * hm-rega.0.65422 val=true, ack=true, ts=1499855972015, q=0, from=system.adapter.javascript.0, lc=1499814503922
! history.0 2017-07-12 12:40:41.155 debug inMem message * hm-rega.0.25167 val=true, ack=true, ts=1499855972015, q=0, from=system.adapter.javascript.0, lc=1499453851687
! history.0 2017-07-12 12:40:41.155 debug inMem message * hm-rega.0.65422 val=true, ack=true, ts=1499855972015, q=0, from=system.adapter.javascript.0, lc=1499814503922
! history.0 2017-07-12 12:40:41.155 debug inMem message * hm-rega.0.25167 val=true, ack=true, ts=1499855972015, q=0, from=system.adapter.javascript.0, lc=1499453851687
! history.0 2017-07-12 12:40:41.155 debug inMem message * hm-rega.0.25167 val=true, ack=true, ts=1499855972015, q=0, from=system.adapter.javascript.0, lc=1499453851687
! history.0 2017-07-12 12:40:41.139 debug inMem message * hm-rega.0.65422 val=true, ack=true, ts=1499855972015, q=0, from=system.adapter.javascript.0, lc=1499814503922
! history.0 2017-07-12 12:40:41.139 debug inMem message * hm-rega.0.65422 val=true, ack=true, ts=1499855972000, q=0, from=system.adapter.javascript.0, lc=1499814503922
! history.0 2017-07-12 12:40:38.499 debug moving 11 entries from hm-rega.0.25167 to file
! history.0 2017-07-12 12:40:38.499 debug inMem message * hm-rega.0.25167 val=true, ack=true, ts=1499855972000, q=0, from=system.adapter.javascript.0, lc=1499453851687
! history.0 2017-07-12 12:40:38.499 debug inMem message * hm-rega.0.25167 val=true, ack=true, ts=1499855972000, q=0, from=system.adapter.javascript.0, lc=1499453851687
! history.0 2017-07-12 12:40:38.499 debug inMem message * hm-rega.0.25167 val=true, ack=true, ts=1499855972000, q=0, from=system.adapter.javascript.0, lc=1499453851687
! history.0 2017-07-12 12:40:38.499 debug inMem message * hm-rega.0.65422 val=true, ack=true, ts=1499855972000, q=0, from=system.adapter.javascript.0, lc=1499814503922
! history.0 2017-07-12 12:40:38.483 debug inMem message * hm-rega.0.65422 val=true, ack=true, ts=1499855972000, q=0, from=system.adapter.javascript.0, lc=1499814503922
! history.0 2017-07-12 12:40:38.483 debug inMem message * hm-rega.0.65422 val=true, ack=true, ts=1499855972000, q=0, from=system.adapter.javascript.0, lc=1499814503922
! history.0 2017-07-12 12:40:38.483 debug inMem message * hm-rega.0.25167 val=true, ack=true, ts=1499855972000, q=0, from=system.adapter.javascript.0, lc=1499453851687
! history.0 2017-07-12 12:40:38.483 debug inMem message * hm-rega.0.25167 val=true, ack=true, ts=1499855972000, q=0, from=system.adapter.javascript.0, lc=1499453851687
! history.0 2017-07-12 12:40:38.483 debug inMem message * hm-rega.0.65422 val=true, ack=true, ts=1499855972000, q=0, from=system.adapter.javascript.0, lc=1499814503922
! history.0 2017-07-12 12:40:38.483 debug inMem message * hm-rega.0.65422 val=true, ack=true, ts=1499855972000, q=0, from=system.adapter.javascript.0, lc=1499814503922
! history.0 2017-07-12 12:40:38.483 debug inMem message * hm-rega.0.25167 val=true, ack=true, ts=1499855972000, q=0, from=system.adapter.javascript.0, lc=1499453851687
! history.0 2017-07-12 12:40:38.483 debug inMem message * hm-rega.0.25167 val=true, ack=true, ts=1499855971984, q=0, from=system.adapter.javascript.0, lc=1499453851687
! history.0 2017-07-12 12:40:38.483 debug inMem message * hm-rega.0.65422 val=true, ack=true, ts=1499855971984, q=0, from=system.adapter.javascript.0, lc=1499814503922
! history.0 2017-07-12 12:40:38.483 debug inMem message * hm-rega.0.25167 val=true, ack=true, ts=1499855971984, q=0, from=system.adapter.javascript.0, lc=1499453851687Adapter neu installieren?
neue Instanz vom History installieren?
-
Wie geht es denn dem System an sich? Du hast geschrieben das es langsamer ist?
Mal iobroker komplett stoppen, schauen das auch wirklich alls "io*" Prozesse weg sind und nicht irgendwas hängengeblieben ist und neu starten.
neue Instanz oder so macht keinen Unterschied
-
so, hab dann auf dem Host unter iobroker/log doch noch einen EIntrag gefunden der evtl. weiterhilft:
! 2017-07-11 20:50:30.281 - [32minfo[39m: host.HTPC instance system.adapter.tvspielfilm.0 terminated with code 0 (OK)
! 2017-07-11 20:50:42.281 - [32minfo[39m: hm-rega.0 pollingTrigger
! 2017-07-11 20:51:24.014 - [32minfo[39m: admin.0 Unsubscribe from all states, except system's, because over 3 seconds the number of events is over 200 (in last second 0)
! 2017-07-11 20:52:24.422 - [32minfo[39m: admin.0 Subscribe on all states again
! 2017-07-11 20:52:40.031 - [32minfo[39m: hm-rega.0 pollingTrigger
! 2017-07-11 20:52:57.484 - [32minfo[39m: admin.0 Unsubscribe from all states, except system's, because over 3 seconds the number of events is over 200 (in last second 0)
! 2017-07-11 20:53:57.719 - [32minfo[39m: admin.0 Subscribe on all states again
! 2017-07-11 20:54:39.687 - [32minfo[39m: hm-rega.0 pollingTrigger
! 2017-07-11 20:54:50.375 - [32minfo[39m: admin.0 Unsubscribe from all states, except system's, because over 3 seconds the number of events is over 200 (in last second 0)
! 2017-07-11 20:54:57.937 - [31merror[39m: history.0 uncaught exception: Maximum call stack size exceeded
! 2017-07-11 20:55:00.639 - [32minfo[39m: host.HTPC instance system.adapter.tvspielfilm.0 started with pid 2796
! 2017-07-11 20:54:57.969 - [31merror[39m: history.0 RangeError: Maximum call stack size exceeded
! at Socket. <anonymous>(C:\iobroker\node_modules\iobroker.js-controller\lib\states\statesInMemClient.js:47:80)
! at Socket.Emitter.emit (C:\iobroker\node_modules\iobroker.js-controller\node_modules\socket.io-client\node_modules\component-emitter\index.js:133:20)
! at Socket.onevent (C:\iobroker\node_modules\iobroker.js-controller\node_modules\socket.io-client\lib\socket.js:270:10)
! at Socket.onpacket (C:\iobroker\node_modules\iobroker.js-controller\node_modules\socket.io-client\lib\socket.js:228:12)
! at Manager. <anonymous>(C:\iobroker\node_modules\iobroker.js-controller\node_modules\socket.io-client\node_modules\component-bind\index.js:21:15)
! at Manager.Emitter.emit (C:\iobroker\node_modules\iobroker.js-controller\node_modules\socket.io-client\node_modules\component-emitter\index.js:133:20)
! at Manager.ondecoded (C:\iobroker\node_modules\iobroker.js-controller\node_modules\socket.io-client\lib\manager.js:332:8)
! at Decoder. <anonymous>(C:\iobroker\node_modules\iobroker.js-controller\node_modules\socket.io-client\node_modules\component-bind\index.js:21:15)
! at Decoder.Emitter.emit (C:\iobroker\node_modules\iobroker.js-controller\node_modules\socket.io-client\node_modules\socket.io-parser\node_modules\component-emitter\index.js:134:20)
! at Decoder.add (C:\iobroker\node_modules\iobroker.js-controller\node_modules\socket.io-client\node_modules\socket.io-parser\index.js:246:12)
! 2017-07-11 20:55:03.625 - [33mwarn[39m: history.0 Reconnection to DB.
! 2017-07-11 20:55:03.921 - [31merror[39m: host.HTPC instance system.adapter.history.0 terminated with code 6 (uncaught exception)
! 2017-07-11 20:55:03.921 - [32minfo[39m: host.HTPC Restart adapter system.adapter.history.0 because enabled
! 2017-07-11 20:55:05.765 - [32minfo[39m: tvspielfilm.0 starting. Version 0.2.2 in C:/iobroker/node_modules/iobroker.tvspielfilm, node: v4.4.7
! 2017-07-11 20:55:05.844 - [32minfo[39m: tvspielfilm.0 objects written
! 2017-07-11 20:55:07.905 - [32minfo[39m: host.HTPC instance system.adapter.tvspielfilm.0 terminated with code 0 (OK)
! 2017-07-11 20:55:34.389 - [32minfo[39m: host.HTPC instance system.adapter.history.0 started with pid 5104
! 2017-07-11 20:55:37.984 - [32minfo[39m: history.0 starting. Version 1.6.2 in C:/iobroker/node_modules/iobroker.history, node: v4.4.7
! 2017-07-11 20:55:38.234 - [32minfo[39m: history.0 enabled logging of tankerkoenig.0.stations.0.e5.short
! 2017-07-11 20:55:38.234 - [32mgeht die LAst auf 1% runter.info[39m: history.0 enabled logging of yr.0.forecast.day0.pressure
! 2017-07-11 20:55:38.234 - [32minfo[39m: history.0 enabled logging of yr.0.forecast.day0.precipitation_level[/spoiler]</anonymous></anonymous></anonymous>Das iobroker so langsam ist liegt wohl daran, das er auf dem Host die CPU Last durch die Decke treibt. Alle vier Kerne mit 100% am Anschlag.
Schalte ich den iobroker Dienst ab, geht die Last auf 1% runter.
-
Dann finde mal raus woran die Last liegt.
AM besten mal alle Adapter ausser Admin ausschalten und dann iobroker auch. Dann ioBroker starten und schrittweise die Adapter wieder aktivieren. Dann solltest Du den finden der es auslöst.
Wieviele Datenpunkte hast Du im History, sah nach nicht sooo vielen aus.
-
Es sieht so aus, das der Javascript Adapter die CPU Last treibt.
So, ich denke ich hab das Problem gefunden. War selbstgemacht :evil:
Ich habe eine CCU Sysvar mit dem History Adapter geloggt.
Diese Sysvar habe ich per Javascript mit einem "tr-064.0.devices.xxx.active" Datenpunkt aktualisiert. D.h. alle 10 Sekunden musste History was wegschreiben.
Nachdem dieses Script deaktiviert ist läuft alles wieder. VIS zeigt auch wieder Diagramme an.
Zu deiner letzten Frage, ich hab ca. 100 Datenpunkte in History geloggt. Gibt's da eine Grenze?
Und ja, Danke für deine Hilfe.
-
Zu deiner letzten Frage, ich hab ca. 100 Datenpunkte in History geloggt. Gibt's da eine Grenze? `
Die Grenze ist "I/O" - wie Du ja selbst gemerkt hastUnd i/o ist dann egal ob es durch wenige Datenpunkte mit vielen Aktualisierungen oder viele Datenpunkte verursacht wird.
Hoffe Du hast keine SD-Karte drunter … Würde ich mittelfristig drüber nachdenken
Ingo F
-
ich hab ca. 100 Datenpunkte in History geloggt. Gibt's da eine Grenze? `
Nicht dass ich wüsste:
History und SQLauf den anderen Installationen um die 230.
Gruß
Rainer
-
[
Hoffe Du hast keine SD-Karte drunter … Würde ich mittelfristig drüber nachdenken `
Ne Ne, kein SD Karte
Meine iobroker Kiste ist ein Intel Atom mit 4GB Ram und einer 320GB Harddisc unter Windows 7 - 64Bit.
Vielleicht etwas oversized aber war halt "übrig".
-
Ich hab 3 Nucs 2x ioBroker mit 4GB RAM und 1x Influxdb und Tools mit 8 GB RAM