"Matter" Adapter: Tester für Alpha Phase gesucht

[Wildbill]

@wildbill So, habe mal doch ein paar Dinge ausge-x-t. War doch meine öffentliche IPv6 mit drin. Auch Dinge, die mit KEYs oder Zertifikaten drin waren, habe ich "verstümmelt". Wenn da nun doch was fehlt, einfach melden, ich kann das ungeschönte Log dann auch gerne per PN/Mail versenden, falls nötig.

2025-01-19 15:01:09.628 - info: host.iobroker-vm "system.adapter.matter.0" enabled
2025-01-19 15:01:09.886 - info: host.iobroker-vm instance system.adapter.matter.0 in version "0.3.6" started with pid 126198
2025-01-19 15:01:11.718 - debug: matter.0 (126198) Redis Objects: Use Redis connection: 10.10.10.194:6379
2025-01-19 15:01:11.726 - debug: matter.0 (126198) Objects client ready ... initialize now
2025-01-19 15:01:11.727 - debug: matter.0 (126198) Objects create System PubSub Client
2025-01-19 15:01:11.727 - debug: matter.0 (126198) Objects create User PubSub Client
2025-01-19 15:01:11.905 - debug: matter.0 (126198) Objects client initialize lua scripts
2025-01-19 15:01:11.907 - debug: matter.0 (126198) Objects connected to redis: 10.10.10.194:6379
2025-01-19 15:01:11.913 - debug: matter.0 (126198) Redis States: Use Redis connection: 10.10.10.194:6379
2025-01-19 15:01:11.916 - debug: matter.0 (126198) States create System PubSub Client
2025-01-19 15:01:11.916 - debug: matter.0 (126198) States create User PubSub Client
2025-01-19 15:01:11.920 - debug: matter.0 (126198) States connected to redis: 10.10.10.194:6379
2025-01-19 15:01:11.944 - debug: matter.0 (126198) Plugin sentry Do not initialize Plugin (enabled=false)
2025-01-19 15:01:12.007 - info: matter.0 (126198) starting. Version 0.3.6 in /opt/iobroker/node_modules/iobroker.matter, node: v20.18.1, js-controller: 7.0.6
2025-01-19 15:01:12.025 - debug: matter.0 (126198) Sync devices
2025-01-19 15:01:12.036 - debug: matter.0 (126198) Process 0 bridges ...
2025-01-19 15:01:12.036 - debug: matter.0 (126198) Process 0 devices ...
2025-01-19 15:01:12.036 - debug: matter.0 (126198) Sync controller
2025-01-19 15:01:12.054 - debug: matter.0 (126198) 2025-01-19 15:01:12.053 DEBUG PromiseQueue Add promise to queue on place 1
2025-01-19 15:01:12.054 - debug: matter.0 (126198) 2025-01-19 15:01:12.054 DEBUG PromiseQueue Processing promise from queue ... Current queue length: 1 Already running: 0
2025-01-19 15:01:12.055 - info: matter.0 (126198) Creating controller with Fabric Label: ioBroker matter.0
2025-01-19 15:01:12.055 - debug: matter.0 (126198) Sync done
2025-01-19 15:01:12.055 - debug: matter.0 (126198) 2025-01-19 15:01:12.055 DEBUG PromiseQueue Promise processed ... Still running: 0
2025-01-19 15:01:12.056 - debug: matter.0 (126198) Devices synced
2025-01-19 15:01:12.069 - debug: matter.0 (126198) [STORAGE] Initializing storage for storage.controller
2025-01-19 15:01:12.146 - debug: matter.0 (126198) 2025-01-19 15:01:12.145 INFO ControllerStore Opened *controller* storage at matter.0.storage/controller
2025-01-19 15:01:12.148 - debug: matter.0 (126198) 2025-01-19 15:01:12.147 DEBUG NodejsChannel Socket created and bound remoteAddress: undefined:5353 localAddress: 0.0.0.0:5353
2025-01-19 15:01:12.148 - debug: matter.0 (126198) 2025-01-19 15:01:12.148 DEBUG NodejsChannel Initialize multicast address: 192.168.20.65:5353 interface: ens19 type: udp4
2025-01-19 15:01:12.152 - debug: matter.0 (126198) 2025-01-19 15:01:12.152 DEBUG NodejsChannel Socket created and bound remoteAddress: undefined:5353 localAddress: :::5353
2025-01-19 15:01:12.152 - debug: matter.0 (126198) 2025-01-19 15:01:12.152 DEBUG NodejsChannel Initialize multicast address: ::%ens19:5353 interface: ens19 type: udp6
2025-01-19 15:01:12.153 - debug: matter.0 (126198) 2025-01-19 15:01:12.153 DEBUG NodejsChannel Socket created and bound remoteAddress: undefined:5353 localAddress: 0.0.0.0:5353
2025-01-19 15:01:12.154 - debug: matter.0 (126198) 2025-01-19 15:01:12.154 DEBUG NodejsChannel Initialize multicast address: 192.168.20.65:5353 interface: ens19 type: udp4
2025-01-19 15:01:12.155 - debug: matter.0 (126198) 2025-01-19 15:01:12.155 DEBUG NodejsChannel Socket created and bound remoteAddress: undefined:5353 localAddress: :::5353
2025-01-19 15:01:12.155 - debug: matter.0 (126198) 2025-01-19 15:01:12.155 DEBUG NodejsChannel Initialize multicast address: ::%ens19:5353 interface: ens19 type: udp6
2025-01-19 15:01:12.156 - debug: matter.0 (126198) 2025-01-19 15:01:12.156 DEBUG NodejsChannel Socket created and bound remoteAddress: undefined:undefined localAddress: :::56498
2025-01-19 15:01:12.157 - debug: matter.0 (126198) 2025-01-19 15:01:12.157 DEBUG NodejsChannel Socket created and bound remoteAddress: undefined:56498 localAddress: 0.0.0.0:56498
2025-01-19 15:01:12.157 - info: matter.0 (126198) 2025-01-19 15:01:12.157 WARN CommissioningController BLE is not supported on this platform
2025-01-19 15:01:12.172 - debug: matter.0 (126198) 2025-01-19 15:01:12.172 INFO CertificateAuthority Loaded stored credentials with ID 0
2025-01-19 15:01:12.175 - debug: matter.0 (126198) 2025-01-19 15:01:12.175 INFO MatterController Loaded existing fabric from storage
2025-01-19 15:01:12.180 - debug: matter.0 (126198) 2025-01-19 15:01:12.179 INFO SessionManager restoring resumption record for node 66963xxxxxxxxxx2140 and peer node 66963xxxxxxxxxx2140 for fabric index 1
2025-01-19 15:01:12.180 - debug: matter.0 (126198) 2025-01-19 15:01:12.180 INFO SessionManager restoring resumption record for node 92177xxxxxxxxxx3215 and peer node 92177xxxxxxxxxx3215 for fabric index 1
2025-01-19 15:01:12.182 - debug: matter.0 (126198) 2025-01-19 15:01:12.182 DEBUG DeviceAdvertiser Announcing fabricIndex: 1 fabricId: 1
2025-01-19 15:01:12.184 - debug: matter.0 (126198) 2025-01-19 15:01:12.184 DEBUG MdnsBroadcaster Announcement Generator: Fabric id: 925Exxxxxxxx5A7E-472Cxxxxxxxx2355 qname: 925Exxxxxxxx5A7E-472Cxxxxxxxx2355._matter._tcp.local port: 56498 interface: ens19
2025-01-19 15:01:12.184 - info: matter.0 (126198) Found 2 nodes: ["66963xxxxxxxxxx2140","92177xxxxxxxxxx3215"]
2025-01-19 15:01:12.184 - info: matter.0 (126198) Initializing to node "66963xxxxxxxxxx2140" ...
2025-01-19 15:01:12.186 - debug: matter.0 (126198) 2025-01-19 15:01:12.186 DEBUG NodejsChannel Socket created and bound remoteAddress: undefined:5353 localAddress: 0.0.0.0:5353
2025-01-19 15:01:12.186 - debug: matter.0 (126198) 2025-01-19 15:01:12.186 DEBUG NodejsChannel Socket created and bound remoteAddress: undefined:5353 localAddress: :::5353
2025-01-19 15:01:12.187 - debug: matter.0 (126198) 2025-01-19 15:01:12.187 DEBUG NodejsChannel Initialize multicast address: 192.168.20.65:5353 interface: ens19 type: udp4
2025-01-19 15:01:12.187 - debug: matter.0 (126198) 2025-01-19 15:01:12.187 DEBUG NodejsChannel Initialize multicast address: ::%ens19:5353 interface: ens19 type: udp6
2025-01-19 15:01:12.190 - debug: matter.0 (126198) 2025-01-19 15:01:12.190 DEBUG MdnsScanner Adding operational device 925Exxxxxxxx5A7E-472Cxxxxxxxx2355._matter._tcp.local in cache (interface ens19, ttl=120) with TXT data: SII: 500 SAI: 300 SAT: 4000 T: 0 ICD: 0
2025-01-19 15:01:12.190 - debug: matter.0 (126198) 2025-01-19 15:01:12.190 DEBUG MdnsScanner Added 5 IPs for operational device 925Exxxxxxxx5A7E-472Cxxxxxxxx2355._matter._tcp.local to cache (interface ens19): type: udp ip: fd8b:xxxx:xxxx:xxxx:8867:3eff:fe61:xxxx port: 56498 type: udp ip: 20xx:xx:xxxx:4044:8867:3eff:fe61:xxxx port: 56498 type: udp ip: fd8b:xxxx:xxxx:4e23:xxxx:3eff:fe61:xxxx port: 56498 type: udp ip: fe80::8xx7:3xxf:fe61:xxxx%ens19 port: 56498 type: udp ip: 192.168.20.65 port: 56498
2025-01-19 15:01:12.313 - debug: matter.0 (126198) 2025-01-19 15:01:12.313 INFO PairedNode Node 66963xxxxxxxxxx2140: Created paired node with device data { ethernetConnected: false, wifiConnected: false, threadConnected: false, rootEndpointServerList: [ 29, 30, 31, 40, 48, 51, 55, 60, 62, 63 ], isBatteryPowered: false, isIntermittentlyConnected: false, isThreadSleepyEndDevice: false, dataRevision: 1 }
2025-01-19 15:01:12.315 - debug: matter.0 (126198) 2025-01-19 15:01:12.315 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Creating device 0 {"29":{"deviceTypeList":[{"deviceType":22,"revision":1}],"serverList":[29,30,31,40,48,51,55,60,62,63],"clientList":[],"partsList":[1,2],"generatedCommandList":[],"acceptedCommandList":[],"attributeList":[0,1,2,3,65528,65529,65531,65532,65533],"featureMap":{"tagList":false},"clusterRevision":2},"30":{"binding":[],"generatedCommandList":[],"acceptedCommandList":[],"attributeList":[0,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":1},"31":{"acl":[{"privilege":5,"authMode":2,"subjects":["5128569453106307925"],"targets":null,"fabricIndex":4}],"extension":[],"subjectsPerAccessControlEntry":4,"targetsPerAccessControlEntry":3,"accessControlEntriesPerFabric":4,"generatedCommandList":[],"acceptedCommandList":[],"attributeList":[0,1,2,3,4,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":1},"40":{"dataModelRevision":17,"vendorName":"Aqara","vendorId":4447,"productName":"Aqara Hub M1S Gen 2","productId":2050,"nodeLabel":"Aqara Hub M1S Gen 2","location":"DE","hardwareVersion":1,"hardwareVersionString":"1","softwareVersion":430,"softwareVersionString":"4.3.0","manufacturingDate":"20200101","partNumber":"AG036","productUrl":"https://www.aqara.com/en/products.html","productLabel":"Aqara Hub M1S Gen 2","serialNumber":"54ef44679b3c","localConfigDisabled":false,"uniqueId":"lumi1.54ef44679b3c","capabilityMinima":{"caseSessionsPerFabric":3,"subscriptionsPerFabric":65535},"specificationVersion":16973824,"maxPathsPerInvoke":5,"generatedCommandList":[],"acceptedCommandList":[],"attributeList":[0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,18,19,21,22,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":3},"48":{"breadcrumb":0,"basicCommissioningInfo":{"failSafeExpiryLengthSeconds":60,"maxCumulativeFailsafeSeconds":900},"regulatoryConfig":0,"locationCapability":2,"supportsConcurrentConnection":true,"generatedCommandList":[1,3,5],"acceptedCommandList":[0,2,4],"attributeList":[0,1,2,3,4,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":1},"51":{"rebootCount":4,"testEventTriggersEnabled":false,"generatedCommandList":[2],"acceptedCommandList":[0,1],"attributeList":[0,1,8,65528,65529,65531,65532,65533],"featureMap":{"dataModelTest":true},"clusterRevision":2},"55":{"phyRate":0,"fullDuplex":false,"packetRxCount":0,"packetTxCount":0,"txErrCount":0,"collisionCount":0,"overrunCount":0,"carrierDetect":null,"timeSinceReset":676188,"generatedCommandList":[],"acceptedCommandList":[0],"attributeList":[0,1,2,3,4,5,6,7,8,65528,65529,65531,65532,65533],"featureMap":{"packetCounts":true,"errorCounts":true},"clusterRevision":1},"60":{"windowStatus":0,"adminFabricIndex":null,"adminVendorId":null,"generatedCommandList":[],"acceptedCommandList":[0,1,2],"attributeList":[0,1,2,65528,65529,65531,65532,65533],"featureMap":{"basic":false},"clusterRevision":1},"62":{"nocs":[{"noc":"15300101022402013703241400182604924b362d26051282e341370624150127115c188287df29ee5c1824070124080130094104c0d71dc3618df1bc6fefdb9a2d7f931e47e71dbc02f29c005f934ecd9a288e36d2af2531e07cade502e2b326cf393c72f0d775ccdddefc7491a0e0e6cb7bff2c370a350128011824020136030402040118300414b8ffd9cfd189d5c60696f6444503f322ad10c744300514a72c705119e36fccf9ef0360d0ca56f1636b541b18300b4039be5f92df87ebd474ec4d45a0b8cde98350b9a6968de3b9fe1d89e6af1133a1af2e692be4e280c494eff2e4a6f9acc7e1132641aec6425ab93fd4fdbbe892e218","icac":null,"fabricIndex":4}],"fabrics":[{"rootPublicKey":"xxxx5668858a146f7c57xxxxfe6cfcdab839f2617398be9xxxx1ac801755305bc790dc274490c78xxxxaa65731e22107a4e2f7bef50b72825c079c58460ae5xxxx","vendorId":65521,"fabricId":"1","nodeId":"66963xxxxxxxxxx2140","label":"ioBroker matter.0","fabricIndex":4}],"supportedFabrics":10,"commissionedFabrics":4,"trustedRootCertificates":["153001010024020137032714818f2947cdaa3b5326150fdf04d7182604067fd02e24050037062714818f2947cdaa3b5326150fdf04d71824070124080130094104fe802eedb9ba88ae7fec2408478c2d2dd92899488b6921b2990ff4d9e32f6f08b61bcaa79b04bbf21fa1e780b54812410b39f34c58bd01b5d7e3bd8010e3ece3370a3501290118240260300414f01e7dc9dd6f8dc07098227c8979af8e7748812a300514f01e7dc9dd6f8dc07098227c8979af8e7748812a18300b40ac56cad820ab5d1e614161da301978672b083a2b38c5a87ba89e3c3091b9b0ae28e00f6ba8cc6ef9e4d1e63c877d9986392cd23efede1648306ddc703bafd4a818","1530010101240201370324140118260480228127260580254d3a370624140118240701240801300941044be6ba9a96284a960b67e04ef50befa48779dd92b246394b7feac0f9f89946fd702fb5741a13f9f1aca665fa381bc7afe548f1fdf0802f707f50822bc8d52144370a350129011824026030041447dd205c44c7232ab67aaba61c67c7b64fa6b85830051447dd205c44c7232ab67aaba61c67c7b64fa6b85818300b4040b44a593ced2f591eb2d8b47aba8d392cf4a9fa34677c21f10876626946da11441793c022538a77b3ee32ccfa91f2031935df7f858d4aca4460f3ae3022f67218","1530010100240201370326149e961400261595eafe9218260461639c2c240500370626149e961400261595eafe921824070124080130094104f7228b19c178e4915226f71bdf3291b58b5586a018e3a53429041fafcc6f7c8411f48776843cfd1bd130636a725ce302d174635ce58335e37a5efc306bc71fee370a35012901182402603004146f5f323b2862b9ec2dae674a2a2b8ea0f2f07a703005146f5f323b2862b9ec2dae674a2a2b8ea0f2f07a7018300b4086adca5620439e4688ce29e2e4c75804f0a3bcd8030940c85d7929ffb3d4c2a879cdca974b4c53cb64cd3055ebac9fbf15dc62b83a5a9ff0ca51516f822fa29b18","153001010024020137032414001826047c4a362d2605fc80e341370624140018240701240801300941xxxx5668858a146f7c57xxxxfe6cfcdab839f2617398be9xxxx1ac801755305bc790dc274490c78xxxxaa65731e22107a4e2f7bef50b72825c079c58460ae5xxxx370a3501290118240260300414a72c705119e36fccf9ef0360d0ca56f1636b541b300514a72c705119e36fccf9ef0360d0ca56f1636b541bxxxx0b40845c7b8324de65cc98c1138c0ed991b646106421c6c9e3e9878097fd00d3fc3e4b24a062f3b22a3413d5b35ab1781b778e56932bxxxxdbb27f6decffae1e243118"],"currentFabricIndex":4,"generatedCommandList":[1,3,5,8],"acceptedCommandList":[0,2,4,6,7,9,10,11],"attributeList":[0,1,2,3,4,5,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":1},"63":{"groupKeyMap":[],"groupTable":[],"maxGroupsPerFabric":4,"maxGroupKeysPerFabric":3,"generatedCommandList":[2,5],"acceptedCommandList":[0,1,3,4],"attributeList":[0,1,2,3,65528,65529,65531,65532,65533],"featureMap":{"cacheAndSync":false},"clusterRevision":2}}
2025-01-19 15:01:12.321 - debug: matter.0 (126198) 2025-01-19 15:01:12.321 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Creating device 1 {"3":{"identifyTime":0,"identifyType":1,"generatedCommandList":[],"acceptedCommandList":[0,64],"attributeList":[0,1,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":2},"29":{"deviceTypeList":[{"deviceType":14,"revision":1}],"serverList":[3,29],"clientList":[],"partsList":[2],"generatedCommandList":[],"acceptedCommandList":[],"attributeList":[0,1,2,3,65528,65529,65531,65532,65533],"featureMap":{"tagList":false},"clusterRevision":2}}
2025-01-19 15:01:12.323 - debug: matter.0 (126198) 2025-01-19 15:01:12.322 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Creating device 2 {"3":{"identifyTime":0,"identifyType":1,"generatedCommandList":[],"acceptedCommandList":[0,64],"attributeList":[0,1,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":4},"6":{"onOff":false,"globalSceneControl":true,"onTime":0,"offWaitTime":0,"startUpOnOff":null,"generatedCommandList":[],"acceptedCommandList":[0,1,2,64,65,66],"attributeList":[0,16384,16385,16386,16387,65528,65529,65531,65532,65533],"featureMap":{"lighting":true,"deadFrontBehavior":false,"offOnly":false},"clusterRevision":6},"8":{"currentLevel":128,"remainingTime":0,"minLevel":1,"maxLevel":254,"options":{"executeIfOff":false,"coupleColorTempToLevel":false},"onLevel":null,"startUpCurrentLevel":null,"generatedCommandList":[],"acceptedCommandList":[0,1,2,3,4,5,6,7],"attributeList":[0,1,2,3,17,15,16384,65528,65529,65531,65532,65533],"featureMap":{"onOff":true,"lighting":true,"frequency":false},"clusterRevision":5},"29":{"deviceTypeList":[{"deviceType":19,"revision":2},{"deviceType":269,"revision":4}],"serverList":[29,57,3,6,8,768],"clientList":[],"partsList":[],"generatedCommandList":[],"acceptedCommandList":[],"attributeList":[0,1,2,3,65528,65529,65531,65532,65533],"featureMap":{"tagList":false},"clusterRevision":2},"57":{"vendorName":"Aqara","vendorId":4447,"productName":"Aqara Night Light","nodeLabel":"Aqara Night Light","hardwareVersion":1,"hardwareVersionString":"1","softwareVersion":430,"softwareVersionString":"430","partNumber":"AG036","productUrl":"https://www.aqara.com/en/products.html","productLabel":"Aqara Night Light","serialNumber":"54ef44679b3c","reachable":true,"uniqueId":"lumi1.54ef44679b3c","generatedCommandList":[],"acceptedCommandList":[],"attributeList":[1,2,3,5,7,8,9,10,15,12,13,14,17,18,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":3},"768":{"currentHue":0,"currentSaturation":0,"colorMode":0,"options":{"executeIfOff":false},"numberOfPrimaries":0,"enhancedColorMode":0,"colorCapabilities":{"hueSaturation":true,"enhancedHue":false,"colorLoop":false,"xy":false,"colorTemperature":false},"generatedCommandList":[],"acceptedCommandList":[71,0,1,2,3,4,5,6],"attributeList":[0,1,8,15,16,16385,16394,65528,65529,65531,65532,65533],"featureMap":{"hueSaturation":true,"enhancedHue":false,"colorLoop":false,"xy":false,"colorTemperature":false},"clusterRevision":6}}
2025-01-19 15:01:12.325 - debug: matter.0 (126198) 2025-01-19 15:01:12.325 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Endpoints from PartsLists [[0,[1,2]],[1,[2]],[2,[]]]
2025-01-19 15:01:12.326 - debug: matter.0 (126198) 2025-01-19 15:01:12.325 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Endpoint usages {"1":[0],"2":[0,1]}
2025-01-19 15:01:12.326 - debug: matter.0 (126198) 2025-01-19 15:01:12.326 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Processing Endpoint [["1",[0]]]
2025-01-19 15:01:12.326 - debug: matter.0 (126198) 2025-01-19 15:01:12.326 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Endpoint structure: Child: 1 -> Parent: 0
2025-01-19 15:01:12.326 - debug: matter.0 (126198) 2025-01-19 15:01:12.326 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Endpoint data Cleanup {"0":true}
2025-01-19 15:01:12.326 - debug: matter.0 (126198) 2025-01-19 15:01:12.326 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Processing Endpoint [["2",[1]]]
2025-01-19 15:01:12.326 - debug: matter.0 (126198) 2025-01-19 15:01:12.326 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Endpoint structure: Child: 2 -> Parent: 1
2025-01-19 15:01:12.326 - debug: matter.0 (126198) 2025-01-19 15:01:12.326 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Endpoint data Cleanup {"1":true}
2025-01-19 15:01:12.342 - info: matter.0 (126198) Node 66963xxxxxxxxxx2140: Endpoint 0 to ioBroker Devices MA-rootnode / RootNode
2025-01-19 15:01:12.522 - info: matter.0 (126198) Node 66963xxxxxxxxxx2140: Endpoint 1 to ioBroker Devices MA-aggregator / Aggregator
2025-01-19 15:01:12.524 - info: matter.0 (126198) Node 66963xxxxxxxxxx2140: Aggregator device type detected
2025-01-19 15:01:12.526 - info: matter.0 (126198) Node 66963xxxxxxxxxx2140: Endpoint 2 to ioBroker Devices MA-bridgednode / ExtendedColorLight
2025-01-19 15:01:12.530 - info: matter.0 (126198) Node 66963xxxxxxxxxx2140: Creating device for ExtendedColorLight (endpoint 2)
2025-01-19 15:01:12.547 - debug: matter.0 (126198) Set matter.0.controller.66963xxxxxxxxxx2140.Aggregator-1.ExtendedColorLight-2.HUE to 0 (ack = true)
2025-01-19 15:01:12.550 - debug: matter.0 (126198) Set matter.0.controller.66963xxxxxxxxxx2140.Aggregator-1.ExtendedColorLight-2.SATURATION to "0" (ack = true)
2025-01-19 15:01:12.553 - debug: matter.0 (126198) Set matter.0.controller.66963xxxxxxxxxx2140.Aggregator-1.ExtendedColorLight-2.ON_ACTUAL to false (ack = true)
2025-01-19 15:01:12.555 - debug: matter.0 (126198) Set matter.0.controller.66963xxxxxxxxxx2140.Aggregator-1.ExtendedColorLight-2.ON to false (ack = true)
2025-01-19 15:01:12.558 - debug: matter.0 (126198) Set matter.0.controller.66963xxxxxxxxxx2140.Aggregator-1.ExtendedColorLight-2.ON_ACTUAL to false (ack = true)
2025-01-19 15:01:12.561 - debug: matter.0 (126198) Set matter.0.controller.66963xxxxxxxxxx2140.Aggregator-1.ExtendedColorLight-2.ON to false (ack = true)
2025-01-19 15:01:12.563 - debug: matter.0 (126198) Set matter.0.controller.66963xxxxxxxxxx2140.Aggregator-1.ExtendedColorLight-2.DIMMER to "50" (ack = true)
2025-01-19 15:01:12.566 - debug: matter.0 (126198) Set matter.0.controller.66963xxxxxxxxxx2140.Aggregator-1.ExtendedColorLight-2.UNREACH to false (ack = true)
2025-01-19 15:01:12.573 - debug: matter.0 (126198) 2025-01-19 15:01:12.573 DEBUG InteractionClient Sending read request: attributes: 0x2/ColorControl(0x300)/colorTempPhysicalMinMireds(0x400b) and events: undefined
2025-01-19 15:01:12.574 - debug: matter.0 (126198) 2025-01-19 15:01:12.574 DEBUG PeerSet Resuming connection to peer@1:0x5cee29df8782185c at fe80::5xxf:44ff:fe67:9xxc%ens19:5540
2025-01-19 15:01:12.576 - debug: matter.0 (126198) 2025-01-19 15:01:12.576 DEBUG MessageExchange New exchange channel: udp://fe80::5xxf:44ff:fe67:9xxc%ens19:5540 on session insecure/11353487267342622812 protocol: 0 exId: 42749 sess: insecure/11353487267342622812 peerSess: 0 SAT: 4000 SAI: 300 SII: 500 maxTrans: 5 MRP
2025-01-19 15:01:12.579 - debug: matter.0 (126198) 2025-01-19 15:01:12.579 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42749/51269371 type: 0x0/0x30 reqAck size: 212 payload: 15300120bce851cf0472c8f5fdcc337f8e6b2aacf7c1dc693e187b501a48e1c74e29fcdd2502ee5030032016a79f7517d2da84fbdfd97c10a252a3484c941f8b75d7650103c97d43766df630044104babbe959debdb94b46e042d372901b465f62907a0b825be4d402ce0f44fc9d91facf7bd6cf226e9f4a30a3c433ce4e4f5539a1919cd5623097b366c7bdefdada35052501f40125022c012503a00f24041124050c26060000030124070a18300610bc68970ab166aabe69b9858f8862a06330071001a915e7f02f3f942666bf48639affd418
2025-01-19 15:01:12.585 - debug: matter.0 (126198) 2025-01-19 15:01:12.585 DEBUG MessageExchange Message « for: SC/Sigma2Resume msgId: 0/42749/35060879 type: 0x0/0x33 acked: 51269371 reqAck size: 74 payload: 15300110c3845310dcd09905a6d4711e3204591b3002107b27e0cc39f3045597323e65752380ff2503b37235042501f40125022c012503a00f24041124050b2606000003012407051818
2025-01-19 15:01:12.588 - debug: matter.0 (126198) 2025-01-19 15:01:12.587 DEBUG SecureSession Created secure CASE session for fabric index 1 secure/20718 SII: 500 SAI: 300 SAT: 4000 DMRev: 17 IMRev: 11 spec: 0x1030000 maxPaths: 5 CATs:
2025-01-19 15:01:12.588 - debug: matter.0 (126198) 2025-01-19 15:01:12.588 DEBUG ExchangeManager Message » for: SC/StatusReport generalStatus: Success protocolStatus: Success msgId: 0/42749/51269372 type: 0x0/0x40 acked: 35060879 reqAck size: 8 payload: 0000000000000000
2025-01-19 15:01:12.594 - debug: matter.0 (126198) 2025-01-19 15:01:12.594 DEBUG MessageExchange Message « for: SC/StandaloneAck msgId: 0/42749/35060880 type: 0x0/0x10 acked: 51269372
2025-01-19 15:01:12.595 - debug: matter.0 (126198) 2025-01-19 15:01:12.595 INFO CaseClient Case client: Session resumed with udp://fe80::5xxf:44ff:fe67:9xxc%ens19:5540 and parameters SII: 500 SAI: 300 SAT: 4000 DMRev: 17 IMRev: 11 spec: 0x1030000 maxPaths: 5 CATs:
2025-01-19 15:01:12.599 - debug: matter.0 (126198) 2025-01-19 15:01:12.599 INFO InsecureSession End insecure session insecure/11353487267342622812
2025-01-19 15:01:12.606 - debug: matter.0 (126198) 2025-01-19 15:01:12.606 DEBUG MessageExchange New exchange channel: udp://fe80::5xxf:44ff:fe67:9xxc%ens19:5540 on session secure/20718 protocol: 1 exId: 42750 sess: secure/20718 peerSess: 29363 SAT: 4000 SAI: 300 SII: 500 maxTrans: 5 MRP
2025-01-19 15:01:12.606 - debug: matter.0 (126198) 2025-01-19 15:01:12.606 DEBUG InteractionClient Sending read request to udp://fe80::5xxf:44ff:fe67:9xxc%ens19:5540 on session secure/20718 for attributes 0x2/ColorControl(0x300)/colorTempPhysicalMinMireds(0x400b) and events undefined
2025-01-19 15:01:12.607 - debug: matter.0 (126198) 2025-01-19 15:01:12.607 DEBUG ExchangeManager Message » for: I/ReadRequest msgId: 29363/42750/264918818 type: 0x1/0x2 reqAck size: 23 payload: 153600172402022503000325040b401818290324ff0c18
2025-01-19 15:01:12.613 - debug: matter.0 (126198) 2025-01-19 15:01:12.612 DEBUG MessageExchange Message « for: I/ReportData msgId: 20718/42750/113044125 type: 0x1/0x5 acked: 264918818 reqAck size: 35 payload: 15360115350037002402022503000325040b4018350124008618181818290424ff0b18
2025-01-19 15:01:12.614 - debug: matter.0 (126198) 2025-01-19 15:01:12.614 DEBUG InteractionClient Received read response with attributes and events
2025-01-19 15:01:12.615 - debug: matter.0 (126198) 2025-01-19 15:01:12.614 DEBUG ExchangeManager Message » for: SC/StandaloneAck msgId: 29363/42750/264918819 type: 0x0/0x10 acked: 113044125
2025-01-19 15:01:12.615 - debug: matter.0 (126198) 2025-01-19 15:01:12.615 DEBUG InteractionClient Sending read request: attributes: 0x2/ColorControl(0x300)/colorTempPhysicalMaxMireds(0x400c) and events: undefined
2025-01-19 15:01:12.615 - debug: matter.0 (126198) 2025-01-19 15:01:12.615 DEBUG MessageExchange New exchange channel: udp://fe80::5xxf:44ff:fe67:9xxc%ens19:5540 on session secure/20718 protocol: 1 exId: 42751 sess: secure/20718 peerSess: 29363 SAT: 4000 SAI: 300 SII: 500 maxTrans: 5 MRP
2025-01-19 15:01:12.615 - debug: matter.0 (126198) 2025-01-19 15:01:12.615 DEBUG InteractionClient Sending read request to udp://fe80::5xxf:44ff:fe67:9xxc%ens19:5540 on session secure/20718 for attributes 0x2/ColorControl(0x300)/colorTempPhysicalMaxMireds(0x400c) and events undefined
2025-01-19 15:01:12.616 - debug: matter.0 (126198) 2025-01-19 15:01:12.616 DEBUG ExchangeManager Message » for: I/ReadRequest msgId: 29363/42751/264918820 type: 0x1/0x2 reqAck size: 23 payload: 153600172402022503000325040c401818290324ff0c18
2025-01-19 15:01:12.620 - debug: matter.0 (126198) 2025-01-19 15:01:12.619 DEBUG MessageExchange Message « for: I/ReportData msgId: 20718/42751/113044126 type: 0x1/0x5 acked: 264918820 reqAck size: 35 payload: 15360115350037002402022503000325040c4018350124008618181818290424ff0b18
2025-01-19 15:01:12.620 - debug: matter.0 (126198) 2025-01-19 15:01:12.620 DEBUG InteractionClient Received read response with attributes and events
2025-01-19 15:01:12.620 - debug: matter.0 (126198) 2025-01-19 15:01:12.620 DEBUG ExchangeManager Message » for: SC/StandaloneAck msgId: 29363/42751/264918821 type: 0x0/0x10 acked: 113044126
2025-01-19 15:01:12.621 - info: matter.0 (126198) Endpoint 2 (MA-bridgednode):
2025-01-19 15:01:12.748 - info: matter.0 (126198) Endpoint 1 (MA-aggregator):
2025-01-19 15:01:12.868 - debug: matter.0 (126198) 2025-01-19 15:01:12.868 INFO PairedNode Node 66963xxxxxxxxxx2140: Reconnecting in 0s ...
2025-01-19 15:01:12.868 - info: matter.0 (126198) Initializing to node "92177xxxxxxxxxx3215" ...
2025-01-19 15:01:12.869 - debug: matter.0 (126198) 2025-01-19 15:01:12.869 INFO PairedNode Node 92177xxxxxxxxxx3215: Created paired node with device data { ethernetConnected: false, wifiConnected: false, threadConnected: true, rootEndpointServerList: [ 29, 31, 40, 42, 48, 49, 51, 60, 62, 63, 323615744 ], isBatteryPowered: true, isIntermittentlyConnected: false, isThreadSleepyEndDevice: false, dataRevision: 1 }
2025-01-19 15:01:12.870 - debug: matter.0 (126198) 2025-01-19 15:01:12.870 DEBUG PairedNode Node 92177xxxxxxxxxx3215: Creating device 0 {"29":{"deviceTypeList":[{"deviceType":22,"revision":1}],"serverList":[29,31,40,42,48,49,51,60,62,63,323615744],"clientList":[41],"partsList":[1,2],"generatedCommandList":[],"acceptedCommandList":[],"attributeList":[0,1,2,3,65528,65529,65531,65532,65533],"featureMap":{"tagList":false},"clusterRevision":2},"31":{"acl":[{"privilege":5,"authMode":2,"subjects":["5128569453106307925"],"targets":null,"fabricIndex":6}],"extension":[],"subjectsPerAccessControlEntry":4,"targetsPerAccessControlEntry":3,"accessControlEntriesPerFabric":4,"generatedCommandList":[],"acceptedCommandList":[],"attributeList":[0,1,2,3,4,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":1},"40":{"dataModelRevision":17,"vendorName":"Aqara","vendorId":4447,"productName":"Aqara Smart Lock U200","productId":10242,"nodeLabel":"","location":"XX","hardwareVersion":1000,"hardwareVersionString":"1.0.0.0","softwareVersion":71,"softwareVersionString":"071","partNumber":"AD040","productUrl":"https://www.aqara.com/en/products.html","productLabel":"Aqara Smart Lock U200","serialNumber":"54EF441000E65972","localConfigDisabled":false,"uniqueId":"B88D03898DC86BD7","capabilityMinima":{"caseSessionsPerFabric":3,"subscriptionsPerFabric":3},"productAppearance":{"finish":2,"primaryColor":16},"generatedCommandList":[],"acceptedCommandList":[],"attributeList":[0,1,2,3,4,5,6,7,8,9,10,12,13,14,15,16,18,19,20,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":2},"42":{"defaultOtaProviders":[],"updatePossible":true,"updateState":1,"updateStateProgress":null,"generatedCommandList":[],"acceptedCommandList":[0],"attributeList":[0,1,2,3,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":1},"48":{"breadcrumb":0,"basicCommissioningInfo":{"failSafeExpiryLengthSeconds":60,"maxCumulativeFailsafeSeconds":900},"regulatoryConfig":0,"locationCapability":0,"supportsConcurrentConnection":true,"generatedCommandList":[1,3,5],"acceptedCommandList":[0,2,4],"attributeList":[0,1,2,3,4,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":1},"49":{"maxNetworks":1,"networks":[{"networkId":"8b3b207b6f204e23","connected":true}],"scanMaxTimeSeconds":10,"connectMaxTimeSeconds":20,"interfaceEnabled":true,"lastNetworkingStatus":0,"lastNetworkId":"8b3b207b6f204e23","lastConnectErrorValue":null,"generatedCommandList":[1,5,7],"acceptedCommandList":[0,3,4,6,8],"attributeList":[0,1,2,3,4,5,6,7,65528,65529,65531,65532,65533],"featureMap":{"wiFiNetworkInterface":false,"threadNetworkInterface":true,"ethernetNetworkInterface":false},"clusterRevision":1},"51":{"networkInterfaces":[{"name":"MyHome21","isOperational":true,"offPremiseServicesReachableIPv4":null,"offPremiseServicesReachableIPv6":null,"hardwareAddress":"08e80120ffbb0308","iPv4Addresses":[],"iPv6Addresses":[],"type":4}],"rebootCount":37,"upTime":154,"totalOperationalHours":0,"bootReason":0,"activeHardwareFaults":[],"activeRadioFaults":[],"activeNetworkFaults":[],"testEventTriggersEnabled":false,"generatedCommandList":[],"acceptedCommandList":[0],"attributeList":[0,1,2,3,4,5,6,7,8,65528,65529,65531,65532,65533],"featureMap":{"dataModelTest":false},"clusterRevision":1},"60":{"windowStatus":0,"adminFabricIndex":null,"adminVendorId":null,"generatedCommandList":[],"acceptedCommandList":[0,1,2],"attributeList":[0,1,2,65528,65529,65531,65532,65533],"featureMap":{"basic":false},"clusterRevision":1},"62":{"nocs":[{"noc":"15300101012402013703241400182604c9ec362d26054923e441370624150127115f732cb17adceb7f1824070124080130094104ff5c4117108287cb37cd7ca74c0d0951fee41b7e3befbefbfd51538089245c5cd2b678c46ed633b5e3a43a0a5f10b99ff1d5b34353fefbf26afae9291b11a9b0370a35012801182402013603040204011830041477118096b75abfe8de2027b36b099dbddc1369b5300514a72c705119e36fccf9ef0360d0ca56f1636b541b18300b406d31d4fbb32bb32bf265441b22566648cec1525f2853d7a55e68c4ed37f582a4251d1abe9f26e1d8a43ac4f25f942c55b59d44f74e9c6992d59891eab38abdc318","icac":null,"fabricIndex":6}],"fabrics":[{"rootPublicKey":"xxxx5668858a146f7c57xxxxfe6cfcdab839f2617398be9xxxx1ac801755305bc790dc274490c78xxxxaa65731e22107a4e2f7bef50b72825c079c58460ae5xxxx","vendorId":65521,"fabricId":"1","nodeId":"92177xxxxxxxxxx3215","label":"ioBroker matter.0","fabricIndex":6}],"supportedFabrics":5,"commissionedFabrics":5,"trustedRootCertificates":["1530010100240201370326149e961400261595eafe9218260461639c2c240500370626149e961400261595eafe921824070124080130094104f7228b19c178e4915226f71bdf3291b58b5586a018e3a53429041fafcc6f7c8411f48776843cfd1bd130636a725ce302d174635ce58335e37a5efc306bc71fee370a35012901182402603004146f5f323b2862b9ec2dae674a2a2b8ea0f2f07a703005146f5f323b2862b9ec2dae674a2a2b8ea0f2f07a7018300b4086adca5620439e4688ce29e2e4c75804f0a3bcd8030940c85d7929ffb3d4c2a879cdca974b4c53cb64cd3055ebac9fbf15dc62b83a5a9ff0ca51516f822fa29b18","153001010024020137032714818f2947cdaa3b5326150fdf04d7182604067fd02e24050037062714818f2947cdaa3b5326150fdf04d71824070124080130094104fe802eedb9ba88ae7fec2408478c2d2dd92899488b6921b2990ff4d9e32f6f08b61bcaa79b04bbf21fa1e780b54812410b39f34c58bd01b5d7e3bd8010e3ece3370a3501290118240260300414f01e7dc9dd6f8dc07098227c8979af8e7748812a300514f01e7dc9dd6f8dc07098227c8979af8e7748812a18300b40ac56cad820ab5d1e614161da301978672b083a2b38c5a87ba89e3c3091b9b0ae28e00f6ba8cc6ef9e4d1e63c877d9986392cd23efede1648306ddc703bafd4a818","1530010101240201370324140118260480228127260580254d3a370624140118240701240801300941044be6ba9a96284a960b67e04ef50befa48779dd92b246394b7feac0f9f89946fd702fb5741a13f9f1aca665fa381bc7afe548f1fdf0802f707f50822bc8d52144370a350129011824026030041447dd205c44c7232ab67aaba61c67c7b64fa6b85830051447dd205c44c7232ab67aaba61c67c7b64fa6b85818300b4040b44a593ced2f591eb2d8b47aba8d392cf4a9fa34677c21f10876626946da11441793c022538a77b3ee32ccfa91f2031935df7f858d4aca4460f3ae3022f67218","15300111008f7e89d8d67b0aecdeae6d212deaa3b724020137032714d894477fd1553601182604537ac72a2605e378cd5937062714d894477fd15536011824070124080130094104047302d8c1c429049055346a31cf2c7e62d7266a3ddeb60a854810d9a8d3ed50a2e90bb5f1fad51b29b727c153946b64718ae2422ea10dfc9b7db0cbc48164d4370a3501290118300414c6e675219d6a1ebb8e664f86d80fe11c3758b859240261300514c6e675219d6a1ebb8e664f86d80fe11c3758b85918300b40092a586ace30018a5fa614cca2c2b23c58ab6c75dc8e759f95a7ba13db97d84043b532505e0cf61c187d29c00f56f90a4952dfb195163d49bbb1f5402e52ad9818","153001010024020137032414001826047c4a362d2605fc80e341370624140018240701240801300941xxxx5668858a146f7c57xxxxfe6cfcdab839f2617398be9xxxx1ac801755305bc790dc274490c78xxxxaa65731e22107a4e2f7bef50b72825c079c58460ae5xxxx370a3501290118240260300414a72c705119e36fccf9ef0360d0ca56f1636b541b300514a72c705119e36fccf9ef0360d0ca56f1636b541b18300b40845c7b8324de65cc98c1138c0ed991b646106421c6c9e3e9878097fd00d3fc3e4b24a062f3b22a3413d5b35ab1781b778e56932be571dbb27f6decffae1e243118"],"currentFabricIndex":6,"generatedCommandList":[1,3,5,8],"acceptedCommandList":[0,2,4,6,7,9,10,11],"attributeList":[0,1,2,3,4,5,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":1},"63":{"groupKeyMap":[],"groupTable":[],"maxGroupsPerFabric":4,"maxGroupKeysPerFabric":3,"generatedCommandList":[2,5],"acceptedCommandList":[0,1,3,4],"attributeList":[0,1,2,3,65528,65529,65531,65532,65533],"featureMap":{"cacheAndSync":false},"clusterRevision":2},"323615744":{"Unknown (0x0)":true,"generatedCommandList":[],"acceptedCommandList":[],"attributeList":[0,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":1}}
2025-01-19 15:01:12.871 - debug: matter.0 (126198) 2025-01-19 15:01:12.871 INFO ClusterHelper Unknown cluster 0x1349fc00 requested: UnknownCluster instance added.
2025-01-19 15:01:12.872 - debug: matter.0 (126198) 2025-01-19 15:01:12.872 INFO ClusterClient Added unknown attribute 0x0 to cluster 0x1349fc00
2025-01-19 15:01:12.872 - debug: matter.0 (126198) 2025-01-19 15:01:12.872 DEBUG PairedNode Node 92177xxxxxxxxxx3215: Creating device 1 {"3":{"identifyTime":0,"identifyType":2,"generatedCommandList":[],"acceptedCommandList":[0,64],"attributeList":[0,1,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":4},"29":{"deviceTypeList":[{"deviceType":10,"revision":1}],"serverList":[3,29,257,291503106],"clientList":[],"partsList":[],"generatedCommandList":[],"acceptedCommandList":[],"attributeList":[0,1,2,3,65528,65529,65531,65532,65533],"featureMap":{"tagList":false},"clusterRevision":2},"257":{"lockState":1,"lockType":9,"actuatorEnabled":false,"numberOfTotalUsersSupported":10,"numberOfPinUsersSupported":15,"numberOfRfidUsersSupported":15,"numberOfWeekDaySchedulesSupportedPerUser":1,"numberOfYearDaySchedulesSupportedPerUser":1,"numberOfHolidaySchedulesSupported":1,"maxPinCodeLength":8,"minPinCodeLength":4,"maxRfidCodeLength":74,"minRfidCodeLength":10,"credentialRulesSupport":{"single":true,"dual":false,"tri":false},"numberOfCredentialsSupportedPerUser":15,"operatingMode":0,"supportedOperatingModes":{"normal":false,"vacation":true,"privacy":true,"noRemoteLockUnlock":false,"passage":true},"enableOneTouchLocking":false,"wrongCodeEntryLimit":10,"userCodeTemporaryDisableTime":60,"requirePinForRemoteOperation":false,"generatedCommandList":[28,35,37],"acceptedCommandList":[0,1,3,26,27,29,34,36,38],"attributeList":[0,1,2,17,18,19,20,21,22,23,24,25,26,27,28,37,38,41,48,49,51,65528,65529,65531,65532,65533],"featureMap":{"pinCredential":true,"rfidCredential":true,"fingerCredentials":false,"logging":false,"weekDayAccessSchedules":false,"doorPositionSensor":false,"faceCredentials":false,"credentialOverTheAirAccess":true,"user":true,"notification":false,"yearDayAccessSchedules":false,"holidaySchedules":false,"unbolting":false},"clusterRevision":7},"291503106":{"Unknown (0x0)":2,"Unknown (0x1)":2,"Unknown (0x2)":2,"Unknown (0x3)":2,"Unknown (0x4)":false,"generatedCommandList":[],"acceptedCommandList":[0,1],"attributeList":[0,1,2,3,4,65528,65529,65531,65532,65533],"featureMap":{},"clusterRevision":1}}
2025-01-19 15:01:12.873 - debug: matter.0 (126198) 2025-01-19 15:01:12.873 INFO ClusterHelper Unknown cluster 0x115ffc02 requested: UnknownCluster instance added.
2025-01-19 15:01:12.874 - debug: matter.0 (126198) 2025-01-19 15:01:12.873 INFO ClusterClient Added unknown attribute 0x0 to cluster 0x115ffc02
2025-01-19 15:01:12.874 - debug: matter.0 (126198) 2025-01-19 15:01:12.874 INFO ClusterClient Added unknown attribute 0x1 to cluster 0x115ffc02
2025-01-19 15:01:12.874 - debug: matter.0 (126198) 2025-01-19 15:01:12.874 INFO ClusterClient Added unknown attribute 0x2 to cluster 0x115ffc02
2025-01-19 15:01:12.874 - debug: matter.0 (126198) 2025-01-19 15:01:12.874 INFO ClusterClient Added unknown attribute 0x3 to cluster 0x115ffc02
2025-01-19 15:01:12.874 - debug: matter.0 (126198) 2025-01-19 15:01:12.874 INFO ClusterClient Added unknown attribute 0x4 to cluster 0x115ffc02
2025-01-19 15:01:12.874 - debug: matter.0 (126198) 2025-01-19 15:01:12.874 INFO ClusterClient Ignoring unknown command 0 at cluster 0x115ffc02
2025-01-19 15:01:12.874 - debug: matter.0 (126198) 2025-01-19 15:01:12.874 INFO ClusterClient Ignoring unknown command 1 at cluster 0x115ffc02

Gruss, Jürgen

[Wildbill]

2025-01-19 15:01:12.875 - debug: matter.0 (126198) 2025-01-19 15:01:12.875 DEBUG PairedNode Node 92177xxxxxxxxxx3215: Creating device 2 {"29":{"deviceTypeList":[{"deviceType":17,"revision":1}],"serverList":[29,47],"clientList":[],"partsList":[],"generatedCommandList":[],"acceptedCommandList":[],"attributeList":[0,1,2,3,65528,65529,65531,65532,65533],"featureMap":{"tagList":false},"clusterRevision":2},"47":{"status":1,"order":0,"description":"Rechargeable Battery","batVoltage":7400,"batPercentRemaining":174,"batChargeLevel":0,"batReplacementNeeded":false,"batReplaceability":3,"endpointList":[],"generatedCommandList":[],"acceptedCommandList":[],"attributeList":[0,1,2,11,12,14,15,16,31,65528,65529,65531,65532,65533],"featureMap":{"wired":false,"battery":true,"rechargeable":false,"replaceable":false},"clusterRevision":1}}
2025-01-19 15:01:12.876 - debug: matter.0 (126198) 2025-01-19 15:01:12.876 DEBUG PairedNode Node 92177xxxxxxxxxx3215: Endpoints from PartsLists [[0,[1,2]],[1,[]],[2,[]]]
2025-01-19 15:01:12.876 - debug: matter.0 (126198) 2025-01-19 15:01:12.876 DEBUG PairedNode Node 92177xxxxxxxxxx3215: Endpoint usages {"1":[0],"2":[0]}
2025-01-19 15:01:12.876 - debug: matter.0 (126198) 2025-01-19 15:01:12.876 DEBUG PairedNode Node 92177xxxxxxxxxx3215: Processing Endpoint [["1",[0]],["2",[0]]]
2025-01-19 15:01:12.876 - debug: matter.0 (126198) 2025-01-19 15:01:12.876 DEBUG PairedNode Node 92177xxxxxxxxxx3215: Endpoint structure: Child: 1 -> Parent: 0
2025-01-19 15:01:12.876 - debug: matter.0 (126198) 2025-01-19 15:01:12.876 DEBUG PairedNode Node 92177xxxxxxxxxx3215: Endpoint structure: Child: 2 -> Parent: 0
2025-01-19 15:01:12.877 - debug: matter.0 (126198) 2025-01-19 15:01:12.877 DEBUG PairedNode Node 92177xxxxxxxxxx3215: Endpoint data Cleanup {"0":true}
2025-01-19 15:01:12.878 - debug: matter.0 (126198) 2025-01-19 15:01:12.878 DEBUG InteractionClient Sending subscribe request: attributes: */*/* and events: !*/*/*, keepSubscriptions=false
2025-01-19 15:01:12.878 - debug: matter.0 (126198) 2025-01-19 15:01:12.878 DEBUG InteractionClient Using DataVersionFilters: 0/29=569127472, 0/30=944158602, 0/31=802506885, 0/40=991472800, 0/48=538966571, 0/51=3961767521, 0/55=278849971, 0/60=1326404654, 0/62=260077834, 0/63=1159407877, 1/3=1180882345, 1/29=3636063679, 2/3=741036309, 2/6=891749384, 2/8=3359718266, 2/29=1050134708, 2/57=3724111010, 2/768=2567028963
2025-01-19 15:01:12.878 - debug: matter.0 (126198) 2025-01-19 15:01:12.878 DEBUG InteractionClient Using event filters: undefined=196615
2025-01-19 15:01:12.879 - debug: matter.0 (126198) 2025-01-19 15:01:12.878 DEBUG MessageExchange New exchange channel: udp://fe80::5xxf:44ff:fe67:9xxc%ens19:5540 on session secure/20718 protocol: 1 exId: 42752 sess: secure/20718 peerSess: 29363 SAT: 4000 SAI: 300 SII: 500 maxTrans: 5 MRP
2025-01-19 15:01:12.880 - debug: matter.0 (126198) 2025-01-19 15:01:12.879 DEBUG ExchangeManager Message » for: I/SubscribeRequest msgId: 29363/42752/264918822 type: 0x1/0x3 reqAck size: 348 payload: 15280024010124023c36031718183604172904181836051526010700030018182907360815370024010024021d1826013032ec211815370024010024021e1826018ab746381815370024010024021f1826018548d52f18153700240100240228182601a0ac183b181537002401002402301826012bfa1f201815370024010024023318260161c623ec18153700240100240237182601b3e99e101815370024010024023c1826012e540f4f1815370024010024023e1826010a79800f1815370024010024023f18260105291b4518153700240101240203182601a9d562461815370024010124021d182601bfedb9d818153700240102240203182601155xxb2c1815370024010224020618260108042735181537002401022402081826017a3b41c81815370024010224021d182601b4c8973e18153700240102240239182601a26cf9dd1815370024010225020003182601e3c00199181824ff0c18
2025-01-19 15:01:12.889 - debug: matter.0 (126198) 2025-01-19 15:01:12.889 DEBUG MessageExchange Message « for: I/ReportData msgId: 20718/42752/113044127 type: 0x1/0x5 acked: 264918822 reqAck size: 329 payload: 152600bf074393360115350126008848d52f370124020024031f24040018360215240105240202360307552352cabe562c4718340424fe041818181815350126008848d52f370124020024031f24040118360218181815350126008848d52f370124020024031f24040218240204181815350126008848d52f370124020024031f24040318240203181815350126008848d52f370124020024031f24040418240204181815350126008848d52f370124020024031f2504fcff18240200181815350126008848d52f370124020024031f2504fdff18240201181815350126008848d52f370124020024031f2504f8ff18360218181815350126008848d52f370124020024031f2504f9ff18360218181815350126008848d52f370124020024031f2504fbff1836020400040104020403040405f8ff05f9ff05fbff05fcff05fdff1818181824ff0b18
2025-01-19 15:01:12.890 - debug: matter.0 (126198) 2025-01-19 15:01:12.890 DEBUG ExchangeManager Message » for: I/StatusResponse status: Success(0x0) subId: 2470643647 attr: 10 msgId: 29363/42752/264918823 type: 0x1/0x1 acked: 113044127 reqAck size: 8 payload: 1524000024ff0c18
2025-01-19 15:01:12.894 - debug: matter.0 (126198) 2025-01-19 15:01:12.893 DEBUG MessageExchange Message « for: I/SubscribeResponse msgId: 20718/42752/113044128 type: 0x1/0x4 acked: 264918823 reqAck size: 14 payload: 152600bf07439324023c24ff0b18
2025-01-19 15:01:12.894 - debug: matter.0 (126198) 2025-01-19 15:01:12.894 DEBUG ExchangeManager Message » for: SC/StandaloneAck msgId: 29363/42752/264918824 type: 0x0/0x10 acked: 113044128
2025-01-19 15:01:12.895 - debug: matter.0 (126198) 2025-01-19 15:01:12.895 INFO InteractionClient Subscription successfully initialized with ID 2470643647 and maxInterval 60s.
2025-01-19 15:01:12.896 - debug: matter.0 (126198) 2025-01-19 15:01:12.896 DEBUG InteractionClient Received attribute update: 0x0/AccessControl(0x1f)/acl(0x0) = [{"privilege":5,"authMode":2,"subjects":["5128569453106307925"],"targets":null,"fabricIndex":4}] (version=802506888)
2025-01-19 15:01:12.896 - debug: matter.0 (126198) 2025-01-19 15:01:12.896 DEBUG InteractionClient Received attribute update: 0x0/AccessControl(0x1f)/extension(0x1) = [] (version=802506888)
2025-01-19 15:01:12.896 - debug: matter.0 (126198) 2025-01-19 15:01:12.896 DEBUG InteractionClient Received attribute update: 0x0/AccessControl(0x1f)/subjectsPerAccessControlEntry(0x2) = 4 (version=802506888)
2025-01-19 15:01:12.896 - debug: matter.0 (126198) 2025-01-19 15:01:12.896 DEBUG InteractionClient Received attribute update: 0x0/AccessControl(0x1f)/targetsPerAccessControlEntry(0x3) = 3 (version=802506888)
2025-01-19 15:01:12.896 - debug: matter.0 (126198) 2025-01-19 15:01:12.896 DEBUG InteractionClient Received attribute update: 0x0/AccessControl(0x1f)/accessControlEntriesPerFabric(0x4) = 4 (version=802506888)
2025-01-19 15:01:12.897 - debug: matter.0 (126198) 2025-01-19 15:01:12.897 DEBUG InteractionClient Received attribute update: 0x0/AccessControl(0x1f)/featureMap(0xfffc) = {} (version=802506888)
2025-01-19 15:01:12.897 - debug: matter.0 (126198) 2025-01-19 15:01:12.897 DEBUG InteractionClient Received attribute update: 0x0/AccessControl(0x1f)/clusterRevision(0xfffd) = 1 (version=802506888)
2025-01-19 15:01:12.897 - debug: matter.0 (126198) 2025-01-19 15:01:12.897 DEBUG InteractionClient Received attribute update: 0x0/AccessControl(0x1f)/generatedCommandList(0xfff8) = [] (version=802506888)
2025-01-19 15:01:12.897 - debug: matter.0 (126198) 2025-01-19 15:01:12.897 DEBUG InteractionClient Received attribute update: 0x0/AccessControl(0x1f)/acceptedCommandList(0xfff9) = [] (version=802506888)
2025-01-19 15:01:12.897 - debug: matter.0 (126198) 2025-01-19 15:01:12.897 DEBUG InteractionClient Received attribute update: 0x0/AccessControl(0x1f)/attributeList(0xfffb) = [0,1,2,3,4,65528,65529,65531,65532,65533] (version=802506888)
2025-01-19 15:01:12.898 - info: matter.0 (126198) Node "66963xxxxxxxxxx2140" reconnecting
2025-01-19 15:01:12.898 - info: matter.0 (126198) Node "66963xxxxxxxxxx2140" offline, waiting for device discovery
2025-01-19 15:01:12.900 - debug: matter.0 (126198) 2025-01-19 15:01:12.899 DEBUG InteractionClient Enriching cached data (9 attributes) for 0/29 with version=569127472
2025-01-19 15:01:12.900 - debug: matter.0 (126198) 2025-01-19 15:01:12.900 DEBUG InteractionClient Enriching cached data (6 attributes) for 0/30 with version=944158602
2025-01-19 15:01:12.900 - debug: matter.0 (126198) 2025-01-19 15:01:12.900 DEBUG InteractionClient Enriching cached data (26 attributes) for 0/40 with version=991472800
2025-01-19 15:01:12.900 - debug: matter.0 (126198) 2025-01-19 15:01:12.900 DEBUG InteractionClient Enriching cached data (10 attributes) for 0/48 with version=538966571
2025-01-19 15:01:12.900 - debug: matter.0 (126198) 2025-01-19 15:01:12.900 DEBUG InteractionClient Enriching cached data (7 attributes) for 0/51 with version=3961767521
2025-01-19 15:01:12.900 - debug: matter.0 (126198) 2025-01-19 15:01:12.900 DEBUG InteractionClient Enriching cached data (14 attributes) for 0/55 with version=278849971
2025-01-19 15:01:12.900 - debug: matter.0 (126198) 2025-01-19 15:01:12.900 DEBUG InteractionClient Enriching cached data (8 attributes) for 0/60 with version=1326404654
2025-01-19 15:01:12.900 - debug: matter.0 (126198) 2025-01-19 15:01:12.900 DEBUG InteractionClient Enriching cached data (11 attributes) for 0/62 with version=260077834
2025-01-19 15:01:12.901 - debug: matter.0 (126198) 2025-01-19 15:01:12.901 DEBUG InteractionClient Enriching cached data (9 attributes) for 0/63 with version=1159407877
2025-01-19 15:01:12.901 - debug: matter.0 (126198) 2025-01-19 15:01:12.901 DEBUG InteractionClient Enriching cached data (7 attributes) for 1/3 with version=1180882345
2025-01-19 15:01:12.901 - debug: matter.0 (126198) 2025-01-19 15:01:12.901 DEBUG InteractionClient Enriching cached data (9 attributes) for 1/29 with version=3636063679
2025-01-19 15:01:12.901 - debug: matter.0 (126198) 2025-01-19 15:01:12.901 DEBUG InteractionClient Enriching cached data (7 attributes) for 2/3 with version=741036309
2025-01-19 15:01:12.901 - debug: matter.0 (126198) 2025-01-19 15:01:12.901 DEBUG InteractionClient Enriching cached data (10 attributes) for 2/6 with version=891749384
2025-01-19 15:01:12.901 - debug: matter.0 (126198) 2025-01-19 15:01:12.901 DEBUG InteractionClient Enriching cached data (12 attributes) for 2/8 with version=3359718266
2025-01-19 15:01:12.901 - debug: matter.0 (126198) 2025-01-19 15:01:12.901 DEBUG InteractionClient Enriching cached data (9 attributes) for 2/29 with version=1050134708
2025-01-19 15:01:12.901 - debug: matter.0 (126198) 2025-01-19 15:01:12.901 DEBUG InteractionClient Enriching cached data (19 attributes) for 2/57 with version=3724111010
2025-01-19 15:01:12.902 - debug: matter.0 (126198) 2025-01-19 15:01:12.902 DEBUG InteractionClient Enriching cached data (12 attributes) for 2/768 with version=2567028963
2025-01-19 15:01:12.902 - debug: matter.0 (126198) 2025-01-19 15:01:12.902 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Retaining device 0
2025-01-19 15:01:12.902 - debug: matter.0 (126198) 2025-01-19 15:01:12.902 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Retaining device 1
2025-01-19 15:01:12.902 - debug: matter.0 (126198) 2025-01-19 15:01:12.902 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Retaining device 2
2025-01-19 15:01:12.902 - debug: matter.0 (126198) 2025-01-19 15:01:12.902 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Endpoints from PartsLists [[0,[1,2]],[1,[2]],[2,[]]]
2025-01-19 15:01:12.902 - debug: matter.0 (126198) 2025-01-19 15:01:12.902 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Endpoint usages {"1":[0],"2":[0,1]}
2025-01-19 15:01:12.902 - debug: matter.0 (126198) 2025-01-19 15:01:12.902 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Processing Endpoint [["1",[0]]]
2025-01-19 15:01:12.903 - debug: matter.0 (126198) 2025-01-19 15:01:12.903 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Endpoint data Cleanup {"0":true}
2025-01-19 15:01:12.903 - debug: matter.0 (126198) 2025-01-19 15:01:12.903 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Processing Endpoint [["2",[1]]]
2025-01-19 15:01:12.903 - debug: matter.0 (126198) 2025-01-19 15:01:12.903 DEBUG PairedNode Node 66963xxxxxxxxxx2140: Endpoint data Cleanup {"1":true}
2025-01-19 15:01:12.904 - debug: matter.0 (126198) 2025-01-19 15:01:12.903 DEBUG InteractionClient Sending read request: attributes: 0x0/OperationalCredentials(0x3e)/fabrics(0x1) and events: undefined
2025-01-19 15:01:12.904 - debug: matter.0 (126198) 2025-01-19 15:01:12.904 DEBUG MessageExchange New exchange channel: udp://fe80::5xxf:44ff:fe67:9xxc%ens19:5540 on session secure/20718 protocol: 1 exId: 42753 sess: secure/20718 peerSess: 29363 SAT: 4000 SAI: 300 SII: 500 maxTrans: 5 MRP
2025-01-19 15:01:12.904 - debug: matter.0 (126198) 2025-01-19 15:01:12.904 DEBUG InteractionClient Sending read request to udp://fe80::5xxf:44ff:fe67:9xxc%ens19:5540 on session secure/20718 for attributes 0x0/OperationalCredentials(0x3e)/fabrics(0x1) and events undefined
2025-01-19 15:01:12.904 - debug: matter.0 (126198) 2025-01-19 15:01:12.904 DEBUG ExchangeManager Message » for: I/ReadRequest msgId: 29363/42753/264918825 type: 0x1/0x2 reqAck size: 21 payload: 1536001724020024033e2404011818290324ff0c18
2025-01-19 15:01:12.916 - debug: matter.0 (126198) 2025-01-19 15:01:12.916 DEBUG MessageExchange Message « for: I/ReportData msgId: 20718/42753/113044129 type: 0x1/0x5 acked: 264918825 reqAck size: 146 payload: 15360115350126000a79800f370124020024033e24040118360215300141xxxx5668858a146f7c57xxxxfe6cfcdab839f2617398be9xxxx1ac801755305bc790dc274490c78xxxxaa65731e22107a4e2f7bef50b72825c079c58460ae5xxxx2502f1ff24030127045c188287df29ee5c2c0511696f42726f6b6572206d61747465722e3024fe041818181818290424ff0b18
2025-01-19 15:01:12.916 - debug: matter.0 (126198) 2025-01-19 15:01:12.916 DEBUG InteractionClient Received read response with attributes 0x0/OperationalCredentials(0x3e)/fabrics(0x1) = [{"rootPublicKey":"xxxx5668858a146f7c57xxxxfe6cfcdab839f2617398be9xxxx1ac801755305bc790dc274490c78xxxxaa65731e22107a4e2f7bef50b72825c079c58460ae5xxxx","vendorId":65521,"fabricId":"1","nodeId":"66963xxxxxxxxxx2140","label":"ioBroker matter.0","fabricIndex":4}] and events
2025-01-19 15:01:12.917 - debug: matter.0 (126198) 2025-01-19 15:01:12.917 DEBUG ExchangeManager Message » for: SC/StandaloneAck msgId: 29363/42753/264918826 type: 0x0/0x10 acked: 113044129
2025-01-19 15:01:12.918 - info: matter.0 (126198) Node 92177xxxxxxxxxx3215: Endpoint 0 to ioBroker Devices MA-rootnode / RootNode
2025-01-19 15:01:12.927 - info: matter.0 (126198) Node "66963xxxxxxxxxx2140" connected
2025-01-19 15:01:13.033 - info: matter.0 (126198) Node 92177xxxxxxxxxx3215: Endpoint 1 to ioBroker Devices MA-doorlock / DoorLock
2025-01-19 15:01:13.036 - info: matter.0 (126198) Node 92177xxxxxxxxxx3215: Creating device for DoorLock (endpoint 1)
2025-01-19 15:01:13.042 - debug: matter.0 (126198) Set matter.0.controller.92177xxxxxxxxxx3215.DoorLock-1.ACTUAL to false (ack = true)
2025-01-19 15:01:13.045 - debug: matter.0 (126198) Set matter.0.controller.92177xxxxxxxxxx3215.DoorLock-1.SET to false (ack = true)
2025-01-19 15:01:13.047 - debug: matter.0 (126198) Set matter.0.controller.92177xxxxxxxxxx3215.DoorLock-1.ACTUAL to false (ack = true)
2025-01-19 15:01:13.049 - debug: matter.0 (126198) Set matter.0.controller.92177xxxxxxxxxx3215.DoorLock-1.SET to false (ack = true)
2025-01-19 15:01:13.051 - info: matter.0 (126198) Endpoint 1 (MA-doorlock):
2025-01-19 15:01:13.188 - info: matter.0 (126198) Node 92177xxxxxxxxxx3215: Endpoint 2 to ioBroker Devices MA-powersource / PowerSource
2025-01-19 15:01:13.191 - info: matter.0 (126198) Node 92177xxxxxxxxxx3215: Creating device for PowerSource (endpoint 2)
2025-01-19 15:01:13.197 - debug: matter.0 (126198) Set matter.0.controller.92177xxxxxxxxxx3215.PowerSource-2.LOWBAT to false (ack = true)
2025-01-19 15:01:13.199 - debug: matter.0 (126198) Set matter.0.controller.92177xxxxxxxxxx3215.PowerSource-2.BATTERY to "87" (ack = true)
2025-01-19 15:01:13.201 - info: matter.0 (126198) Endpoint 2 (MA-powersource):
2025-01-19 15:01:13.314 - debug: matter.0 (126198) 2025-01-19 15:01:13.314 INFO PairedNode Node 92177xxxxxxxxxx3215: Reconnecting in 0s ...
2025-01-19 15:01:13.314 - debug: matter.0 (126198) Initialization done, Objects subscribed
2025-01-19 15:01:13.315 - debug: matter.0 (126198) 2025-01-19 15:01:13.315 DEBUG PeerSet Resuming connection to peer@1:0x7febdc7ab12c735f at fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540
2025-01-19 15:01:13.316 - debug: matter.0 (126198) 2025-01-19 15:01:13.316 DEBUG MessageExchange New exchange channel: udp://fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540 on session insecure/9724246412754357486 protocol: 0 exId: 42754 sess: insecure/9724246412754357486 peerSess: 0 SAT: 1000 SAI: 2250 SII: 2800 maxTrans: 5 MRP
2025-01-19 15:01:13.317 - debug: matter.0 (126198) 2025-01-19 15:01:13.317 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42754/51269373 type: 0x0/0x30 reqAck size: 212 payload: 15300120041460861ee252684f5fd537b02db049842313b35c2ca88c6750f823beb428482502ef50300320eafbf8c54079ccb8622d41d5c1fbcbbb1c8658900be23dfdeab992202522f30b30044104463a7df4e853d7c2ef5cac6ebf28d99f1d613dc2636ed690989403d8e51699e6969e9506e3a3a9570471c45230e4aae2c0beb012a2b28b6b73e61033c7a4edbd35052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710ddbfbd34b8aff20ec5b019f17d37401118
2025-01-19 15:01:13.320 - info: matter.0 (126198) Node "92177xxxxxxxxxx3215" reconnecting
2025-01-19 15:01:13.620 - debug: matter.0 (126198) Send to GUI: {"command":"updateController"}
2025-01-19 15:01:17.095 - debug: matter.0 (126198) 2025-01-19 15:01:17.095 DEBUG DeviceAdvertiser Resubmission started, re-announce node 9724246412754357486
2025-01-19 15:01:17.096 - debug: matter.0 (126198) 2025-01-19 15:01:17.095 DEBUG DeviceAdvertiser Announcing fabricIndex: 1 fabricId: 1
2025-01-19 15:01:17.096 - debug: matter.0 (126198) 2025-01-19 15:01:17.096 DEBUG MessageExchange Resubmit message 51269373 (retransmission attempt 1, backoff time 3612ms))
2025-01-19 15:01:17.096 - debug: matter.0 (126198) 2025-01-19 15:01:17.096 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42754/51269373 type: 0x0/0x30 reqAck size: 212 payload: 15300120041460861ee252684f5fd537b02db049842313b35c2ca88c6750f823beb428482502ef50300320eafbf8c54079ccb8622d41d5c1fbcbbb1c8658900be23dfdeab992202522f30b30044104463a7df4e853d7c2ef5cac6ebf28d99f1d613dc2636ed690989403d8e51699e6969e9506e3a3a9570471c45230e4aae2c0beb012a2b28b6b73e61033c7a4edbd35052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710ddbfbd34b8aff20ec5b019f17d37401118
2025-01-19 15:01:17.097 - debug: matter.0 (126198) 2025-01-19 15:01:17.097 DEBUG MdnsBroadcaster Announcement Generator: Fabric id: 925Exxxxxxxx5A7E-472Cxxxxxxxx2355 qname: 925Exxxxxxxx5A7E-472Cxxxxxxxx2355._matter._tcp.local port: 56498 interface: ens19
2025-01-19 15:01:20.710 - debug: matter.0 (126198) 2025-01-19 15:01:20.710 DEBUG MessageExchange Resubmit message 51269373 (retransmission attempt 2, backoff time 5908ms))
2025-01-19 15:01:20.710 - debug: matter.0 (126198) 2025-01-19 15:01:20.710 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42754/51269373 type: 0x0/0x30 reqAck size: 212 payload: 15300120041460861ee252684f5fd537b02db049842313b35c2ca88c6750f823beb428482502ef50300320eafbf8c54079ccb8622d41d5c1fbcbbb1c8658900be23dfdeab992202522f30b30044104463a7df4e853d7c2ef5cac6ebf28d99f1d613dc2636ed690989403d8e51699e6969e9506e3a3a9570471c45230e4aae2c0beb012a2b28b6b73e61033c7a4edbd35052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710ddbfbd34b8aff20ec5b019f17d37401118
2025-01-19 15:01:26.619 - debug: matter.0 (126198) 2025-01-19 15:01:26.618 DEBUG MessageExchange Resubmit message 51269373 (retransmission attempt 3, backoff time 9758ms))
2025-01-19 15:01:26.619 - debug: matter.0 (126198) 2025-01-19 15:01:26.619 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42754/51269373 type: 0x0/0x30 reqAck size: 212 payload: 15300120041460861ee252684f5fd537b02db049842313b35c2ca88c6750f823beb428482502ef50300320eafbf8c54079ccb8622d41d5c1fbcbbb1c8658900be23dfdeab992202522f30b30044104463a7df4e853d7c2ef5cac6ebf28d99f1d613dc2636ed690989403d8e51699e6969e9506e3a3a9570471c45230e4aae2c0beb012a2b28b6b73e61033c7a4edbd35052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710ddbfbd34b8aff20ec5b019f17d37401118
2025-01-19 15:01:36.378 - debug: matter.0 (126198) 2025-01-19 15:01:36.378 DEBUG MessageExchange Resubmit message 51269373 (retransmission attempt 4, backoff time 13371ms))
2025-01-19 15:01:36.379 - debug: matter.0 (126198) 2025-01-19 15:01:36.379 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42754/51269373 type: 0x0/0x30 reqAck size: 212 payload: 15300120041460861ee252684f5fd537b02db049842313b35c2ca88c6750f823beb428482502ef50300320eafbf8c54079ccb8622d41d5c1fbcbbb1c8658900be23dfdeab992202522f30b30044104463a7df4e853d7c2ef5cac6ebf28d99f1d613dc2636ed690989403d8e51699e6969e9506e3a3a9570471c45230e4aae2c0beb012a2b28b6b73e61033c7a4edbd35052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710ddbfbd34b8aff20ec5b019f17d37401118
2025-01-19 15:01:49.750 - debug: matter.0 (126198) 2025-01-19 15:01:49.750 DEBUG MessageExchange Message 51269373: Wait additional 20858ms for processing time and peer resubmissions after all our resubmissions
2025-01-19 15:02:10.609 - debug: matter.0 (126198) 2025-01-19 15:02:10.609 INFO InsecureSession End insecure session insecure/9724246412754357486
2025-01-19 15:02:10.611 - debug: matter.0 (126198) 2025-01-19 15:02:10.610 DEBUG PeerSet Failed to resume connection to peer@1:0x7febdc7ab12c735f connection with fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540, discover the node: PairRetransmissionLimitReachedError
at #pair (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:498:13)
at async #reconnectKnownAddress (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:434:23)
at async #connectOrDiscoverNode (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:316:34)
at async #resume (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:280:14)
2025-01-19 15:02:10.611 - debug: matter.0 (126198) 2025-01-19 15:02:10.611 INFO PeerSet Resume failed, remove all sessions for peer@1:0x7febdc7ab12c735f
2025-01-19 15:02:10.611 - debug: matter.0 (126198) 2025-01-19 15:02:10.611 INFO PairedNode Node 92177xxxxxxxxxx3215: Simple re-establishing session did not worked. Reconnect ... peer@1:0x7febdc7ab12c735f is not reachable right now.
at #connectOrDiscoverNode (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:321:15)
at async #resume (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:280:14)
2025-01-19 15:02:10.612 - debug: matter.0 (126198) 2025-01-19 15:02:10.612 DEBUG PeerSet Starting reconnection polling for udp://fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540 (Interval 600s)
2025-01-19 15:02:10.612 - debug: matter.0 (126198) 2025-01-19 15:02:10.612 DEBUG MdnsScanner Registered waiter for query 925Exxxxxxxx5A7E-7FEBDC7AB12C735F._matter._tcp.local with no timeout
2025-01-19 15:02:10.613 - debug: matter.0 (126198) 2025-01-19 15:02:10.613 DEBUG MdnsScanner Set 1 query records for query 925Exxxxxxxx5A7E-7FEBDC7AB12C735F._matter._tcp.local: [{"name":"925Exxxxxxxx5A7E-7FEBDC7AB12C735F._matter._tcp.local","recordClass":1,"recordType":33}]
2025-01-19 15:02:10.615 - debug: matter.0 (126198) 2025-01-19 15:02:10.615 DEBUG MdnsScanner Sending 1 query records for 1 queries with 0 known answers. Re-Announce in 1.5 seconds
2025-01-19 15:02:10.616 - debug: matter.0 (126198) 2025-01-19 15:02:10.616 DEBUG NodejsChannel Socket created and bound remoteAddress: undefined:5353 localAddress: 0.0.0.0:5353
2025-01-19 15:02:10.616 - debug: matter.0 (126198) 2025-01-19 15:02:10.616 DEBUG NodejsChannel Socket created and bound remoteAddress: undefined:5353 localAddress: :::5353
2025-01-19 15:02:10.617 - debug: matter.0 (126198) 2025-01-19 15:02:10.617 DEBUG NodejsChannel Initialize multicast address: 192.168.20.65:5353 interface: ens19 type: udp4
2025-01-19 15:02:10.617 - debug: matter.0 (126198) 2025-01-19 15:02:10.617 DEBUG NodejsChannel Initialize multicast address: ::%ens19:5353 interface: ens19 type: udp6
2025-01-19 15:02:10.626 - info: matter.0 (126198) Node "92177xxxxxxxxxx3215" offline, waiting for device discovery
2025-01-19 15:02:10.727 - debug: matter.0 (126198) 2025-01-19 15:02:10.727 DEBUG MdnsScanner Added 1 IPs for operational device 925Exxxxxxxx5A7E-7FEBDC7AB12C735F._matter._tcp.local to cache (interface ens19): type: udp ip: fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4 port: 5540
2025-01-19 15:02:10.728 - debug: matter.0 (126198) 2025-01-19 15:02:10.728 DEBUG MdnsScanner Finishing waiter for query 925Exxxxxxxx5A7E-7FEBDC7AB12C735F._matter._tcp.local, resolving: true
2025-01-19 15:02:10.728 - debug: matter.0 (126198) 2025-01-19 15:02:10.728 DEBUG MdnsScanner Removing last query 925Exxxxxxxx5A7E-7FEBDC7AB12C735F._matter._tcp.local and stopping announce timer
2025-01-19 15:02:10.729 - debug: matter.0 (126198) 2025-01-19 15:02:10.729 DEBUG ControllerDiscovery Server addresses to try: udp://fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540
2025-01-19 15:02:10.730 - debug: matter.0 (126198) 2025-01-19 15:02:10.729 DEBUG ControllerDiscovery Try to communicate with udp://fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540 ...
2025-01-19 15:02:10.730 - debug: matter.0 (126198) 2025-01-19 15:02:10.730 DEBUG MessageExchange New exchange channel: udp://fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540 on session insecure/2794315573037570270 protocol: 0 exId: 42755 sess: insecure/2794315573037570270 peerSess: 0 SAT: 1000 SAI: 2250 SII: 2800 maxTrans: 5 MRP
2025-01-19 15:02:10.733 - debug: matter.0 (126198) 2025-01-19 15:02:10.733 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42755/51269374 type: 0x0/0x30 reqAck size: 212 payload: 15300120d3fb2c576664e4253837579ae24ae222c00023d3e50cdf4407a7770982630d3b2502f050300320036bdd0422337ade7f1c5b343f0dff1a6e9ca68f7eab751137b500bf51b554de3004410444a0ab96f826d11f6fcc939462c301b15ac1051b399e5cbdbe1e3c7ce3bdf3f5991db4fbd681e9717e8e28d92b8e30a23f1630d49c9af1e82cd3521ef7249f4135052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710a359bd50ff6469ac3f9862b82d0cc86b18
2025-01-19 15:02:10.918 - debug: matter.0 (126198) 2025-01-19 15:02:10.918 DEBUG MdnsScanner Adding operational device D6EDFxxxxxx631E5-0000000xxxxxx669._matter._tcp.local in cache (interface ens19, ttl=4500) with TXT data: T: 6 ICD: 0
2025-01-19 15:02:10.918 - debug: matter.0 (126198) 2025-01-19 15:02:10.918 DEBUG MdnsScanner Added 5 IPs for operational device D6EDFxxxxxx631E5-0000000xxxxxx669._matter._tcp.local to cache (interface ens19): type: udp ip: fd8b:xxxx:7b6f:4e23:xxxx:4f51:8e9:1xx9 port: 33581 type: udp ip: 2xxx:xx:8f24:4044:xxxx:52ad:6006:2xx8 port: 33581 type: udp ip: fd8b:xxxx:7b6f:204e:xxxx:a8f1:dde9:xxxx port: 33581 type: udp ip: fe80::dxx7:2xx6:bxx8:3xx2%ens19 port: 33581 type: udp ip: 192.168.20.168 port: 33581
2025-01-19 15:02:10.924 - debug: matter.0 (126198) 2025-01-19 15:02:10.923 DEBUG MdnsScanner Adding operational device D79D4Axxxxxx4CD1-03FE15xxxxxx8EA1._matter._tcp.local in cache (interface ens19, ttl=4500) with TXT data: T: 0 ICD: 0
2025-01-19 15:02:10.924 - debug: matter.0 (126198) 2025-01-19 15:02:10.924 DEBUG MdnsScanner Added 5 IPs for operational device D79D4Axxxxxx4CD1-03FE15xxxxxx8EA1._matter._tcp.local to cache (interface ens19): type: udp ip: fe80::4e17:44ff:fe76:41d5%ens19 port: 5541 type: udp ip: fd8b:xxxx:7xxf:4e23:4e17:44ff:fe76:41d5 port: 5541 type: udp ip: 2xxx:xx:8f24:4044:xxxx:44ff:fe76:4xx5 port: 5541 type: udp ip: fd8b:xxxx:7xxf:204e:4e17:44ff:fe76:41d5 port: 5541 type: udp ip: 192.168.20.224 port: 5541
2025-01-19 15:02:10.927 - debug: matter.0 (126198) Send to GUI: {"command":"updateController"}
2025-01-19 15:02:10.937 - debug: matter.0 (126198) 2025-01-19 15:02:10.937 DEBUG MdnsScanner Adding operational device D79D4Axxxxxx4CD1-03FE15885A733BA1._matter._tcp.local in cache (interface ens19, ttl=4500) with TXT data: T: 0 ICD: 0
2025-01-19 15:02:10.937 - debug: matter.0 (126198) 2025-01-19 15:02:10.937 DEBUG MdnsScanner Added 2 IPs for operational device D79D4Axxxxxx4CD1-03FE15885A733BA1._matter._tcp.local to cache (interface ens19): type: udp ip: fe80::f2f0:a4ff:fe1d:2873%ens19 port: 5541 type: udp ip: 192.168.100.174 port: 5541
2025-01-19 15:02:11.006 - debug: matter.0 (126198) 2025-01-19 15:02:11.006 DEBUG MdnsScanner Adding operational device 40951BFxxxxxx148-00000000628ACA9A._matter._tcp.local in cache (interface ens19, ttl=4500) with TXT data: T: 0 ICD: 0
2025-01-19 15:02:11.006 - debug: matter.0 (126198) 2025-01-19 15:02:11.006 DEBUG MdnsScanner Adding operational device D6EDFxxxxxx631E5-0000000000000001._matter._tcp.local in cache (interface ens19, ttl=4500) with TXT data: T: 0 ICD: 0
2025-01-19 15:02:11.007 - debug: matter.0 (126198) 2025-01-19 15:02:11.007 DEBUG MdnsScanner Adding operational device CFE50DxxxxxxEBD4-00000000B957BD41._matter._tcp.local in cache (interface ens19, ttl=4500) with TXT data: T: 0 ICD: 0
2025-01-19 15:02:11.007 - debug: matter.0 (126198) 2025-01-19 15:02:11.007 DEBUG MdnsScanner Adding operational device 925Exxxxxxxx5A7E-5CEE29DF8782185C._matter._tcp.local in cache (interface ens19, ttl=4500) with TXT data: T: 0 ICD: 0
2025-01-19 15:02:11.007 - debug: matter.0 (126198) 2025-01-19 15:02:11.007 DEBUG MdnsScanner Added 5 IPs for operational device 40951BFxxxxxx148-00000000628ACA9A._matter._tcp.local to cache (interface ens19): type: udp ip: fd8b:xxxx:7xxf:xxxx:xxxx:44ff:fe67:9xxc port: 5540 type: udp ip: fd8b:3b20:xxxx:xxxx:xxxx:44ff:fe67:9xxc port: 5540 type: udp ip: 2xxx:xx:8f24:xxxx:56ef:44ff:fe67:9xxc port: 5540 type: udp ip: fe80::5xxf:44ff:fe67:9xxc%ens19 port: 5540 type: udp ip: 192.168.20.217 port: 5540
2025-01-19 15:02:11.008 - debug: matter.0 (126198) 2025-01-19 15:02:11.008 DEBUG MdnsScanner Added 5 IPs for operational device D6EDFxxxxxx631E5-0000000000000001._matter._tcp.local to cache (interface ens19): type: udp ip: fd8b:xxxx:7xxf:xxxx:xxxx:44ff:fe67:9xxc port: 5540 type: udp ip: fd8b:3b20:xxxx:xxxx:xxxx:44ff:fe67:9xxc port: 5540 type: udp ip: 2xxx:xx:8f24:xxxx:56ef:44ff:fe67:9xxc port: 5540 type: udp ip: fe80::5xxf:44ff:fe67:9xxc%ens19 port: 5540 type: udp ip: 192.168.20.217 port: 5540
2025-01-19 15:02:11.008 - debug: matter.0 (126198) 2025-01-19 15:02:11.008 DEBUG MdnsScanner Added 5 IPs for operational device CFE50DxxxxxxEBD4-00000000B957BD41._matter._tcp.local to cache (interface ens19): type: udp ip: fd8b:xxxx:7xxf:xxxx:xxxx:44ff:fe67:9xxc port: 5540 type: udp ip: fd8b:3b20:xxxx:xxxx:xxxx:44ff:fe67:9xxc port: 5540 type: udp ip: 2xxx:xx:8f24:xxxx:56ef:44ff:fe67:9xxc port: 5540 type: udp ip: fe80::5xxf:44ff:fe67:9xxc%ens19 port: 5540 type: udp ip: 192.168.20.217 port: 5540
2025-01-19 15:02:11.008 - debug: matter.0 (126198) 2025-01-19 15:02:11.008 DEBUG MdnsScanner Added 5 IPs for operational device 925Exxxxxxxx5A7E-5CEE29DF8782185C._matter._tcp.local to cache (interface ens19): type: udp ip: fd8b:xxxx:7xxf:xxxx:xxxx:44ff:fe67:9xxc port: 5540 type: udp ip: fd8b:3b20:xxxx:xxxx:xxxx:44ff:fe67:9xxc port: 5540 type: udp ip: 2xxx:xx:8f24:xxxx:56ef:44ff:fe67:9xxc port: 5540 type: udp ip: fe80::5xxf:44ff:fe67:9xxc%ens19 port: 5540 type: udp ip: 192.168.20.217 port: 5540
2025-01-19 15:02:11.085 - debug: matter.0 (126198) 2025-01-19 15:02:11.085 DEBUG MdnsScanner Adding operational device D79D4Axxxxxx4CD1-040FB4DDD442D791._matter._tcp.local in cache (interface ens19, ttl=4500) with TXT data: T: 0 ICD: 0
2025-01-19 15:02:11.085 - debug: matter.0 (126198) 2025-01-19 15:02:11.085 DEBUG MdnsScanner Added 9 IPs for operational device D79D4Axxxxxx4CD1-040FB4DDD442D791._matter._tcp.local to cache (interface ens19): type: udp ip: fe80::1e4d:xxxx:fe3f:fxx6%ens19 port: 5541 type: udp ip: fd8b:xxxx:7xxf:4e23:1e4d:66ff:fe3f:fxx6 port: 5541 type: udp ip: 2xxx:xx:8xx4:4xx4:1e4d:66ff:fe3f:fxx6 port: 5541 type: udp ip: fd8b:xxxx:7xxf:204e:1e4d:66ff:fe3f:fxx6 port: 5541 type: udp ip: fd8b:xxxx:7b6f:xxxx:786f:xxxx:1f52:dxx0 port: 5541 type: udp ip: fd8b:xxxx:7xxf:4e23:2401:a636:2b74:fxx2 port: 5541 type: udp ip: fd8b:xxxx:7xxf:4e23:bc2c:ffba:4ff9:ed92 port: 5541 type: udp ip: fd8b:xxxx:7xxf:4e23:f0a9:86e3:229b:exx5 port: 5541 type: udp ip: 192.168.20.216 port: 5541
2025-01-19 15:02:11.268 - debug: matter.0 (126198) 2025-01-19 15:02:11.267 DEBUG MdnsScanner Adding operational device D79D4Axxxxxx4CD1-0410C88082C60C41._matter._tcp.local in cache (interface ens19, ttl=4500) with TXT data: T: 0 ICD: 0
2025-01-19 15:02:11.268 - debug: matter.0 (126198) 2025-01-19 15:02:11.268 DEBUG MdnsScanner Added 5 IPs for operational device D79D4Axxxxxx4CD1-0410C88082C60C41._matter._tcp.local to cache (interface ens19): type: udp ip: fe80::4xx2:dxxf:fxx6:cxx8%ens19 port: 5541 type: udp ip: fd8b:xxxx:7xxf:204e:42a2:dbff:feb6:cxx8 port: 5541 type: udp ip: 2xxx:xx:8f24:xxxx:42a2:dbff:feb6:cxx8 port: 5541 type: udp ip: fd8b:xxxx:7xxf:4e23:42a2:dbff:feb6:cxx8 port: 5541 type: udp ip: 192.168.20.225 port: 5541
2025-01-19 15:02:12.899 - debug: matter.0 (126198) 2025-01-19 15:02:12.899 DEBUG MessageExchange New exchange channel: udp://fe80::5xxf:44ff:fe67:9xxc%ens19:5540 on session secure/20718 protocol: 1 exId: 59984 sess: secure/20718 peerSess: 20718 SAT: 4000 SAI: 300 SII: 500 maxTrans: 5 MRP
2025-01-19 15:02:12.899 - debug: matter.0 (126198) 2025-01-19 15:02:12.899 DEBUG MessageExchange Message « for: I/ReportData msgId: 20718/59984/113044130 type: 0x1/0x5 reqAck size: 11 payload: 152600bf07439324ff0b18
2025-01-19 15:02:12.900 - debug: matter.0 (126198) 2025-01-19 15:02:12.900 DEBUG ExchangeManager Message » for: I/StatusResponse status: Success(0x0) subId: 2470643647 empty msgId: 20718/59984/264918827 type: 0x1/0x1 acked: 113044130 reqAck size: 8 payload: 1524000024ff0c18
2025-01-19 15:02:12.903 - debug: matter.0 (126198) 2025-01-19 15:02:12.903 DEBUG MessageExchange Message « for: SC/StandaloneAck msgId: 20718/59984/113044131 type: 0x0/0x10 acked: 264918827
2025-01-19 15:02:14.095 - debug: matter.0 (126198) 2025-01-19 15:02:14.095 DEBUG DeviceAdvertiser Resubmission started, re-announce node 2794315573037570270
2025-01-19 15:02:14.095 - debug: matter.0 (126198) 2025-01-19 15:02:14.095 DEBUG DeviceAdvertiser Announcing fabricIndex: 1 fabricId: 1
2025-01-19 15:02:14.095 - debug: matter.0 (126198) 2025-01-19 15:02:14.095 DEBUG MessageExchange Resubmit message 51269374 (retransmission attempt 1, backoff time 3447ms))
2025-01-19 15:02:14.096 - debug: matter.0 (126198) 2025-01-19 15:02:14.095 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42755/51269374 type: 0x0/0x30 reqAck size: 212 payload: 15300120d3fb2c576664e4253837579ae24ae222c00023d3e50cdf4407a7770982630d3b2502f050300320036bdd0422337ade7f1c5b343f0dff1a6e9ca68f7eab751137b500bf51b554de3004410444a0ab96f826d11f6fcc939462c301b15ac1051b399e5cbdbe1e3c7ce3bdf3f5991db4fbd681e9717e8e28d92b8e30a23f1630d49c9af1e82cd3521ef7249f4135052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710a359bd50ff6469ac3f9862b82d0cc86b18
2025-01-19 15:02:14.096 - debug: matter.0 (126198) 2025-01-19 15:02:14.096 DEBUG MdnsBroadcaster Announcement Generator: Fabric id: 925Exxxxxxxx5A7E-472Cxxxxxxxx2355 qname: 925Exxxxxxxx5A7E-472Cxxxxxxxx2355._matter._tcp.local port: 56498 interface: ens19
2025-01-19 15:02:14.941 - debug: matter.0 (126198) 2025-01-19 15:02:14.940 DEBUG MdnsScanner Adding operational device D79D4Axxxxxx4CD1-03FE15866C6A57D1._matter._tcp.local in cache (interface ens19, ttl=4500) with TXT data: T: 0 ICD: 0
2025-01-19 15:02:14.941 - debug: matter.0 (126198) 2025-01-19 15:02:14.941 DEBUG MdnsScanner Added 2 IPs for operational device D79D4Axxxxxx4CD1-03FE15866C6A57D1._matter._tcp.local to cache (interface ens19): type: udp ip: fe80::bxxc:9xxf:fxx9:3xx4%ens19 port: 5541 type: udp ip: 192.168.100.242 port: 5541
2025-01-19 15:02:17.544 - debug: matter.0 (126198) 2025-01-19 15:02:17.544 DEBUG MessageExchange Resubmit message 51269374 (retransmission attempt 2, backoff time 5083ms))
2025-01-19 15:02:17.545 - debug: matter.0 (126198) 2025-01-19 15:02:17.544 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42755/51269374 type: 0x0/0x30 reqAck size: 212 payload: 15300120d3fb2c576664e4253837579ae24ae222c00023d3e50cdf4407a7770982630d3b2502f050300320036bdd0422337ade7f1c5b343f0dff1a6e9ca68f7eab751137b500bf51b554de3004410444a0ab96f826d11f6fcc939462c301b15ac1051b399e5cbdbe1e3c7ce3bdf3f5991db4fbd681e9717e8e28d92b8e30a23f1630d49c9af1e82cd3521ef7249f4135052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710a359bd50ff6469ac3f9862b82d0cc86b18
2025-01-19 15:02:22.629 - debug: matter.0 (126198) 2025-01-19 15:02:22.629 DEBUG MessageExchange Resubmit message 51269374 (retransmission attempt 3, backoff time 8242ms))
2025-01-19 15:02:22.629 - debug: matter.0 (126198) 2025-01-19 15:02:22.629 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42755/51269374 type: 0x0/0x30 reqAck size: 212 payload: 15300120d3fb2c576664e4253837579ae24ae222c00023d3e50cdf4407a7770982630d3b2502f050300320036bdd0422337ade7f1c5b343f0dff1a6e9ca68f7eab751137b500bf51b554de3004410444a0ab96f826d11f6fcc939462c301b15ac1051b399e5cbdbe1e3c7ce3bdf3f5991db4fbd681e9717e8e28d92b8e30a23f1630d49c9af1e82cd3521ef7249f4135052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710a359bd50ff6469ac3f9862b82d0cc86b18
2025-01-19 15:02:24.285 - debug: matter.0 (126198) 2025-01-19 15:02:24.285 DEBUG MdnsScanner Adding operational device D79D4Axxxxxx4CD1-0429CEC4F65C20B1._matter._tcp.local in cache (interface ens19, ttl=4500) with TXT data: SII: 800 SAI: 800 SAT: 4000 T: 0 ICD: 0
2025-01-19 15:02:24.286 - debug: matter.0 (126198) 2025-01-19 15:02:24.285 DEBUG MdnsScanner Added 12 IPs for operational device D79D4Axxxxxx4CD1-0429CEC4F65C20B1._matter._tcp.local to cache (interface ens19): type: udp ip: fe80::8xx8:5xxf:fxx7:5xxb%ens19 port: 5541 type: udp ip: 2xxx:xx:8xx4:4xx4:8628:59ff:fe47:5xxb port: 5541 type: udp ip: fd8b:xxxx:7xxf:204e:8628:59ff:fe47:5xxb port: 5541 type: udp ip: fd8b:xxxx:7xxf:4e23:8628:59ff:fe47:5xxb port: 5541 type: udp ip: fd8b:xxxx:7xxf:4e23:d137:367:d1cd:d77f port: 5541 type: udp ip: 2xxx:xx:8xx4:4xx4:e8bd:1e57:976d:84f3 port: 5541 type: udp ip: fd8b:xxxx:7xxf:4e23:e8bd:1e57:976d:84f3 port: 5541 type: udp ip: 2xxx:xx:8xx4:4xx4:7570:12de:4690:eb9b port: 5541 type: udp ip: fd8b:xxxx:7xxf:4e23:7570:12de:4690:eb9b port: 5541 type: udp ip: 2xxx:xx:8xx4:4xx4:d1c0:4565:ff14:dfb4 port: 5541 type: udp ip: fd8b:xxxx:7xxf:4e23:d1c0:4565:ff14:dfb4 port: 5541 type: udp ip: 2xxx:xx:8xx4:4xx4:7149:5d47:ef9b:25bc port: 5541
2025-01-19 15:02:30.872 - debug: matter.0 (126198) 2025-01-19 15:02:30.872 DEBUG MessageExchange Resubmit message 51269374 (retransmission attempt 4, backoff time 14031ms))
2025-01-19 15:02:30.873 - debug: matter.0 (126198) 2025-01-19 15:02:30.873 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42755/51269374 type: 0x0/0x30 reqAck size: 212 payload: 15300120d3fb2c576664e4253837579ae24ae222c00023d3e50cdf4407a7770982630d3b2502f050300320036bdd0422337ade7f1c5b343f0dff1a6e9ca68f7eab751137b500bf51b554de3004410444a0ab96f826d11f6fcc939462c301b15ac1051b399e5cbdbe1e3c7ce3bdf3f5991db4fbd681e9717e8e28d92b8e30a23f1630d49c9af1e82cd3521ef7249f4135052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710a359bd50ff6469ac3f9862b82d0cc86b18
2025-01-19 15:02:44.904 - debug: matter.0 (126198) 2025-01-19 15:02:44.904 DEBUG MessageExchange Message 51269374: Wait additional 20198ms for processing time and peer resubmissions after all our resubmissions
2025-01-19 15:02:46.263 - debug: matter.0 (126198) Subscribe from 173729xxxx001-system.adapter.admin.0-gui
2025-01-19 15:02:46.263 - debug: matter.0 (126198) Start GUI
2025-01-19 15:02:46.364 - debug: matter.0 (126198) Send to GUI: {"command":"bridgeStates","states":{}}
2025-01-19 15:02:46.666 - debug: matter.0 (126198) Send to GUI: {"command":"updateController"}
2025-01-19 15:02:47.598 - debug: matter.0 (126198) DeviceManagement received: {"command":"dm:instanceInfo","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":543,"ack":false,"time":1737295367596},"_id":55750376}
2025-01-19 15:02:47.606 - debug: matter.0 (126198) DeviceManagement received: {"command":"dm:listDevices","message":null,"from":"system.adapter.admin.0","callback":{"message":null,"id":544,"ack":false,"time":1737295367605},"_id":55750377}
2025-01-19 15:02:52.113 - debug: matter.0 (126198) Client "173729xxxx001-system.adapter.admin.0-gui: disconnect
2025-01-19 15:02:52.114 - debug: matter.0 (126198) Unsubscribe from 173729xxxx001-system.adapter.admin.0-gui
2025-01-19 15:03:05.103 - debug: matter.0 (126198) 2025-01-19 15:03:05.103 INFO InsecureSession End insecure session insecure/2794315573037570270
2025-01-19 15:03:05.104 - debug: matter.0 (126198) 2025-01-19 15:03:05.103 DEBUG ControllerDiscovery Failed to communicate with udp://fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540, try other servers ... PairRetransmissionLimitReachedError
at #pair (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:498:13)
at async /opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:407:27
at async processOneAddress (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/ControllerDiscovery.js:138:26)
at async ControllerDiscovery.iterateServerAddresses (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/ControllerDiscovery.js:173:26)
at async /opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:396:26
2025-01-19 15:03:05.105 - debug: matter.0 (126198) 2025-01-19 15:03:05.104 DEBUG ControllerDiscovery Server addresses to try: udp://fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540
2025-01-19 15:03:05.105 - debug: matter.0 (126198) 2025-01-19 15:03:05.105 INFO PeerSet Resume failed, remove all sessions for peer@1:0x7febdc7ab12c735f
2025-01-19 15:03:05.105 - debug: matter.0 (126198) 2025-01-19 15:03:05.105 INFO PairedNode Node 92177xxxxxxxxxx3215: Error waiting for device rediscovery, retrying Failed to connect on any discovered server
at ControllerDiscovery.iterateServerAddresses (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/ControllerDiscovery.js:192:15)
at async /opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:396:26
2025-01-19 15:03:05.106 - debug: matter.0 (126198) 2025-01-19 15:03:05.106 INFO PairedNode Node 92177xxxxxxxxxx3215: Reconnecting in 30s ...
2025-01-19 15:03:12.920 - debug: matter.0 (126198) 2025-01-19 15:03:12.920 DEBUG MessageExchange New exchange channel: udp://fe80::5xxf:44ff:fe67:9xxc%ens19:5540 on session secure/20718 protocol: 1 exId: 59986 sess: secure/20718 peerSess: 20718 SAT: 4000 SAI: 300 SII: 500 maxTrans: 5 MRP
2025-01-19 15:03:12.920 - debug: matter.0 (126198) 2025-01-19 15:03:12.920 DEBUG MessageExchange Message « for: I/ReportData msgId: 20718/59986/113044132 type: 0x1/0x5 reqAck size: 11 payload: 152600bf07439324ff0b18
2025-01-19 15:03:12.921 - debug: matter.0 (126198) 2025-01-19 15:03:12.921 DEBUG ExchangeManager Message » for: I/StatusResponse status: Success(0x0) subId: 2470643647 empty msgId: 20718/59986/264918828 type: 0x1/0x1 acked: 113044132 reqAck size: 8 payload: 1524000024ff0c18
2025-01-19 15:03:12.924 - debug: matter.0 (126198) 2025-01-19 15:03:12.924 DEBUG MessageExchange Message « for: SC/StandaloneAck msgId: 20718/59986/113044133 type: 0x0/0x10 acked: 264918828
2025-01-19 15:03:26.607 - debug: matter.0 (126198) 2025-01-19 15:03:26.607 DEBUG MdnsScanner Adding operational device D79D4Axxxxxx4CD1-0425EDB40F565EE0._matter._tcp.local in cache (interface ens19, ttl=4500) with TXT data: SII: 2800 SAI: 2250 SAT: 1000 T: 0 ICD: 0
2025-01-19 15:03:26.607 - debug: matter.0 (126198) 2025-01-19 15:03:26.607 DEBUG MdnsScanner Added 1 IPs for operational device D79D4Axxxxxx4CD1-0425EDB40F565EE0._matter._tcp.local to cache (interface ens19): type: udp ip: fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4 port: 5540
2025-01-19 15:03:35.107 - debug: matter.0 (126198) 2025-01-19 15:03:35.107 DEBUG PeerSet Starting reconnection polling for udp://fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540 (Interval 600s)
2025-01-19 15:03:35.108 - debug: matter.0 (126198) 2025-01-19 15:03:35.108 DEBUG MdnsScanner Registered waiter for query 925Exxxxxxxx5A7E-7FEBDC7AB12C735F._matter._tcp.local with no timeout
2025-01-19 15:03:35.108 - debug: matter.0 (126198) 2025-01-19 15:03:35.108 DEBUG MdnsScanner Set 1 query records for query 925Exxxxxxxx5A7E-7FEBDC7AB12C735F._matter._tcp.local: [{"name":"925Exxxxxxxx5A7E-7FEBDC7AB12C735F._matter._tcp.local","recordClass":1,"recordType":33}]
2025-01-19 15:03:35.109 - debug: matter.0 (126198) 2025-01-19 15:03:35.109 DEBUG MdnsScanner Sending 1 query records for 1 queries with 0 known answers. Re-Announce in 1.5 seconds
2025-01-19 15:03:35.112 - debug: matter.0 (126198) 2025-01-19 15:03:35.112 DEBUG MdnsScanner Finishing waiter for query 925Exxxxxxxx5A7E-7FEBDC7AB12C735F._matter._tcp.local, resolving: true
2025-01-19 15:03:35.113 - debug: matter.0 (126198) 2025-01-19 15:03:35.112 DEBUG MdnsScanner Removing last query 925Exxxxxxxx5A7E-7FEBDC7AB12C735F._matter._tcp.local and stopping announce timer
2025-01-19 15:03:35.113 - debug: matter.0 (126198) 2025-01-19 15:03:35.113 DEBUG ControllerDiscovery Server addresses to try: udp://fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540
2025-01-19 15:03:35.113 - debug: matter.0 (126198) 2025-01-19 15:03:35.113 DEBUG ControllerDiscovery Try to communicate with udp://fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540 ...
2025-01-19 15:03:35.113 - debug: matter.0 (126198) 2025-01-19 15:03:35.113 DEBUG MessageExchange New exchange channel: udp://fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540 on session insecure/1407129814459350771 protocol: 0 exId: 42756 sess: insecure/1407129814459350771 peerSess: 0 SAT: 1000 SAI: 2250 SII: 2800 maxTrans: 5 MRP
2025-01-19 15:03:35.115 - debug: matter.0 (126198) 2025-01-19 15:03:35.115 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42756/51269375 type: 0x0/0x30 reqAck size: 212 payload: 15300120de6f361c0a28888bd71084967f2292198ba6984062cfee3969e17dd7faca17412502f150300320f3a469210e5764b3d34f080652c251f2440efb22a249f9273d71c888e609464730044104370f288e77447484934ffd09b418b94b878ebd253d159f8baaadae1dc8a738f8dff418d8172408a58df9ecc53cdd912c365c9d14c42b5b64902713df9c7a687b35052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710fc85b68c53eb4af947a09811d1439a6118
2025-01-19 15:03:38.409 - debug: matter.0 (126198) 2025-01-19 15:03:38.409 DEBUG DeviceAdvertiser Resubmission started, re-announce node 1407129814459350771
2025-01-19 15:03:38.410 - debug: matter.0 (126198) 2025-01-19 15:03:38.410 DEBUG DeviceAdvertiser Announcing fabricIndex: 1 fabricId: 1
2025-01-19 15:03:38.410 - debug: matter.0 (126198) 2025-01-19 15:03:38.410 DEBUG MessageExchange Resubmit message 51269375 (retransmission attempt 1, backoff time 3224ms))
2025-01-19 15:03:38.411 - debug: matter.0 (126198) 2025-01-19 15:03:38.411 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42756/51269375 type: 0x0/0x30 reqAck size: 212 payload: 15300120de6f361c0a28888bd71084967f2292198ba6984062cfee3969e17dd7faca17412502f150300320f3a469210e5764b3d34f080652c251f2440efb22a249f9273d71c888e609464730044104370f288e77447484934ffd09b418b94b878ebd253d159f8baaadae1dc8a738f8dff418d8172408a58df9ecc53cdd912c365c9d14c42b5b64902713df9c7a687b35052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710fc85b68c53eb4af947a09811d1439a6118
2025-01-19 15:03:38.411 - debug: matter.0 (126198) 2025-01-19 15:03:38.411 DEBUG MdnsBroadcaster Announcement Generator: Fabric id: 925Exxxxxxxx5A7E-472Cxxxxxxxx2355 qname: 925Exxxxxxxx5A7E-472Cxxxxxxxx2355._matter._tcp.local port: 56498 interface: ens19
2025-01-19 15:03:41.636 - debug: matter.0 (126198) 2025-01-19 15:03:41.635 DEBUG MessageExchange Resubmit message 51269375 (retransmission attempt 2, backoff time 5212ms))
2025-01-19 15:03:41.636 - debug: matter.0 (126198) 2025-01-19 15:03:41.636 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42756/51269375 type: 0x0/0x30 reqAck size: 212 payload: 15300120de6f361c0a28888bd71084967f2292198ba6984062cfee3969e17dd7faca17412502f150300320f3a469210e5764b3d34f080652c251f2440efb22a249f9273d71c888e609464730044104370f288e77447484934ffd09b418b94b878ebd253d159f8baaadae1dc8a738f8dff418d8172408a58df9ecc53cdd912c365c9d14c42b5b64902713df9c7a687b35052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710fc85b68c53eb4af947a09811d1439a6118
2025-01-19 15:03:46.849 - debug: matter.0 (126198) 2025-01-19 15:03:46.849 DEBUG MessageExchange Resubmit message 51269375 (retransmission attempt 3, backoff time 8743ms))
2025-01-19 15:03:46.850 - debug: matter.0 (126198) 2025-01-19 15:03:46.850 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42756/51269375 type: 0x0/0x30 reqAck size: 212 payload: 15300120de6f361c0a28888bd71084967f2292198ba6984062cfee3969e17dd7faca17412502f150300320f3a469210e5764b3d34f080652c251f2440efb22a249f9273d71c888e609464730044104370f288e77447484934ffd09b418b94b878ebd253d159f8baaadae1dc8a738f8dff418d8172408a58df9ecc53cdd912c365c9d14c42b5b64902713df9c7a687b35052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710fc85b68c53eb4af947a09811d1439a6118
2025-01-19 15:03:55.594 - debug: matter.0 (126198) 2025-01-19 15:03:55.594 DEBUG MessageExchange Resubmit message 51269375 (retransmission attempt 4, backoff time 14804ms))
2025-01-19 15:03:55.594 - debug: matter.0 (126198) 2025-01-19 15:03:55.594 DEBUG ExchangeManager Message » for: SC/Sigma1 msgId: 0/42756/51269375 type: 0x0/0x30 reqAck size: 212 payload: 15300120de6f361c0a28888bd71084967f2292198ba6984062cfee3969e17dd7faca17412502f150300320f3a469210e5764b3d34f080652c251f2440efb22a249f9273d71c888e609464730044104370f288e77447484934ffd09b418b94b878ebd253d159f8baaadae1dc8a738f8dff418d8172408a58df9ecc53cdd912c365c9d14c42b5b64902713df9c7a687b35052501f40125022c012503a00f24041124050c26060000030124070a18300610d264c4c2cce05a122c8f17617759cfc1300710fc85b68c53eb4af947a09811d1439a6118
2025-01-19 15:04:10.400 - debug: matter.0 (126198) 2025-01-19 15:04:10.400 DEBUG MessageExchange Message 51269375: Wait additional 19425ms for processing time and peer resubmissions after all our resubmissions
2025-01-19 15:04:12.929 - debug: matter.0 (126198) 2025-01-19 15:04:12.928 DEBUG MessageExchange New exchange channel: udp://fe80::5xxf:44ff:fe67:9xxc%ens19:5540 on session secure/20718 protocol: 1 exId: 59988 sess: secure/20718 peerSess: 20718 SAT: 4000 SAI: 300 SII: 500 maxTrans: 5 MRP
2025-01-19 15:04:12.929 - debug: matter.0 (126198) 2025-01-19 15:04:12.929 DEBUG MessageExchange Message « for: I/ReportData msgId: 20718/59988/113044134 type: 0x1/0x5 reqAck size: 11 payload: 152600bf07439324ff0b18
2025-01-19 15:04:12.929 - debug: matter.0 (126198) 2025-01-19 15:04:12.929 DEBUG ExchangeManager Message » for: I/StatusResponse status: Success(0x0) subId: 2470643647 empty msgId: 20718/59988/264918829 type: 0x1/0x1 acked: 113044134 reqAck size: 8 payload: 1524000024ff0c18
2025-01-19 15:04:12.944 - debug: matter.0 (126198) 2025-01-19 15:04:12.943 DEBUG MessageExchange Message « for: SC/StandaloneAck msgId: 20718/59988/113044135 type: 0x0/0x10 acked: 264918829
2025-01-19 15:04:29.826 - debug: matter.0 (126198) 2025-01-19 15:04:29.826 INFO InsecureSession End insecure session insecure/1407129814459350771
2025-01-19 15:04:29.828 - debug: matter.0 (126198) 2025-01-19 15:04:29.827 DEBUG ControllerDiscovery Failed to communicate with udp://fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540, try other servers ... PairRetransmissionLimitReachedError
at #pair (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:498:13)
at async /opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:407:27
at async processOneAddress (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/ControllerDiscovery.js:138:26)
at async ControllerDiscovery.iterateServerAddresses (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/ControllerDiscovery.js:173:26)
at async /opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:396:26
2025-01-19 15:04:29.828 - debug: matter.0 (126198) 2025-01-19 15:04:29.828 DEBUG ControllerDiscovery Server addresses to try: udp://fd28:5xxd:axx8::exx9:6xx6:ad4c:bxx4:5540
2025-01-19 15:04:29.828 - debug: matter.0 (126198) 2025-01-19 15:04:29.828 INFO PeerSet Resume failed, remove all sessions for peer@1:0x7febdc7ab12c735f
2025-01-19 15:04:29.829 - debug: matter.0 (126198) 2025-01-19 15:04:29.828 INFO PairedNode Node 92177xxxxxxxxxx3215: Error waiting for device rediscovery, retrying Failed to connect on any discovered server
at ControllerDiscovery.iterateServerAddresses (/opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/ControllerDiscovery.js:192:15)
at async /opt/iobroker/node_modules/@matter/protocol/dist/cjs/peer/PeerSet.js:396:26
2025-01-19 15:04:29.829 - debug: matter.0 (126198) 2025-01-19 15:04:29.829 INFO PairedNode Node 92177xxxxxxxxxx3215: Reconnecting in 60s ...
2025-01-19 15:04:43.355 - debug: matter.0 (126198) Send to GUI: {"command":"stopped"}
2025-01-19 15:04:43.386 - debug: matter.0 (126198) 2025-01-19 15:04:43.385 INFO InsecureSession End insecure session insecure/0
2025-01-19 15:04:43.386 - debug: matter.0 (126198) 2025-01-19 15:04:43.386 INFO SecureSession End CASE session secure/20718
2025-01-19 15:04:43.386 - debug: matter.0 (126198) 2025-01-19 15:04:43.386 INFO CommissioningController Session for peer node 66963xxxxxxxxxx2140 disconnected ...
2025-01-19 15:04:43.386 - debug: matter.0 (126198) 2025-01-19 15:04:43.386 INFO PairedNode Node 66963xxxxxxxxxx2140: Session disconnected
2025-01-19 15:04:43.388 - debug: matter.0 (126198) 2025-01-19 15:04:43.387 DEBUG MdnsServer Expiring records instanceName: 925Exxxxxxxx5A7E-472Cxxxxxxxx2355._matter._tcp.local port: 56498 netInterface: ens19
2025-01-19 15:04:43.390 - debug: matter.0 (126198) 2025-01-19 15:04:43.390 DEBUG MdnsScanner Removing operational device 925Exxxxxxxx5A7E-472Cxxxxxxxx2355._matter._tcp.local from cache (interface ens19) because of ttl=0
2025-01-19 15:04:43.453 - debug: matter.0 (126198) Plugin sentry destroyed

EDIT: Musste es aufteilen, kam "Payload too large"...

[Wildbill]

@peter-v sagte in "Matter" Adapter: Tester für Alpha Phase gesucht:

@wildbill
deinen TBR mal neu gestartet?, hatte ich auch schon, das sich mein Echo4 aus dem WLAN abgemeldet hatte, Stromlos machen hatte geholfen.

Da es via Homeassistant und Apple Home nach wie vor problemlos läuft, sehe ich da erst einmal kein Problem mit einem der Border Router. iobroker hat das Gerät ja aus einer Freigabe von Apple Home erhalten und das zweite Matter-Gerät läuft ja auch noch.
Wenn das Log da niemand auf eine Idee bringt, dann starte ich die mal alle neu (2 Homepod Mini, 2 Homepod Gen 2, Apple TV4K, Echo Show 8).

Gruss, Jürgen

[Feuersturm]

@wildbill sagte in "Matter" Adapter: Tester für Alpha Phase gesucht:

War doch meine öffentliche IPv6 mit drin. Auch Dinge, die mit KEYs oder Zertifikaten drin waren, habe ich "verstümmelt"

Kannst du bitte hier https://github.com/ioBroker/ioBroker.matter/issues einmal ein issue anlegen, welche Daten aus deiner Sicht im Log (teilweise) anonymisiert werden sollten?

[Wildbill]

@feuersturm Erledigt: LINK

[Wildbill]

So, da ich ja notorisch ungeduldig bin habe ich noch den Rat von @peter-v befolgt und mal alle TBR (Homepods, Apple TV 4k, Echo Show 8 ) stromlos gemacht und neu gestartet. Ebenso danach noch die Batterie vom Schloss getrennt (vom Schloss selbst, das Keypad hängt an Dauerstrom, der gesamte Verkehr läuft aber eh über das eigentliche Schloss). Ergebnis: Funktion nach wie vor gegeben via Alexa, Home assistant und Apple Home. In iobroker war der Aqara M1S sofort online und ließ sich bedienen. Das Schloss stand nach wie vor auf reconnecting. Ich habe dann den Adapter nochmals neu gestartet, gleiches Bild, AAAAAABER: 3 Minuten später nochmal geschaut, Schloss Status auf

connected(0)

und zeigt wieder korrekt an und lässt sich bedienen.

Ich hatte gestern bereits mal die Batterie entfernt und danach den Adapter neu gestartet, das hatte aber nichts geholfen. Sollte es wirklich am Neustart sämtlicher Border Router gelegen haben, obwohl die Funktionalität in allen anderen 3 Systemen außer iobroker nach wie vor gegeben war? Alle Border Router haben die ganze Zeit einwandfrei funktioniert, also als das was sie eigentlich sind. Homepods, Apple TV und Echo. Keine Aussetzer, kein Hinweis, dass irgendeiner sich mal im Netzwerk neu verbunden hätte. Erst eben jetzt nach dem Neustart...

Manches muss man nicht direkt verstehen, aber Hauptsache, es läuft erstmal wieder ohne neu Anlernen. Ich beobachte dann mal weiter...

Gruss, Jürgen

[apollon77]

@wildbill Das ist ein Thread Gerät - hat dein iobroker Host die relevanten IPv6 Einstellungen wie im Troubleshootling guide beschrieben und auch "Persistiert"? hast Du vllr rebootet und das ist verloren gegangen? Bei HAOS tut das weil die diese IPv6 Settings direkt im System rein-twekaen.

[Wildbill]

@apollon77 Ja, die aus dem Troubleshooting empfohlenen Einstellungen hat mein System. Bzw., hatte es schon immer, bis auf den Punkt

sysctl -n net.ipv6.conf.wlp0s20f3.accept_ra_rt_info_max_plen

den ich damals anpassen musste.
Und nein, weder iobroker, gar der Proxmox-Host oder einer der Border Router oder das Schloss selbst wurden zum Zeitpunkt des Aussteigens in iobroker neu gestartet oder Ähnliches. Auch kein Neustart des Adapters. Aufgefallen ist es mir erst, als ich in iobroker in den Objekten gesehen habe, dass da die Farbe anders ist, als beim M1S. Hat also in aller Stille heimlich einfach die Verbindung verloren. In Apple Home und Homeassistant hat alles weiter funktioniert.

Da ein Herausnehmen der Batterien mit anschließendem Neustart des Adapters vorgestern nichts gebracht haben und es erst wieder lief, nachdem ich auch mal die Border Router ALLE neu gestartet habe, vermute ich tatsächlich bei denen einen "Schluckauf", auch wenn die anderen Systeme abseits iobroker kein Problem hatten.

Ich habe die Logs nochmal abgesucht. Zum Zeitpunkt an dem es in iobroker offline ging, waren an diesem gesamten Tag überhaupt nur 4 Zeilen bezüglich Matter im Log:

2025-01-18 02:40:16.194 - info: matter.0 (11282) Node "9217703481860453215" reconnecting
2025-01-18 02:40:29.331 - info: matter.0 (11282) Node "9217703481860453215" connected
2025-01-18 03:10:34.397 - info: matter.0 (11282) Node "9217703481860453215" reconnecting
2025-01-18 03:12:54.543 - info: matter.0 (11282) Node "9217703481860453215" offline, waiting for device discovery

Allerdings natürlich nicht im Debug-Modus und Loglevel auf Info.

Gruss, Jürgen

[apollon77]

@wildbill Also an sich sollte er auch im Modus "waiting for device discovery" alle 10 Minuten versuchen zu connecten ... sind dann aber andere logs weil sich der status ja nicht ändert

[RISSN]

Hallo zusammen, ich habe mir mal den Matter Adapter installiert und zum testen habe ich einen Shelly Plug geholt, Die Verbindung konnte ich herstellen, schalten geht auch, aber der Verbrauch nicht. Liegt das jetzt daran, dass Shelly diesen nicht überträgt, oder liegt es am Adapter?

[Feuersturm]

@rissn Welche Matter Adapterversion hast du installiert? Ohne ein Debug Log inkl. "Erweitertes Debug-Logging für das Matter-Protokoll aktivieren (nur sichtbar mit der Protokollebene „Debug“)" wird man nicht sagen können woran es liegt

[Wim741]

@apollon77 Hi, könnte man noch mittesten? hab aquara und tado mit matter. lg

[RISSN]

@feuersturm ich habe Version 0.4.2

matter.0
2025-01-24 06:18:10.648	debug	handleChangedAttribute "10683754491737671200": Attribute undefined/56/0x0402/measuredValue changed to 1625

matter.0
2025-01-24 06:16:28.299	debug	handleChangedAttribute "10683754491737671200": Attribute undefined/0/0x0033/totalOperationalHours changed to 1074

matter.0
2025-01-24 06:16:28.298	debug	handleChangedAttribute "10683754491737671200": Attribute undefined/0/0x0033/upTime changed to 3869958

matter.0
2025-01-24 06:16:28.295	debug	handleChangedAttribute "10683754491737671200": Attribute undefined/0/0x0033/networkInterfaces changed to [{"name":"eth1","isOperational":true,"offPremiseServicesReachableIPv4":null,"offPremiseServicesReachableIPv6":null,"hardwareAddress":"ecb5fa241b15","iPv4Addresses":["c0a80090"],"iPv6Addresses":["200300c1f70dce00eeb5fafffe241b15","fd0b532f3be10000eeb5fafffe241b15","fe80000000000000eeb5fafffe241b15"],"type":0},{"name":"eth0","isOperational":false,"offPremiseServicesReachableIPv4":null,"offPremiseServicesReachableIPv6":null,"hardwareAddress":"00037f1120ce","iPv4Addresses":[],"iPv6Addresses":[],"type":2},{"name":"lo","isOperational":true,"offPremiseServicesReachableIPv4":null,"offPremiseServicesReachableIPv6":null,"hardwareAddress":"000000000000","iPv4Addresses":["7f000001"],"iPv6Addresses":["00000000000000000000000000000001"],"type":0}]

matter.0
2025-01-24 06:16:27.305	debug	2025-01-24 06:16:27.305 INFO ExchangeManager Invalid Data report with unexpected subscription ID 1654648002

matter.0
2025-01-24 06:16:16.109	debug	handleChangedAttribute "10683754491737671200": Attribute undefined/9/0x0402/measuredValue changed to 1676

matter.0
2025-01-24 06:13:21.645	debug	Send to GUI: {"command":"updateController"}

matter.0
2025-01-24 06:13:21.344	info	Node "10683754491737671200" connected

matter.0
2025-01-24 06:13:21.216	debug	handleChangedAttribute "10683754491737671200": Attribute undefined/56/0x0402/measuredValue changed to 1600

matter.0
2025-01-24 06:13:21.129	debug	handleChangedAttribute "10683754491737671200": Attribute undefined/33/0x0402/measuredValue changed to 1929

matter.0
2025-01-24 06:13:21.054	debug	handleChangedAttribute "10683754491737671200": Attribute undefined/9/0x0402/measuredValue changed to 1650

matter.0
2025-01-24 06:13:20.979	debug	2025-01-24 06:13:20.979 INFO InteractionClient Subscription successfully initialized with ID 3040863973 and maxInterval 600s.

matter.0
2025-01-24 06:13:20.740	debug	Send to GUI: {"command":"updateController"}

matter.0
2025-01-24 06:13:20.439	info	Node "7398579136186651997" connected

matter.0
2025-01-24 06:13:20.358	debug	Send to GUI: {"command":"updateController"}

matter.0
2025-01-24 06:13:20.277	debug	2025-01-24 06:13:20.277 INFO InteractionClient Subscription successfully initialized with ID 1931890527 and maxInterval 60s.

matter.0
2025-01-24 06:13:20.058	info	Node "7398579136186651997" offline, waiting for device discovery

matter.0
2025-01-24 06:13:19.999	debug	2025-01-24 06:13:19.999 INFO InsecureSession End insecure session insecure/14722600410172216989

matter.0
2025-01-24 06:13:19.936	debug	Send to GUI: {"command":"updateController"}

matter.0
2025-01-24 06:13:19.919	debug	2025-01-24 06:13:19.919 INFO CaseClient Case client: Session resumed with udp://192.168.1.42:5540 and parameters SII: 500 SAI: 300 SAT: 4000 DMRev: 17 IMRev: 11 spec: 0x0 maxPaths: 1 CATs:

matter.0
2025-01-24 06:13:19.634	info	Node "7398579136186651997" reconnecting

matter.0
2025-01-24 06:13:19.575	debug	Initialization done, Objects subscribed

matter.0
2025-01-24 06:13:19.575	debug	2025-01-24 06:13:19.575 INFO PairedNode Node 7398579136186651997: Reconnecting in 0s ...

matter.0
2025-01-24 06:13:19.537	info	Endpoint 1 (MA-onoffpluginunit):

matter.0
2025-01-24 06:13:19.493	debug	Set matter.0.controller.7398579136186651997.OnOffPlugInUnit-1.ACTUAL to true (ack = true)

matter.0
2025-01-24 06:13:19.444	debug	Set matter.0.controller.7398579136186651997.OnOffPlugInUnit-1.SET to true (ack = true)

matter.0
2025-01-24 06:13:19.392	debug	Set matter.0.controller.7398579136186651997.OnOffPlugInUnit-1.ACTUAL to true (ack = true)

matter.0
2025-01-24 06:13:19.391	debug	Received state change for matter.0.controller.7398579136186651997.OnOffPlugInUnit-1.SET: true (ack=true) --> true (triggerUpdate=true)

matter.0
2025-01-24 06:13:19.342	info	Node 7398579136186651997: Creating device for OnOffPlugInUnit (endpoint 1)

matter.0
2025-01-24 06:13:19.334	info	Node 7398579136186651997: Endpoint 1 to ioBroker Devices MA-onoffpluginunit / OnOffPlugInUnit

matter.0
2025-01-24 06:13:19.302	info	Node 7398579136186651997: Endpoint 0 to ioBroker Devices MA-rootnode / RootNode

matter.0
2025-01-24 06:13:19.257	info	Node "10683754491737671200" offline, waiting for device discovery

matter.0
2025-01-24 06:13:19.164	info	Node "10683754491737671200" reconnecting

Das Log ist leider sehr lang, habe Hue mit drin, aber der Verbrauch ist leider nicht da und als Beispiel bei Hue sehe ich die BWM aber kein Status, sicher auch nicht so wichtig wie der Verbrauch beim Shelly. Auch übernimmt es beim Start vom Adapter nicht den richtigen aktuellen Status, der Shelly ist an und im Status steht = False. Somit muss man einmal aus, wieder einschalten um dann ausschalten zu können.

[arteck]

@rissn

ach komm.. wie soll man da aus dem LOG schlau werden...

der gehört in den Code tag

[RISSN]

@arteck sorry dafür, du hast natürlich Recht, kommt nicht wieder vor

[apollon77]

Ok, die Beta startet jetzt, von daher mache ich hier mal zu ... Weiter gehts unter https://forum.iobroker.net/topic/79493/beta-iobroker-matter-adapter