MiSchroe / ioBroker.klf200

Adapter for ioBroker to connect to a KLF200 interface and run scenes and products.
MIT License
17 stars 14 forks source link

Timeout in adapter start #224

Open MiSchroe opened 1 month ago

MiSchroe commented 1 month ago

Describe the bug
There will be a timeout error during adapter start of there are products in the KLF that don't exist anymore.

To Reproduce
Steps to reproduce the behavior:

  1. Mimic by removing the battery from one of the windows.

Expected behavior
The adapter should log a warning but it should still start and be fully functional for the remaining products.

Screenshots & Logfiles
If applicable, add screenshots and logfiles to help explain your problem.

Versions:

Additional context

Details

```text 2024-07-23 19:42:26.770 - info: host.iobroker iobroker.js-controller version 6.0.6 js-controller starting 2024-07-23 19:42:26.802 - info: host.iobroker Copyright (c) 2014-2023 bluefox, 2014 hobbyquaker 2024-07-23 19:42:26.803 - info: host.iobroker hostname: iobroker, node: v18.19.0 2024-07-23 19:42:26.815 - info: host.iobroker ip addresses: 172.22.0.2 2024-07-23 19:42:34.857 - info: host.iobroker connected to Objects and States 2024-07-23 19:42:35.011 - info: host.iobroker added notifications configuration of host 2024-07-23 19:42:36.772 - info: host.iobroker 10 instances found 2024-07-23 19:42:36.916 - info: host.iobroker starting 8 instances 2024-07-23 19:42:39.438 - info: host.iobroker Delete state "system.host.iobroker.versions.nodeCurrent" 2024-07-23 19:42:39.582 - info: host.iobroker Delete state "system.host.iobroker.versions.nodeNewest" 2024-07-23 19:42:39.631 - info: host.iobroker Delete state "system.host.iobroker.versions.nodeNewestNext" 2024-07-23 19:42:39.719 - info: host.iobroker instance system.adapter.admin.0 started with pid 199 2024-07-23 19:42:39.738 - info: host.iobroker Delete state "system.host.iobroker.versions.npmCurrent" 2024-07-23 19:42:39.797 - info: host.iobroker Delete state "system.host.iobroker.versions.npmNewest" 2024-07-23 19:42:39.867 - info: host.iobroker Delete state "system.host.iobroker.versions.npmNewestNext" 2024-07-23 19:42:39.929 - info: host.iobroker Some obsolete host states deleted. 2024-07-23 19:42:44.413 - info: host.iobroker instance system.adapter.javascript.0 started with pid 206 2024-07-23 19:42:47.610 - info: host.iobroker instance system.adapter.backitup.0 started with pid 225 2024-07-23 19:42:51.109 - info: host.iobroker instance system.adapter.net-tools.0 started with pid 232 2024-07-23 19:42:55.234 - info: host.iobroker instance system.adapter.discovery.0 started with pid 251 2024-07-23 19:42:58.693 - info: host.iobroker instance system.adapter.klf200.0 started with pid 262 2024-07-23 19:42:59.415 - info: javascript.0 (206) starting. Version 8.6.0 in /opt/iobroker/node_modules/iobroker.javascript, node: v18.19.0, js-controller: 6.0.6 2024-07-23 19:42:59.465 - info: admin.0 (199) starting. Version 6.17.14 in /opt/iobroker/node_modules/iobroker.admin, node: v18.19.0, js-controller: 6.0.6 2024-07-23 19:42:59.655 - info: backitup.0 (225) starting. Version 3.0.8 in /opt/iobroker/node_modules/iobroker.backitup, node: v18.19.0, js-controller: 6.0.6 2024-07-23 19:42:59.711 - info: admin.0 (199) requesting all objects 2024-07-23 19:42:59.916 - info: backitup.0 (225) [iobroker] backup will be activated at 02:40 every 1 day(s) 2024-07-23 19:43:02.723 - info: javascript.0 (206) requesting all states 2024-07-23 19:43:02.725 - info: javascript.0 (206) requesting all objects 2024-07-23 19:43:04.160 - info: admin.0 (199) received all objects 2024-07-23 19:43:05.458 - info: admin.0 (199) Request actual repository... 2024-07-23 19:43:06.700 - warn: admin.0 (199) Cannot update news: self-signed certificate in certificate chain 2024-07-23 19:43:07.084 - info: admin.0 (199) socket.io server listening on port 8081 2024-07-23 19:43:07.116 - info: admin.0 (199) http server listening on port 8081 2024-07-23 19:43:07.118 - info: admin.0 (199) Use link "http://127.0.0.1:8081" to configure. 2024-07-23 19:43:07.490 - debug: klf200.0 (262) Redis Objects: Use Redis connection: 127.0.0.1:9001 2024-07-23 19:43:07.818 - info: javascript.0 (206) received all objects 2024-07-23 19:43:08.004 - info: javascript.0 (206) received all states 2024-07-23 19:43:08.122 - debug: klf200.0 (262) Objects client ready ... initialize now 2024-07-23 19:43:09.077 - warn: admin.0 (199) Cannot update rating: self-signed certificate in certificate chain 2024-07-23 19:43:09.361 - debug: klf200.0 (262) Objects create System PubSub Client 2024-07-23 19:43:09.362 - debug: klf200.0 (262) Objects create User PubSub Client 2024-07-23 19:43:10.609 - info: javascript.0 (206) Start JavaScript script.js.Skript_1 (Blockly) 2024-07-23 19:43:10.609 - debug: klf200.0 (262) Objects client initialize lua scripts 2024-07-23 19:43:10.661 - debug: klf200.0 (262) Objects connected to redis: 127.0.0.1:9001 2024-07-23 19:43:10.675 - silly: klf200.0 (262) redis psubscribe cfg.o.system.user.* 2024-07-23 19:43:10.703 - info: host.iobroker instance system.adapter.device-manager.0 started with pid 313 2024-07-23 19:43:10.831 - silly: klf200.0 (262) redis psubscribe cfg.o.enum.* 2024-07-23 19:43:10.844 - silly: klf200.0 (262) objectDB connected 2024-07-23 19:43:10.848 - debug: klf200.0 (262) Redis States: Use Redis connection: 127.0.0.1:9000 2024-07-23 19:43:10.881 - info: javascript.0 (206) script.js.Skript_1: registered 1 subscription, 0 schedules, 0 messages, 0 logs and 0 file subscriptions 2024-07-23 19:43:10.960 - debug: klf200.0 (262) States create System PubSub Client 2024-07-23 19:43:10.962 - debug: klf200.0 (262) States create User PubSub Client 2024-07-23 19:43:11.103 - info: host.iobroker instance system.adapter.iobapp.0 started with pid 320 2024-07-23 19:43:14.174 - info: host.iobroker Updating repository "beta" under "http://download.iobroker.net/sources-dist-latest.json" 2024-07-23 19:43:14.255 - debug: klf200.0 (262) States connected to redis: 127.0.0.1:9000 2024-07-23 19:43:14.257 - silly: klf200.0 (262) statesDB connected 2024-07-23 19:43:14.986 - info: net-tools.0 (232) starting. Version 1.0.11 in /opt/iobroker/node_modules/iobroker.net-tools, node: v18.19.0, js-controller: 6.0.6 2024-07-23 19:43:15.114 - error: net-tools.0 (232) License Key is not set! Enter a valid license key in the adapter settings. 2024-07-23 19:43:15.237 - info: klf200.0 (262) starting. Version 1.3.0 in /opt/iobroker/node_modules/iobroker.klf200, node: v18.19.0, js-controller: 6.0.6 2024-07-23 19:43:15.396 - silly: klf200.0 (262) States system redis pmessage system.adapter.klf200.0.logLevel/system.adapter.klf200.0.logLevel:{"val":"silly","ack":true,"ts":1721756595333,"q":0,"from":"system.adapter.klf200.0","lc":1721062662294} 2024-07-23 19:43:15.448 - debug: klf200.0 (262) klf-200-api found in path /opt/iobroker/node_modules/iobroker.klf200/node_modules/klf-200-api/dist/cjs/index.js 2024-07-23 19:43:15.460 - info: klf200.0 (262) klf-200-api version: 5.0.1 2024-07-23 19:43:15.461 - info: klf200.0 (262) Host: 192.168.178.155 2024-07-23 19:43:16.017 - info: discovery.0 (251) starting. Version 4.5.0 in /opt/iobroker/node_modules/iobroker.discovery, node: v18.19.0, js-controller: 6.0.6 2024-07-23 19:43:18.046 - info: device-manager.0 (313) starting. Version 0.0.8 in /opt/iobroker/node_modules/iobroker.device-manager, node: v18.19.0, js-controller: 6.0.6 2024-07-23 19:43:18.833 - info: iobapp.0 (320) starting. Version 0.1.0 in /opt/iobroker/node_modules/iobroker.iobapp, node: v18.19.0, js-controller: 6.0.6 2024-07-23 19:43:18.931 - info: iobapp.0 (320) WebSocket server listening on port 9192 2024-07-23 19:43:18.947 - info: iobapp.0 (320) REST server listening on port 9191 2024-07-23 19:43:21.196 - info: klf200.0 (262) Connected to interface. 2024-07-23 19:43:21.198 - info: klf200.0 (262) Setting up notification handler for gateway state... 2024-07-23 19:43:21.209 - info: klf200.0 (262) Reading device information... 2024-07-23 19:43:21.210 - info: klf200.0 (262) Enabling the house status monitor... 2024-07-23 19:43:21.212 - debug: klf200.0 (262) Frame sent (GW_HOUSE_STATUS_MONITOR_ENABLE_REQ): {"Command":576,"offset":3,"BufferSize":0,"data":{"type":"Buffer","data":[3,2,64]}} 2024-07-23 19:43:21.327 - debug: klf200.0 (262) Frame received (GW_HOUSE_STATUS_MONITOR_ENABLE_CFM): {"Command":577,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:43:21.329 - info: klf200.0 (262) Setting UTC clock to the current time. 2024-07-23 19:43:21.331 - debug: klf200.0 (262) Frame sent (GW_SET_UTC_REQ): {"Command":8192,"offset":3,"BufferSize":4,"data":{"type":"Buffer","data":[7,32,0,102,159,235,185]},"UTCTime":"2024-07-23T17:43:21.330Z"} 2024-07-23 19:43:21.542 - debug: klf200.0 (262) Frame received (GW_SET_UTC_CFM): {"Command":8193,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:43:21.543 - info: klf200.0 (262) Setting time zone to :GMT+1:GMT+2:0060:(1994)040102-0:110102-0 2024-07-23 19:43:21.544 - debug: klf200.0 (262) Frame sent (GW_RTC_SET_TIME_ZONE_REQ): {"Command":8194,"offset":3,"BufferSize":64,"data":{"type":"Buffer","data":[67,32,2,58,71,77,84,43,49,58,71,77,84,43,50,58,48,48,54,48,58,40,49,57,57,52,41,48,52,48,49,48,50,45,48,58,49,49,48,49,48,50,45,48,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0]},"TimeZoneString":":GMT+1:GMT+2:0060:(1994)040102-0:110102-0"} 2024-07-23 19:43:21.817 - debug: klf200.0 (262) Frame received (GW_RTC_SET_TIME_ZONE_CFM): {"Command":8195,"offset":3,"Data":{"type":"Buffer","data":[1]},"Status":1} 2024-07-23 19:43:21.819 - info: klf200.0 (262) Reading scenes... 2024-07-23 19:43:21.822 - debug: klf200.0 (262) Frame sent (GW_GET_SCENE_LIST_REQ): {"Command":1036,"offset":3,"BufferSize":0,"data":{"type":"Buffer","data":[3,4,12]}} 2024-07-23 19:43:21.947 - debug: klf200.0 (262) Frame received (GW_GET_SCENE_LIST_CFM): {"Command":1037,"offset":3,"Data":{"type":"Buffer","data":[5]},"NumberOfScenes":5} 2024-07-23 19:43:21.961 - debug: klf200.0 (262) Frame received (GW_GET_SCENE_LIST_NTF): {"Command":1038,"offset":3,"Data":{"type":"Buffer","data":[3,0,80,52,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,80,51,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,2,80,53,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,2]},"NumberOfScenes":3,"NumberOfRemainingScenes":2,"Scenes":[{"SceneID":0,"Name":"P4"},{"SceneID":1,"Name":"P3"},{"SceneID":2,"Name":"P5"}]} 2024-07-23 19:43:21.966 - debug: klf200.0 (262) Frame received (GW_GET_SCENE_LIST_NTF): {"Command":1038,"offset":3,"Data":{"type":"Buffer","data":[2,3,80,54,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,4,80,56,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0]},"NumberOfScenes":2,"NumberOfRemainingScenes":0,"Scenes":[{"SceneID":3,"Name":"P6"},{"SceneID":4,"Name":"P8"}]} 2024-07-23 19:43:21.968 - debug: klf200.0 (262) Frame sent (GW_GET_SCENE_INFORMATION_REQ): {"Command":1039,"offset":3,"BufferSize":1,"data":{"type":"Buffer","data":[4,4,15,0]},"SceneID":0} 2024-07-23 19:43:22.218 - debug: klf200.0 (262) Frame received (GW_GET_SCENE_INFORMATION_CFM): {"Command":1040,"offset":3,"Data":{"type":"Buffer","data":[0,0]},"Status":0,"SceneID":0} 2024-07-23 19:43:22.221 - debug: klf200.0 (262) Frame received (GW_GET_SCENE_INFORMATION_NTF): {"Command":1041,"offset":3,"Data":{"type":"Buffer","data":[0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,4,0,76,0,0]},"SceneID":0,"Name":"","NumberOfNodes":1,"NumberOfRemainingNodes":0,"Nodes":[{"NodeID":4,"ParameterID":0,"ParameterValue":19456}]} 2024-07-23 19:43:22.222 - debug: klf200.0 (262) Frame sent (GW_GET_SCENE_INFORMATION_REQ): {"Command":1039,"offset":3,"BufferSize":1,"data":{"type":"Buffer","data":[4,4,15,1]},"SceneID":1} 2024-07-23 19:43:22.465 - debug: klf200.0 (262) Frame received (GW_GET_SCENE_INFORMATION_CFM): {"Command":1040,"offset":3,"Data":{"type":"Buffer","data":[0,1]},"Status":0,"SceneID":1} 2024-07-23 19:43:22.472 - debug: klf200.0 (262) Frame received (GW_GET_SCENE_INFORMATION_NTF): {"Command":1041,"offset":3,"Data":{"type":"Buffer","data":[0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,4,0,186,0,0]},"SceneID":0,"Name":"","NumberOfNodes":1,"NumberOfRemainingNodes":0,"Nodes":[{"NodeID":4,"ParameterID":0,"ParameterValue":47616}]} 2024-07-23 19:43:22.473 - debug: klf200.0 (262) Frame sent (GW_GET_SCENE_INFORMATION_REQ): {"Command":1039,"offset":3,"BufferSize":1,"data":{"type":"Buffer","data":[4,4,15,2]},"SceneID":2} 2024-07-23 19:43:22.877 - info: admin.0 (199) ==> Connected system.user.admin from ::ffff:172.22.0.1 2024-07-23 19:43:22.957 - debug: klf200.0 (262) Frame received (GW_GET_SCENE_INFORMATION_CFM): {"Command":1040,"offset":3,"Data":{"type":"Buffer","data":[0,2]},"Status":0,"SceneID":2} 2024-07-23 19:43:22.959 - debug: klf200.0 (262) Frame received (GW_GET_SCENE_INFORMATION_NTF): {"Command":1041,"offset":3,"Data":{"type":"Buffer","data":[0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,4,0,50,0,0]},"SceneID":0,"Name":"","NumberOfNodes":1,"NumberOfRemainingNodes":0,"Nodes":[{"NodeID":4,"ParameterID":0,"ParameterValue":12800}]} 2024-07-23 19:43:22.961 - debug: klf200.0 (262) Frame sent (GW_GET_SCENE_INFORMATION_REQ): {"Command":1039,"offset":3,"BufferSize":1,"data":{"type":"Buffer","data":[4,4,15,3]},"SceneID":3} 2024-07-23 19:43:23.124 - debug: klf200.0 (262) Frame received (GW_GET_SCENE_INFORMATION_CFM): {"Command":1040,"offset":3,"Data":{"type":"Buffer","data":[0,3]},"Status":0,"SceneID":3} 2024-07-23 19:43:23.127 - debug: klf200.0 (262) Frame received (GW_GET_SCENE_INFORMATION_NTF): {"Command":1041,"offset":3,"Data":{"type":"Buffer","data":[0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,4,0,40,0,0]},"SceneID":0,"Name":"","NumberOfNodes":1,"NumberOfRemainingNodes":0,"Nodes":[{"NodeID":4,"ParameterID":0,"ParameterValue":10240}]} 2024-07-23 19:43:23.129 - debug: klf200.0 (262) Frame sent (GW_GET_SCENE_INFORMATION_REQ): {"Command":1039,"offset":3,"BufferSize":1,"data":{"type":"Buffer","data":[4,4,15,4]},"SceneID":4} 2024-07-23 19:43:23.527 - debug: klf200.0 (262) Frame received (GW_GET_SCENE_INFORMATION_CFM): {"Command":1040,"offset":3,"Data":{"type":"Buffer","data":[0,4]},"Status":0,"SceneID":4} 2024-07-23 19:43:23.528 - debug: klf200.0 (262) Frame received (GW_GET_SCENE_INFORMATION_NTF): {"Command":1041,"offset":3,"Data":{"type":"Buffer","data":[0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,4,0,32,0,0]},"SceneID":0,"Name":"","NumberOfNodes":1,"NumberOfRemainingNodes":0,"Nodes":[{"NodeID":4,"ParameterID":0,"ParameterValue":8192}]} 2024-07-23 19:43:23.530 - info: klf200.0 (262) 5 scenes found. 2024-07-23 19:43:23.530 - info: klf200.0 (262) Reading groups... 2024-07-23 19:43:23.533 - debug: klf200.0 (262) Frame sent (GW_GET_ALL_GROUPS_INFORMATION_REQ): {"Command":553,"offset":3,"BufferSize":2,"data":{"type":"Buffer","data":[5,2,41,1,0]},"_useFilter":true,"_groupType":0} 2024-07-23 19:43:23.683 - debug: klf200.0 (262) Frame received (GW_GET_ALL_GROUPS_INFORMATION_CFM): {"Command":554,"offset":3,"Data":{"type":"Buffer","data":[0,12]},"Status":0,"NumberOfGroups":12} 2024-07-23 19:43:23.686 - debug: klf200.0 (262) Frame received (GW_GET_ALL_GROUPS_INFORMATION_NTF): {"Command":555,"offset":3,"Data":{"type":"Buffer","data":[50,0,0,0,70,101,110,115,116,101,114,32,83,195,188,100,101,110,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,2,6,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0]},"GroupID":50,"Order":0,"Placement":0,"Name":"Fenster Süden","Velocity":0,"GroupType":0,"NodeVariation":0,"Revision":0,"Nodes":[1,2]} 2024-07-23 19:43:23.704 - debug: klf200.0 (262) Frame received (GW_GET_ALL_GROUPS_INFORMATION_NTF): {"Command":555,"offset":3,"Data":{"type":"Buffer","data":[51,0,1,0,65,108,108,101,32,70,101,110,115,116,101,114,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,4,23,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0]},"GroupID":51,"Order":1,"Placement":0,"Name":"Alle Fenster","Velocity":0,"GroupType":0,"NodeVariation":0,"Revision":0,"Nodes":[0,1,2,4]} 2024-07-23 19:43:23.706 - debug: klf200.0 (262) Frame received (GW_GET_ALL_GROUPS_INFORMATION_NTF): {"Command":555,"offset":3,"Data":{"type":"Buffer","data":[52,0,2,0,70,101,110,115,116,101,114,32,78,111,114,100,101,110,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,2,17,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0]},"GroupID":52,"Order":2,"Placement":0,"Name":"Fenster Norden","Velocity":0,"GroupType":0,"NodeVariation":0,"Revision":0,"Nodes":[0,4]} 2024-07-23 19:43:23.708 - debug: klf200.0 (262) Frame received (GW_GET_ALL_GROUPS_INFORMATION_FINISHED_NTF): {"Command":556,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:43:23.709 - info: klf200.0 (262) 3 groups found. 2024-07-23 19:43:23.709 - info: klf200.0 (262) Reading products... 2024-07-23 19:43:23.712 - debug: klf200.0 (262) Frame sent (GW_GET_ALL_NODES_INFORMATION_REQ): {"Command":514,"offset":3,"BufferSize":0,"data":{"type":"Buffer","data":[3,2,2]}} 2024-07-23 19:43:23.996 - debug: klf200.0 (262) Frame received (GW_GET_ALL_NODES_INFORMATION_CFM): {"Command":515,"offset":3,"Data":{"type":"Buffer","data":[0,5]},"Status":0,"NumberOfNode":5} 2024-07-23 19:43:24.002 - debug: klf200.0 (262) Frame received (GW_GET_ALL_NODES_INFORMATION_NTF): {"Command":516,"offset":3,"Data":{"type":"Buffer","data":[0,0,0,0,70,101,110,115,116,101,114,32,66,97,100,101,122,105,109,109,101,114,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,1,3,7,0,1,3,83,39,67,38,24,1,1,156,5,200,0,200,0,0,0,247,255,247,255,247,255,0,0,102,159,235,187,2,216,2,100,0,216,3,178,21,0,0,0,0,0,0,0,0,0,0,0,0]},"NodeID":0,"Order":0,"Placement":0,"Name":"Fenster Badezimmer","Velocity":0,"ActuatorType":4,"ActuatorSubType":1,"ProductGroup":3,"ProductType":7,"NodeVariation":0,"PowerSaveMode":1,"SerialNumber":{"type":"Buffer","data":[83,39,67,38,24,1,1,156]},"OperatingState":5,"CurrentPosition":51200,"TargetPosition":51200,"FunctionalPosition1CurrentPosition":0,"FunctionalPosition2CurrentPosition":63487,"FunctionalPosition3CurrentPosition":63487,"FunctionalPosition4CurrentPosition":63487,"RemainingTime":0,"TimeStamp":"2024-07-23T17:43:23.000Z","ActuatorAliases":[{"AliasType":55298,"AliasValue":25600},{"AliasType":55299,"AliasValue":45589}]} 2024-07-23 19:43:24.005 - debug: klf200.0 (262) Frame received (GW_GET_ALL_NODES_INFORMATION_NTF): {"Command":516,"offset":3,"Data":{"type":"Buffer","data":[1,0,1,2,70,101,110,115,116,101,114,32,83,99,104,108,97,102,122,105,109,109,101,114,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,1,3,7,0,1,42,83,37,46,38,23,41,4,122,5,200,0,200,0,0,0,247,255,247,255,247,255,0,0,102,159,235,187,2,216,2,100,0,216,3,186,0,0,0,0,0,0,0,0,0,0,0,0,0]},"NodeID":1,"Order":1,"Placement":2,"Name":"Fenster Schlafzimmer","Velocity":0,"ActuatorType":4,"ActuatorSubType":1,"ProductGroup":3,"ProductType":7,"NodeVariation":0,"PowerSaveMode":1,"SerialNumber":{"type":"Buffer","data":[83,37,46,38,23,41,4,122]},"OperatingState":5,"CurrentPosition":51200,"TargetPosition":51200,"FunctionalPosition1CurrentPosition":0,"FunctionalPosition2CurrentPosition":63487,"FunctionalPosition3CurrentPosition":63487,"FunctionalPosition4CurrentPosition":63487,"RemainingTime":0,"TimeStamp":"2024-07-23T17:43:23.000Z","ActuatorAliases":[{"AliasType":55298,"AliasValue":25600},{"AliasType":55299,"AliasValue":47616}]} 2024-07-23 19:43:24.016 - debug: klf200.0 (262) Frame received (GW_GET_ALL_NODES_INFORMATION_NTF): {"Command":516,"offset":3,"Data":{"type":"Buffer","data":[2,0,2,3,70,101,110,115,116,101,114,32,65,110,107,108,101,105,100,101,122,105,109,109,101,114,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,1,213,7,0,1,30,83,54,39,38,16,45,0,200,5,200,0,200,0,0,0,247,255,247,255,247,255,0,0,102,159,235,187,2,216,2,100,0,216,3,186,0,0,0,0,0,0,0,0,0,0,0,0,0]},"NodeID":2,"Order":2,"Placement":3,"Name":"Fenster Ankleidezimmer","Velocity":0,"ActuatorType":4,"ActuatorSubType":1,"ProductGroup":213,"ProductType":7,"NodeVariation":0,"PowerSaveMode":1,"SerialNumber":{"type":"Buffer","data":[83,54,39,38,16,45,0,200]},"OperatingState":5,"CurrentPosition":51200,"TargetPosition":51200,"FunctionalPosition1CurrentPosition":0,"FunctionalPosition2CurrentPosition":63487,"FunctionalPosition3CurrentPosition":63487,"FunctionalPosition4CurrentPosition":63487,"RemainingTime":0,"TimeStamp":"2024-07-23T17:43:23.000Z","ActuatorAliases":[{"AliasType":55298,"AliasValue":25600},{"AliasType":55299,"AliasValue":47616}]} 2024-07-23 19:43:24.018 - debug: klf200.0 (262) Frame received (GW_GET_ALL_NODES_INFORMATION_NTF): {"Command":516,"offset":3,"Data":{"type":"Buffer","data":[3,0,3,2,82,111,108,108,108,97,100,101,110,32,83,99,104,108,97,102,122,105,109,109,101,114,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,0,128,213,5,0,1,19,83,9,64,90,16,42,8,176,5,200,0,200,0,247,255,247,255,247,255,247,255,0,0,102,159,235,187,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0]},"NodeID":3,"Order":3,"Placement":2,"Name":"Rollladen Schlafzimmer","Velocity":1,"ActuatorType":2,"ActuatorSubType":0,"ProductGroup":213,"ProductType":5,"NodeVariation":0,"PowerSaveMode":1,"SerialNumber":{"type":"Buffer","data":[83,9,64,90,16,42,8,176]},"OperatingState":5,"CurrentPosition":51200,"TargetPosition":51200,"FunctionalPosition1CurrentPosition":63487,"FunctionalPosition2CurrentPosition":63487,"FunctionalPosition3CurrentPosition":63487,"FunctionalPosition4CurrentPosition":63487,"RemainingTime":0,"TimeStamp":"2024-07-23T17:43:23.000Z","ActuatorAliases":[]} 2024-07-23 19:43:24.092 - debug: klf200.0 (262) Frame received (GW_GET_ALL_NODES_INFORMATION_NTF): {"Command":516,"offset":3,"Data":{"type":"Buffer","data":[4,0,4,4,70,101,110,115,116,101,114,32,66,195,188,114,111,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,1,213,7,0,1,30,83,54,39,38,16,47,0,129,5,200,0,200,0,0,0,247,255,247,255,247,255,0,0,102,159,235,187,2,216,2,100,0,216,3,186,0,0,0,0,0,0,0,0,0,0,0,0,0]},"NodeID":4,"Order":4,"Placement":4,"Name":"Fenster Büro","Velocity":0,"ActuatorType":4,"ActuatorSubType":1,"ProductGroup":213,"ProductType":7,"NodeVariation":0,"PowerSaveMode":1,"SerialNumber":{"type":"Buffer","data":[83,54,39,38,16,47,0,129]},"OperatingState":5,"CurrentPosition":51200,"TargetPosition":51200,"FunctionalPosition1CurrentPosition":0,"FunctionalPosition2CurrentPosition":63487,"FunctionalPosition3CurrentPosition":63487,"FunctionalPosition4CurrentPosition":63487,"RemainingTime":0,"TimeStamp":"2024-07-23T17:43:23.000Z","ActuatorAliases":[{"AliasType":55298,"AliasValue":25600},{"AliasType":55299,"AliasValue":47616}]} 2024-07-23 19:43:24.094 - debug: klf200.0 (262) Frame received (GW_GET_ALL_NODES_INFORMATION_FINISHED_NTF): {"Command":517,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:43:24.098 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,0,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0]},"SessionID":0,"Nodes":0,"LimitationType":0,"ParameterActive":0} 2024-07-23 19:43:24.177 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,0,1]},"SessionID":0,"Status":1} 2024-07-23 19:43:25.675 - silly: klf200.0 (262) States system redis pmessage system.adapter.*.logging/system.adapter.admin.0.logging:{"val":true,"ack":true,"ts":1721756604043,"q":0,"from":"system.adapter.admin.0","user":"system.user.admin","lc":1721377576365} 2024-07-23 19:43:25.676 - silly: klf200.0 (262) system.adapter.admin.0: logging true 2024-07-23 19:43:32.504 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,0,1,0,0,255,255,1,2,14,0,0,0]},"SessionID":0,"StatusOwner":1,"NodeID":0,"NodeParameter":0,"ParameterValue":65535,"RunStatus":1,"StatusReply":2,"InformationCode":234881024} 2024-07-23 19:43:32.522 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,0]},"SessionID":0} 2024-07-23 19:43:32.525 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,1,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1]},"SessionID":1,"Nodes":0,"LimitationType":1,"ParameterActive":0} 2024-07-23 19:43:32.537 - debug: klf200.0 (262) Frame received (GW_ACTIVATION_LOG_UPDATED_NTF): {"Command":1286,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:43:32.973 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,1,1]},"SessionID":1,"Status":1} 2024-07-23 19:43:35.200 - info: admin.0 (199) Repository received successfully. 2024-07-23 19:43:41.639 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,1,1,0,0,255,255,1,2,14,0,0,0]},"SessionID":1,"StatusOwner":1,"NodeID":0,"NodeParameter":0,"ParameterValue":65535,"RunStatus":1,"StatusReply":2,"InformationCode":234881024} 2024-07-23 19:43:41.641 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,1]},"SessionID":1} 2024-07-23 19:43:41.643 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,2,1,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0]},"SessionID":2,"Nodes":1,"LimitationType":0,"ParameterActive":0} 2024-07-23 19:43:41.848 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,2,1]},"SessionID":2,"Status":1} 2024-07-23 19:43:42.407 - debug: klf200.0 (262) Frame received (GW_LIMITATION_STATUS_NTF): {"Command":788,"offset":3,"Data":{"type":"Buffer","data":[0,2,1,0,0,0,247,255,255,255]},"SessionID":2,"NodeID":1,"ParameterID":0,"LimitationValueMin":0,"LimitationValueMax":63487,"LimitationOriginator":255,"LimitationTime":255} 2024-07-23 19:43:42.409 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,2,1,1,0,200,0,0,1,42,0,0,0]},"SessionID":2,"StatusOwner":1,"NodeID":1,"NodeParameter":0,"ParameterValue":51200,"RunStatus":0,"StatusReply":1,"InformationCode":704643072} 2024-07-23 19:43:42.422 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,2]},"SessionID":2} 2024-07-23 19:43:42.423 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,3,1,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1]},"SessionID":3,"Nodes":1,"LimitationType":1,"ParameterActive":0} 2024-07-23 19:43:42.607 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,3,1]},"SessionID":3,"Status":1} 2024-07-23 19:43:42.960 - debug: klf200.0 (262) Frame received (GW_ACTIVATION_LOG_UPDATED_NTF): {"Command":1286,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:43:43.191 - debug: klf200.0 (262) Frame received (GW_LIMITATION_STATUS_NTF): {"Command":788,"offset":3,"Data":{"type":"Buffer","data":[0,3,1,0,247,255,200,0,255,255]},"SessionID":3,"NodeID":1,"ParameterID":0,"LimitationValueMin":63487,"LimitationValueMax":51200,"LimitationOriginator":255,"LimitationTime":255} 2024-07-23 19:43:43.192 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,3,1,1,0,200,0,0,1,42,0,0,0]},"SessionID":3,"StatusOwner":1,"NodeID":1,"NodeParameter":0,"ParameterValue":51200,"RunStatus":0,"StatusReply":1,"InformationCode":704643072} 2024-07-23 19:43:43.193 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,3]},"SessionID":3} 2024-07-23 19:43:43.194 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,4,1,2,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0]},"SessionID":4,"Nodes":2,"LimitationType":0,"ParameterActive":0} 2024-07-23 19:43:43.430 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,4,1]},"SessionID":4,"Status":1} 2024-07-23 19:43:44.005 - debug: klf200.0 (262) Frame received (GW_LIMITATION_STATUS_NTF): {"Command":788,"offset":3,"Data":{"type":"Buffer","data":[0,4,2,0,0,0,247,255,255,255]},"SessionID":4,"NodeID":2,"ParameterID":0,"LimitationValueMin":0,"LimitationValueMax":63487,"LimitationOriginator":255,"LimitationTime":255} 2024-07-23 19:43:44.007 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,4,1,2,0,200,0,0,1,42,0,0,0]},"SessionID":4,"StatusOwner":1,"NodeID":2,"NodeParameter":0,"ParameterValue":51200,"RunStatus":0,"StatusReply":1,"InformationCode":704643072} 2024-07-23 19:43:44.008 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,4]},"SessionID":4} 2024-07-23 19:43:44.009 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,5,1,2,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1]},"SessionID":5,"Nodes":2,"LimitationType":1,"ParameterActive":0} 2024-07-23 19:43:44.200 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,5,1]},"SessionID":5,"Status":1} 2024-07-23 19:43:44.749 - debug: klf200.0 (262) Frame received (GW_LIMITATION_STATUS_NTF): {"Command":788,"offset":3,"Data":{"type":"Buffer","data":[0,5,2,0,247,255,200,0,255,255]},"SessionID":5,"NodeID":2,"ParameterID":0,"LimitationValueMin":63487,"LimitationValueMax":51200,"LimitationOriginator":255,"LimitationTime":255} 2024-07-23 19:43:44.750 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,5,1,2,0,200,0,0,1,42,0,0,0]},"SessionID":5,"StatusOwner":1,"NodeID":2,"NodeParameter":0,"ParameterValue":51200,"RunStatus":0,"StatusReply":1,"InformationCode":704643072} 2024-07-23 19:43:44.752 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,5]},"SessionID":5} 2024-07-23 19:43:44.754 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,6,1,3,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0]},"SessionID":6,"Nodes":3,"LimitationType":0,"ParameterActive":0} 2024-07-23 19:43:44.970 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,6,1]},"SessionID":6,"Status":1} 2024-07-23 19:43:45.531 - debug: klf200.0 (262) Frame received (GW_LIMITATION_STATUS_NTF): {"Command":788,"offset":3,"Data":{"type":"Buffer","data":[0,6,3,0,0,0,247,255,255,255]},"SessionID":6,"NodeID":3,"ParameterID":0,"LimitationValueMin":0,"LimitationValueMax":63487,"LimitationOriginator":255,"LimitationTime":255} 2024-07-23 19:43:45.532 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,6,1,3,0,200,0,0,1,42,0,0,0]},"SessionID":6,"StatusOwner":1,"NodeID":3,"NodeParameter":0,"ParameterValue":51200,"RunStatus":0,"StatusReply":1,"InformationCode":704643072} 2024-07-23 19:43:45.534 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,6]},"SessionID":6} 2024-07-23 19:43:45.535 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,7,1,3,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1]},"SessionID":7,"Nodes":3,"LimitationType":1,"ParameterActive":0} 2024-07-23 19:43:45.755 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,7,1]},"SessionID":7,"Status":1} 2024-07-23 19:43:46.340 - debug: klf200.0 (262) Frame received (GW_LIMITATION_STATUS_NTF): {"Command":788,"offset":3,"Data":{"type":"Buffer","data":[0,7,3,0,247,255,200,0,255,255]},"SessionID":7,"NodeID":3,"ParameterID":0,"LimitationValueMin":63487,"LimitationValueMax":51200,"LimitationOriginator":255,"LimitationTime":255} 2024-07-23 19:43:46.342 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,7,1,3,0,200,0,0,1,42,0,0,0]},"SessionID":7,"StatusOwner":1,"NodeID":3,"NodeParameter":0,"ParameterValue":51200,"RunStatus":0,"StatusReply":1,"InformationCode":704643072} 2024-07-23 19:43:46.343 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,7]},"SessionID":7} 2024-07-23 19:43:46.344 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,8,1,4,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0]},"SessionID":8,"Nodes":4,"LimitationType":0,"ParameterActive":0} 2024-07-23 19:43:46.593 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,8,1]},"SessionID":8,"Status":1} 2024-07-23 19:43:47.134 - debug: klf200.0 (262) Frame received (GW_LIMITATION_STATUS_NTF): {"Command":788,"offset":3,"Data":{"type":"Buffer","data":[0,8,4,0,0,0,247,255,255,255]},"SessionID":8,"NodeID":4,"ParameterID":0,"LimitationValueMin":0,"LimitationValueMax":63487,"LimitationOriginator":255,"LimitationTime":255} 2024-07-23 19:43:47.135 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,8,1,4,0,200,0,0,1,42,0,0,0]},"SessionID":8,"StatusOwner":1,"NodeID":4,"NodeParameter":0,"ParameterValue":51200,"RunStatus":0,"StatusReply":1,"InformationCode":704643072} 2024-07-23 19:43:47.137 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,8]},"SessionID":8} 2024-07-23 19:43:47.138 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,9,1,4,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1]},"SessionID":9,"Nodes":4,"LimitationType":1,"ParameterActive":0} 2024-07-23 19:43:47.412 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,9,1]},"SessionID":9,"Status":1} 2024-07-23 19:43:48.073 - debug: klf200.0 (262) Frame received (GW_LIMITATION_STATUS_NTF): {"Command":788,"offset":3,"Data":{"type":"Buffer","data":[0,9,4,0,247,255,200,0,255,255]},"SessionID":9,"NodeID":4,"ParameterID":0,"LimitationValueMin":63487,"LimitationValueMax":51200,"LimitationOriginator":255,"LimitationTime":255} 2024-07-23 19:43:48.074 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,9,1,4,0,200,0,0,1,42,0,0,0]},"SessionID":9,"StatusOwner":1,"NodeID":4,"NodeParameter":0,"ParameterValue":51200,"RunStatus":0,"StatusReply":1,"InformationCode":704643072} 2024-07-23 19:43:48.075 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,9]},"SessionID":9} 2024-07-23 19:43:48.076 - info: klf200.0 (262) 5 products found. 2024-07-23 19:43:48.076 - info: klf200.0 (262) Reading product limitations... 2024-07-23 19:43:48.077 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,10,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0]},"SessionID":10,"Nodes":0,"LimitationType":0,"ParameterActive":0} 2024-07-23 19:43:48.332 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,10,1]},"SessionID":10,"Status":1} 2024-07-23 19:43:55.093 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,10,1,0,0,255,255,1,2,14,0,0,0]},"SessionID":10,"StatusOwner":1,"NodeID":0,"NodeParameter":0,"ParameterValue":65535,"RunStatus":1,"StatusReply":2,"InformationCode":234881024} 2024-07-23 19:43:55.095 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,10]},"SessionID":10} 2024-07-23 19:43:55.097 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,11,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,0]},"SessionID":11,"Nodes":0,"LimitationType":0,"ParameterActive":1} 2024-07-23 19:43:55.117 - debug: klf200.0 (262) Frame received (GW_ACTIVATION_LOG_UPDATED_NTF): {"Command":1286,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:43:55.326 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,11,1]},"SessionID":11,"Status":1} 2024-07-23 19:44:04.421 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,11,1,0,0,255,255,1,2,14,0,0,0]},"SessionID":11,"StatusOwner":1,"NodeID":0,"NodeParameter":0,"ParameterValue":65535,"RunStatus":1,"StatusReply":2,"InformationCode":234881024} 2024-07-23 19:44:04.436 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,11]},"SessionID":11} 2024-07-23 19:44:04.437 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,12,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,2,0]},"SessionID":12,"Nodes":0,"LimitationType":0,"ParameterActive":2} 2024-07-23 19:44:04.438 - debug: klf200.0 (262) Frame received (GW_ACTIVATION_LOG_UPDATED_NTF): {"Command":1286,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:44:04.751 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,12,1]},"SessionID":12,"Status":1} 2024-07-23 19:44:12.821 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,12,1,0,0,255,255,1,2,14,0,0,0]},"SessionID":12,"StatusOwner":1,"NodeID":0,"NodeParameter":0,"ParameterValue":65535,"RunStatus":1,"StatusReply":2,"InformationCode":234881024} 2024-07-23 19:44:12.823 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,12]},"SessionID":12} 2024-07-23 19:44:12.825 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,13,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,3,0]},"SessionID":13,"Nodes":0,"LimitationType":0,"ParameterActive":3} 2024-07-23 19:44:12.857 - debug: klf200.0 (262) Frame received (GW_ACTIVATION_LOG_UPDATED_NTF): {"Command":1286,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:44:13.345 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,13,1]},"SessionID":13,"Status":1} 2024-07-23 19:44:22.277 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,13,1,0,0,255,255,1,2,14,0,0,0]},"SessionID":13,"StatusOwner":1,"NodeID":0,"NodeParameter":0,"ParameterValue":65535,"RunStatus":1,"StatusReply":2,"InformationCode":234881024} 2024-07-23 19:44:22.278 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,13]},"SessionID":13} 2024-07-23 19:44:22.280 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,14,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,4,0]},"SessionID":14,"Nodes":0,"LimitationType":0,"ParameterActive":4} 2024-07-23 19:44:22.282 - debug: klf200.0 (262) Frame received (GW_ACTIVATION_LOG_UPDATED_NTF): {"Command":1286,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:44:22.600 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,14,1]},"SessionID":14,"Status":1} 2024-07-23 19:44:30.305 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,14,1,0,0,255,255,1,2,14,0,0,0]},"SessionID":14,"StatusOwner":1,"NodeID":0,"NodeParameter":0,"ParameterValue":65535,"RunStatus":1,"StatusReply":2,"InformationCode":234881024} 2024-07-23 19:44:30.307 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,14]},"SessionID":14} 2024-07-23 19:44:30.308 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,15,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1]},"SessionID":15,"Nodes":0,"LimitationType":1,"ParameterActive":0} 2024-07-23 19:44:30.328 - debug: klf200.0 (262) Frame received (GW_ACTIVATION_LOG_UPDATED_NTF): {"Command":1286,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:44:30.824 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,15,1]},"SessionID":15,"Status":1} 2024-07-23 19:44:39.195 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,15,1,0,0,255,255,1,2,14,0,0,0]},"SessionID":15,"StatusOwner":1,"NodeID":0,"NodeParameter":0,"ParameterValue":65535,"RunStatus":1,"StatusReply":2,"InformationCode":234881024} 2024-07-23 19:44:39.196 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,15]},"SessionID":15} 2024-07-23 19:44:39.197 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,16,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,1]},"SessionID":16,"Nodes":0,"LimitationType":1,"ParameterActive":1} 2024-07-23 19:44:39.198 - debug: klf200.0 (262) Frame received (GW_ACTIVATION_LOG_UPDATED_NTF): {"Command":1286,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:44:39.584 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,16,1]},"SessionID":16,"Status":1} 2024-07-23 19:44:48.751 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,16,1,0,0,255,255,1,2,14,0,0,0]},"SessionID":16,"StatusOwner":1,"NodeID":0,"NodeParameter":0,"ParameterValue":65535,"RunStatus":1,"StatusReply":2,"InformationCode":234881024} 2024-07-23 19:44:48.752 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,16]},"SessionID":16} 2024-07-23 19:44:48.753 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,17,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,2,1]},"SessionID":17,"Nodes":0,"LimitationType":1,"ParameterActive":2} 2024-07-23 19:44:48.754 - debug: klf200.0 (262) Frame received (GW_ACTIVATION_LOG_UPDATED_NTF): {"Command":1286,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:44:49.144 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,17,1]},"SessionID":17,"Status":1} 2024-07-23 19:44:56.542 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,17,1,0,0,255,255,1,2,14,0,0,0]},"SessionID":17,"StatusOwner":1,"NodeID":0,"NodeParameter":0,"ParameterValue":65535,"RunStatus":1,"StatusReply":2,"InformationCode":234881024} 2024-07-23 19:44:56.545 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,17]},"SessionID":17} 2024-07-23 19:44:56.547 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,18,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,3,1]},"SessionID":18,"Nodes":0,"LimitationType":1,"ParameterActive":3} 2024-07-23 19:44:56.548 - debug: klf200.0 (262) Frame received (GW_ACTIVATION_LOG_UPDATED_NTF): {"Command":1286,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:44:56.879 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,18,1]},"SessionID":18,"Status":1} 2024-07-23 19:45:03.636 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,18,1,0,0,255,255,1,2,14,0,0,0]},"SessionID":18,"StatusOwner":1,"NodeID":0,"NodeParameter":0,"ParameterValue":65535,"RunStatus":1,"StatusReply":2,"InformationCode":234881024} 2024-07-23 19:45:03.639 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,18]},"SessionID":18} 2024-07-23 19:45:03.640 - debug: klf200.0 (262) Frame sent (GW_GET_LIMITATION_STATUS_REQ): {"Command":786,"offset":3,"BufferSize":25,"data":{"type":"Buffer","data":[28,3,18,0,19,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,4,1]},"SessionID":19,"Nodes":0,"LimitationType":1,"ParameterActive":4} 2024-07-23 19:45:03.669 - debug: klf200.0 (262) Frame received (GW_ACTIVATION_LOG_UPDATED_NTF): {"Command":1286,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:45:03.882 - debug: klf200.0 (262) Frame received (GW_GET_LIMITATION_STATUS_CFM): {"Command":787,"offset":3,"Data":{"type":"Buffer","data":[0,19,1]},"SessionID":19,"Status":1} 2024-07-23 19:45:13.507 - debug: klf200.0 (262) Frame received (GW_COMMAND_RUN_STATUS_NTF): {"Command":770,"offset":3,"Data":{"type":"Buffer","data":[0,19,1,0,0,255,255,1,2,14,0,0,0]},"SessionID":19,"StatusOwner":1,"NodeID":0,"NodeParameter":0,"ParameterValue":65535,"RunStatus":1,"StatusReply":2,"InformationCode":234881024} 2024-07-23 19:45:13.510 - debug: klf200.0 (262) Frame received (GW_SESSION_FINISHED_NTF): {"Command":772,"offset":3,"Data":{"type":"Buffer","data":[0,19]},"SessionID":19} 2024-07-23 19:45:13.512 - debug: klf200.0 (262) Frame sent (GW_STATUS_REQUEST_REQ): {"Command":773,"offset":3,"BufferSize":26,"data":{"type":"Buffer","data":[29,3,5,0,20,1,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,0,1,240,0]},"SessionID":20,"Nodes":0,"StatusType":1,"FunctionalParameters":[1,2,3,4]} 2024-07-23 19:45:13.535 - debug: klf200.0 (262) Frame received (GW_ACTIVATION_LOG_UPDATED_NTF): {"Command":1286,"offset":3,"Data":{"type":"Buffer","data":[]}} 2024-07-23 19:45:13.755 - debug: klf200.0 (262) Frame received (GW_STATUS_REQUEST_CFM): {"Command":774,"offset":3,"Data":{"type":"Buffer","data":[0,20,1]},"SessionID":20,"CommandStatus":1} 2024-07-23 19:45:16.759 - error: klf200.0 (262) Error during initialization of the adapter. 2024-07-23 19:45:16.761 - error: klf200.0 (262) Error: Timeout error 2024-07-23 19:45:16.764 - debug: klf200.0 (262) Error: Timeout error at /opt/iobroker/node_modules/iobroker.klf200/build/util/utils.js:45:14 at Timeout._onTimeout (/opt/iobroker/node_modules/@iobroker/js-controller-adapter/build/cjs/lib/adapter/adapter.js:1092:7) at listOnTimeout (node:internal/timers:569:17) at process.processTimers (node:internal/timers:512:7) 2024-07-23 19:45:16.768 - info: klf200.0 (262) Terminated (ADAPTER_REQUESTED_TERMINATION): Error: Timeout error 2024-07-23 19:45:17.486 - info: host.iobroker instance system.adapter.klf200.0 terminated by request of the instance itself and will not be restarted, before user restarts it. 2024-07-23 19:45:17.488 - info: host.iobroker Do not restart adapter system.adapter.klf200.0 because desired by instance ```

MiSchroe commented 1 month ago

Implementation idea:

  1. Send a GW_STATUS_REQUEST for all nodes and FP parameters 1-4.
  2. Each node that is online will respond with a GW_STATUS_REQUEST_NTF.
  3. Wait for GW_SESSION_FINISHED_NTF.
  4. Each responding node additionally sends a GW_NODE_STATE_POSITION_CHANGED_NTF. Those may eventually arrive after GW_SESSION_FINISHED_NTF, so they should be handled differently and should also be timeboxed after the GW_SESSION_FINISHED_NTF. Wait for the next notificiation max. 1 second after the last one or stop waiting if all responding nodes have sent one.