copystring / ioBroker.roborock

Roborock ioBroker Adapter
MIT License
48 stars 22 forks source link

S8 Pro Ultra - Adapter crasht beim Update der Map #148

Closed brasax closed 1 year ago

brasax commented 1 year ago

Describe the bug
S8 Pro Ultra - Adapter crasht beim Update der Map.

To Reproduce
Map erstellen im Adapater aktivieren und S8 starten. Adapter crasht mit diversen Exceptions, siehe Log.

Expected behavior
A clear and concise description of what you expected to happen.

Screenshots & Logfiles

host.debian | 2023-05-04 15:42:34.248 | info | Restart adapter system.adapter.roborock.0 because enabled
host.debian | 2023-05-04 15:42:34.248 | info | instance system.adapter.roborock.0 terminated with code NaN ()
host.debian | 2023-05-04 15:42:34.248 | warn | instance system.adapter.roborock.0 terminated due to SIGABRT
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: 12: 0x15d9c19 [io.roborock.0]
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: 11: 0x11e5864 v8::internal::Runtime_StackGuardWithGap(int, unsigned long*, v8::internal::Isolate*) [io.roborock.0]
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: 10: 0xe39287 v8::internal::StackGuard::HandleInterrupts() [io.roborock.0]
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: 9: 0xeabbe5 v8::internal::Heap::HandleGCRequest() [io.roborock.0]
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: 8: 0xea8cf0 v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [io.roborock.0]
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: 7: 0xea82ae [io.roborock.0]
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: 6: 0xe99d86 [io.roborock.0]
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: 5: 0xe992a5 [io.roborock.0]
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: 4: 0xce1c37 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [io.roborock.0]
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: 3: 0xce1890 v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [io.roborock.0]
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: 2: 0xa1b70e [io.roborock.0]
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: 1: 0xb08e80 node::Abort() [io.roborock.0]
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: FATAL ERROR: Ineffective mark-compacts near heap limit Allocation failed - JavaScript heap out of memory
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: <--- JS stacktrace --->
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: [3163:0x58bc0d0] 50713 ms: Scavenge (reduce) 2042.0 (2079.6) -> 2041.3 (2079.6) MB, 7.2 / 0.0 ms (average mu = 0.282, current mu = 0.263) allocation failure
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: [3163:0x58bc0d0] 50673 ms: Scavenge (reduce) 2041.9 (2079.1) -> 2041.2 (2079.6) MB, 11.0 / 0.0 ms (average mu = 0.282, current mu = 0.263) allocation failure
host.debian | 2023-05-04 15:42:34.248 | error | Caught by controller[0]: [3163:0x58bc0d0] 50627 ms: Scavenge (reduce) 2041.8 (2079.1) -> 2041.1 (2079.1) MB, 13.5 / 0.0 ms (average mu = 0.282, current mu = 0.263) allocation failure
host.debian | 2023-05-04 15:42:34.247 | error | Caught by controller[0]: <--- Last few GCs --->
roborock.0 | 2023-05-04 15:41:47.585 | debug | Length of message queue: 7
roborock.0 | 2023-05-04 15:41:47.568 | debug | Length of message queue: 8
roborock.0 | 2023-05-04 15:41:47.567 | debug | null - 14525
roborock.0 | 2023-05-04 15:41:47.567 | debug | dps debug: {"id":7411,"result":["ok"]}
roborock.0 | 2023-05-04 15:41:47.467 | debug | Update map
roborock.0 | 2023-05-04 15:41:46.842 | debug | downloadURL: https://github.com/AlexxIT/go2rtc/releases/download/v1.3.0/go2rtc_linux_amd64
roborock.0 | 2023-05-04 15:41:46.842 | debug | System type: go2rtc_linux_amd64
roborock.0 | 2023-05-04 15:41:46.842 | debug | platform: linux
roborock.0 | 2023-05-04 15:41:46.842 | debug | arch: x64
roborock.0 | 2023-05-04 15:41:46.841 | debug | getParameter: get_network_info
roborock.0 | 2023-05-04 15:41:46.841 | debug | getParameter: get_consumable
roborock.0 | 2023-05-04 15:41:46.841 | debug | getParameter: get_room_mapping
roborock.0 | 2023-05-04 15:41:46.841 | debug | getParameter: get_status
roborock.0 | 2023-05-04 15:41:46.841 | debug | Latest data requested
roborock.0 | 2023-05-04 15:41:46.841 | debug | getParameter: get_multi_maps_list
roborock.0 | 2023-05-04 15:41:46.840 | debug | Firmware features request
roborock.0 | 2023-05-04 15:41:46.840 | debug | getParameter: get_fw_features
roborock.0 | 2023-05-04 15:41:46.321 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:46.321 | debug | dps debug: {"id":4743,"result":[{"begin":1682868360,"end":1682868449,"duration":88,"area":1225000,"error":0,"complete":1,"start_type":2,"clean_type":2,"finish_reason":54,"dust_collection_status":0,"avoid_count":6,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:46.279 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:46.279 | debug | dps debug: {"id":3373,"result":[{"begin":1682868479,"end":1682868723,"duration":244,"area":952500,"error":0,"complete":1,"start_type":2,"clean_type":2,"finish_reason":54,"dust_collection_status":0,"avoid_count":43,"wash_count":1,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:46.229 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:46.229 | debug | dps debug: {"id":3888,"result":[{"begin":1682869054,"end":1682869314,"duration":259,"area":4257500,"error":0,"complete":1,"start_type":2,"clean_type":2,"finish_reason":54,"dust_collection_status":1,"avoid_count":10,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:46.193 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:46.193 | debug | dps debug: {"id":3383,"result":[{"begin":1682876419,"end":1682877162,"duration":599,"area":7822500,"error":0,"complete":1,"start_type":2,"clean_type":3,"finish_reason":56,"dust_collection_status":1,"avoid_count":19,"wash_count":2,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:46.155 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:46.155 | debug | dps debug: {"id":5674,"result":[{"begin":1682888806,"end":1682889203,"duration":397,"area":5690000,"error":0,"complete":1,"start_type":2,"clean_type":3,"finish_reason":56,"dust_collection_status":0,"avoid_count":9,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:46.119 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:46.118 | debug | dps debug: {"id":2070,"result":[{"begin":1682926465,"end":1682926692,"duration":227,"area":2557500,"error":0,"complete":1,"start_type":101,"clean_type":3,"finish_reason":56,"dust_collection_status":0,"avoid_count":14,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:46.080 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:46.080 | debug | dps debug: {"id":3438,"result":[{"begin":1682927041,"end":1682927158,"duration":117,"area":1592500,"error":0,"complete":1,"start_type":2,"clean_type":3,"finish_reason":56,"dust_collection_status":0,"avoid_count":3,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:46.030 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:46.030 | debug | dps debug: {"id":1167,"result":[{"begin":1682927212,"end":1682927598,"duration":126,"area":2170000,"error":0,"complete":0,"start_type":2,"clean_type":3,"finish_reason":43,"dust_collection_status":0,"avoid_count":11,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:45.979 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:45.978 | debug | dps debug: {"id":8199,"result":[{"begin":1682927616,"end":1682928010,"duration":394,"area":2637500,"error":0,"complete":1,"start_type":2,"clean_type":3,"finish_reason":56,"dust_collection_status":0,"avoid_count":19,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:45.934 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:45.934 | debug | dps debug: {"id":8455,"result":[{"begin":1682928043,"end":1682928208,"duration":165,"area":1787500,"error":0,"complete":1,"start_type":2,"clean_type":3,"finish_reason":56,"dust_collection_status":0,"avoid_count":19,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:45.896 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:45.896 | debug | dps debug: {"id":2210,"result":[{"begin":1682952788,"end":1682952828,"duration":40,"area":0,"error":0,"complete":0,"start_type":2,"clean_type":3,"finish_reason":60,"dust_collection_status":0,"avoid_count":3,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:45.859 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:45.859 | debug | dps debug: {"id":3723,"result":[{"begin":1682955821,"end":1682958464,"duration":1880,"area":23302500,"error":0,"complete":1,"start_type":2,"clean_type":1,"finish_reason":52,"dust_collection_status":1,"avoid_count":132,"wash_count":6,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:45.823 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:45.823 | debug | dps debug: {"id":7006,"result":[{"begin":1683022575,"end":1683025679,"duration":1976,"area":23892500,"error":0,"complete":1,"start_type":2,"clean_type":1,"finish_reason":52,"dust_collection_status":1,"avoid_count":95,"wash_count":5,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:45.781 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:45.780 | debug | dps debug: {"id":9495,"result":[{"begin":1683046356,"end":1683048169,"duration":1813,"area":24192500,"error":0,"complete":1,"start_type":810,"clean_type":1,"finish_reason":52,"dust_collection_status":1,"avoid_count":129,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:45.742 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:45.742 | debug | dps debug: {"id":4293,"result":[{"begin":1683098215,"end":1683100021,"duration":1806,"area":23550000,"error":0,"complete":1,"start_type":2,"clean_type":1,"finish_reason":52,"dust_collection_status":0,"avoid_count":143,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:45.690 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:45.690 | debug | dps debug: {"id":6942,"result":[{"begin":1683120796,"end":1683123347,"duration":1890,"area":23722500,"error":0,"complete":1,"start_type":2,"clean_type":1,"finish_reason":52,"dust_collection_status":1,"avoid_count":152,"wash_count":4,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:45.651 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:45.651 | debug | dps debug: {"id":6370,"result":[{"begin":1683194795,"end":1683196623,"duration":1827,"area":24110000,"error":0,"complete":1,"start_type":2,"clean_type":1,"finish_reason":52,"dust_collection_status":1,"avoid_count":97,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:45.615 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:45.614 | debug | dps debug: {"id":4530,"result":[{"begin":1683203512,"end":1683203761,"duration":221,"area":2457500,"error":0,"complete":1,"start_type":2,"clean_type":3,"finish_reason":56,"dust_collection_status":1,"avoid_count":21,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:45.579 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:45.579 | debug | dps debug: {"id":6264,"result":[{"begin":1683205536,"end":1683205828,"duration":292,"area":2500000,"error":0,"complete":1,"start_type":2,"clean_type":3,"finish_reason":56,"dust_collection_status":1,"avoid_count":25,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:45.541 | debug | Length of message queue: 0
roborock.0 | 2023-05-04 15:41:45.541 | debug | dps debug: {"id":6093,"result":[{"begin":1683206210,"end":1683206410,"duration":200,"area":2487500,"error":0,"complete":1,"start_type":2,"clean_type":3,"finish_reason":56,"dust_collection_status":1,"avoid_count":17,"wash_count":0,"map_flag":0}]}
roborock.0 | 2023-05-04 15:41:45.478 | debug | Mapped room matched: 10627499 with name: Esszimmer
roborock.0 | 2023-05-04 15:41:45.478 | debug | Mapped room matched: 11742236 with name: Flur
roborock.0 | 2023-05-04 15:41:45.478 | debug | Mapped room matched: 10627510 with name: Wohnzimmer
roborock.0 | 2023-05-04 15:41:45.478 | debug | Mapped room matched: 10627507 with name: Couch
roborock.0 | 2023-05-04 15:41:45.477 | debug | Mapped room matched: 10627496 with name: Küche
roborock.0 | 2023-05-04 15:41:45.477 | debug | Mapped room matched: 11742231 with name: Eingang
roborock.0 | 2023-05-04 15:41:45.477 | debug | All mapped rooms: [[16,"11742231",12],[17,"10627496",14],[18,"10627507",12],[19,"10627510",6],[20,"11742236",8],[21,"10627499",13]]
roborock.0 | 2023-05-04 15:41:45.477 | debug | Length of message queue: 1
roborock.0 | 2023-05-04 15:41:45.477 | debug | dps debug: {"id":7658,"result":[[16,"11742231",12],[17,"10627496",14],[18,"10627507",12],[19,"10627510",6],[20,"11742236",8],[21,"10627499",13]]}
roborock.0 | 2023-05-04 15:41:45.476 | debug | Length of message queue: 1
roborock.0 | 2023-05-04 15:41:45.476 | debug | dps debug: {"id":9371,"result":{"clean_time":30943,"clean_area":392742500,"clean_count":42,"dust_collection_count":19,"records":[1683206210,1683205536,1683203512,1683194795,1683120796,1683098215,1683046356,1683022575,1682955821,1682952788,1682928043,1682927616,1682927212,1682927041,1682926465,1682888806,1682876419,1682869054,1682868479,1682868360]}}
roborock.0 | 2023-05-04 15:41:45.467 | debug | Length of message queue: 2
roborock.0 | 2023-05-04 15:41:45.467 | debug | dps debug: {"id":1903,"result":[{"enable":1,"current_integral":450,"current_high":500,"current_low":400,"stall_time":10}]}
roborock.0 | 2023-05-04 15:41:45.467 | debug | Length of message queue: 3
roborock.0 | 2023-05-04 15:41:45.467 | debug | dps debug: {"id":7586,"result":[{"carpet_clean_mode":3}]}
roborock.0 | 2023-05-04 15:41:45.466 | debug | Started map updater on robot:xxxxxxxxxxxxxx

Bin auch die vorherigen Fehler durch. Immer beim

roborock.0 | 2023-05-04 15:41:47.585 | debug | Length of message queue: 7
roborock.0 | 2023-05-04 15:41:47.568 | debug | Length of message queue: 8
roborock.0 | 2023-05-04 15:41:47.567 | debug | null - 14525
roborock.0 | 2023-05-04 15:41:47.567 | debug | dps debug: {"id":7411,"result":["ok"]}
roborock.0 | 2023-05-04 15:41:47.467 | debug | Update map

fällt er auf die Nase. Also mal die Map im Adapter deaktiviert und keine Exception mehr.

Versions:

copystring commented 1 year ago

Ist das mit der neuesten dev immer noch so? Ich glaube, dass es gar nicht am S8 liegt, sondern allgemein gar nicht lief :)

brasax commented 1 year ago

Muss ich morgen mal schauen wann ich die letzte DEV installiert habe.

Ich habe ja noch einen S6MaxV und der Adapter ist vorher nicht abgestürzt, die Map war aktiv (auch wenn ich sie nicht genutzt habe).

Mit dem S8 gabs dann erst die Crashes. Habe die Scripte vom S6 erst auf den S8 umgeschrieben, bzw ergänzt, daher ist mir das nicht aufgefallen.

brasax commented 1 year ago

Fehler ist immer noch vorhanden, siehe log. Beim S6 kommt lediglich:

The error was: Error: Request with id 2256 timed out after 10 seconds for response.102

log_s8.txt

copystring commented 1 year ago

Vor einer Weile habe ich alle Timeouts als Warnung, anstatt als Error eingestellt. Das ist schon ein paar Tage her. Du hast also nicht die aktuellste dev Version installiert.

brasax commented 1 year ago

Wenn ich den hier angebe beim installieren, dann zieht er sich doch die letzte Version, oder?

copystring/ioBroker.roborock#dev

2023-05-07 11:40:28.165 - info: host.debian iobroker Installing copystring/ioBroker.roborock#dev... (System call)

copystring commented 1 year ago

Hier gib es die dev: https://github.com/copystring/ioBroker.roborock/tree/dev

brasax commented 1 year ago

Äh, ja..

iOBroker kürzt den Link im Log, also -> ich hatte die letzte Dev installiert. Abgesehen davon ist in dem Log ein TimeOut zu finden als "Debug" und nicht als Error..

host.debian | 2023-05-12 18:33:29.794 | info | iobroker Installing copystring/ioBroker.roborock#dev... (System call)
host.debian | 2023-05-12 18:33:29.794 | info | iobroker NPM version: 8.19.3
host.debian | 2023-05-12 18:33:29.474 | info | iobroker install copystring/ioBroker.roborock#dev
host.debian | 2023-05-12 18:33:28.618 | info | iobroker url https://github.com/copystring/ioBroker.roborock/tree/dev --host debian --debug
copystring commented 1 year ago

Das sieht nicht so aus wie das richtige log.

brasax commented 1 year ago

Was erwartest du für ein Log? Das vom iOBroker oder ein anderes? Der Auszug ist vom Protokoll innerhalb von iOBroker auf "silly" gestellt:

image
copystring commented 1 year ago

Genauso wie dein allererstes log ganz oben.

brasax commented 1 year ago

Wir reden grad aneinander vorbei. Du hattest geschrieben, ich hätte nicht die aktuelle DEV installiert, daher habe ich dir einen kurzen Auszug aus dem Log gepostet, damit du siehst, dass ich diese erst Minuten vorher installiert hatte.

Daraufhin hast du mir den Link gepostet, den ich eigentlich auch geschrieben hatte (aber gekürzt), daher der Hinweis, iobroker kürzt den Link im Log, wieder mit einem Auszug aus dem Log, damit du das sehen kannst.

Mein Hinweis mit dem TimeOut bezog sich auf das Log, das ich als txt gepostet hatte weiter oben.

Ich kann gerne nochmal ein Log liefern die Tage.

copystring commented 1 year ago

Ja, scheint so zu sein :). In der neuen dev ist ein fataler Fehler behoben. Teste mal die neue dev. Wenn alles läuft, brauche ich kein Log mehr.

brasax commented 1 year ago

:)

Also, sobald ich das Kartenupdate aktiviere, fällt er gleich wieder auf die Schnauze:

Und davor den Adapter installiert:

host.debian | 2023-05-13 13:23:41.121 | info | iobroker 122 packages are looking for funding run `npm fund` for details
host.debian | 2023-05-13 13:23:41.120 | info | iobroker
host.debian | 2023-05-13 13:23:41.120 | info | iobroker removed 197 packages, and changed 1 package in 4s
host.debian | 2023-05-13 13:23:36.627 | info | iobroker Installing copystring/ioBroker.roborock#dev... (System call)
host.debian | 2023-05-13 13:23:36.626 | info | iobroker NPM version: 8.19.3
host.debian | 2023-05-13 13:23:36.334 | info | iobroker install copystring/ioBroker.roborock#dev
host.debian | 2023-05-13 13:23:35.655 | info | iobroker url https://github.com/copystring/ioBroker.roborock/tree/dev --host debian --debug
host.debian | 2023-05-13 13:27:33.457 | info | instance system.adapter.roborock.0 terminated with code NaN ()
-- | -- | -- | --
host.debian | 2023-05-13 13:27:33.457 | warn | instance system.adapter.roborock.0 terminated due to SIGABRT
host.debian | 2023-05-13 13:27:33.457 | error | Caught by controller[3]: 12: 0x15d9c19 [io.roborock.0]
host.debian | 2023-05-13 13:27:33.457 | error | Caught by controller[3]: 11: 0x11e5864 v8::internal::Runtime_StackGuardWithGap(int, unsigned long*, v8::internal::Isolate*) [io.roborock.0]
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[3]: 10: 0xe39287 v8::internal::StackGuard::HandleInterrupts() [io.roborock.0]
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[3]: 9: 0xeabbe5 v8::internal::Heap::HandleGCRequest() [io.roborock.0]
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[2]: 8: 0xea8cf0 v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [io.roborock.0]
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[1]: 7: 0xea82ae [io.roborock.0]
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[1]: 6: 0xe99d86 [io.roborock.0]
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[1]: 5: 0xe992a5 [io.roborock.0]
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[1]: 4: 0xce1c37 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [io.roborock.0]
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[0]: 3: 0xce1890 v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [io.roborock.0]
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[0]: 2: 0xa1b70e [io.roborock.0]
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[0]: 1: 0xb08e80 node::Abort() [io.roborock.0]
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[0]: FATAL ERROR: Ineffective mark-compacts near heap limit Allocation failed - JavaScript heap out of memory
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[0]: <--- JS stacktrace --->
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[0]: [20488:0x5da70d0] 52782 ms: Scavenge (reduce) 2045.9 (2082.1) -> 2045.2 (2082.1) MB, 12.7 / 0.0 ms (average mu = 0.250, current mu = 0.236) allocation failure
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[0]: [20488:0x5da70d0] 52715 ms: Scavenge (reduce) 2045.8 (2081.9) -> 2045.0 (2082.1) MB, 18.2 / 0.0 ms (average mu = 0.250, current mu = 0.236) allocation failure
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[0]: [20488:0x5da70d0] 52655 ms: Scavenge (reduce) 2045.7 (2081.9) -> 2044.9 (2081.9) MB, 8.3 / 0.0 ms (average mu = 0.250, current mu = 0.236) allocation failure
host.debian | 2023-05-13 13:27:33.456 | error | Caught by controller[0]: <--- Last few GCs --->
roborock.0 | 2023-05-13 13:26:43.039 | warn | Failed to execute get_consumable. TypeError: Cannot read properties of undefined (reading 'divider')
roborock.0 | 2023-05-13 13:26:41.254 | info | MQTT initialized
roborock.0 | 2023-05-13 13:26:40.927 | info | starting. Version 0.1.6 (non-npm: copystring/ioBroker.roborock#dev) in /opt/iobroker/node_modules/iobroker.roborock, node: v16.19.0, js-controller: 4.0.23

Ansonsten sind die Error mit den "Unsported attribute" weg.

Vielen Dank für deine Mühen und Support! :)

copystring commented 1 year ago

OK. Der Roboter hat Verbrauchsmaterialien, die der Adapter nicht kennt. In der neuen dev ist mehr Logging eingebaut. Im Debuglog steht dann etwas wie das hier: Consumables of robot: ... Wenn ich das habe, kann ich die neuen Verbrauchsmaterialien einbauen.

brasax commented 1 year ago

Hier mal ein längeres Log. Adapter auf Debug gestellt:

S8.txt

copystring commented 1 year ago

Hm. Leider Consumables of robot: ... sicher, dass du die aktuelle dev installiert hast?

brasax commented 1 year ago

Ah, du hast vor knapp einer halben Stunde nochmal comitted, habe ich nicht mitbekommen. Dann habe ich nicht die aktuelle gehabt. Habe heute die Dev um 13:23 Uhr installiert..

Jetzt aber:

2023-05-13 14:12:21.000 - debug: roborock.0 (21414) dps debug: {"id":4970,"result":[{"main_brush_work_time":100040,"side_brush_work_time":60608,"filter_work_time":100040,"filter_element_work_time":0,"sensor_dirty_time":60608,"strainer_work_times":78,"dust_collection_work_times":34,"cleaning_brush_work_times":78}]}
2023-05-13 14:12:21.000 - debug: roborock.0 (21414) Consumables of robot: [{"main_brush_work_time":100040,"side_brush_work_time":60608,"filter_work_time":100040,"filter_element_work_time":0,"sensor_dirty_time":60608,"strainer_work_times":78,"dust_collection_work_times":34,"cleaning_brush_work_times":78}]
2023-05-13 14:12:21.001 - warn: roborock.0 (21414) Failed to execute get_consumable. TypeError: Cannot read properties of undefined (reading 'divider')
copystring commented 1 year ago

Ja genau :) Ich habe die Änderungen gerade zur dev hinzugefügt. Bitte nochmal testen und ein neues Log anhängen.

brasax commented 1 year ago

Installiert:

host.debian | 2023-05-13 14:30:23.727 | info | iobroker removed 197 packages, and changed 1 package in 5s
host.debian | 2023-05-13 14:30:23.727 | info | iobroker
host.debian | 2023-05-13 14:30:18.936 | info | iobroker Installing copystring/ioBroker.roborock#dev... (System call)
host.debian | 2023-05-13 14:30:18.935 | info | iobroker NPM version: 8.19.3
host.debian | 2023-05-13 14:30:18.620 | info | iobroker install copystring/ioBroker.roborock#dev

Und das Log: S8.txt

copystring commented 1 year ago

Joh, sieht gut aus. Keine Fehler. Kannst ja mal gucken, ob in ioBroker alle Objekte sauber angelegt werden und mit den Daten korrekt gefüllt werden. Das sollte so aussehen: image

Es kann vorkommen, dass manche Daten keinen Inhalt haben. Das ist dann für optionales Zubehör.

brasax commented 1 year ago

Sieht so aus:

Bildschirmfoto 2023-05-13 um 14 45 53
copystring commented 1 year ago

OK. Mal bitte den Adapter beenden, dann den Ordner consumables löschen und anschließend die neue dev installieren. Kann sein, dass diese wieder in einen Fehler läuft. Das muss ich mir dann angucken.

brasax commented 1 year ago

Schaut besser aus:

image

Im Log auch nichts auffälliges.

EDIT2: Vergiss den vorherigen Edit. Ich habe den Filter gestern saubergemacht und zurückgesetzt..

copystring commented 1 year ago

Das eigentliche Problem mit dem Crash beim Aktualisieren der Karte ist auch behoben?

brasax commented 1 year ago

Darauf hatte ich jetzt nicht geschaut. Nein, das Problem besteht weiterhin, sobald man "Kartenerstellung aktivieren" anhakt, dann crasht der Adapter sofort. Nur diesmal direkt ohne "Update Map":

2023-05-14 13:27:18.482 - info: roborock.0 (7244) MQTT initialized
--
2023-05-14 13:27:20.666 - warn: roborock.0 (7244) Unknown block type! Please report this to the developer. Block type is:33
2023-05-14 13:28:09.860 - error: host.debian Caught by controller[1]: <--- Last few GCs --->
2023-05-14 13:28:09.860 - error: host.debian Caught by controller[1]: [7244:0x55c70d0] 52181 ms: Scavenge (reduce) 2042.9 (2079.9) -> 2042.2 (2080.1) MB, 8.6 / 0.0 ms (average mu = 0.280, current mu = 0.260) allocation failure
2023-05-14 13:28:09.860 - error: host.debian Caught by controller[1]: [7244:0x55c70d0] 52217 ms: Scavenge (reduce) 2043.0 (2080.1) -> 2042.3 (2080.1) MB, 5.6 / 0.0 ms (average mu = 0.280, current mu = 0.260) allocation failure
2023-05-14 13:28:09.860 - error: host.debian Caught by controller[1]: [7244:0x55c70d0] 52252 ms: Scavenge (reduce) 2043.1 (2080.1) -> 2042.4 (2080.1) MB, 4.7 / 0.0 ms (average mu = 0.280, current mu = 0.260) allocation failure
2023-05-14 13:28:09.860 - error: host.debian Caught by controller[1]: <--- JS stacktrace --->
2023-05-14 13:28:09.860 - error: host.debian Caught by controller[1]: FATAL ERROR: Ineffective mark-compacts near heap limit Allocation failed - JavaScript heap out of memory
2023-05-14 13:28:09.860 - error: host.debian Caught by controller[1]: 1: 0xb08e80 node::Abort() [io.roborock.0]
2023-05-14 13:28:09.860 - error: host.debian Caught by controller[1]: 2: 0xa1b70e [io.roborock.0]
2023-05-14 13:28:09.860 - error: host.debian Caught by controller[1]: 3: 0xce1890 v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [io.roborock.0]
2023-05-14 13:28:09.860 - error: host.debian Caught by controller[1]: 4: 0xce1c37 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [io.roborock.0]
2023-05-14 13:28:09.860 - error: host.debian Caught by controller[1]: 5: 0xe992a5 [io.roborock.0]
2023-05-14 13:28:09.861 - error: host.debian Caught by controller[1]: 6: 0xe99d86 [io.roborock.0]
2023-05-14 13:28:09.861 - error: host.debian Caught by controller[1]: 7: 0xea82ae [io.roborock.0]
2023-05-14 13:28:09.861 - error: host.debian Caught by controller[1]: 8: 0xea8cf0 v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [io.roborock.0]
2023-05-14 13:28:09.861 - error: host.debian Caught by controller[1]: 9: 0xeabbe5 v8::internal::Heap::HandleGCRequest() [io.roborock.0]
2023-05-14 13:28:09.861 - error: host.debian Caught by controller[1]: 10: 0xe39287 v8::internal::StackGuard::HandleInterrupts() [io.roborock.0]
2023-05-14 13:28:09.861 - error: host.debian Caught by controller[1]: 11: 0x11e56e5 v8::internal::Runtime_StackGuard(int, unsigned long*, v8::internal::Isolate*) [io.roborock.0]
2023-05-14 13:28:09.861 - error: host.debian Caught by controller[1]: 12: 0x15d9c19 [io.roborock.0]
2023-05-14 13:28:09.861 - warn: host.debian instance system.adapter.roborock.0 terminated due to SIGABRT
2023-05-14 13:28:09.861 - info: host.debian instance system.adapter.roborock.0 terminated with code NaN ()
copystring commented 1 year ago

Okay. Bisschen schwierig, aber das bekommen wir hin. In ioBroker im Ordner map sind drei Objekte. mapData und mapBase64. Magst du mir mal die Inhalte davon hier als Datei anhängen?

brasax commented 1 year ago

Da müsstest du mir allerdings helfen, bzw. sagen wie ich da ran komme.

copystring commented 1 year ago

Du hast doch schon den Ordner consumables gefunden. Da ist auch ein Ordner map. Da ist beides drin.

brasax commented 1 year ago

Schon klar, aber da dort nichts weiter steht bin ich davon ausgegangen, dass das Dateien sind. Und wenn dem so sein sollte, wie komme ich an die ran?

image
copystring commented 1 year ago

Das ist schon richtig so. Bei dir läuft es halt gar nicht. Um zu gucken, warum das so ist, habe ich gerade eben zusätzliches Logging in dev eingebaut. Die mal installieren und das Log hier anhängen.

brasax commented 1 year ago

Done:

S8.txt

copystring commented 1 year ago

Hast du diese Datei? /opt/iobroker/node_modules/iobroker.roborock/test.rrmap Mal bitte hier anhängen.

brasax commented 1 year ago

jep test.rrmap.zip

copystring commented 1 year ago

Okay. Das ist krass. Die ist leer. Läuft das auf einem mac?

brasax commented 1 year ago

nein, auf einem NUC in einer Proxmox VM.

copystring commented 1 year ago

OK. Dann sollte es daran nicht liegen. Mal bitte https://github.com/copystring/ioBroker.roborock/tree/s8_map_testing installieren und ein neues log anhängen. Herauszufinden, woran es liegt, wird anscheinend etwas aufwändiger.

brasax commented 1 year ago

Das ist blöd. Hier das Log: S8.txt

copystring commented 1 year ago

Er kommt halt schon mit der Antwort vom Server nicht klar. Hast du vielleicht zu wenig RAM der VM zugewiesen? Bei dir läuft es immer wieder in einen out of memory Fehler und das schon bevor ich irgendwas mit den Daten anfangen kann. Sprich schon beim Empfangen der Daten läuft der RAM voll.

copystring commented 1 year ago

Du läufst übrigens noch auf der dev und nicht s8_map_testing. Hier ein Auszug aus deinem log: 2023-05-14 17:32:26.302 - info: roborock.0 (10617) starting. Version 0.1.6 (non-npm: copystring/ioBroker.roborock#dev) in /opt/iobroker/node_modules/iobroker.roborock, node: v16.19.0, js-controller: 4.0.23

brasax commented 1 year ago

Kann ich mir nicht vorstellen. Kiste neu gestartet:

image image

Adapter stürzt sofort ab: S8.txt

copystring commented 1 year ago

OK. Hätte ja sein können :) Ich habe jetzt mal die Bearbeitung der Karte fast komplett deaktiviert. Sie nur noch geholt und ein Eintrag ins Log geschrieben. Wenn das wieder abstürzt, wird es langsam merkwürdig. Bitte damit ein neues log machen.

brasax commented 1 year ago

Du läufst übrigens noch auf der dev und nicht s8_map_testing. Hier ein Auszug aus deinem log: 2023-05-14 17:32:26.302 - info: roborock.0 (10617) starting. Version 0.1.6 (non-npm: copystring/ioBroker.roborock#dev) in /opt/iobroker/node_modules/iobroker.roborock, node: v16.19.0, js-controller: 4.0.23

Doch:

2023-05-14 17:56:17.127 - info: host.debian iobroker url https://github.com/copystring/ioBroker.roborock/tree/s8_map_testing --host debian --debug
--
2023-05-14 17:56:17.739 - info: host.debian iobroker install copystring/ioBroker.roborock#s8_map_testing
2023-05-14 17:56:18.036 - info: host.debian iobroker NPM version: 8.19.3
2023-05-14 17:56:18.037 - info: host.debian iobroker Installing copystring/ioBroker.roborock#s8_map_testing... (System call)
2023-05-14 17:56:23.070 - info: host.debian iobroker removed 197 packages, and changed 1 package in 5s

EDIT: Mist, vergessen das Log zu speichern..

brasax commented 1 year ago

Nochmal mit https://github.com/copystring/ioBroker.roborock/tree/s8_map_testing?

copystring commented 1 year ago

Ja erstmal nur diese verwenden.

brasax commented 1 year ago

Done. Stürzt nicht mehr ab:

S8.txt

copystring commented 1 year ago

Top. Ich nehme jetzt Stück für Stück alles wieder rein. Irgendwann hängt er dann wieder. Dann weiß ich, wo ich gucken muss. Der erste Versuch ist jetzt hochgeladen. Den mal testen.

brasax commented 1 year ago

Dauert etwas. Andere Adapter machen grad Stress, muss sie erstmal pausieren, sonst ist ein Haufen anders Zeug in den Logs..

brasax commented 1 year ago

So, Adapter stürzt ab:

S8.txt


roborock.0 | 2023-05-14 18:42:42.180 | debug | Update map
copystring commented 1 year ago

OK. Nochmal neu laden. Im Log müsste dann stehen: buf.length: 179340

brasax commented 1 year ago
host.debian | 2023-05-14 19:04:18.394 | info | iobroker 122 packages are looking for funding run `npm fund` for details
host.debian | 2023-05-14 19:04:18.393 | info | iobroker up to date in 4s
host.debian | 2023-05-14 19:04:14.441 | info | iobroker NPM version: 8.19.3Installing copystring/ioBroker.roborock#s8_map_testing... (System call)
host.debian | 2023-05-14 19:04:14.131 | info | iobroker install copystring/ioBroker.roborock#s8_map_testing
host.debian | 2023-05-14 19:04:13.493 | info | iobroker url https://github.com/copystring/ioBroker.roborock/tree/s8_map_testing --host debian --debug

den String finde ich nicht:

2023-05-14 19:05:30.689 - info: roborock.0 (2756) starting. Version 0.1.6 (non-npm: copystring/ioBroker.roborock#s8_map_testing) in /opt/iobroker/node_modules/iobroker.roborock, node: v16.19.0, js-controller: 4.0.23
--
2023-05-14 19:05:31.055 - info: roborock.0 (2756) MQTT initialized
2023-05-14 19:05:31.056 - debug: roborock.0 (2756) RoomIDs debug: {"10627496":"Küche","10627499":"Esszimmer","10627505":"Gang","10627507":"Couch","10627510":"Wohnzimmer","11443938":"Gallerie","11443943":"Bad","11443951":"Schlafzimmer","11742231":"Eingang","11742236":"Flur"}
2023-05-14 19:05:31.056 - debug: roborock.0 (2756) Robot key: roborock.vacuum.a70
2023-05-14 19:05:32.106 - debug: roborock.0 (2756) getParameter: get_fw_features
2023-05-14 19:05:32.106 - debug: roborock.0 (2756) Firmware features request
2023-05-14 19:05:32.169 - debug: roborock.0 (2756) dps debug: {"id":1959,"result":[111,112,113,114,115,116,117,118,119,120,121,122,123,124,125]}
2023-05-14 19:05:32.169 - debug: roborock.0 (2756) Length of message queue: 0
2023-05-14 19:05:32.787 - debug: roborock.0 (2756) getParameter: get_multi_maps_list
2023-05-14 19:05:32.875 - debug: roborock.0 (2756) dps debug: {"id":8062,"result":[{"max_multi_map":4,"max_bak_map":1,"multi_map_count":1,"map_info":[{"mapFlag":0,"add_time":1684078595,"length":5,"name":"Unten","bak_maps":[{"mapFlag":4,"add_time":1682691601}]}]}]}
2023-05-14 19:05:32.875 - debug: roborock.0 (2756) Length of message queue: 0
2023-05-14 19:05:32.876 - debug: roborock.0 (2756) Latest data requested
2023-05-14 19:05:32.876 - debug: roborock.0 (2756) getParameter: get_status
2023-05-14 19:05:32.938 - debug: roborock.0 (2756) dps debug: {"id":9833,"result":[{"msg_ver":2,"msg_seq":2049,"state":8,"battery":100,"clean_time":2159,"clean_area":21230000,"error_code":0,"map_present":1,"in_cleaning":0,"in_returning":0,"in_fresh_state":1,"lab_status":3,"water_box_status":1,"back_type":-1,"wash_phase":0,"wash_ready":0,"wash_status":33024,"fan_power":101,"dnd_enabled":0,"map_status":3,"is_locating":0,"lock_status":0,"water_box_mode":200,"water_box_carriage_status":1,"mop_forbidden_enable":1,"camera_status":387,"is_exploring":0,"adbumper_status":[0,0,0],"water_shortage_status":0,"dock_type":7,"dust_collection_status":0,"auto_dust_collection":1,"avoid_count":176,"mop_mode":300,"debug_mode":0,"collision_avoid_status":1,"switch_map_mode":0,"dock_error_status":0,"charge_status":1,"unsave_map_reason":0,"unsave_map_flag":0,"dry_status":0,"rdt":0,"clean_percent":0,"rss":2,"dss":2729,"last_clean_t":1684078520}]}
2023-05-14 19:05:32.939 - debug: roborock.0 (2756) Length of message queue: 0
2023-05-14 19:05:32.939 - debug: roborock.0 (2756) get_status: {"msg_ver":2,"msg_seq":2049,"state":8,"battery":100,"clean_time":2159,"clean_area":21230000,"error_code":0,"map_present":1,"in_cleaning":0,"in_returning":0,"in_fresh_state":1,"lab_status":3,"water_box_status":1,"back_type":-1,"wash_phase":0,"wash_ready":0,"wash_status":33024,"fan_power":101,"dnd_enabled":0,"map_status":3,"is_locating":0,"lock_status":0,"water_box_mode":200,"water_box_carriage_status":1,"mop_forbidden_enable":1,"camera_status":387,"is_exploring":0,"adbumper_status":[0,0,0],"water_shortage_status":0,"dock_type":7,"dust_collection_status":0,"auto_dust_collection":1,"avoid_count":176,"mop_mode":300,"debug_mode":0,"collision_avoid_status":1,"switch_map_mode":0,"dock_error_status":0,"charge_status":1,"unsave_map_reason":0,"unsave_map_flag":0,"dry_status":0,"rdt":0,"clean_percent":0,"rss":2,"dss":2729,"last_clean_t":1684078520}
2023-05-14 19:05:32.940 - debug: roborock.0 (2756) getParameter: get_room_mapping
2023-05-14 19:05:32.994 - debug: roborock.0 (2756) dps debug: {"id":9086,"result":[{"msg_ver":2,"msg_seq":2050,"state":8,"battery":100,"clean_time":2159,"clean_area":21230000,"error_code":0,"map_present":1,"in_cleaning":0,"in_returning":0,"in_fresh_state":1,"lab_status":3,"water_box_status":1,"back_type":-1,"wash_phase":0,"wash_ready":0,"wash_status":33024,"fan_power":101,"dnd_enabled":0,"map_status":3,"is_locating":0,"lock_status":0,"water_box_mode":200,"water_box_carriage_status":1,"mop_forbidden_enable":1,"camera_status":387,"is_exploring":0,"adbumper_status":[0,0,0],"water_shortage_status":0,"dock_type":7,"dust_collection_status":0,"auto_dust_collection":1,"avoid_count":176,"mop_mode":300,"debug_mode":0,"collision_avoid_status":1,"switch_map_mode":0,"dock_error_status":0,"charge_status":1,"unsave_map_reason":0,"unsave_map_flag":0,"dry_status":0,"rdt":0,"clean_percent":0,"rss":2,"dss":2729,"last_clean_t":1684078520}]}
2023-05-14 19:05:32.994 - debug: roborock.0 (2756) Length of message queue: 0
2023-05-14 19:05:33.063 - debug: roborock.0 (2756) dps debug: {"id":7769,"result":[[16,"11742231",12],[17,"10627496",14],[18,"10627507",12],[19,"10627510",6],[20,"11742236",8],[21,"10627499",13]]}
2023-05-14 19:05:33.064 - debug: roborock.0 (2756) Length of message queue: 0
2023-05-14 19:05:33.064 - debug: roborock.0 (2756) All mapped rooms: [[16,"11742231",12],[17,"10627496",14],[18,"10627507",12],[19,"10627510",6],[20,"11742236",8],[21,"10627499",13]]
2023-05-14 19:05:33.064 - debug: roborock.0 (2756) Mapped room matched: 11742231 with name: Eingang
2023-05-14 19:05:33.064 - debug: roborock.0 (2756) Mapped room matched: 10627496 with name: Küche
2023-05-14 19:05:33.064 - debug: roborock.0 (2756) Mapped room matched: 10627507 with name: Couch
2023-05-14 19:05:33.065 - debug: roborock.0 (2756) Mapped room matched: 10627510 with name: Wohnzimmer
2023-05-14 19:05:33.065 - debug: roborock.0 (2756) Mapped room matched: 11742236 with name: Flur
2023-05-14 19:05:33.065 - debug: roborock.0 (2756) Mapped room matched: 10627499 with name: Esszimmer
2023-05-14 19:05:33.065 - debug: roborock.0 (2756) getParameter: get_consumable
2023-05-14 19:05:33.107 - debug: roborock.0 (2756) dps debug: {"id":3721,"result":[{"main_brush_work_time":112176,"side_brush_work_time":66872,"filter_work_time":112176,"filter_element_work_time":0,"sensor_dirty_time":66872,"strainer_work_times":0,"dust_collection_work_times":38,"cleaning_brush_work_times":78}]}
2023-05-14 19:05:33.107 - debug: roborock.0 (2756) Length of message queue: 0
2023-05-14 19:05:33.107 - debug: roborock.0 (2756) Consumables of robot: [{"main_brush_work_time":112176,"side_brush_work_time":66872,"filter_work_time":112176,"filter_element_work_time":0,"sensor_dirty_time":66872,"strainer_work_times":0,"dust_collection_work_times":38,"cleaning_brush_work_times":78}]
2023-05-14 19:05:33.108 - debug: roborock.0 (2756) getParameter: get_network_info
2023-05-14 19:05:33.191 - debug: roborock.0 (2756) dps debug: {"id":1764,"result":{"ssid":"IoT","ip":"192.168.20.19","mac":"b0:4a:39:4f:99:1a","bssid":"76:83:c2:97:c2:87","rssi":-56}}
2023-05-14 19:05:33.191 - debug: roborock.0 (2756) Length of message queue: 0
2023-05-14 19:05:33.192 - debug: roborock.0 (2756) getParameter: get_server_timer
2023-05-14 19:05:33.192 - debug: roborock.0 (2756) getParameter: get_timer
2023-05-14 19:05:33.192 - debug: roborock.0 (2756) getParameter: get_carpet_mode
2023-05-14 19:05:33.236 - debug: roborock.0 (2756) dps debug: {"id":6634,"result":[]}
2023-05-14 19:05:33.237 - debug: roborock.0 (2756) Length of message queue: 2
2023-05-14 19:05:33.237 - debug: roborock.0 (2756) get_timer: []
2023-05-14 19:05:33.264 - debug: roborock.0 (2756) dps debug: {"id":9750,"result":[]}
2023-05-14 19:05:33.264 - debug: roborock.0 (2756) Length of message queue: 1
2023-05-14 19:05:33.264 - debug: roborock.0 (2756) get_server_timer: []
2023-05-14 19:05:33.265 - debug: roborock.0 (2756) dps debug: {"id":6293,"result":[{"enable":1,"current_integral":450,"current_high":500,"current_low":400,"stall_time":10}]}
2023-05-14 19:05:33.265 - debug: roborock.0 (2756) Length of message queue: 0
2023-05-14 19:05:33.266 - debug: roborock.0 (2756) getParameter: get_carpet_clean_mode
2023-05-14 19:05:33.305 - debug: roborock.0 (2756) dps debug: {"id":8419,"result":[{"carpet_clean_mode":3}]}
2023-05-14 19:05:33.305 - debug: roborock.0 (2756) Length of message queue: 0
2023-05-14 19:05:33.305 - debug: roborock.0 (2756) getParameter: get_water_box_custom_mode
2023-05-14 19:05:33.355 - debug: roborock.0 (2756) dps debug: {"id":3866,"result":{"water_box_mode":200}}
2023-05-14 19:05:33.355 - debug: roborock.0 (2756) Length of message queue: 0
2023-05-14 19:05:33.356 - debug: roborock.0 (2756) Update map
2023-05-14 19:05:33.357 - debug: roborock.0 (2756) Robot key: roborock.vacuum.a10
2023-05-14 19:05:33.464 - debug: roborock.0 (2756) dps debug: {"id":1623,"result":{"clean_time":66872,"clean_area":806142500,"clean_count":85,"dust_collection_count":38,"records":[1684076363,1684064459,1683996163,1683992226,1683974317,1683972770,1683922247,1683895691,1683825898,1683820320,1683742908,1683742717,1683654379,1683628417,1683607145,1683573113,1683572916,1683542144,1683521842,1683493358]}}
2023-05-14 19:05:33.464 - debug: roborock.0 (2756) Length of message queue: 1
2023-05-14 19:05:33.507 - debug: roborock.0 (2756) dps debug: {"id":8395,"result":[{"begin":1684076363,"end":1684078523,"duration":2159,"area":21230000,"error":0,"complete":1,"start_type":810,"clean_type":1,"finish_reason":52,"dust_collection_status":1,"avoid_count":176,"wash_count":0,"map_flag":0}]}
2023-05-14 19:05:33.507 - debug: roborock.0 (2756) Length of message queue: 1
2023-05-14 19:05:33.540 - debug: roborock.0 (2756) dps debug: {"id":8315,"result":["ok"]}
2023-05-14 19:05:33.540 - debug: roborock.0 (2756) Timeouts not cleared! null - 7695
2023-05-14 19:05:33.541 - debug: roborock.0 (2756) Length of message queue: 2
2023-05-14 19:05:33.547 - debug: roborock.0 (2756) Length of message queue: 1
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: <--- Last few GCs --->
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: [2756:0x4dbe0d0] 55219 ms: Scavenge (reduce) 2044.1 (2081.4) -> 2043.3 (2081.4) MB, 12.3 / 0.0 ms (average mu = 0.332, current mu = 0.392) allocation failure
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: [2756:0x4dbe0d0] 55260 ms: Scavenge (reduce) 2044.2 (2081.4) -> 2043.4 (2081.4) MB, 5.7 / 0.0 ms (average mu = 0.332, current mu = 0.392) allocation failure
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: [2756:0x4dbe0d0] 55297 ms: Scavenge (reduce) 2044.3 (2081.4) -> 2043.6 (2081.4) MB, 4.2 / 0.0 ms (average mu = 0.332, current mu = 0.392) allocation failure
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: <--- JS stacktrace --->
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: FATAL ERROR: Ineffective mark-compacts near heap limit Allocation failed - JavaScript heap out of memory
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: 1: 0xb08e80 node::Abort() [io.roborock.0]
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: 2: 0xa1b70e [io.roborock.0]
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: 3: 0xce1890 v8::Utils::ReportOOMFailure(v8::internal::Isolate*, char const*, bool) [io.roborock.0]
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: 4: 0xce1c37 v8::internal::V8::FatalProcessOutOfMemory(v8::internal::Isolate*, char const*, bool) [io.roborock.0]
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: 5: 0xe992a5 [io.roborock.0]
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: 6: 0xe99d86 [io.roborock.0]
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: 7: 0xea82ae [io.roborock.0]
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: 8: 0xea8cf0 v8::internal::Heap::CollectGarbage(v8::internal::AllocationSpace, v8::internal::GarbageCollectionReason, v8::GCCallbackFlags) [io.roborock.0]
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: 9: 0xeabbe5 v8::internal::Heap::HandleGCRequest() [io.roborock.0]
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: 10: 0xe39287 v8::internal::StackGuard::HandleInterrupts() [io.roborock.0]
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: 11: 0x11e56e5 v8::internal::Runtime_StackGuard(int, unsigned long*, v8::internal::Isolate*) [io.roborock.0]
2023-05-14 19:06:25.307 - error: host.debian Caught by controller[0]: 12: 0x15d9c19 [io.roborock.0]
2023-05-14 19:06:25.307 - warn: host.debian instance system.adapter.roborock.0 terminated due to SIGABRT
2023-05-14 19:06:25.307 - info: host.debian instance system.adapter.roborock.0 terminated with code NaN ()