Test Adapter History 2.0.0

apollon77

@homoran debug log vom Adapter mal an und bitte log von so nem löschen zeigen. Dran hab ich nix geändert. Muss man schauen

Homoran

@apollon77 Hab ich (oder du) ein Problem.
Das debug müllt das log zu.
ich erkenne nicht was zum löschen gehört

Wie lange dauert das Ganze?

fängt an mit:

2022-04-27 14:53:18.765 - debug: history.0 (4085778) Redis Objects: Use Redis connection: 0.0.0.0:9001
2022-04-27 14:53:18.794 - debug: history.0 (4085778) Objects client ready ... initialize now
2022-04-27 14:53:18.799 - debug: history.0 (4085778) Objects create System PubSub Client
2022-04-27 14:53:18.800 - debug: history.0 (4085778) Objects create User PubSub Client
2022-04-27 14:53:18.801 - debug: history.0 (4085778) Objects client initialize lua scripts
2022-04-27 14:53:18.816 - debug: history.0 (4085778) Objects connected to redis: 0.0.0.0:9001
2022-04-27 14:53:18.822 - debug: history.0 (4085778) objectDB connected
2022-04-27 14:53:18.823 - debug: history.0 (4085778) Redis States: Use Redis connection: 0.0.0.0:9000
2022-04-27 14:53:18.832 - debug: history.0 (4085778) States create System PubSub Client
2022-04-27 14:53:18.833 - debug: history.0 (4085778) States create User PubSub Client
2022-04-27 14:53:18.844 - debug: history.0 (4085778) States connected to redis: 0.0.0.0:9000
2022-04-27 14:53:18.845 - debug: history.0 (4085778) statesDB connected
2022-04-27 14:53:19.057 - debug: history.0 (4085778) Plugin sentry Initialize Plugin (enabled=true)

Hab's nochmal versucht und finde:

2022-04-27 14:59:41.657 - debug: history.0 (4085778) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-27 14:59:50.596 - debug: history.0 (4085778) deleteState 1 items
2022-04-27 14:59:50.597 - warn: history.0 (4085778) States system pmessage io.messagebox.system.adapter.history.0 {"command":"delete","message":[{"state":{"ts":1651063995440},"id":"Messwerte.0.Stromzaehler.Summenwerte.Tagesendverbrauch"}],"from":"system.adapter.admin.0","callback":{"message":[{"state":{"ts":1651063995440},"id":"Messwerte.0.Stromzaehler.Summenwerte.Tagesendverbrauch"}],"id":325,"ack":false,"time":1651064390595},"_id":70540713} file is not defined
2022-04-27 14:59:50.604 - warn: history.0 (4085778) ReferenceError: file is not defined
at /opt/iobroker/node_modules/iobroker.history/main.js:1552:59
at Array.forEach ()
at _delete (/opt/iobroker/node_modules/iobroker.history/main.js:1505:15)
at deleteState (/opt/iobroker/node_modules/iobroker.history/main.js:1628:17)
at processMessage (/opt/iobroker/node_modules/iobroker.history/main.js:326:9)
at Object.message (/opt/iobroker/node_modules/iobroker.history/main.js:233:25)
at change (/opt/iobroker/node_modules/iobroker.js-controller/lib/adapter.js:5634:41)
at Immediate._onImmediate (/opt/iobroker/node_modules/@iobroker/db-states-redis/lib/states/statesInRedisClient.js:232:37)
at processImmediate (internal/timers.js:464:21)

apollon77

@homoran COngrats, you forund a bug :-)) Fixed ion GitHub

Homoran

@apollon77 Aber immer wieder gerne :grinning:

EDIT:

Works like a charm!

Endlich kann ich meine Charts aufräumen.
Sind natürlich jetzt unendlich viele DPs mit Dp*8 null drin :-(

apollon77

@homoran Viel Erfolg

Homoran

@apollon77 sagte in Test Adapter History 2.0.0:

@homoran COngrats, you forund a bug :-)) Fixed ion GitHub

ich versuche es gleich nochmal :-)

Ich habe gerade festgestellt, dass in einem Chart eine Linie fehlte.
Beim Versuch die Daten des zuständigen Datenpunktes anzusehen scheint history abgestürzt zu sein:

2022-04-28 14:41:30.041 - error: host.iobroker-VM03 Caught by controller[0]: <--- Last few GCs --->
2022-04-28 14:41:30.043 - error: host.iobroker-VM03 Caught by controller[0]: [2034430:0x597ac00] 38402 ms: Mark-sweep 1862.1 (1987.9) -> 1858.1 (1990.6) MB, 1777.6 / 0.0 ms (average mu = 0.225, current mu = 0.029) allocation failure scavenge might not succeed
2022-04-28 14:41:30.043 - error: host.iobroker-VM03 Caught by controller[0]: [2034430:0x597ac00] 40186 ms: Mark-sweep 1874.1 (1990.6) -> 1870.1 (1993.1) MB, 1712.1 / 0.0 ms (average mu = 0.147, current mu = 0.040) allocation failure scavenge might not succeed
2022-04-28 14:41:30.043 - error: host.iobroker-VM03 Caught by controller[0]: <--- JS stacktrace --->
2022-04-28 14:41:30.043 - error: host.iobroker-VM03 Caught by controller[0]: FATAL ERROR: Ineffective mark-compacts near heap limit Allocation failed - JavaScript heap out of memory
2022-04-28 14:41:30.043 - error: host.iobroker-VM03 Caught by controller[1]: 1: 0xa3aaf0 node::Abort() [io.history.0]
2022-04-28 14:41:30.043 - error: host.iobroker-VM03 Caught by controller[2]: 2: 0x970199 node::FatalError(char const*, char const*) [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[3]: 3: 0xbba45e v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[4]: 4: 0xbba7d7 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[5]: 5: 0xd769e5 [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[6]: 6: 0xd7756f [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[7]: 7: 0xd853ab v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[8]: 8: 0xd88f6c v8::internal::Heap::AllocateRawWithRetryOrFailSlowPath(int, v8::internal::AllocationType, v8::internal::AllocationOrigin, v8::internal::AllocationAlignment) [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[9]: 9: 0xd4e73d v8::internal::Factory::AllocateRaw(int, v8::internal::AllocationType, v8::internal::AllocationAlignment) [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[10]: 10: 0xd4a999 v8::internal::FactoryBase::AllocateRawArray(int, v8::internal::AllocationType) [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[11]: 11: 0xd4aa54 v8::internal::FactoryBase::NewFixedArrayWithFiller(v8::internal::Handle, int, v8::internal::Handle, v8::internal::AllocationType) [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[12]: 12: 0xf80ffe v8::internal::Handle v8::internal::HashTable::New(v8::internal::Isolate*, int, v8::internal::AllocationType, v8::internal::MinimumCapacity) [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[13]: 13: 0xf81cf9 v8::internal::Handle v8::internal::BaseNameDictionary::New(v8::internal::Isolate*, int, v8::internal::AllocationType, v8::internal::MinimumCapacity) [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[14]: 14: 0xf35be1 v8::internal::JSObject::MigrateToMap(v8::internal::Isolate*, v8::internal::Handle, v8::internal::Handle, int) [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[15]: 15: 0xf556cc v8::internal::LookupIterator::Delete() [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[16]: 16: 0xf2c55b v8::internal::JSReceiver::DeleteProperty(v8::internal::LookupIterator*, v8::internal::LanguageMode) [io.history.0]
2022-04-28 14:41:30.044 - error: host.iobroker-VM03 Caught by controller[17]: 17: 0x10b4600 v8::internal::Runtime::DeleteObjectProperty(v8::internal::Isolate*, v8::internal::Handle, v8::internal::Handle, v8::internal::LanguageMode) [io.history.0]
2022-04-28 14:41:30.045 - error: host.iobroker-VM03 Caught by controller[18]: 18: 0x10b673a v8::internal::Runtime_DeleteProperty(int, unsigned long*, v8::internal::Isolate*) [io.history.0]
2022-04-28 14:41:30.045 - error: host.iobroker-VM03 Caught by controller[19]: 19: 0x1448e19 [io.history.0]
2022-04-28 14:41:30.045 - warn: host.iobroker-VM03 instance system.adapter.history.0 terminated due to SIGABRT

EDIT:
Habe bei dem Datenpunkt Logging deaktiviert und neu konfiguriert.
Seitdem loggt er anscheinend wieder, aber sobald ich mir die Werte ansehen will stürzt history ab

apollon77

@homoran Wie lange zurück schaust Du denn? Das ist ein "Out of memory" ... Ansonsten Debug wieder an und dann mal log von so einem crash senden

Homoran

@apollon77 sagte in Test Adapter History 2.0.0:

Das ist ein "Out of memory"

Hatte ich gesehen
habe 4GB RAM zugewiesen und etwa 0,5GB free und 1,5 - 2 GB available

@apollon77 sagte in Test Adapter History 2.0.0:

Wie lange zurück schaust Du denn?

erst drei Tage, dann nur noch 10 Minuten.
Allerdings loggt er (???) alle 6 Sekunden

2022-04-28 16:03:08.838 - info: history.0 (2087532) Loglevel changed from "info" to "debug"
2022-04-28 16:03:11.278 - debug: history.0 (2087532) getHistory call: {"id":"system.host.iobroker-VM03.load","path":"/opt/iobroker/iobroker-data/history/","start":1651151993789,"end":1651154589581,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":57,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:11.278 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:11.359 - debug: history.0 (2087532) got 2 datapoints for system.host.iobroker-VM03.load
2022-04-28 16:03:11.388 - debug: history.0 (2087532) Send: 30 of: 178 in: 110ms
2022-04-28 16:03:11.388 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:12.276 - debug: history.0 (2087532) getHistory call: {"id":"system.host.iobroker-VM03.freemem","path":"/opt/iobroker/iobroker-data/history/","start":1651151993789,"end":1651154589581,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"minmax","limit":2000,"addId":false,"sessionId":57,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:12.277 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:12.285 - debug: history.0 (2087532) getHistory call: {"id":"system.host.iobroker-VM03.inputCount","path":"/opt/iobroker/iobroker-data/history/","start":1651151993789,"end":1651154589581,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":57,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:12.285 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:12.293 - debug: history.0 (2087532) getHistory call: {"id":"system.host.iobroker-VM03.outputCount","path":"/opt/iobroker/iobroker-data/history/","start":1651151993789,"end":1651154589581,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":57,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:12.293 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:12.347 - debug: history.0 (2087532) got 2 datapoints for system.host.iobroker-VM03.freemem
2022-04-28 16:03:12.369 - debug: history.0 (2087532) got 0 datapoints for system.host.iobroker-VM03.inputCount
2022-04-28 16:03:12.380 - debug: history.0 (2087532) got 0 datapoints for system.host.iobroker-VM03.outputCount
2022-04-28 16:03:12.397 - debug: history.0 (2087532) Send: 30 of: 180 in: 121ms
2022-04-28 16:03:12.397 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:12.404 - debug: history.0 (2087532) Send: 16 of: 43 in: 111ms
2022-04-28 16:03:12.404 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:12.405 - debug: history.0 (2087532) Send: 11 of: 29 in: 120ms
2022-04-28 16:03:12.405 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:19.313 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Stromzaehler.Summenwerte.Tagesendverbrauch","path":"/opt/iobroker/iobroker-data/history/","start":1650549799567,"end":1651154599567,"step":null,"count":300,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"onchange","limit":300,"addId":false,"sessionId":27,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:19.313 - debug: history.0 (2087532) got 0 datapoints for Messwerte.0.Stromzaehler.Summenwerte.Tagesendverbrauch
2022-04-28 16:03:19.328 - debug: history.0 (2087532) Send: 11 values in: 15ms
2022-04-28 16:03:19.328 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:19.355 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Solarestimate2","path":"/opt/iobroker/iobroker-data/history/","start":1651096800000,"end":1651183200000,"step":null,"count":300,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":300,"addId":false,"sessionId":52,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:19.355 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:19.423 - debug: history.0 (2087532) got 1 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Solarestimate2
2022-04-28 16:03:19.446 - debug: history.0 (2087532) Send: 125 of: 577 in: 91ms
2022-04-28 16:03:19.447 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:20.279 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Stromzaehler.Summenwerte.Tagesendeinspeisung","path":"/opt/iobroker/iobroker-data/history/","start":1650539799567,"end":1651144599567,"step":null,"count":300,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"onchange","limit":300,"addId":false,"sessionId":27,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:20.279 - debug: history.0 (2087532) got 0 datapoints for Messwerte.0.Stromzaehler.Summenwerte.Tagesendeinspeisung
2022-04-28 16:03:20.290 - debug: history.0 (2087532) Send: 9 values in: 11ms
2022-04-28 16:03:20.290 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:20.291 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Stromzaehler.Summenwerte.Tagesendbezug","path":"/opt/iobroker/iobroker-data/history/","start":1650529799567,"end":1651134599567,"step":null,"count":300,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"onchange","limit":300,"addId":false,"sessionId":27,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:20.291 - debug: history.0 (2087532) got 0 datapoints for Messwerte.0.Stromzaehler.Summenwerte.Tagesendbezug
2022-04-28 16:03:20.302 - debug: history.0 (2087532) Send: 9 values in: 11ms
2022-04-28 16:03:20.302 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:20.303 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Leistung_AC_aktuell","path":"/opt/iobroker/iobroker-data/history/","start":1651096800000,"end":1651183200000,"step":null,"count":300,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":300,"addId":false,"sessionId":52,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:20.303 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:20.310 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch","path":"/opt/iobroker/iobroker-data/history/","start":1651096800000,"end":1651183200000,"step":null,"count":300,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"minmax","limit":300,"addId":false,"sessionId":52,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:20.310 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:20.319 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Stromzaehler.Momentanwerte.akt_Verbrauch","path":"/opt/iobroker/iobroker-data/history/","start":1651096800000,"end":1651183200000,"step":null,"count":300,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":300,"addId":false,"sessionId":52,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:20.319 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:20.326 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Stromzaehler.Momentanwerte.akt_Einspeisung","path":"/opt/iobroker/iobroker-data/history/","start":1651096800000,"end":1651183200000,"step":null,"count":300,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":300,"addId":false,"sessionId":52,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:20.327 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:20.399 - debug: history.0 (2087532) got 5 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Leistung_AC_aktuell
2022-04-28 16:03:20.403 - debug: history.0 (2087532) got 5 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch
2022-04-28 16:03:20.422 - debug: history.0 (2087532) got 5 datapoints for Messwerte.0.Stromzaehler.Momentanwerte.akt_Verbrauch
2022-04-28 16:03:20.434 - debug: history.0 (2087532) got 5 datapoints for Messwerte.0.Stromzaehler.Momentanwerte.akt_Einspeisung
2022-04-28 16:03:20.475 - debug: history.0 (2087532) Send: 124 of: 4473 in: 172ms
2022-04-28 16:03:20.475 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:20.488 - debug: history.0 (2087532) Send: 140 of: 4709 in: 178ms
2022-04-28 16:03:20.488 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:20.505 - debug: history.0 (2087532) Send: 133 of: 4387 in: 179ms
2022-04-28 16:03:20.505 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:20.509 - debug: history.0 (2087532) Send: 204 of: 7340 in: 191ms
2022-04-28 16:03:20.510 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:21.391 - debug: history.0 (2087532) getHistory call: {"id":"hm-rpc.0.NEQ0384904.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651111401646,"end":1651154601646,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":53,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:21.391 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:21.457 - debug: history.0 (2087532) got 0 datapoints for hm-rpc.0.NEQ0384904.2.POWER
2022-04-28 16:03:21.478 - debug: history.0 (2087532) Send: 26 of: 27 in: 87ms
2022-04-28 16:03:21.478 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:22.294 - debug: history.0 (2087532) getHistory call: {"id":"hm-rpc.0.LTK0124191.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651111401646,"end":1651154601646,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":53,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:22.294 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:22.303 - debug: history.0 (2087532) getHistory call: {"id":"hm-rpc.0.KEQ0966548.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651111401646,"end":1651154601646,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":53,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:22.304 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:22.311 - debug: history.0 (2087532) getHistory call: {"id":"hm-rpc.0.KEQ0967747.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651111401646,"end":1651154601646,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":53,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:22.311 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:22.321 - debug: history.0 (2087532) getHistory call: {"id":"hm-rpc.0.NEQ0386317.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651111401646,"end":1651154601646,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":53,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:22.322 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:22.332 - debug: history.0 (2087532) getHistory call: {"id":"hm-rpc.0.LTK0124795.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651111401646,"end":1651154601646,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":53,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:22.333 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:22.344 - debug: history.0 (2087532) getHistory call: {"id":"hm-rpc.0.LTK0124195.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651111401646,"end":1651154601646,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":53,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:22.344 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:22.374 - debug: history.0 (2087532) getHistory call: {"id":"hm-rpc.0.LTK0124798.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651111401646,"end":1651154601646,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":53,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:22.375 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:22.395 - debug: history.0 (2087532) getHistory call: {"id":"hm-rpc.0.LTK0124143.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651111401646,"end":1651154601646,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":53,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:22.395 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:22.446 - debug: history.0 (2087532) getHistory call: {"id":"hm-rpc.0.REQ0777349.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651111401646,"end":1651154601646,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":53,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:22.447 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:22.466 - debug: history.0 (2087532) getHistory call: {"id":"hm-rpc.0.NEQ0116043.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651111401646,"end":1651154601646,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":53,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:22.467 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:22.483 - debug: history.0 (2087532) getHistory call: {"id":"hm-rpc.1.0001D3C99C3EFB.6.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651111401646,"end":1651154601646,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":53,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:22.483 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:22.513 - debug: history.0 (2087532) got 0 datapoints for hm-rpc.0.LTK0124191.2.POWER
2022-04-28 16:03:22.523 - debug: history.0 (2087532) got 0 datapoints for hm-rpc.0.KEQ0966548.2.POWER
2022-04-28 16:03:22.525 - debug: history.0 (2087532) got 0 datapoints for hm-rpc.0.KEQ0967747.2.POWER
2022-04-28 16:03:22.528 - debug: history.0 (2087532) got 0 datapoints for hm-rpc.0.NEQ0386317.2.POWER
2022-04-28 16:03:22.530 - debug: history.0 (2087532) got 0 datapoints for hm-rpc.0.LTK0124795.2.POWER
2022-04-28 16:03:22.552 - debug: history.0 (2087532) Send: 192 of: 193 in: 258ms
2022-04-28 16:03:22.553 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:22.554 - debug: history.0 (2087532) Send: 165 of: 166 in: 251ms
2022-04-28 16:03:22.554 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:22.555 - debug: history.0 (2087532) Send: 84 of: 86 in: 244ms
2022-04-28 16:03:22.555 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:22.557 - debug: history.0 (2087532) got 0 datapoints for hm-rpc.0.LTK0124798.2.POWER
2022-04-28 16:03:22.573 - debug: history.0 (2087532) Send: 129 of: 134 in: 252ms
2022-04-28 16:03:22.574 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:22.584 - debug: history.0 (2087532) Send: 279 of: 339 in: 252ms
2022-04-28 16:03:22.584 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:22.607 - debug: history.0 (2087532) got 2 datapoints for hm-rpc.0.LTK0124195.2.POWER
2022-04-28 16:03:22.609 - debug: history.0 (2087532) Send: 292 of: 549 in: 235ms
2022-04-28 16:03:22.609 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:22.619 - debug: history.0 (2087532) got 0 datapoints for hm-rpc.0.REQ0777349.2.POWER
2022-04-28 16:03:22.652 - debug: history.0 (2087532) got 0 datapoints for hm-rpc.0.LTK0124143.2.POWER
2022-04-28 16:03:22.654 - debug: history.0 (2087532) Send: 367 of: 1181 in: 309ms
2022-04-28 16:03:22.654 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:22.670 - debug: history.0 (2087532) Send: 26 of: 27 in: 224ms
2022-04-28 16:03:22.670 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:22.677 - debug: history.0 (2087532) got 0 datapoints for hm-rpc.0.NEQ0116043.2.POWER
2022-04-28 16:03:22.681 - debug: history.0 (2087532) got 2 datapoints for hm-rpc.1.0001D3C99C3EFB.6.POWER
2022-04-28 16:03:22.696 - debug: history.0 (2087532) Send: 278 of: 280 in: 301ms
2022-04-28 16:03:22.697 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:22.705 - debug: history.0 (2087532) Send: 26 of: 27 in: 239ms
2022-04-28 16:03:22.706 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:22.709 - debug: history.0 (2087532) Send: 221 of: 508 in: 226ms
2022-04-28 16:03:22.709 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-04-28 16:03:24.438 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch","path":"/opt/iobroker/iobroker-data/history/","start":1651068000000,"end":1651154604692,"step":3600000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:24.438 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:24.450 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch","path":"/opt/iobroker/iobroker-data/history/","start":1651068000000,"end":1651154604705,"step":3600000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:24.450 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:24.473 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch","path":"/opt/iobroker/iobroker-data/history/","start":1651068000000,"end":1651154604727,"step":3600000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:24.473 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:24.488 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch","path":"/opt/iobroker/iobroker-data/history/","start":1651068000000,"end":1651154604743,"step":3600000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:24.489 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:24.520 - debug: history.0 (2087532) got 6 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch
2022-04-28 16:03:24.529 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch","path":"/opt/iobroker/iobroker-data/history/","start":1651068000000,"end":1651154604783,"step":3600000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:03:24.529 - debug: history.0 (2087532) use parallel requests for getHistory
2022-04-28 16:03:24.549 - debug: history.0 (2087532) got 6 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch
2022-04-28 16:03:24.582 - debug: history.0 (2087532) got 6 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch
2022-04-28 16:03:24.591 - debug: history.0 (2087532) got 6 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch
2022-04-28 16:03:24.674 - debug: history.0 (2087532) got 6 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch
2022-04-28 16:03:24.676 - debug: history.0 (2087532) Send: 28 of: 7528 in: 226ms
2022-04-28 16:03:24.676 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.admin.0 from system.adapter.history.0
2022-04-28 16:03:24.700 - debug: history.0 (2087532) Send: 28 of: 7528 in: 262ms
2022-04-28 16:03:24.701 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.admin.0 from system.adapter.history.0
2022-04-28 16:03:24.712 - debug: history.0 (2087532) Send: 28 of: 7528 in: 239ms
2022-04-28 16:03:24.713 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.admin.0 from system.adapter.history.0
2022-04-28 16:03:24.724 - debug: history.0 (2087532) Send: 28 of: 7528 in: 236ms
2022-04-28 16:03:24.724 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.admin.0 from system.adapter.history.0
2022-04-28 16:03:24.765 - debug: history.0 (2087532) Send: 28 of: 7528 in: 236ms
2022-04-28 16:03:24.766 - debug: history.0 (2087532) sendTo "getHistory" to system.adapter.admin.0 from system.adapter.history.0
2022-04-28 16:03:26.310 - debug: history.0 (2087532) sendTo "features" to system.adapter.admin.0 from system.adapter.history.0
2022-04-28 16:03:26.395 - debug: history.0 (2087532) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch","path":"/opt/iobroker/iobroker-data/history/","start":946681200000,"end":1651154606644,"step":null,"count":500,"from":false,"ack":false,"q":false,"aggregate":"none","limit":1,"addId":false,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false}
2022-04-28 16:04:00.486 - warn: javascript.1 (229936) script.js.Hardware.netScan_ganzneu: no Data
2022-04-28 16:04:08.785 - error: host.iobroker-VM03 Caught by controller[0]: <--- Last few GCs --->
2022-04-28 16:04:08.788 - error: host.iobroker-VM03 Caught by controller[0]: [2087532:0x4b72c00] 3086022 ms: Mark-sweep 1870.7 (1991.6) -> 1866.7 (1994.1) MB, 1783.6 / 0.0 ms (average mu = 0.209, current mu = 0.037) allocation failure scavenge might not succeed
2022-04-28 16:04:08.788 - error: host.iobroker-VM03 Caught by controller[0]: [2087532:0x4b72c00] 3087879 ms: Mark-sweep 1882.7 (1994.1) -> 1878.8 (1996.6) MB, 1793.0 / 0.0 ms (average mu = 0.134, current mu = 0.035) allocation failure scavenge might not succeed
2022-04-28 16:04:08.788 - error: host.iobroker-VM03 Caught by controller[0]: <--- JS stacktrace --->
2022-04-28 16:04:08.788 - error: host.iobroker-VM03 Caught by controller[1]: FATAL ERROR: Ineffective mark-compacts near heap limit Allocation failed - JavaScript heap out of memory
2022-04-28 16:04:08.788 - error: host.iobroker-VM03 Caught by controller[2]: 1: 0xa3aaf0 node::Abort() [io.history.0]
2022-04-28 16:04:08.788 - error: host.iobroker-VM03 Caught by controller[3]: 2: 0x970199 node::FatalError(char const*, char const*) [io.history.0]
2022-04-28 16:04:08.788 - error: host.iobroker-VM03 Caught by controller[4]: 3: 0xbba45e v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [io.history.0]
2022-04-28 16:04:08.788 - error: host.iobroker-VM03 Caught by controller[5]: 4: 0xbba7d7 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [io.history.0]
2022-04-28 16:04:08.788 - error: host.iobroker-VM03 Caught by controller[5]: 5: 0xd769e5 [io.history.0]
2022-04-28 16:04:08.788 - error: host.iobroker-VM03 Caught by controller[6]: 6: 0xd7756f [io.history.0]
2022-04-28 16:04:08.788 - error: host.iobroker-VM03 Caught by controller[7]: 7: 0xd853ab v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [io.history.0]
2022-04-28 16:04:08.789 - error: host.iobroker-VM03 Caught by controller[8]: 8: 0xd88f6c v8::internal::Heap::AllocateRawWithRetryOrFailSlowPath(int, v8::internal::AllocationType, v8::internal::AllocationOrigin, v8::internal::AllocationAlignment) [io.history.0]
2022-04-28 16:04:08.789 - error: host.iobroker-VM03 Caught by controller[9]: 9: 0xd4e73d v8::internal::Factory::AllocateRaw(int, v8::internal::AllocationType, v8::internal::AllocationAlignment) [io.history.0]
2022-04-28 16:04:08.789 - error: host.iobroker-VM03 Caught by controller[10]: 10: 0xd4a999 v8::internal::FactoryBase::AllocateRawArray(int, v8::internal::AllocationType) [io.history.0]
2022-04-28 16:04:08.789 - error: host.iobroker-VM03 Caught by controller[11]: 11: 0xd4aa54 v8::internal::FactoryBase::NewFixedArrayWithFiller(v8::internal::Handle, int, v8::internal::Handle, v8::internal::AllocationType) [io.history.0]
2022-04-28 16:04:08.789 - error: host.iobroker-VM03 Caught by controller[12]: 12: 0xf80ffe v8::internal::Handle v8::internal::HashTable::New(v8::internal::Isolate*, int, v8::internal::AllocationType, v8::internal::MinimumCapacity) [io.history.0]
2022-04-28 16:04:08.789 - error: host.iobroker-VM03 Caught by controller[13]: 13: 0xf81cf9 v8::internal::Handle v8::internal::BaseNameDictionary::New(v8::internal::Isolate*, int, v8::internal::AllocationType, v8::internal::MinimumCapacity) [io.history.0]
2022-04-28 16:04:08.789 - error: host.iobroker-VM03 Caught by controller[14]: 14: 0xf35be1 v8::internal::JSObject::MigrateToMap(v8::internal::Isolate*, v8::internal::Handle, v8::internal::Handle, int) [io.history.0]
2022-04-28 16:04:08.789 - error: host.iobroker-VM03 Caught by controller[15]: 15: 0xf556cc v8::internal::LookupIterator::Delete() [io.history.0]
2022-04-28 16:04:08.789 - error: host.iobroker-VM03 Caught by controller[16]: 16: 0xf2c55b v8::internal::JSReceiver::DeleteProperty(v8::internal::LookupIterator*, v8::internal::LanguageMode) [io.history.0]
2022-04-28 16:04:08.789 - error: host.iobroker-VM03 Caught by controller[17]: 17: 0x10b4600 v8::internal::Runtime::DeleteObjectProperty(v8::internal::Isolate*, v8::internal::Handle, v8::internal::Handle, v8::internal::LanguageMode) [io.history.0]
2022-04-28 16:04:08.789 - error: host.iobroker-VM03 Caught by controller[18]: 18: 0x10b673a v8::internal::Runtime_DeleteProperty(int, unsigned long*, v8::internal::Isolate*) [io.history.0]
2022-04-28 16:04:08.789 - error: host.iobroker-VM03 Caught by controller[18]: 19: 0x1448e19 [io.history.0]
2022-04-28 16:04:08.789 - warn: host.iobroker-VM03 instance system.adapter.history.0 terminated due to SIGABRT
2022-04-28 16:04:08.790 - info: host.iobroker-VM03 instance system.adapter.history.0 terminated with code NaN ()

scheint in Zeile 119 loszugehen

apollon77

@homoran siehst du wieviele getHistpry abfragen da quasi parallel kommen ?! Wow. Ixh schaue mal.

apollon77

@homoran Ich hab mal versucht was zu optimieren, aber das ist schwierig. versuch mal GitHub version. Sonst setzen wir einfach den Heap für deinen Prozess hoch

apollon77

Auf GitHub sind einige Fixes hinzugekommen und auch noch zwei neue Features:

Bei storeState kann nun mittels dem Parameter "rule=true" festlegen das die Daten nicht direkt geloggt werden sondern alle Rules angewendet werden wie für jeden normalen Wert - inkl. Debounce u.ä. Bitte vorsichtig nutzen das nicht unabsichtlich Werte nicht geschrieben werden!
Eine Einstellung pro Datenpunkt ist dazugekommen, mit der man angeben kann auf wie viele Stellen nach dem Komma die Werte beim lesen (GetHistory) gerundet werden.

Homoran

@apollon77 ich bekomme nicht mal einen sinnvollen debug-log zustande :-(

2022-05-01 14:31:34.235 - info: host.iobroker-VM03 stopInstance system.adapter.history.0 (force=false, process=true)
2022-05-01 14:31:38.374 - error: host.iobroker-VM03 Caught by controller[0]: <--- Last few GCs --->
2022-05-01 14:31:38.374 - error: host.iobroker-VM03 Caught by controller[0]: [4074178:0x543dc00] 60961 ms: Mark-sweep 1870.8 (1993.1) -> 1866.8 (1995.6) MB, 1798.0 / 0.0 ms (average mu = 0.216, current mu = 0.040) allocation failure scavenge might not succeed
2022-05-01 14:31:38.374 - error: host.iobroker-VM03 Caught by controller[0]: [4074178:0x543dc00] 62792 ms: Mark-sweep 1882.7 (1995.6) -> 1878.8 (1998.4) MB, 1761.4 / 0.0 ms (average mu = 0.139, current mu = 0.038) allocation failure scavenge might not succeed
2022-05-01 14:31:38.375 - error: host.iobroker-VM03 Caught by controller[0]: <--- JS stacktrace --->
2022-05-01 14:31:38.375 - error: host.iobroker-VM03 Caught by controller[0]: FATAL ERROR: Ineffective mark-compacts near heap limit Allocation failed - JavaScript heap out of memory
2022-05-01 14:31:38.375 - error: host.iobroker-VM03 Caught by controller[1]: 1: 0xa3aaf0 node::Abort() [io.history.0]
2022-05-01 14:31:38.375 - error: host.iobroker-VM03 Caught by controller[2]: 2: 0x970199 node::FatalError(char const*, char const*) [io.history.0]
2022-05-01 14:31:38.375 - error: host.iobroker-VM03 Caught by controller[3]: 3: 0xbba45e v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [io.history.0]
2022-05-01 14:31:38.375 - error: host.iobroker-VM03 Caught by controller[4]: 4: 0xbba7d7 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [io.history.0]
2022-05-01 14:31:38.375 - error: host.iobroker-VM03 Caught by controller[5]: 5: 0xd769e5 [io.history.0]
2022-05-01 14:31:38.375 - error: host.iobroker-VM03 Caught by controller[6]: 6: 0xd7756f [io.history.0]
2022-05-01 14:31:38.375 - error: host.iobroker-VM03 Caught by controller[7]: 7: 0xd853ab v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [io.history.0]
2022-05-01 14:31:38.375 - error: host.iobroker-VM03 Caught by controller[8]: 8: 0xd88f6c v8::internal::Heap::AllocateRawWithRetryOrFailSlowPath(int, v8::internal::AllocationType, v8::internal::AllocationOrigin, v8::internal::AllocationAlignment) [io.history.0]
2022-05-01 14:31:38.376 - error: host.iobroker-VM03 Caught by controller[9]: 9: 0xd4e73d v8::internal::Factory::AllocateRaw(int, v8::internal::AllocationType, v8::internal::AllocationAlignment) [io.history.0]
2022-05-01 14:31:38.376 - error: host.iobroker-VM03 Caught by controller[10]: 10: 0xd4a999 v8::internal::FactoryBase::AllocateRawArray(int, v8::internal::AllocationType) [io.history.0]
2022-05-01 14:31:38.376 - error: host.iobroker-VM03 Caught by controller[11]: 11: 0xd4aa54 v8::internal::FactoryBase::NewFixedArrayWithFiller(v8::internal::Handle, int, v8::internal::Handle, v8::internal::AllocationType) [io.history.0]
2022-05-01 14:31:38.376 - error: host.iobroker-VM03 Caught by controller[12]: 12: 0xf80ffe v8::internal::Handle v8::internal::HashTable::New(v8::internal::Isolate*, int, v8::internal::AllocationType, v8::internal::MinimumCapacity) [io.history.0]
2022-05-01 14:31:38.376 - error: host.iobroker-VM03 Caught by controller[13]: 13: 0xf81cf9 v8::internal::Handle v8::internal::BaseNameDictionary::New(v8::internal::Isolate*, int, v8::internal::AllocationType, v8::internal::MinimumCapacity) [io.history.0]
2022-05-01 14:31:38.376 - error: host.iobroker-VM03 Caught by controller[14]: 14: 0xf35be1 v8::internal::JSObject::MigrateToMap(v8::internal::Isolate*, v8::internal::Handle, v8::internal::Handle, int) [io.history.0]
2022-05-01 14:31:38.376 - error: host.iobroker-VM03 Caught by controller[15]: 15: 0xf556cc v8::internal::LookupIterator::Delete() [io.history.0]
2022-05-01 14:31:38.376 - error: host.iobroker-VM03 Caught by controller[16]: 16: 0xf2c55b v8::internal::JSReceiver::DeleteProperty(v8::internal::LookupIterator*, v8::internal::LanguageMode) [io.history.0]
2022-05-01 14:31:38.376 - error: host.iobroker-VM03 Caught by controller[17]: 17: 0x10b4600 v8::internal::Runtime::DeleteObjectProperty(v8::internal::Isolate*, v8::internal::Handle, v8::internal::Handle, v8::internal::LanguageMode) [io.history.0]
2022-05-01 14:31:38.376 - error: host.iobroker-VM03 Caught by controller[18]: 18: 0x10b673a v8::internal::Runtime_DeleteProperty(int, unsigned long*, v8::internal::Isolate*) [io.history.0]
2022-05-01 14:31:38.376 - error: host.iobroker-VM03 Caught by controller[19]: 19: 0x1448e19 [io.history.0]
2022-05-01 14:31:38.376 - warn: host.iobroker-VM03 instance system.adapter.history.0 terminated due to SIGABRT
2022-05-01 14:31:38.376 - info: host.iobroker-VM03 instance system.adapter.history.0 terminated with code NaN ()

Habe dann immer relativ schnell den debug wieder abschalten wollen um das log nicht zu groß werden zu lassen, aber anscheinend kommt nach dem Absturz erst wieder dei Meldungen vom Neustart und dann..

2022-05-01 14:31:41.918 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Stromzaehler.Summenwerte.Tagesendverbrauch","path":"/opt/iobroker/iobroker-data/history/","start":1650803341003,"end":1651408141003,"step":null,"count":300,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"onchange","limit":300,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:41.918 - debug: history.0 (4075723) got 1 datapoints for Messwerte.0.Stromzaehler.Summenwerte.Tagesendverbrauch
2022-05-01 14:31:41.964 - debug: history.0 (4075723) Send: 11 values in: 47ms
2022-05-01 14:31:41.964 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:41.967 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Stromzaehler.Summenwerte.Tagesendeinspeisung","path":"/opt/iobroker/iobroker-data/history/","start":1650793341003,"end":1651398141003,"step":null,"count":300,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"onchange","limit":300,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:41.967 - debug: history.0 (4075723) got 1 datapoints for Messwerte.0.Stromzaehler.Summenwerte.Tagesendeinspeisung
2022-05-01 14:31:41.988 - debug: history.0 (4075723) Send: 9 values in: 22ms
2022-05-01 14:31:41.988 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:41.989 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Stromzaehler.Summenwerte.Tagesendbezug","path":"/opt/iobroker/iobroker-data/history/","start":1650783341003,"end":1651388141003,"step":null,"count":300,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"onchange","limit":300,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:41.989 - debug: history.0 (4075723) got 1 datapoints for Messwerte.0.Stromzaehler.Summenwerte.Tagesendbezug
2022-05-01 14:31:42.010 - debug: history.0 (4075723) Send: 9 values in: 21ms
2022-05-01 14:31:42.010 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:42.861 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Solarestimate2","path":"/opt/iobroker/iobroker-data/history/","start":1651356000000,"end":1651442400000,"step":null,"count":300,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":300,"addId":false,"sessionId":608,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:42.861 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:42.894 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Leistung_AC_aktuell","path":"/opt/iobroker/iobroker-data/history/","start":1651356000000,"end":1651442400000,"step":null,"count":300,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":300,"addId":false,"sessionId":608,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:42.894 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:42.910 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch","path":"/opt/iobroker/iobroker-data/history/","start":1651356000000,"end":1651442400000,"step":null,"count":300,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"minmax","limit":300,"addId":false,"sessionId":608,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:42.910 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:42.921 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Stromzaehler.Momentanwerte.akt_Verbrauch","path":"/opt/iobroker/iobroker-data/history/","start":1651356000000,"end":1651442400000,"step":null,"count":300,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":300,"addId":false,"sessionId":608,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:42.922 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:42.930 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Stromzaehler.Momentanwerte.akt_Einspeisung","path":"/opt/iobroker/iobroker-data/history/","start":1651356000000,"end":1651442400000,"step":null,"count":300,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":300,"addId":false,"sessionId":608,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:42.930 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:42.987 - debug: history.0 (4075723) got 1 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Solarestimate2
2022-05-01 14:31:43.008 - debug: history.0 (4075723) got 1 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Leistung_AC_aktuell
2022-05-01 14:31:43.064 - debug: history.0 (4075723) got 3 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch
2022-05-01 14:31:43.070 - debug: history.0 (4075723) got 2 datapoints for Messwerte.0.Stromzaehler.Momentanwerte.akt_Einspeisung
2022-05-01 14:31:43.079 - debug: history.0 (4075723) Send: 109 of: 508 in: 219ms
2022-05-01 14:31:43.080 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:43.112 - debug: history.0 (4075723) got 2 datapoints for Messwerte.0.Stromzaehler.Momentanwerte.akt_Verbrauch
2022-05-01 14:31:43.140 - debug: history.0 (4075723) Send: 106 of: 3896 in: 245ms
2022-05-01 14:31:43.140 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:43.176 - debug: history.0 (4075723) Send: 111 of: 3484 in: 246ms
2022-05-01 14:31:43.176 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:43.188 - debug: history.0 (4075723) Send: 122 of: 4157 in: 278ms
2022-05-01 14:31:43.189 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:43.222 - debug: history.0 (4075723) Send: 185 of: 6716 in: 301ms
2022-05-01 14:31:43.222 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:43.590 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.NEQ0384904.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651364942685,"end":1651408142685,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.590 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:43.619 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.JEQ0646431.1.STATE","path":"/opt/iobroker/iobroker-data/history/","start":1651148942708,"end":1651408142708,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"onchange","limit":2000,"addId":false,"sessionId":401,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.619 - debug: history.0 (4075723) got 2 datapoints for hm-rpc.0.JEQ0646431.1.STATE
2022-05-01 14:31:43.646 - debug: history.0 (4075723) Send: 181 values in: 27ms
2022-05-01 14:31:43.646 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:43.663 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.NEQ0384904.2.POWER
2022-05-01 14:31:43.668 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.LTK0124191.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651364942685,"end":1651408142685,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.669 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:43.676 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.KEQ0966548.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651364942685,"end":1651408142685,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.676 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:43.687 - debug: history.0 (4075723) Send: 27 of: 31 in: 96ms
2022-05-01 14:31:43.687 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:43.714 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.KEQ0967747.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651364942685,"end":1651408142685,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.714 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:43.723 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.NEQ0386317.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651364942685,"end":1651408142685,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.724 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:43.732 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.LTK0124795.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651364942685,"end":1651408142685,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.733 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:43.746 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.LTK0124195.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651364942685,"end":1651408142685,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.746 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:43.754 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.LTK0124798.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651364942685,"end":1651408142685,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.755 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:43.772 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.LTK0124143.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651364942685,"end":1651408142685,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.773 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:43.790 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.REQ0777349.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651364942685,"end":1651408142685,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.790 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:43.810 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.NEQ0116043.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651364942685,"end":1651408142685,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.810 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:43.833 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.1.0001D3C99C3EFB.6.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651364942685,"end":1651408142685,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":305,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.834 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:43.847 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Pool.Druck_real","path":"/opt/iobroker/iobroker-data/history/","start":1651148942708,"end":1651408142708,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"onchange","limit":2000,"addId":false,"sessionId":401,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:43.848 - debug: history.0 (4075723) got 1 datapoints for Messwerte.0.Pool.Druck_real
2022-05-01 14:31:43.933 - debug: history.0 (4075723) Send: 3073 values in: 86ms
2022-05-01 14:31:43.933 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:43.972 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.LTK0124191.2.POWER
2022-05-01 14:31:43.975 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.KEQ0966548.2.POWER
2022-05-01 14:31:43.994 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.KEQ0967747.2.POWER
2022-05-01 14:31:44.012 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.NEQ0386317.2.POWER
2022-05-01 14:31:44.020 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.LTK0124795.2.POWER
2022-05-01 14:31:44.022 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.LTK0124195.2.POWER
2022-05-01 14:31:44.048 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.JEQ0140901.1.TEMPERATURE","path":"/opt/iobroker/iobroker-data/history/","start":1651148942708,"end":1651408142708,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":401,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:44.048 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:44.071 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.LEQ0773306.2.TEMPERATURE","path":"/opt/iobroker/iobroker-data/history/","start":1651148942708,"end":1651408142708,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":401,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:44.072 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:44.093 - debug: history.0 (4075723) Send: 180 of: 185 in: 425ms
2022-05-01 14:31:44.094 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:44.096 - debug: history.0 (4075723) Send: 194 of: 198 in: 420ms
2022-05-01 14:31:44.096 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:44.100 - debug: history.0 (4075723) Send: 192 of: 197 in: 385ms
2022-05-01 14:31:44.100 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:44.101 - debug: history.0 (4075723) Send: 186 of: 199 in: 378ms
2022-05-01 14:31:44.102 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:44.103 - debug: history.0 (4075723) Send: 282 of: 313 in: 371ms
2022-05-01 14:31:44.104 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:44.109 - debug: history.0 (4075723) Send: 334 of: 592 in: 363ms
2022-05-01 14:31:44.109 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:44.113 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.REQ0777349.2.POWER
2022-05-01 14:31:44.132 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.LTK0124798.2.POWER
2022-05-01 14:31:44.134 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.LTK0124143.2.POWER
2022-05-01 14:31:44.142 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.NEQ0116043.2.POWER
2022-05-01 14:31:44.147 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.1.0001D3C99C3EFB.6.POWER
2022-05-01 14:31:44.168 - debug: history.0 (4075723) Send: 27 of: 31 in: 378ms
2022-05-01 14:31:44.169 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:44.170 - debug: history.0 (4075723) Send: 302 of: 494 in: 416ms
2022-05-01 14:31:44.171 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:44.176 - debug: history.0 (4075723) Send: 283 of: 290 in: 404ms
2022-05-01 14:31:44.176 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:44.181 - debug: history.0 (4075723) Send: 28 of: 31 in: 371ms
2022-05-01 14:31:44.181 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:44.183 - debug: history.0 (4075723) Send: 35 of: 38 in: 350ms
2022-05-01 14:31:44.183 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:44.209 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.JEQ0140901.1.TEMPERATURE
2022-05-01 14:31:44.212 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.LEQ0773306.2.TEMPERATURE
2022-05-01 14:31:44.238 - debug: history.0 (4075723) Send: 60 of: 365 in: 167ms
2022-05-01 14:31:44.238 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:44.244 - debug: history.0 (4075723) Send: 62 of: 1409 in: 197ms
2022-05-01 14:31:44.244 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:48.540 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Leistung_AC_aktuell","path":"/opt/iobroker/iobroker-data/history/","start":1651320000000,"end":1651408312584,"step":3600000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:48.540 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:48.632 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Leistung_AC_aktuell","path":"/opt/iobroker/iobroker-data/history/","start":1651320000000,"end":1651408312667,"step":3600000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:48.632 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:48.644 - debug: history.0 (4075723) got 1 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Leistung_AC_aktuell
2022-05-01 14:31:48.687 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Leistung_AC_aktuell","path":"/opt/iobroker/iobroker-data/history/","start":1651320000000,"end":1651408312693,"step":3600000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:48.688 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:48.761 - debug: history.0 (4075723) got 1 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Leistung_AC_aktuell
2022-05-01 14:31:48.775 - debug: history.0 (4075723) Send: 20 of: 7471 in: 235ms
2022-05-01 14:31:48.775 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.admin.0 from system.adapter.history.0
2022-05-01 14:31:48.800 - debug: history.0 (4075723) got 1 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Leistung_AC_aktuell
2022-05-01 14:31:48.874 - debug: history.0 (4075723) Send: 20 of: 7471 in: 243ms
2022-05-01 14:31:48.874 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.admin.0 from system.adapter.history.0
2022-05-01 14:31:48.927 - debug: history.0 (4075723) Send: 20 of: 7471 in: 240ms
2022-05-01 14:31:48.927 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.admin.0 from system.adapter.history.0
2022-05-01 14:31:53.487 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.JEQ0646431.1.STATE","path":"/opt/iobroker/iobroker-data/history/","start":1651149117531,"end":1651408317531,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"onchange","limit":2000,"addId":false,"sessionId":11,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:53.487 - debug: history.0 (4075723) got 2 datapoints for hm-rpc.0.JEQ0646431.1.STATE
2022-05-01 14:31:53.502 - debug: history.0 (4075723) Send: 186 values in: 15ms
2022-05-01 14:31:53.502 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:54.487 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Pool.Druck_real","path":"/opt/iobroker/iobroker-data/history/","start":1651149117531,"end":1651408317531,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"onchange","limit":2000,"addId":false,"sessionId":11,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:54.487 - debug: history.0 (4075723) got 1 datapoints for Messwerte.0.Pool.Druck_real
2022-05-01 14:31:54.511 - debug: history.0 (4075723) Send: 3076 values in: 24ms
2022-05-01 14:31:54.511 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:54.517 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.JEQ0140901.1.TEMPERATURE","path":"/opt/iobroker/iobroker-data/history/","start":1651149117531,"end":1651408317531,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":11,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:54.517 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:54.526 - debug: history.0 (4075723) getHistory call: {"id":"hm-rpc.0.LEQ0773306.2.TEMPERATURE","path":"/opt/iobroker/iobroker-data/history/","start":1651149117531,"end":1651408317531,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":11,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 14:31:54.527 - debug: history.0 (4075723) use parallel requests for getHistory
2022-05-01 14:31:54.612 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.JEQ0140901.1.TEMPERATURE
2022-05-01 14:31:54.625 - debug: history.0 (4075723) got 1 datapoints for hm-rpc.0.LEQ0773306.2.TEMPERATURE
2022-05-01 14:31:54.649 - debug: history.0 (4075723) Send: 63 of: 1409 in: 132ms
2022-05-01 14:31:54.650 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:54.651 - debug: history.0 (4075723) Send: 60 of: 366 in: 125ms
2022-05-01 14:31:54.651 - debug: history.0 (4075723) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 14:31:56.753 - debug: history.0 (4075723) sendTo "features" to system.adapter.admin.0 from system.adapter.history.0
2022-05-01 14:31:56.871 - debug: history.0 (4075723) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch","path":"/opt/iobroker/iobroker-data/history/","start":946681200000,"end":1651408320907,"step":null,"count":500,"from":false,"ack":false,"q":false,"aggregate":"none","limit":1,"addId":false,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}

wobei ich da auf die Schnelle nichts finde was zu dem DP gehört, den ich öffnen will:
Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch

übrigens bei allen DPs, die im 6Sekunden-Takt loggen gleiches Problem.

@apollon77 sagte in Test Adapter History 2.0.0:

Auf GitHub sind einige Fixes hinzugekommen und auch noch zwei neue Features:

aber immer noch 2.0.0??

apollon77

@homoran wo kommen denn diese massiv vielen gehHistory calls her? Das sind ja mehrere pro Sekunde???
Vor allem
Für den gleichen Datenpunkt. Weil am Ende ist’s sehr einfach: jeder der calls lädt mindestens die Daten des gesamten Tages und dann werden die auf die relevante Zeit gekürzt quasi. Ich schaue nochmal ob man das optimieren kann

Und ja. GitHub weiter auf 2.0.0

Homoran

@apollon77 sagte in Test Adapter History 2.0.0:

wo kommen denn diese massiv vielen gehHistory calls her? Das sind ja mehrere pro Sekunde???
Vor allem
Für den gleichen Datenpunkt.

Ich denke, das liegt daran, dass ich gerade die History des Datenpunktes aufrufe
(Hoffentlich)

apollon77

@homoran dann wäre es aber schon ein Admin Bug das er soooooo oft fragt. Muss ich nochmal genau schauen.

Homoran

@apollon77 sagte in Test Adapter History 2.0.0:

ein Admin

ist aber noch 5.2.3

apollon77

@homoran Update mal?

Homoran

@apollon77 sagte in Test Adapter History 2.0.0:

@homoran Update mal?

:cry:

Homoran

@apollon77 und wieder tausend null

Wie gehabt, erst:

2022-05-01 18:57:30.412 - error: host.iobroker-VM03 Caught by controller[0]: <--- Last few GCs --->
2022-05-01 18:57:30.416 - error: host.iobroker-VM03 Caught by controller[0]: [320902:0x4c95c00] 73098 ms: Mark-sweep 1871.8 (1987.1) -> 1867.8 (1989.6) MB, 1742.9 / 0.0 ms (average mu = 0.153, current mu = 0.042) allocation failure scavenge might not succeed
2022-05-01 18:57:30.416 - error: host.iobroker-VM03 Caught by controller[0]: [320902:0x4c95c00] 74837 ms: Mark-sweep 1883.8 (1989.6) -> 1879.9 (1992.1) MB, 1666.9 / 0.0 ms (average mu = 0.103, current mu = 0.041) allocation failure scavenge might not succeed
2022-05-01 18:57:30.416 - error: host.iobroker-VM03 Caught by controller[1]: <--- JS stacktrace --->
2022-05-01 18:57:30.416 - error: host.iobroker-VM03 Caught by controller[1]: FATAL ERROR: Ineffective mark-compacts near heap limit Allocation failed - JavaScript heap out of memory
2022-05-01 18:57:30.417 - error: host.iobroker-VM03 Caught by controller[2]: 1: 0xa3aaf0 node::Abort() [io.history.0]
2022-05-01 18:57:30.417 - error: host.iobroker-VM03 Caught by controller[2]: 2: 0x970199 node::FatalError(char const*, char const*) [io.history.0]
2022-05-01 18:57:30.417 - error: host.iobroker-VM03 Caught by controller[3]: 3: 0xbba45e v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [io.history.0]
2022-05-01 18:57:30.417 - error: host.iobroker-VM03 Caught by controller[4]: 4: 0xbba7d7 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [io.history.0]
2022-05-01 18:57:30.417 - error: host.iobroker-VM03 Caught by controller[4]: 5: 0xd769e5 [io.history.0]
2022-05-01 18:57:30.417 - error: host.iobroker-VM03 Caught by controller[4]: 6: 0xd7756f [io.history.0]
2022-05-01 18:57:30.417 - error: host.iobroker-VM03 Caught by controller[4]: 7: 0xd853ab v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [io.history.0]
2022-05-01 18:57:30.417 - error: host.iobroker-VM03 Caught by controller[4]: 8: 0xd88f6c v8::internal::Heap::AllocateRawWithRetryOrFailSlowPath(int, v8::internal::AllocationType, v8::internal::AllocationOrigin, v8::internal::AllocationAlignment) [io.history.0]
2022-05-01 18:57:30.417 - error: host.iobroker-VM03 Caught by controller[5]: 9: 0xd4e73d v8::internal::Factory::AllocateRaw(int, v8::internal::AllocationType, v8::internal::AllocationAlignment) [io.history.0]
2022-05-01 18:57:30.417 - error: host.iobroker-VM03 Caught by controller[6]: 10: 0xd4a999 v8::internal::FactoryBase::AllocateRawArray(int, v8::internal::AllocationType) [io.history.0]
2022-05-01 18:57:30.418 - error: host.iobroker-VM03 Caught by controller[7]: 11: 0xd4aa54 v8::internal::FactoryBase::NewFixedArrayWithFiller(v8::internal::Handle, int, v8::internal::Handle, v8::internal::AllocationType) [io.history.0]
2022-05-01 18:57:30.418 - error: host.iobroker-VM03 Caught by controller[8]: 12: 0xf80ffe v8::internal::Handle v8::internal::HashTable::New(v8::internal::Isolate*, int, v8::internal::AllocationType, v8::internal::MinimumCapacity) [io.history.0]
2022-05-01 18:57:30.418 - error: host.iobroker-VM03 Caught by controller[9]: 13: 0xf81cf9 v8::internal::Handle v8::internal::BaseNameDictionary::New(v8::internal::Isolate*, int, v8::internal::AllocationType, v8::internal::MinimumCapacity) [io.history.0]
2022-05-01 18:57:30.418 - error: host.iobroker-VM03 Caught by controller[9]: 14: 0xf35be1 v8::internal::JSObject::MigrateToMap(v8::internal::Isolate*, v8::internal::Handle, v8::internal::Handle, int) [io.history.0]
2022-05-01 18:57:30.418 - error: host.iobroker-VM03 Caught by controller[9]: 15: 0xf556cc v8::internal::LookupIterator::Delete() [io.history.0]
2022-05-01 18:57:30.418 - error: host.iobroker-VM03 Caught by controller[9]: 16: 0xf2c55b v8::internal::JSReceiver::DeleteProperty(v8::internal::LookupIterator*, v8::internal::LanguageMode) [io.history.0]
2022-05-01 18:57:30.418 - error: host.iobroker-VM03 Caught by controller[9]: 17: 0x10b4600 v8::internal::Runtime::DeleteObjectProperty(v8::internal::Isolate*, v8::internal::Handle, v8::internal::Handle, v8::internal::LanguageMode) [io.history.0]
2022-05-01 18:57:30.418 - error: host.iobroker-VM03 Caught by controller[9]: 18: 0x10b673a v8::internal::Runtime_DeleteProperty(int, unsigned long*, v8::internal::Isolate*) [io.history.0]
2022-05-01 18:57:30.418 - error: host.iobroker-VM03 Caught by controller[9]: 19: 0x1448e19 [io.history.0]
2022-05-01 18:57:30.418 - warn: host.iobroker-VM03 instance system.adapter.history.0 terminated due to SIGABRT
2022-05-01 18:57:30.418 - info: host.iobroker-VM03 instance system.adapter.history.0 terminated with code NaN ()
2022-05-01 18:57:30.418 - info: host.iobroker-VM03 Restart adapter system.adapter.history.0 because enabled
2022-05-01 18:58:00.450 - info: host.iobroker-VM03 instance system.adapter.history.0 started with pid 323469

dann die tausend Meldungen enabled logging of....

ein paar wenige debug mit found alias

zwischendrin noch

2022-05-01 18:58:09.706 - debug: history.0 (323704) Redis Objects: Use Redis connection: 0.0.0.0:9001
2022-05-01 18:58:09.729 - debug: history.0 (323704) Objects client ready ... initialize now
2022-05-01 18:58:09.730 - debug: history.0 (323704) Objects create System PubSub Client
2022-05-01 18:58:09.731 - debug: history.0 (323704) Objects create User PubSub Client
2022-05-01 18:58:09.731 - debug: history.0 (323704) Objects client initialize lua scripts
2022-05-01 18:58:09.746 - debug: history.0 (323704) Objects connected to redis: 0.0.0.0:9001
2022-05-01 18:58:09.750 - debug: history.0 (323704) objectDB connected
2022-05-01 18:58:09.751 - debug: history.0 (323704) Redis States: Use Redis connection: 0.0.0.0:9000
2022-05-01 18:58:09.758 - debug: history.0 (323704) States create System PubSub Client
2022-05-01 18:58:09.759 - debug: history.0 (323704) States create User PubSub Client
2022-05-01 18:58:09.768 - debug: history.0 (323704) States connected to redis: 0.0.0.0:9000
2022-05-01 18:58:09.768 - debug: history.0 (323704) statesDB connected
2022-05-01 18:58:09.996 - debug: history.0 (323704) Plugin sentry Initialize Plugin (enabled=true)

und dann wieder:

2022-05-01 18:58:13.235 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.JEQ0646431.1.STATE","path":"/opt/iobroker/iobroker-data/history/","start":1651164932467,"end":1651424132467,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"onchange","limit":2000,"addId":false,"sessionId":934,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:13.236 - debug: history.0 (323704) got 2 datapoints for hm-rpc.0.JEQ0646431.1.STATE
2022-05-01 18:58:13.260 - debug: history.0 (323704) Send: 176 values in: 25ms
2022-05-01 18:58:13.261 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:13.263 - debug: history.0 (323704) getHistory call: {"id":"Messwerte.0.Pool.Druck_real","path":"/opt/iobroker/iobroker-data/history/","start":1651164932467,"end":1651424132467,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"onchange","limit":2000,"addId":false,"sessionId":934,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:13.264 - debug: history.0 (323704) got 1 datapoints for Messwerte.0.Pool.Druck_real
2022-05-01 18:58:13.298 - debug: history.0 (323704) Send: 2951 values in: 35ms
2022-05-01 18:58:13.298 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:13.303 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.JEQ0140901.1.TEMPERATURE","path":"/opt/iobroker/iobroker-data/history/","start":1651164932467,"end":1651424132467,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":934,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:13.303 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:13.311 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.LEQ0773306.2.TEMPERATURE","path":"/opt/iobroker/iobroker-data/history/","start":1651164932467,"end":1651424132467,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":934,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:13.312 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:13.397 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.JEQ0140901.1.TEMPERATURE
2022-05-01 18:58:13.407 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.LEQ0773306.2.TEMPERATURE
2022-05-01 18:58:13.433 - debug: history.0 (323704) Send: 63 of: 1413 in: 130ms
2022-05-01 18:58:13.433 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:13.438 - debug: history.0 (323704) Send: 59 of: 418 in: 127ms
2022-05-01 18:58:13.439 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:16.791 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.NEQ0384904.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651381096528,"end":1651424296528,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":60,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:16.791 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:16.863 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.NEQ0384904.2.POWER
2022-05-01 18:58:16.892 - debug: history.0 (323704) Send: 26 of: 39 in: 101ms
2022-05-01 18:58:16.893 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:17.777 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.LTK0124191.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651381096528,"end":1651424296528,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":60,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:17.778 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:17.786 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.KEQ0966548.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651381096528,"end":1651424296528,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":60,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:17.786 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:17.794 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.KEQ0967747.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651381096528,"end":1651424296528,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":60,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:17.794 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:17.801 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.NEQ0386317.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651381096528,"end":1651424296528,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":60,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:17.802 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:17.812 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.LTK0124795.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651381096528,"end":1651424296528,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":60,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:17.812 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:17.827 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.LTK0124195.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651381096528,"end":1651424296528,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":60,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:17.828 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:17.842 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.LTK0124798.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651381096528,"end":1651424296528,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":60,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:17.842 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:17.860 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.LTK0124143.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651381096528,"end":1651424296528,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":60,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:17.862 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:17.886 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.REQ0777349.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651381096528,"end":1651424296528,"step":100000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":2000,"addId":false,"sessionId":60,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:17.887 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:17.901 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.NEQ0116043.2.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651381096528,"end":1651424296528,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":60,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:17.901 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:17.937 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.1.0001D3C99C3EFB.6.POWER","path":"/opt/iobroker/iobroker-data/history/","start":1651381096528,"end":1651424296528,"step":100000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":60,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:17.938 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:17.972 - debug: history.0 (323704) got 2 datapoints for hm-rpc.0.LTK0124795.2.POWER
2022-05-01 18:58:18.003 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.LTK0124191.2.POWER
2022-05-01 18:58:18.013 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.KEQ0967747.2.POWER
2022-05-01 18:58:18.173 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.KEQ0966548.2.POWER
2022-05-01 18:58:18.174 - debug: history.0 (323704) Send: 283 of: 331 in: 362ms
2022-05-01 18:58:18.175 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:18.177 - debug: history.0 (323704) Send: 182 of: 195 in: 400ms
2022-05-01 18:58:18.178 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:18.182 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.NEQ0386317.2.POWER
2022-05-01 18:58:18.184 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.REQ0777349.2.POWER
2022-05-01 18:58:18.193 - debug: history.0 (323704) Send: 179 of: 192 in: 399ms
2022-05-01 18:58:18.194 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:18.203 - debug: history.0 (323704) got 2 datapoints for hm-rpc.0.LTK0124195.2.POWER
2022-05-01 18:58:18.206 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.LTK0124798.2.POWER
2022-05-01 18:58:18.232 - debug: history.0 (323704) Send: 200 of: 213 in: 446ms
2022-05-01 18:58:18.233 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:18.237 - debug: history.0 (323704) Send: 192 of: 212 in: 436ms
2022-05-01 18:58:18.238 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:18.240 - debug: history.0 (323704) Send: 28 of: 39 in: 354ms
2022-05-01 18:58:18.242 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:18.243 - debug: history.0 (323704) Send: 364 of: 1318 in: 416ms
2022-05-01 18:58:18.244 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:18.245 - debug: history.0 (323704) Send: 303 of: 570 in: 403ms
2022-05-01 18:58:18.246 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:18.249 - debug: history.0 (323704) got 1 datapoints for hm-rpc.1.0001D3C99C3EFB.6.POWER
2022-05-01 18:58:18.254 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.LTK0124143.2.POWER
2022-05-01 18:58:18.261 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.NEQ0116043.2.POWER
2022-05-01 18:58:18.265 - debug: history.0 (323704) Send: 40 of: 46 in: 328ms
2022-05-01 18:58:18.265 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:18.266 - debug: history.0 (323704) Send: 284 of: 292 in: 406ms
2022-05-01 18:58:18.267 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:18.274 - debug: history.0 (323704) Send: 33 of: 39 in: 372ms
2022-05-01 18:58:18.274 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:21.810 - debug: history.0 (323704) getHistory call: {"id":"hm-rega.0.1995","path":"/opt/iobroker/iobroker-data/history/","start":1651165101563,"end":1651424301563,"step":null,"count":3000,"from":false,"ack":false,"q":false,"ignoreNull":"true","aggregate":"minmax","limit":3000,"addId":false,"sessionId":96,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:21.810 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:21.818 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.JEQ0140901.1.WIND_SPEED","path":"/opt/iobroker/iobroker-data/history/","start":1650819501567,"end":1651424301567,"step":null,"count":400,"from":false,"ack":false,"q":false,"aggregate":"max","limit":400,"addId":false,"sessionId":49,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:21.818 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:21.892 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.JEQ0140901.1.WIND_SPEED
2022-05-01 18:58:21.927 - debug: history.0 (323704) got 1 datapoints for hm-rega.0.1995
2022-05-01 18:58:21.938 - debug: history.0 (323704) Send: 153 of: 167 in: 127ms
2022-05-01 18:58:21.938 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:21.942 - debug: history.0 (323704) Send: 356 of: 2640 in: 124ms
2022-05-01 18:58:21.943 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:22.776 - debug: history.0 (323704) getHistory call: {"id":"Messwerte.0.Wetterdaten.Regenintensitaet","path":"/opt/iobroker/iobroker-data/history/","start":1651165101563,"end":1651424301563,"step":null,"count":3000,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"minmax","limit":3000,"addId":false,"sessionId":96,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:22.776 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:22.783 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.KEQ1022589.1.STATE","path":"/opt/iobroker/iobroker-data/history/","start":1651165101563,"end":1651424301563,"step":null,"count":3000,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":3000,"addId":false,"sessionId":96,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:22.784 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:22.793 - debug: history.0 (323704) getHistory call: {"id":"hm-rega.0.12770","path":"/opt/iobroker/iobroker-data/history/","start":1650819501567,"end":1651424301567,"step":null,"count":400,"from":false,"ack":false,"q":false,"aggregate":"average","limit":400,"addId":false,"sessionId":49,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:22.793 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:22.801 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.JEQ0140901.1.WIND_SPEED","path":"/opt/iobroker/iobroker-data/history/","start":1650819501567,"end":1651424301567,"step":null,"count":400,"from":false,"ack":false,"q":false,"aggregate":"min","limit":400,"addId":false,"sessionId":49,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:22.802 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:22.906 - debug: history.0 (323704) got 1 datapoints for hm-rega.0.12770
2022-05-01 18:58:22.920 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.JEQ0140901.1.WIND_SPEED
2022-05-01 18:58:22.945 - debug: history.0 (323704) got 1 datapoints for Messwerte.0.Wetterdaten.Regenintensitaet
2022-05-01 18:58:22.963 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.KEQ1022589.1.STATE
2022-05-01 18:58:22.975 - debug: history.0 (323704) Send: 165 of: 179 in: 192ms
2022-05-01 18:58:22.976 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:22.987 - debug: history.0 (323704) Send: 357 of: 2640 in: 186ms
2022-05-01 18:58:22.988 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:23.006 - debug: history.0 (323704) Send: 16 of: 21 in: 230ms
2022-05-01 18:58:23.006 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:23.010 - debug: history.0 (323704) Send: 368 of: 3430 in: 218ms
2022-05-01 18:58:23.010 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:42.385 - debug: history.0 (323704) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Solarestimate2","path":"/opt/iobroker/iobroker-data/history/","start":1651356000000,"end":1651442400000,"step":null,"count":300,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":300,"addId":false,"sessionId":875,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:42.386 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:42.393 - debug: history.0 (323704) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Leistung_AC_aktuell","path":"/opt/iobroker/iobroker-data/history/","start":1651356000000,"end":1651442400000,"step":null,"count":300,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":300,"addId":false,"sessionId":875,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:42.393 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:42.398 - debug: history.0 (323704) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch","path":"/opt/iobroker/iobroker-data/history/","start":1651356000000,"end":1651442400000,"step":null,"count":300,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"minmax","limit":300,"addId":false,"sessionId":875,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:42.399 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:42.406 - debug: history.0 (323704) getHistory call: {"id":"Messwerte.0.Stromzaehler.Momentanwerte.akt_Verbrauch","path":"/opt/iobroker/iobroker-data/history/","start":1651356000000,"end":1651442400000,"step":null,"count":300,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":300,"addId":false,"sessionId":875,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:42.407 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:42.413 - debug: history.0 (323704) getHistory call: {"id":"Messwerte.0.Stromzaehler.Momentanwerte.akt_Einspeisung","path":"/opt/iobroker/iobroker-data/history/","start":1651356000000,"end":1651442400000,"step":null,"count":300,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":300,"addId":false,"sessionId":875,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:42.413 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:42.482 - debug: history.0 (323704) got 4 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Leistung_AC_aktuell
2022-05-01 18:58:42.499 - debug: history.0 (323704) got 6 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch
2022-05-01 18:58:42.512 - debug: history.0 (323704) got 2 datapoints for Messwerte.0.Stromzaehler.Momentanwerte.akt_Einspeisung
2022-05-01 18:58:42.516 - debug: history.0 (323704) got 1 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Solarestimate2
2022-05-01 18:58:42.571 - debug: history.0 (323704) Send: 161 of: 6024 in: 178ms
2022-05-01 18:58:42.571 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:42.589 - debug: history.0 (323704) Send: 157 of: 736 in: 204ms
2022-05-01 18:58:42.589 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:42.595 - debug: history.0 (323704) Send: 152 of: 4825 in: 182ms
2022-05-01 18:58:42.595 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:42.612 - debug: history.0 (323704) got 5 datapoints for Messwerte.0.Stromzaehler.Momentanwerte.akt_Verbrauch
2022-05-01 18:58:42.652 - debug: history.0 (323704) Send: 178 of: 6341 in: 254ms
2022-05-01 18:58:42.652 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:42.694 - debug: history.0 (323704) Send: 241 of: 8896 in: 288ms
2022-05-01 18:58:42.694 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:43.234 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.JEQ0646431.1.STATE","path":"/opt/iobroker/iobroker-data/history/","start":1651164962469,"end":1651424162469,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"onchange","limit":2000,"addId":false,"sessionId":935,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:43.234 - debug: history.0 (323704) got 2 datapoints for hm-rpc.0.JEQ0646431.1.STATE
2022-05-01 18:58:43.271 - debug: history.0 (323704) Send: 176 values in: 37ms
2022-05-01 18:58:43.271 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:43.273 - debug: history.0 (323704) getHistory call: {"id":"Messwerte.0.Pool.Druck_real","path":"/opt/iobroker/iobroker-data/history/","start":1651164962469,"end":1651424162469,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"ignoreNull":"false","aggregate":"onchange","limit":2000,"addId":false,"sessionId":935,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:43.273 - debug: history.0 (323704) got 1 datapoints for Messwerte.0.Pool.Druck_real
2022-05-01 18:58:43.303 - debug: history.0 (323704) Send: 2951 values in: 30ms
2022-05-01 18:58:43.303 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:43.310 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.JEQ0140901.1.TEMPERATURE","path":"/opt/iobroker/iobroker-data/history/","start":1651164962469,"end":1651424162469,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":935,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:43.310 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:43.316 - debug: history.0 (323704) getHistory call: {"id":"hm-rpc.0.LEQ0773306.2.TEMPERATURE","path":"/opt/iobroker/iobroker-data/history/","start":1651164962469,"end":1651424162469,"step":4800000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"sessionId":935,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:43.316 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:43.383 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.JEQ0140901.1.TEMPERATURE
2022-05-01 18:58:43.396 - debug: history.0 (323704) got 1 datapoints for hm-rpc.0.LEQ0773306.2.TEMPERATURE
2022-05-01 18:58:43.410 - debug: history.0 (323704) Send: 63 of: 1413 in: 100ms
2022-05-01 18:58:43.411 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:43.419 - debug: history.0 (323704) Send: 59 of: 418 in: 103ms
2022-05-01 18:58:43.419 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.web.0 from system.adapter.history.0
2022-05-01 18:58:51.231 - debug: history.0 (323704) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Leistung_String1","path":"/opt/iobroker/iobroker-data/history/","start":1651334400000,"end":1651424330980,"step":3600000,"count":500,"from":false,"ack":false,"q":false,"aggregate":"minmax","limit":2000,"addId":false,"returnNewestEntries":false,"percentile":null,"quantile":null,"integralUnit":null,"integralInterpolation":null,"removeBorderValues":false,"round":null}
2022-05-01 18:58:51.232 - debug: history.0 (323704) use parallel requests for getHistory
2022-05-01 18:58:51.293 - debug: history.0 (323704) got 6 datapoints for Messwerte.0.Solaranlage.Momentanwerte.Leistung_String1
2022-05-01 18:58:51.372 - debug: history.0 (323704) Send: 19 of: 8168 in: 141ms
2022-05-01 18:58:51.372 - debug: history.0 (323704) sendTo "getHistory" to system.adapter.admin.0 from system.adapter.history.0
2022-05-01 18:58:52.856 - debug: history.0 (323704) sendTo "features" to system.adapter.admin.0 from system.adapter.history.0
2022-05-01 18:58:52.966 - debug: history.0 (323704) getHistory call: {"id":"Messwerte.0.Solaranlage.Momentanwerte.Eigenverbrauch","path":"/opt/iobroker/iobroker-

Hat lange gedauert, aber habe ich das richtig verstanden, dass erst der gesamte Tag eingelesen wird, mit allen DPs?
Das sind bei mir etwa 50MB

apollon77

@homoran kann das sein das auch deine Vis so oft alles neu lädt?!

Also die Abfolge passt ja. Zuerst der Crash (was genau loggt er denn VOR dem Crash??) dann startet er neu, aktiviert alle datenpunkte und dann kommen ggf von Vis oder admin Dinge rein.

ich schaue heute Abend nochmal log weil an sich sollte das alles nicht sooooo wild sein mit RAM weil an sich die datenabfrage und nem extra Prozess passiert.

Community Forum

NEWS

Test Adapter History 2.0.0

Support us

620

32.4k

81.4k

1.3m