search

project-chip / connectedhomeip

Matter (formerly Project CHIP) creates more connections between more objects, simplifying development for manufacturers and increasing compatibility for consumers, guided by the Connectivity Standards Alliance.
https://buildwithmatter.com
Apache License 2.0
7.39k stars 1.98k forks source link

[BUG] Does Amazon Alexa support Bridged devices? Pairing with dynamic-bridge-app failed #24445

Closed Apollon77 closed 1 year ago

Apollon77 commented 1 year ago

Reproduction steps

Does anyone know if Amazon Alexa should support bridged devices with Matter or only simple devices?

If I try to pair Amazon Alexa with "dynamic-bridge-app" then it fails (roughly the same oif I try with my development version of node-matter :-) )

[1673868783251] [20318:17564122] [DL] KVS will be written to: file:///tmp/chip_kvs
[1673868783267] [20318:17564122] [DL] _Init
[1673868783267] [20318:17564122] [SPT] *** WARNING: Using temporary passcode 20202021 due to no neither --passcode or --spake2p-verifier-base64 given on command line. This is temporary and will disappear. Please update your scripts to explicitly configure onboarding credentials. ***
[1673868783267] [20318:17564122] [SPT] *** WARNING: Using temporary test discriminator 3840 due to --discriminator not given on command line. This is temporary and will disappear. Please update your scripts to explicitly configure discriminator. ***
[1673868783267] [20318:17564122] [SPT] PASE PBKDF iterations set to 1000
[1673868783267] [20318:17564122] [SPT] LinuxCommissionableDataProvider didn't get a PASE salt, generating one.
[1673868783271] [20318:17564122] [DL] Device Configuration:
[1673868783271] [20318:17564122] [DL]   Serial Number: TEST_SN
[1673868783271] [20318:17564122] [DL]   Vendor Id: 65521 (0xFFF1)
[1673868783271] [20318:17564122] [DL]   Product Id: 32769 (0x8001)
[1673868783271] [20318:17564122] [DL]   Hardware Version: 0
[1673868783271] [20318:17564122] [DL]   Setup Pin Code (0 for UNKNOWN/ERROR): 20202021
[1673868783271] [20318:17564122] [DL]   Setup Discriminator (0xFFFF for UNKNOWN/ERROR): 3840 (0xF00)
[1673868783271] [20318:17564122] [DL]   Manufacturing Date: (not set)
[1673868783271] [20318:17564122] [DL]   Device Type: 65535 (0xFFFF)
[1673868783271] [20318:17564122] [-] ==== Onboarding payload for Standard Commissioning Flow ====
[1673868783271] [20318:17564122] [SVR] SetupQRCode: [MT:-24J042C00KA0648G00]
[1673868783271] [20318:17564122] [SVR] Copy/paste the below URL in a browser to see the QR Code:
[1673868783271] [20318:17564122] [SVR] https://project-chip.github.io/connectedhomeip/qrcode.html?data=MT%3A-24J042C00KA0648G00
[1673868783271] [20318:17564122] [SVR] Manual pairing code: [34970112332]
[1673868783271] [20318:17564122] [DL] _SetDeviceName
[1673868783271] [20318:17564122] [DL] _SetAdvertisingEnabled
[1673868783271] [20318:17564122] [SVR] Server initializing...
[1673868783271] [20318:17564122] [FP] Initializing FabricTable from persistent storage
[1673868783271] [20318:17564122] [TS] Last Known Good Time: 2023-01-16T12:17:49
[1673868783272] [20318:17564122] [DMG] AccessControl: initializing
[1673868783272] [20318:17564122] [DMG] Examples::AccessControlDelegate::Init
[1673868783272] [20318:17564122] [DMG] AccessControl: setting
[1673868783272] [20318:17564122] [DMG] DefaultAclStorage: initializing
[1673868783272] [20318:17564122] [DMG] DefaultAclStorage: 0 entries loaded
[1673868783272] [20318:17564122] [IN] UDP::Init bind&listen port=5540
[1673868783272] [20318:17564122] [IN] UDP::Init bound to port=5540
[1673868783272] [20318:17564122] [IN] UDP::Init bind&listen port=5540
[1673868783272] [20318:17564122] [IN] UDP::Init bound to port=5540
[1673868783272] [20318:17564122] [IN] BLEBase::Init - setting/overriding transport
[1673868783272] [20318:17564122] [IN] TransportMgr initialized
[1673868783274] [20318:17564122] [ZCL] Using ZAP configuration...
[1673868783274] [20318:17564122] [DMG] Failed to read stored attribute (0, 0x0000_0028, 0x0000_0005: ../../third_party/connectedhomeip/src/platform/Darwin/KeyValueStoreManagerImpl.mm:222: CHIP Error 0x000000A0: Value not found in the persisted storage
[1673868783274] [20318:17564122] [DMG] Failed to read stored attribute (0, 0x0000_0028, 0x0000_0010: ../../third_party/connectedhomeip/src/platform/Darwin/KeyValueStoreManagerImpl.mm:222: CHIP Error 0x000000A0: Value not found in the persisted storage
[1673868783274] [20318:17564122] [DMG] Failed to read stored attribute (0, 0x0000_002C, 0x0000_0000: ../../third_party/connectedhomeip/src/platform/Darwin/KeyValueStoreManagerImpl.mm:222: CHIP Error 0x000000A0: Value not found in the persisted storage
[1673868783274] [20318:17564122] [DMG] Failed to read stored attribute (0, 0x0000_002C, 0x0000_0001: ../../third_party/connectedhomeip/src/platform/Darwin/KeyValueStoreManagerImpl.mm:222: CHIP Error 0x000000A0: Value not found in the persisted storage
[1673868783274] [20318:17564122] [DMG] Failed to read stored attribute (0, 0x0000_002D, 0x0000_0000: ../../third_party/connectedhomeip/src/platform/Darwin/KeyValueStoreManagerImpl.mm:222: CHIP Error 0x000000A0: Value not found in the persisted storage
[1673868783275] [20318:17564122] [DMG] Failed to read stored attribute (2, 0x0000_0008, 0x0000_4000: ../../third_party/connectedhomeip/src/platform/Darwin/KeyValueStoreManagerImpl.mm:222: CHIP Error 0x000000A0: Value not found in the persisted storage
[1673868783275] [20318:17564122] [DMG] AccessControlCluster: initializing
[1673868783275] [20318:17564122] [ZCL] Initiating Admin Commissioning cluster.
[1673868783275] [20318:17564122] [DMG] Endpoint 0, Cluster 0x0000_0030 update version to 745f2fb2
[1673868783275] [20318:17564122] [ZCL] GeneralDiagnostics: OnDeviceReboot
[1673868783275] [20318:17564122] [DMG] Endpoint 0, Cluster 0x0000_0033 update version to 688fd1f8
[1673868783275] [20318:17564122] [EVL] LogEvent event number: 0x0000000000020000 priority: 2, endpoint id:  0x0 cluster id: 0x0000_0033 event id: 0x3 Sys timestamp: 0x0000000086617D44
[1673868783275] [20318:17564122] [DMG] Endpoint 0, Cluster 0x0000_002B update version to f55be764
[1673868783276] [20318:17564122] [DMG] Endpoint 2, Cluster 0x0000_0008 update version to 88633445
[1673868783276] [20318:17564122] [IN] SecureSession[0x600001e6c000]: Allocated Type:1 LSID:56125
[1673868783276] [20318:17564122] [SC] Assigned local session key ID 56125
[1673868783276] [20318:17564122] [SC] Waiting for PBKDF param request
[1673868783276] [20318:17564122] [DL] _SetAdvertisingEnabled
[1673868783276] [20318:17564122] [SVR] BLE networking available but BLE advertising is not supported
[1673868783276] [20318:17564122] [DIS] Updating services using commissioning mode 1
[1673868783276] [20318:17564122] [DL] Using wifi MAC for hostname
[1673868783276] [20318:17564122] [DIS] Advertise commission parameter vendorID=65521 productID=32769 discriminator=3840/15 cm=1
[1673868783276] [20318:17564122] [DIS] Registering service D0FA56F466C1171C on host 000000000000.local. with port 5540 and type: _matterc._udp,_V65521,_S15,_L3840,_CM on interface id: 0
[1673868783276] [20318:17564122] [DIS] Updating services using commissioning mode 1
[1673868783277] [20318:17564122] [DL] Using wifi MAC for hostname
[1673868783277] [20318:17564122] [DIS] Advertise commission parameter vendorID=65521 productID=32769 discriminator=3840/15 cm=1
[1673868783277] [20318:17564122] [DIS] Registering service D0FA56F466C1171C on host 000000000000.local. with port 5540 and type: _matterc._udp,_V65521,_S15,_L3840,_CM on interface id: 0
[1673868783277] [20318:17564122] [IN] CASE Server enabling CASE session setups
[1673868783277] [20318:17564122] [IN] SecureSession[0x600001e781e0]: Allocated Type:2 LSID:56126
[1673868783277] [20318:17564122] [SC] Allocated SecureSession (0x600001e781e0) - waiting for Sigma1 msg
[1673868783277] [20318:17564122] [SVR] Joining Multicast groups
[1673868783277] [20318:17564122] [ZCL] Emitting StartUp event
[1673868783277] [20318:17564122] [EVL] LogEvent event number: 0x0000000000020001 priority: 2, endpoint id:  0x0 cluster id: 0x0000_0028 event id: 0x0 Sys timestamp: 0x0000000086617D46
[1673868783277] [20318:17564122] [SVR] Server Listening...
[1673868783277] [20318:17564122] [DL] Device Configuration:
[1673868783277] [20318:17564122] [DL]   Serial Number: TEST_SN
[1673868783278] [20318:17564122] [DL]   Vendor Id: 65521 (0xFFF1)
[1673868783278] [20318:17564122] [DL]   Product Id: 32769 (0x8001)
[1673868783278] [20318:17564122] [DL]   Hardware Version: 0
[1673868783278] [20318:17564122] [DL]   Setup Pin Code (0 for UNKNOWN/ERROR): 20202021
[1673868783278] [20318:17564122] [DL]   Setup Discriminator (0xFFFF for UNKNOWN/ERROR): 3840 (0xF00)
[1673868783278] [20318:17564122] [DL]   Manufacturing Date: (not set)
[1673868783278] [20318:17564122] [DL]   Device Type: 65535 (0xFFFF)
[1673868783278] [20318:17564122] [SVR] SetupQRCode: [MT:-24J042C00KA0648G00]
[1673868783278] [20318:17564122] [SVR] Copy/paste the below URL in a browser to see the QR Code:
[1673868783278] [20318:17564122] [SVR] https://project-chip.github.io/connectedhomeip/qrcode.html?data=MT%3A-24J042C00KA0648G00
[1673868783278] [20318:17564122] [SVR] Manual pairing code: [34970112332]
? [1673868783278] [20318:17564125] [DL] _OnPlatformEvent
[1673868783278] [20318:17564125] [DIS] Updating services using commissioning mode 1
[1673868783278] [20318:17564125] [DL] Using wifi MAC for hostname
[1673868783279] [20318:17564125] [DIS] Advertise commission parameter vendorID=65521 productID=32769 discriminator=3840/15 cm=1
[1673868783279] [20318:17564125] [DIS] Registering service D0FA56F466C1171C on host 000000000000.local. with port 5540 and type: _matterc._udp,_V65521,_S15,_L3840,_CM on interface id: 0
[1673868783930] [20318:17564125] [DIS] Mdns: OnRegister name: D0FA56F466C1171C, type: _matterc._udp., domain: local., flags: 2
[1673868783930] [20318:17564125] [DIS] mDNS service published: _matterc._udp; instance name: D0FA56F466C1171C
[1673868783931] [20318:17564125] [DIS] Status: Satisfied
[1673868783931] [20318:17564125] [DIS]  lo0 (1)
[1673868783931] [20318:17564125] [DIS]      * ipv4: 127.0.0.1
[1673868783931] [20318:17564125] [DIS]      * ipv6: ::1
[1673868783931] [20318:17564125] [DIS]      * ipv6: fe80::1
[1673868783934] [20318:17564125] [DIS]  bridge0 (8 / Wired)
[1673868783934] [20318:17564125] [DIS]      * ipv4: 192.168.178.57
[1673868783934] [20318:17564125] [DIS]      * ipv6: fe80::468:655b:d4ce:4e4f
[1673868783934] [20318:17564125] [DIS]      * ipv6: 2a02:8071:2c87:399c:1cc5:8756:a18d:3ecf
[1673868783934] [20318:17564125] [DIS]      * ipv6: 2a02:8071:2c87:399c:d43c:53c3:29ae:173a
[1673868783937] [20318:17564125] [DIS]  en0 (6 / WiFi)
[1673868783937] [20318:17564125] [DIS]      * ipv4: 192.168.178.159
[1673868783937] [20318:17564125] [DIS]      * ipv6: fe80::1c30:855c:9d80:6e0c
[1673868783937] [20318:17564125] [DIS]      * ipv6: 2a02:8071:2c87:399c:8a0:8914:4763:faad
[1673868783937] [20318:17564125] [DIS]      * ipv6: 2a02:8071:2c87:399c:c143:989e:db30:1e64
[1673868783937] [20318:17564125] [DIS]      * ipv6: 2a02:8071:2c87:399c:8125:a0d:bc81:fe9
[1673868783938] [20318:17564125] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868783938] [20318:17564125] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868783938] [20318:17564125] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868783938] [20318:17564125] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868783938] [20318:17564125] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868783938] [20318:17564125] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868783938] [20318:17564125] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868783938] [20318:17564125] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868783938] [20318:17564125] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868783938] [20318:17564125] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868783938] [20318:17564125] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868783938] [20318:17564125] [DIS] Mdns: OnRegisterRecord flags: 0
[1673868800584] [20318:17564125] [EM] >>> [E:58590r M:172004158] (U) Msg RX from 0:38F8ECB32E860920 [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest)
[1673868800584] [20318:17564125] [EM] Handling via exchange: 58590r, Delegate: 0x1096b4ec0
[1673868800584] [20318:17564125] [SC] Received PBKDF param request
[1673868800584] [20318:17564125] [SC] Peer assigned session ID 39847
[1673868800585] [20318:17564125] [EM] <<< [E:58590r M:210306328 (Ack:172004158)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:21 (SecureChannel:PBKDFParamResponse)
[1673868800585] [20318:17564125] [IN] (U) Sending msg 210306328 to IP address 'UDP:192.168.178.34%en0:5541'
[1673868800585] [20318:17564125] [SC] Sent PBKDF param response
[1673868800585] [20318:17564125] [IN] Received a duplicate message with MessageCounter:172004158 on exchange 58590r
[1673868800585] [20318:17564125] [EM] >>> [E:58590r M:172004158] (U) Msg RX from 0:38F8ECB32E860920 [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest)
[1673868800585] [20318:17564125] [EM] Found matching exchange: 58590r, Delegate: 0x1096b4ec0
[1673868800585] [20318:17564125] [EM] Forcing tx of solitary ack for duplicate MessageCounter:172004158 on exchange 58590r
[1673868800585] [20318:17564125] [EM] <<< [E:58590r M:210306329 (Ack:172004158)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868800585] [20318:17564125] [IN] (U) Sending msg 210306329 to IP address 'UDP:192.168.178.34%en0:5541'
[1673868800585] [20318:17564125] [IN] Received a duplicate message with MessageCounter:172004158 on exchange 58590r
[1673868800585] [20318:17564125] [EM] >>> [E:58590r M:172004158] (U) Msg RX from 0:38F8ECB32E860920 [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest)
[1673868800585] [20318:17564125] [EM] Found matching exchange: 58590r, Delegate: 0x1096b4ec0
[1673868800585] [20318:17564125] [EM] Forcing tx of solitary ack for duplicate MessageCounter:172004158 on exchange 58590r
[1673868800585] [20318:17564125] [EM] <<< [E:58590r M:210306330 (Ack:172004158)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868800586] [20318:17564125] [IN] (U) Sending msg 210306330 to IP address 'UDP:192.168.178.34%en0:5541'
[1673868800586] [20318:17564125] [IN] Received a duplicate message with MessageCounter:172004158 on exchange 58590r
[1673868800586] [20318:17564125] [EM] >>> [E:58590r M:172004158] (U) Msg RX from 0:38F8ECB32E860920 [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest)
[1673868800586] [20318:17564125] [EM] Found matching exchange: 58590r, Delegate: 0x1096b4ec0
[1673868800586] [20318:17564125] [EM] Forcing tx of solitary ack for duplicate MessageCounter:172004158 on exchange 58590r
[1673868800586] [20318:17564125] [EM] <<< [E:58590r M:210306331 (Ack:172004158)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868800586] [20318:17564125] [IN] (U) Sending msg 210306331 to IP address 'UDP:192.168.178.34%en0:5541'
[1673868800586] [20318:17564125] [IN] Received a duplicate message with MessageCounter:172004158 on exchange 58590r
[1673868800586] [20318:17564125] [EM] >>> [E:58590r M:172004158] (U) Msg RX from 0:38F8ECB32E860920 [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest)
[1673868800586] [20318:17564125] [EM] Found matching exchange: 58590r, Delegate: 0x1096b4ec0
[1673868800586] [20318:17564125] [EM] Forcing tx of solitary ack for duplicate MessageCounter:172004158 on exchange 58590r
[1673868800586] [20318:17564125] [EM] <<< [E:58590r M:210306332 (Ack:172004158)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868800586] [20318:17564125] [IN] (U) Sending msg 210306332 to IP address 'UDP:192.168.178.34%en0:5541'
[1673868800602] [20318:17564125] [EM] >>> [E:58590r M:172004159 (Ack:210306328)] (U) Msg RX from 0:38F8ECB32E860920 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868800602] [20318:17564125] [EM] Found matching exchange: 58590r, Delegate: 0x1096b4ec0
[1673868800602] [20318:17564125] [EM] Rxd Ack; Removing MessageCounter:210306328 from Retrans Table on exchange 58590r
[1673868800689] [20318:17564125] [EM] >>> [E:58590r M:172004160 (Ack:210306328)] (U) Msg RX from 0:38F8ECB32E860920 [0000] --- Type 0000:22 (SecureChannel:PASE_Pake1)
[1673868800689] [20318:17564125] [EM] Found matching exchange: 58590r, Delegate: 0x1096b4ec0
[1673868800689] [20318:17564125] [EM] CHIP MessageCounter:210306328 not in RetransTable on exchange 58590r
[1673868800689] [20318:17564125] [SC] Received spake2p msg1
[1673868800692] [20318:17564125] [EM] <<< [E:58590r M:210306333 (Ack:172004160)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:23 (SecureChannel:PASE_Pake2)
[1673868800692] [20318:17564125] [IN] (U) Sending msg 210306333 to IP address 'UDP:192.168.178.34%en0:5541'
[1673868800693] [20318:17564125] [SC] Sent spake2p msg2
[1673868800704] [20318:17564125] [EM] >>> [E:58590r M:172004161 (Ack:210306333)] (U) Msg RX from 0:38F8ECB32E860920 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868800705] [20318:17564125] [EM] Found matching exchange: 58590r, Delegate: 0x1096b4ec0
[1673868800705] [20318:17564125] [EM] Rxd Ack; Removing MessageCounter:210306333 from Retrans Table on exchange 58590r
[1673868800768] [20318:17564125] [EM] >>> [E:58590r M:172004162 (Ack:210306333)] (U) Msg RX from 0:38F8ECB32E860920 [0000] --- Type 0000:24 (SecureChannel:PASE_Pake3)
[1673868800768] [20318:17564125] [EM] Found matching exchange: 58590r, Delegate: 0x1096b4ec0
[1673868800768] [20318:17564125] [EM] CHIP MessageCounter:210306333 not in RetransTable on exchange 58590r
[1673868800768] [20318:17564125] [SC] Received spake2p msg3
[1673868800768] [20318:17564125] [SC] Sending status report. Protocol code 0, exchange 58590
[1673868800768] [20318:17564125] [EM] <<< [E:58590r M:210306334 (Ack:172004162)] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:40 (SecureChannel:StatusReport)
[1673868800768] [20318:17564125] [IN] (U) Sending msg 210306334 to IP address 'UDP:192.168.178.34%en0:5541'
[1673868800769] [20318:17564125] [SC] SecureSession[0x600001e6c000]: Moving from state 'kEstablishing' --> 'kActive'
[1673868800769] [20318:17564125] [IN] SecureSession[0x600001e6c000]: Activated - Type:1 LSID:56125
[1673868800769] [20318:17564125] [IN] New secure session activated for device <FFFFFFFB00000000, 0>, LSID:56125 PSID:39847!
[1673868800769] [20318:17564125] [SVR] Commissioning completed session establishment step
[1673868800769] [20318:17564125] [DIS] Updating services using commissioning mode 0
[1673868800769] [20318:17564125] [DL] _SetAdvertisingEnabled
[1673868800769] [20318:17564125] [SVR] Device completed Rendezvous process
[1673868800787] [20318:17564125] [EM] >>> [E:58590r M:172004163 (Ack:210306334)] (U) Msg RX from 0:38F8ECB32E860920 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868800787] [20318:17564125] [EM] Found matching exchange: 58590r, Delegate: 0x0
[1673868800787] [20318:17564125] [EM] Rxd Ack; Removing MessageCounter:210306334 from Retrans Table on exchange 58590r
[1673868800885] [20318:17564125] [EM] >>> [E:58591r M:4891364] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
[1673868800885] [20318:17564125] [EM] Handling via exchange: 58591r, Delegate: 0x1096afc00
[1673868800885] [20318:17564125] [DMG] TimedRequestMessage =
[1673868800886] [20318:17564125] [DMG] {
[1673868800886] [20318:17564125] [DMG]  TimeoutMs = 0x2710,
[1673868800886] [20318:17564125] [DMG]  InteractionModelRevision = 1
[1673868800886] [20318:17564125] [DMG] }
[1673868800886] [20318:17564125] [DMG] Got Timed Request with timeout 10000: handler 0x60000215fa40 exchange 58591r
[1673868800886] [20318:17564125] [EM] <<< [E:58591r M:216976914 (Ack:4891364)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
[1673868800886] [20318:17564125] [IN] (S) Sending msg 216976914 on secure session with LSID: 56125
[1673868800886] [20318:17564125] [DMG] Timed Request time limit 0x000000008661E91E: handler 0x60000215fa40 exchange 58591r
[1673868800900] [20318:17564125] [EM] >>> [E:58591r M:4891365 (Ack:216976914)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1673868800900] [20318:17564125] [EM] Found matching exchange: 58591r, Delegate: 0x60000215fa40
[1673868800900] [20318:17564125] [EM] Rxd Ack; Removing MessageCounter:216976914 from Retrans Table on exchange 58591r
[1673868800900] [20318:17564125] [DMG] Timed following action arrived at 0x000000008661C21C: handler 0x60000215fa40 exchange 58591r
[1673868800900] [20318:17564125] [DMG] Handing timed invoke to IM engine: handler 0x60000215fa40 exchange 58591r
[1673868800900] [20318:17564125] [DMG] InvokeRequestMessage =
[1673868800900] [20318:17564125] [DMG] {
[1673868800900] [20318:17564125] [DMG]  suppressResponse = false, 
[1673868800900] [20318:17564125] [DMG]  timedRequest = true, 
[1673868800900] [20318:17564125] [DMG]  InvokeRequests =
[1673868800900] [20318:17564125] [DMG]  [
[1673868800900] [20318:17564125] [DMG]      CommandDataIB =
[1673868800900] [20318:17564125] [DMG]      {
[1673868800900] [20318:17564125] [DMG]          CommandPathIB =
[1673868800900] [20318:17564125] [DMG]          {
[1673868800900] [20318:17564125] [DMG]              EndpointId = 0x0,
[1673868800900] [20318:17564125] [DMG]              ClusterId = 0x3e,
[1673868800900] [20318:17564125] [DMG]              CommandId = 0x2,
[1673868800900] [20318:17564125] [DMG]          },
[1673868800900] [20318:17564125] [DMG]          
[1673868800900] [20318:17564125] [DMG]          CommandFields = 
[1673868800900] [20318:17564125] [DMG]          {
[1673868800900] [20318:17564125] [DMG]              0x0 = 1, 
[1673868800900] [20318:17564125] [DMG]          },
[1673868800900] [20318:17564125] [DMG]      },
[1673868800900] [20318:17564125] [DMG]      
[1673868800900] [20318:17564125] [DMG]  ],
[1673868800900] [20318:17564125] [DMG]  
[1673868800900] [20318:17564125] [DMG]  InteractionModelRevision = 1
[1673868800900] [20318:17564125] [DMG] },
[1673868800900] [20318:17564125] [DMG] AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_003E e=0 p=a
[1673868800900] [20318:17564125] [DMG] AccessControl: implicit admin (PASE)
[1673868800900] [20318:17564125] [DMG] Received command for Endpoint=0 Cluster=0x0000_003E Command=0x0000_0002
[1673868800900] [20318:17564125] [ZCL] OpCreds: Certificate Chain request received for DAC
[1673868800900] [20318:17564125] [DMG] Command handler moving to [ Preparing]
[1673868800901] [20318:17564125] [DMG] Command handler moving to [AddingComm]
[1673868800901] [20318:17564125] [DMG] Command handler moving to [AddedComma]
[1673868800901] [20318:17564125] [DMG] Decreasing reference count for CommandHandler, remaining 0
[1673868800901] [20318:17564125] [EM] <<< [E:58591r M:216976915 (Ack:4891365)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1673868800901] [20318:17564125] [IN] (S) Sending msg 216976915 on secure session with LSID: 56125
[1673868800901] [20318:17564125] [DMG] Command handler moving to [CommandSen]
[1673868800901] [20318:17564125] [DMG] Command handler moving to [AwaitingDe]
[1673868800910] [20318:17564125] [EM] >>> [E:58591r M:4891366 (Ack:216976915)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868800910] [20318:17564125] [EM] Found matching exchange: 58591r, Delegate: 0x0
[1673868800910] [20318:17564125] [EM] Rxd Ack; Removing MessageCounter:216976915 from Retrans Table on exchange 58591r
[1673868801012] [20318:17564125] [EM] >>> [E:58592r M:4891367] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
[1673868801012] [20318:17564125] [EM] Handling via exchange: 58592r, Delegate: 0x1096afc00
[1673868801012] [20318:17564125] [DMG] TimedRequestMessage =
[1673868801012] [20318:17564125] [DMG] {
[1673868801012] [20318:17564125] [DMG]  TimeoutMs = 0x2710,
[1673868801012] [20318:17564125] [DMG]  InteractionModelRevision = 1
[1673868801012] [20318:17564125] [DMG] }
[1673868801012] [20318:17564125] [DMG] Got Timed Request with timeout 10000: handler 0x600002155220 exchange 58592r
[1673868801012] [20318:17564125] [EM] <<< [E:58592r M:216976916 (Ack:4891367)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
[1673868801012] [20318:17564125] [IN] (S) Sending msg 216976916 on secure session with LSID: 56125
[1673868801012] [20318:17564125] [DMG] Timed Request time limit 0x000000008661E99D: handler 0x600002155220 exchange 58592r
[1673868801019] [20318:17564386] [EM] >>> [E:58592r M:4891368 (Ack:216976916)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1673868801020] [20318:17564386] [EM] Found matching exchange: 58592r, Delegate: 0x600002155220
[1673868801020] [20318:17564386] [EM] Rxd Ack; Removing MessageCounter:216976916 from Retrans Table on exchange 58592r
[1673868801020] [20318:17564386] [DMG] Timed following action arrived at 0x000000008661C294: handler 0x600002155220 exchange 58592r
[1673868801020] [20318:17564386] [DMG] Handing timed invoke to IM engine: handler 0x600002155220 exchange 58592r
[1673868801020] [20318:17564386] [DMG] InvokeRequestMessage =
[1673868801020] [20318:17564386] [DMG] {
[1673868801020] [20318:17564386] [DMG]  suppressResponse = false, 
[1673868801020] [20318:17564386] [DMG]  timedRequest = true, 
[1673868801020] [20318:17564386] [DMG]  InvokeRequests =
[1673868801020] [20318:17564386] [DMG]  [
[1673868801020] [20318:17564386] [DMG]      CommandDataIB =
[1673868801020] [20318:17564386] [DMG]      {
[1673868801020] [20318:17564386] [DMG]          CommandPathIB =
[1673868801020] [20318:17564386] [DMG]          {
[1673868801020] [20318:17564386] [DMG]              EndpointId = 0x0,
[1673868801020] [20318:17564386] [DMG]              ClusterId = 0x3e,
[1673868801020] [20318:17564386] [DMG]              CommandId = 0x2,
[1673868801020] [20318:17564386] [DMG]          },
[1673868801020] [20318:17564386] [DMG]          
[1673868801020] [20318:17564386] [DMG]          CommandFields = 
[1673868801020] [20318:17564386] [DMG]          {
[1673868801020] [20318:17564386] [DMG]              0x0 = 2, 
[1673868801020] [20318:17564386] [DMG]          },
[1673868801020] [20318:17564386] [DMG]      },
[1673868801020] [20318:17564386] [DMG]      
[1673868801020] [20318:17564386] [DMG]  ],
[1673868801020] [20318:17564386] [DMG]  
[1673868801020] [20318:17564386] [DMG]  InteractionModelRevision = 1
[1673868801020] [20318:17564386] [DMG] },
[1673868801020] [20318:17564386] [DMG] AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_003E e=0 p=a
[1673868801020] [20318:17564386] [DMG] AccessControl: implicit admin (PASE)
[1673868801020] [20318:17564386] [DMG] Received command for Endpoint=0 Cluster=0x0000_003E Command=0x0000_0002
[1673868801020] [20318:17564386] [ZCL] OpCreds: Certificate Chain request received for PAI
[1673868801020] [20318:17564386] [DMG] Command handler moving to [ Preparing]
[1673868801020] [20318:17564386] [DMG] Command handler moving to [AddingComm]
[1673868801020] [20318:17564386] [DMG] Command handler moving to [AddedComma]
[1673868801020] [20318:17564386] [DMG] Decreasing reference count for CommandHandler, remaining 0
[1673868801020] [20318:17564386] [EM] <<< [E:58592r M:216976917 (Ack:4891368)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1673868801020] [20318:17564386] [IN] (S) Sending msg 216976917 on secure session with LSID: 56125
[1673868801020] [20318:17564386] [DMG] Command handler moving to [CommandSen]
[1673868801020] [20318:17564386] [DMG] Command handler moving to [AwaitingDe]
[1673868801030] [20318:17564386] [EM] >>> [E:58592r M:4891369 (Ack:216976917)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868801030] [20318:17564386] [EM] Found matching exchange: 58592r, Delegate: 0x0
[1673868801030] [20318:17564386] [EM] Rxd Ack; Removing MessageCounter:216976917 from Retrans Table on exchange 58592r
[1673868801134] [20318:17564386] [EM] >>> [E:58593r M:4891370] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
[1673868801134] [20318:17564386] [EM] Handling via exchange: 58593r, Delegate: 0x1096afc00
[1673868801134] [20318:17564386] [DMG] TimedRequestMessage =
[1673868801134] [20318:17564386] [DMG] {
[1673868801134] [20318:17564386] [DMG]  TimeoutMs = 0x2710,
[1673868801134] [20318:17564386] [DMG]  InteractionModelRevision = 1
[1673868801134] [20318:17564386] [DMG] }
[1673868801134] [20318:17564386] [DMG] Got Timed Request with timeout 10000: handler 0x6000021501c0 exchange 58593r
[1673868801134] [20318:17564386] [EM] <<< [E:58593r M:216976918 (Ack:4891370)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
[1673868801134] [20318:17564386] [IN] (S) Sending msg 216976918 on secure session with LSID: 56125
[1673868801134] [20318:17564386] [DMG] Timed Request time limit 0x000000008661EA17: handler 0x6000021501c0 exchange 58593r
[1673868801142] [20318:17564386] [EM] >>> [E:58593r M:4891371 (Ack:216976918)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1673868801142] [20318:17564386] [EM] Found matching exchange: 58593r, Delegate: 0x6000021501c0
[1673868801142] [20318:17564386] [EM] Rxd Ack; Removing MessageCounter:216976918 from Retrans Table on exchange 58593r
[1673868801142] [20318:17564386] [DMG] Timed following action arrived at 0x000000008661C30F: handler 0x6000021501c0 exchange 58593r
[1673868801142] [20318:17564386] [DMG] Handing timed invoke to IM engine: handler 0x6000021501c0 exchange 58593r
[1673868801143] [20318:17564386] [DMG] InvokeRequestMessage =
[1673868801143] [20318:17564386] [DMG] {
[1673868801143] [20318:17564386] [DMG]  suppressResponse = false, 
[1673868801143] [20318:17564386] [DMG]  timedRequest = true, 
[1673868801143] [20318:17564386] [DMG]  InvokeRequests =
[1673868801143] [20318:17564386] [DMG]  [
[1673868801143] [20318:17564386] [DMG]      CommandDataIB =
[1673868801143] [20318:17564386] [DMG]      {
[1673868801143] [20318:17564386] [DMG]          CommandPathIB =
[1673868801143] [20318:17564386] [DMG]          {
[1673868801143] [20318:17564386] [DMG]              EndpointId = 0x0,
[1673868801143] [20318:17564386] [DMG]              ClusterId = 0x3e,
[1673868801143] [20318:17564386] [DMG]              CommandId = 0x0,
[1673868801143] [20318:17564386] [DMG]          },
[1673868801143] [20318:17564386] [DMG]          
[1673868801143] [20318:17564386] [DMG]          CommandFields = 
[1673868801143] [20318:17564386] [DMG]          {
[1673868801143] [20318:17564386] [DMG]              0x0 = [
[1673868801143] [20318:17564386] [DMG]                      0x27, 0xbc, 0x42, 0xf9, 0x2a, 0xe7, 0x27, 0xcf, 0x4b, 0xff, 0xd4, 0xb7, 0xce, 0xcf, 0x1a, 0xb3, 0x32, 0xb1, 0x78, 0x81, 0xf1, 0xc7, 0x13, 0x42, 0x0f, 0xa6, 0xdb, 0x0b, 0xae, 0xe9, 0xb7, 0xd5, 
[1673868801143] [20318:17564386] [DMG]              ] (32 bytes)
[1673868801143] [20318:17564386] [DMG]          },
[1673868801143] [20318:17564386] [DMG]      },
[1673868801143] [20318:17564386] [DMG]      
[1673868801143] [20318:17564386] [DMG]  ],
[1673868801143] [20318:17564386] [DMG]  
[1673868801143] [20318:17564386] [DMG]  InteractionModelRevision = 1
[1673868801143] [20318:17564386] [DMG] },
[1673868801143] [20318:17564386] [DMG] AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_003E e=0 p=a
[1673868801143] [20318:17564386] [DMG] AccessControl: implicit admin (PASE)
[1673868801143] [20318:17564386] [DMG] Received command for Endpoint=0 Cluster=0x0000_003E Command=0x0000_0000
[1673868801143] [20318:17564386] [ZCL] OpCreds: Received an AttestationRequest command
[1673868801143] [20318:17564386] [EM] <<< [E:58593r M:216976919 (Ack:4891371)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868801143] [20318:17564386] [IN] (S) Sending msg 216976919 on secure session with LSID: 56125
[1673868801143] [20318:17564386] [EM] Flushed pending ack for MessageCounter:4891371 on exchange 58593r
[1673868801146] [20318:17564386] [ZCL] OpCreds: AttestationRequest successful.
[1673868801146] [20318:17564386] [DMG] Command handler moving to [ Preparing]
[1673868801146] [20318:17564386] [DMG] Command handler moving to [AddingComm]
[1673868801146] [20318:17564386] [DMG] Command handler moving to [AddedComma]
[1673868801146] [20318:17564386] [DMG] Decreasing reference count for CommandHandler, remaining 0
[1673868801146] [20318:17564386] [EM] <<< [E:58593r M:216976920 (Ack:4891371)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1673868801146] [20318:17564386] [IN] (S) Sending msg 216976920 on secure session with LSID: 56125
[1673868801146] [20318:17564386] [DMG] Command handler moving to [CommandSen]
[1673868801146] [20318:17564386] [DMG] Command handler moving to [AwaitingDe]
[1673868801154] [20318:17564386] [EM] >>> [E:58593r M:4891372 (Ack:216976920)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868801154] [20318:17564386] [EM] Found matching exchange: 58593r, Delegate: 0x0
[1673868801154] [20318:17564386] [EM] Rxd Ack; Removing MessageCounter:216976920 from Retrans Table on exchange 58593r
[1673868801701] [20318:17564125] [EM] >>> [E:58594r M:4891373] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
[1673868801701] [20318:17564125] [EM] Handling via exchange: 58594r, Delegate: 0x1096afc00
[1673868801702] [20318:17564125] [DMG] TimedRequestMessage =
[1673868801702] [20318:17564125] [DMG] {
[1673868801702] [20318:17564125] [DMG]  TimeoutMs = 0x2710,
[1673868801702] [20318:17564125] [DMG]  InteractionModelRevision = 1
[1673868801702] [20318:17564125] [DMG] }
[1673868801702] [20318:17564125] [DMG] Got Timed Request with timeout 10000: handler 0x60000215f9c0 exchange 58594r
[1673868801702] [20318:17564125] [EM] <<< [E:58594r M:216976921 (Ack:4891373)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
[1673868801702] [20318:17564125] [IN] (S) Sending msg 216976921 on secure session with LSID: 56125
[1673868801702] [20318:17564125] [DMG] Timed Request time limit 0x000000008661EC4F: handler 0x60000215f9c0 exchange 58594r
[1673868801710] [20318:17564125] [EM] >>> [E:58594r M:4891374 (Ack:216976921)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1673868801710] [20318:17564125] [EM] Found matching exchange: 58594r, Delegate: 0x60000215f9c0
[1673868801710] [20318:17564125] [EM] Rxd Ack; Removing MessageCounter:216976921 from Retrans Table on exchange 58594r
[1673868801710] [20318:17564125] [DMG] Timed following action arrived at 0x000000008661C547: handler 0x60000215f9c0 exchange 58594r
[1673868801710] [20318:17564125] [DMG] Handing timed invoke to IM engine: handler 0x60000215f9c0 exchange 58594r
[1673868801710] [20318:17564125] [DMG] InvokeRequestMessage =
[1673868801710] [20318:17564125] [DMG] {
[1673868801710] [20318:17564125] [DMG]  suppressResponse = false, 
[1673868801710] [20318:17564125] [DMG]  timedRequest = true, 
[1673868801710] [20318:17564125] [DMG]  InvokeRequests =
[1673868801710] [20318:17564125] [DMG]  [
[1673868801710] [20318:17564125] [DMG]      CommandDataIB =
[1673868801710] [20318:17564125] [DMG]      {
[1673868801710] [20318:17564125] [DMG]          CommandPathIB =
[1673868801710] [20318:17564125] [DMG]          {
[1673868801710] [20318:17564125] [DMG]              EndpointId = 0x0,
[1673868801710] [20318:17564125] [DMG]              ClusterId = 0x30,
[1673868801710] [20318:17564125] [DMG]              CommandId = 0x0,
[1673868801710] [20318:17564125] [DMG]          },
[1673868801710] [20318:17564125] [DMG]          
[1673868801710] [20318:17564125] [DMG]          CommandFields = 
[1673868801710] [20318:17564125] [DMG]          {
[1673868801710] [20318:17564125] [DMG]              0x0 = 900, 
[1673868801710] [20318:17564125] [DMG]              0x1 = 1, 
[1673868801710] [20318:17564125] [DMG]          },
[1673868801710] [20318:17564125] [DMG]      },
[1673868801710] [20318:17564125] [DMG]      
[1673868801710] [20318:17564125] [DMG]  ],
[1673868801710] [20318:17564125] [DMG]  
[1673868801710] [20318:17564125] [DMG]  InteractionModelRevision = 1
[1673868801710] [20318:17564125] [DMG] },
[1673868801710] [20318:17564125] [DMG] AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_0030 e=0 p=a
[1673868801710] [20318:17564125] [DMG] AccessControl: implicit admin (PASE)
[1673868801710] [20318:17564125] [DMG] Received command for Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0000
[1673868801710] [20318:17564125] [FS] GeneralCommissioning: Received ArmFailSafe (900s)
[1673868801710] [20318:17564125] [DMG] Endpoint 0, Cluster 0x0000_0030 update version to 745f2fb3
[1673868801711] [20318:17564125] [DMG] Command handler moving to [ Preparing]
[1673868801711] [20318:17564125] [DMG] Command handler moving to [AddingComm]
[1673868801711] [20318:17564125] [DMG] Command handler moving to [AddedComma]
[1673868801711] [20318:17564125] [DMG] Decreasing reference count for CommandHandler, remaining 0
[1673868801711] [20318:17564125] [EM] <<< [E:58594r M:216976922 (Ack:4891374)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1673868801711] [20318:17564125] [IN] (S) Sending msg 216976922 on secure session with LSID: 56125
[1673868801711] [20318:17564125] [DMG] Command handler moving to [CommandSen]
[1673868801711] [20318:17564125] [DMG] Command handler moving to [AwaitingDe]
[1673868801722] [20318:17564125] [EM] >>> [E:58594r M:4891375 (Ack:216976922)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868801722] [20318:17564125] [EM] Found matching exchange: 58594r, Delegate: 0x0
[1673868801722] [20318:17564125] [EM] Rxd Ack; Removing MessageCounter:216976922 from Retrans Table on exchange 58594r
[1673868801823] [20318:17564125] [EM] >>> [E:58595r M:4891376] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
[1673868801823] [20318:17564125] [EM] Handling via exchange: 58595r, Delegate: 0x1096afc00
[1673868801823] [20318:17564125] [DMG] TimedRequestMessage =
[1673868801823] [20318:17564125] [DMG] {
[1673868801823] [20318:17564125] [DMG]  TimeoutMs = 0x2710,
[1673868801823] [20318:17564125] [DMG]  InteractionModelRevision = 1
[1673868801823] [20318:17564125] [DMG] }
[1673868801823] [20318:17564125] [DMG] Got Timed Request with timeout 10000: handler 0x600002155180 exchange 58595r
[1673868801823] [20318:17564125] [EM] <<< [E:58595r M:216976923 (Ack:4891376)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
[1673868801823] [20318:17564125] [IN] (S) Sending msg 216976923 on secure session with LSID: 56125
[1673868801823] [20318:17564125] [DMG] Timed Request time limit 0x000000008661ECC8: handler 0x600002155180 exchange 58595r
[1673868801832] [20318:17564125] [EM] >>> [E:58595r M:4891377 (Ack:216976923)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1673868801832] [20318:17564125] [EM] Found matching exchange: 58595r, Delegate: 0x600002155180
[1673868801832] [20318:17564125] [EM] Rxd Ack; Removing MessageCounter:216976923 from Retrans Table on exchange 58595r
[1673868801832] [20318:17564125] [DMG] Timed following action arrived at 0x000000008661C5C0: handler 0x600002155180 exchange 58595r
[1673868801832] [20318:17564125] [DMG] Handing timed invoke to IM engine: handler 0x600002155180 exchange 58595r
[1673868801832] [20318:17564125] [DMG] InvokeRequestMessage =
[1673868801832] [20318:17564125] [DMG] {
[1673868801832] [20318:17564125] [DMG]  suppressResponse = false, 
[1673868801832] [20318:17564125] [DMG]  timedRequest = true, 
[1673868801832] [20318:17564125] [DMG]  InvokeRequests =
[1673868801832] [20318:17564125] [DMG]  [
[1673868801832] [20318:17564125] [DMG]      CommandDataIB =
[1673868801832] [20318:17564125] [DMG]      {
[1673868801832] [20318:17564125] [DMG]          CommandPathIB =
[1673868801832] [20318:17564125] [DMG]          {
[1673868801832] [20318:17564125] [DMG]              EndpointId = 0x0,
[1673868801832] [20318:17564125] [DMG]              ClusterId = 0x3e,
[1673868801832] [20318:17564125] [DMG]              CommandId = 0x4,
[1673868801832] [20318:17564125] [DMG]          },
[1673868801832] [20318:17564125] [DMG]          
[1673868801832] [20318:17564125] [DMG]          CommandFields = 
[1673868801832] [20318:17564125] [DMG]          {
[1673868801832] [20318:17564125] [DMG]              0x0 = [
[1673868801832] [20318:17564125] [DMG]                      0xa5, 0xf9, 0xce, 0xcf, 0xe1, 0xf5, 0x9e, 0x2c, 0xf4, 0x72, 0xe3, 0xc2, 0x41, 0xfd, 0x75, 0x74, 0xae, 0xee, 0xf5, 0x9f, 0xb5, 0x09, 0xe1, 0xc4, 0xaf, 0xbc, 0xcf, 0x5d, 0xa5, 0x87, 0x32, 0x4a, 
[1673868801832] [20318:17564125] [DMG]              ] (32 bytes)
[1673868801832] [20318:17564125] [DMG]          },
[1673868801832] [20318:17564125] [DMG]      },
[1673868801832] [20318:17564125] [DMG]      
[1673868801832] [20318:17564125] [DMG]  ],
[1673868801832] [20318:17564125] [DMG]  
[1673868801832] [20318:17564125] [DMG]  InteractionModelRevision = 1
[1673868801832] [20318:17564125] [DMG] },
[1673868801832] [20318:17564125] [DMG] AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_003E e=0 p=a
[1673868801832] [20318:17564125] [DMG] AccessControl: implicit admin (PASE)
[1673868801832] [20318:17564125] [DMG] Received command for Endpoint=0 Cluster=0x0000_003E Command=0x0000_0004
[1673868801832] [20318:17564125] [ZCL] OpCreds: Received a CSRRequest command
[1673868801832] [20318:17564125] [ZCL] OpCreds: Finding fabric with fabricIndex 0x0
[1673868801832] [20318:17564125] [EM] <<< [E:58595r M:216976924 (Ack:4891377)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868801832] [20318:17564125] [IN] (S) Sending msg 216976924 on secure session with LSID: 56125
[1673868801832] [20318:17564125] [EM] Flushed pending ack for MessageCounter:4891377 on exchange 58595r
[1673868801837] [20318:17564125] [ZCL] OpCreds: AllocatePendingOperationalKey succeeded
[1673868801838] [20318:17564125] [ZCL] OpCreds: CSRRequest successful.
[1673868801838] [20318:17564125] [DMG] Command handler moving to [ Preparing]
[1673868801838] [20318:17564125] [DMG] Command handler moving to [AddingComm]
[1673868801838] [20318:17564125] [DMG] Command handler moving to [AddedComma]
[1673868801838] [20318:17564125] [DMG] Decreasing reference count for CommandHandler, remaining 0
[1673868801838] [20318:17564125] [EM] <<< [E:58595r M:216976925 (Ack:4891377)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1673868801838] [20318:17564125] [IN] (S) Sending msg 216976925 on secure session with LSID: 56125
[1673868801838] [20318:17564125] [DMG] Command handler moving to [CommandSen]
[1673868801838] [20318:17564125] [DMG] Command handler moving to [AwaitingDe]
[1673868801869] [20318:17564125] [EM] >>> [E:58595r M:4891378 (Ack:216976925)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868801869] [20318:17564125] [EM] Found matching exchange: 58595r, Delegate: 0x0
[1673868801869] [20318:17564125] [EM] Rxd Ack; Removing MessageCounter:216976925 from Retrans Table on exchange 58595r
[1673868805495] [20318:17564386] [EM] >>> [E:58596r M:4891379] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
[1673868805495] [20318:17564386] [EM] Handling via exchange: 58596r, Delegate: 0x1096afc00
[1673868805495] [20318:17564386] [DMG] TimedRequestMessage =
[1673868805495] [20318:17564386] [DMG] {
[1673868805495] [20318:17564386] [DMG]  TimeoutMs = 0x2710,
[1673868805495] [20318:17564386] [DMG]  InteractionModelRevision = 1
[1673868805495] [20318:17564386] [DMG] }
[1673868805495] [20318:17564386] [DMG] Got Timed Request with timeout 10000: handler 0x6000021793e0 exchange 58596r
[1673868805495] [20318:17564386] [EM] <<< [E:58596r M:216976926 (Ack:4891379)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
[1673868805496] [20318:17564386] [IN] (S) Sending msg 216976926 on secure session with LSID: 56125
[1673868805496] [20318:17564386] [DMG] Timed Request time limit 0x000000008661FB20: handler 0x6000021793e0 exchange 58596r
[1673868805508] [20318:17564386] [EM] >>> [E:58596r M:4891380 (Ack:216976926)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1673868805508] [20318:17564386] [EM] Found matching exchange: 58596r, Delegate: 0x6000021793e0
[1673868805508] [20318:17564386] [EM] Rxd Ack; Removing MessageCounter:216976926 from Retrans Table on exchange 58596r
[1673868805508] [20318:17564386] [DMG] Timed following action arrived at 0x000000008661D41D: handler 0x6000021793e0 exchange 58596r
[1673868805508] [20318:17564386] [DMG] Handing timed invoke to IM engine: handler 0x6000021793e0 exchange 58596r
[1673868805508] [20318:17564386] [DMG] InvokeRequestMessage =
[1673868805508] [20318:17564386] [DMG] {
[1673868805508] [20318:17564386] [DMG]  suppressResponse = false, 
[1673868805508] [20318:17564386] [DMG]  timedRequest = true, 
[1673868805508] [20318:17564386] [DMG]  InvokeRequests =
[1673868805508] [20318:17564386] [DMG]  [
[1673868805508] [20318:17564386] [DMG]      CommandDataIB =
[1673868805508] [20318:17564386] [DMG]      {
[1673868805508] [20318:17564386] [DMG]          CommandPathIB =
[1673868805508] [20318:17564386] [DMG]          {
[1673868805508] [20318:17564386] [DMG]              EndpointId = 0x0,
[1673868805508] [20318:17564386] [DMG]              ClusterId = 0x3e,
[1673868805508] [20318:17564386] [DMG]              CommandId = 0xb,
[1673868805508] [20318:17564386] [DMG]          },
[1673868805508] [20318:17564386] [DMG]          
[1673868805509] [20318:17564386] [DMG]          CommandFields = 
[1673868805509] [20318:17564386] [DMG]          {
[1673868805509] [20318:17564386] [DMG]              0x0 = [
[1673868805509] [20318:17564386] [DMG]                      0x15, 0x30, 0x01, 0x11, 0x00, 0x8f, 0x7e, 0x89, 0xd8, 0xd6, 0x7b, 0x0a, 0xec, 0xde, 0xae, 0x6d, 0x21, 0x2d, 0xea, 0xa3, 0xb7, 0x24, 0x02, 0x01, 0x37, 0x03, 0x27, 0x14, 0xd8, 0x94, 0x47, 0x7f, 0xd1, 0x55, 0x36, 0x01, 0x18, 0x26, 0x04, 0x53, 0x7a, 0xc7, 0x2a, 0x26, 0x05, 0xe3, 0x78, 0xcd, 0x59, 0x37, 0x06, 0x27, 0x14, 0xd8, 0x94, 0x47, 0x7f, 0xd1, 0x55, 0x36, 0x01, 0x18, 0x24, 0x07, 0x01, 0x24, 0x08, 0x01, 0x30, 0x09, 0x41, 0x04, 0x04, 0x73, 0x02, 0xd8, 0xc1, 0xc4, 0x29, 0x04, 0x90, 0x55, 0x34, 0x6a, 0x31, 0xcf, 0x2c, 0x7e, 0x62, 0xd7, 0x26, 0x6a, 0x3d, 0xde, 0xb6, 0x0a, 0x85, 0x48, 0x10, 0xd9, 0xa8, 0xd3, 0xed, 0x50, 0xa2, 0xe9, 0x0b, 0xb5, 0xf1, 0xfa, 0xd5, 0x1b, 0x29, 0xb7, 0x27, 0xc1, 0x53, 0x94, 0x6b, 0x64, 0x71, 0x8a, 0xe2, 0x42, 0x2e, 0xa1, 0x0d, 0xfc, 0x9b, 0x7d, 0xb0, 0xcb, 0xc4, 0x81, 0x64, 0xd4, 0x37, 0x0a, 0x35, 0x01, 0x29, 0x01, 0x18, 0x30, 0x04, 0x14, 0xc6, 0xe6, 0x75, 0x21, 0x9d, 0x6a, 0x1e, 0xbb, 0x8e, 0x66, 0x4f, 0x86, 0xd8, 0x0f, 0xe1, 0x1c, 0x37, 0x58, 0xb8, 0x59, 0x24, 0x02, 0x61, 0x30, 0x05, 0x14, 0xc6, 0xe6, 0x75, 0x21, 0x9d, 0x6a, 0x1e, 0xbb, 0x8e, 0x66, 0x4f, 0x86, 0xd8, 0x0f, 0xe1, 0x1c, 0x37, 0x58, 0xb8, 0x59, 0x18, 0x30, 0x0b, 0x40, 0x09, 0x2a, 0x58, 0x6a, 0xce, 0x30, 0x01, 0x8a, 0x5f, 0xa6, 0x14, 0xcc, 0xa2, 0xc2, 0xb2, 0x3c, 0x58, 0xab, 0x6c, 0x75, 0xdc, 0x8e, 0x75, 0x9f, 0x95, 0xa7, 0xba, 0x13, 0xdb, 0x97, 0xd8, 0x40, 0x43, 0xb5, 0x32, 0x50, 0x5e, 0x0c, 0xf6, 0x1c, 0x18, 0x7d, 0x29, 0xc0, 0x0f, 0x56, 0xf9, 0x0a, 0x49, 0x52, 0xdf, 0xb1, 0x95, 0x16, 0x3d, 0x49, 0xbb, 0xb1, 0xf5, 0x40, 0x2e, 0x52, 0xad, 0x98, 0x18, 
[1673868805509] [20318:17564386] [DMG]              ] (261 bytes)
[1673868805509] [20318:17564386] [DMG]          },
[1673868805509] [20318:17564386] [DMG]      },
[1673868805509] [20318:17564386] [DMG]      
[1673868805509] [20318:17564386] [DMG]  ],
[1673868805509] [20318:17564386] [DMG]  
[1673868805509] [20318:17564386] [DMG]  InteractionModelRevision = 1
[1673868805509] [20318:17564386] [DMG] },
[1673868805509] [20318:17564386] [DMG] AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_003E e=0 p=a
[1673868805509] [20318:17564386] [DMG] AccessControl: implicit admin (PASE)
[1673868805509] [20318:17564386] [DMG] Received command for Endpoint=0 Cluster=0x0000_003E Command=0x0000_000B
[1673868805509] [20318:17564386] [ZCL] OpCreds: Received an AddTrustedRootCertificate command
[1673868805509] [20318:17564386] [EM] <<< [E:58596r M:216976927 (Ack:4891380)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868805509] [20318:17564386] [IN] (S) Sending msg 216976927 on secure session with LSID: 56125
[1673868805509] [20318:17564386] [EM] Flushed pending ack for MessageCounter:4891380 on exchange 58596r
[1673868805510] [20318:17564386] [ZCL] OpCreds: AddTrustedRootCertificate successful.
[1673868805510] [20318:17564386] [DMG] Command handler moving to [ Preparing]
[1673868805510] [20318:17564386] [DMG] Command handler moving to [AddingComm]
[1673868805510] [20318:17564386] [DMG] Command handler moving to [AddedComma]
[1673868805510] [20318:17564386] [DMG] Decreasing reference count for CommandHandler, remaining 0
[1673868805510] [20318:17564386] [EM] <<< [E:58596r M:216976928 (Ack:4891380)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1673868805510] [20318:17564386] [IN] (S) Sending msg 216976928 on secure session with LSID: 56125
[1673868805510] [20318:17564386] [DMG] Command handler moving to [CommandSen]
[1673868805510] [20318:17564386] [DMG] Command handler moving to [AwaitingDe]
[1673868805521] [20318:17564386] [EM] >>> [E:58596r M:4891381 (Ack:216976928)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868805521] [20318:17564386] [EM] Found matching exchange: 58596r, Delegate: 0x0
[1673868805521] [20318:17564386] [EM] Rxd Ack; Removing MessageCounter:216976928 from Retrans Table on exchange 58596r
[1673868805622] [20318:17564125] [EM] >>> [E:58597r M:4891382] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
[1673868805622] [20318:17564125] [EM] Handling via exchange: 58597r, Delegate: 0x1096afc00
[1673868805623] [20318:17564125] [DMG] TimedRequestMessage =
[1673868805623] [20318:17564125] [DMG] {
[1673868805623] [20318:17564125] [DMG]  TimeoutMs = 0x2710,
[1673868805623] [20318:17564125] [DMG]  InteractionModelRevision = 1
[1673868805623] [20318:17564125] [DMG] }
[1673868805623] [20318:17564125] [DMG] Got Timed Request with timeout 10000: handler 0x600002155260 exchange 58597r
[1673868805623] [20318:17564125] [EM] <<< [E:58597r M:216976929 (Ack:4891382)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
[1673868805623] [20318:17564125] [IN] (S) Sending msg 216976929 on secure session with LSID: 56125
[1673868805623] [20318:17564125] [DMG] Timed Request time limit 0x000000008661FBA0: handler 0x600002155260 exchange 58597r
[1673868805630] [20318:17564386] [EM] >>> [E:58597r M:4891383 (Ack:216976929)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1673868805630] [20318:17564386] [EM] Found matching exchange: 58597r, Delegate: 0x600002155260
[1673868805631] [20318:17564386] [EM] Rxd Ack; Removing MessageCounter:216976929 from Retrans Table on exchange 58597r
[1673868805631] [20318:17564386] [DMG] Timed following action arrived at 0x000000008661D497: handler 0x600002155260 exchange 58597r
[1673868805631] [20318:17564386] [DMG] Handing timed invoke to IM engine: handler 0x600002155260 exchange 58597r
[1673868805631] [20318:17564386] [DMG] InvokeRequestMessage =
[1673868805631] [20318:17564386] [DMG] {
[1673868805631] [20318:17564386] [DMG]  suppressResponse = false, 
[1673868805631] [20318:17564386] [DMG]  timedRequest = true, 
[1673868805631] [20318:17564386] [DMG]  InvokeRequests =
[1673868805631] [20318:17564386] [DMG]  [
[1673868805631] [20318:17564386] [DMG]      CommandDataIB =
[1673868805631] [20318:17564386] [DMG]      {
[1673868805631] [20318:17564386] [DMG]          CommandPathIB =
[1673868805631] [20318:17564386] [DMG]          {
[1673868805631] [20318:17564386] [DMG]              EndpointId = 0x0,
[1673868805631] [20318:17564386] [DMG]              ClusterId = 0x3e,
[1673868805631] [20318:17564386] [DMG]              CommandId = 0x6,
[1673868805631] [20318:17564386] [DMG]          },
[1673868805631] [20318:17564386] [DMG]          
[1673868805631] [20318:17564386] [DMG]          CommandFields = 
[1673868805631] [20318:17564386] [DMG]          {
[1673868805631] [20318:17564386] [DMG]              0x0 = [
[1673868805631] [20318:17564386] [DMG]                      0x15, 0x30, 0x01, 0x11, 0x00, 0xb5, 0x24, 0xd3, 0x73, 0x0f, 0x6d, 0x7e, 0x25, 0xa1, 0x73, 0xaf, 0x63, 0x90, 0x4d, 0x59, 0x9a, 0x24, 0x02, 0x01, 0x37, 0x03, 0x27, 0x13, 0xd8, 0x94, 0x47, 0x7f, 0xd1, 0x55, 0x36, 0x11, 0x18, 0x26, 0x04, 0x72, 0xe4, 0x57, 0x2b, 0x26, 0x05, 0x82, 0xf5, 0x23, 0x3e, 0x37, 0x06, 0x27, 0x15, 0x22, 0xc1, 0x19, 0xb0, 0x29, 0x19, 0xa7, 0x00, 0x27, 0x11, 0xa0, 0x11, 0x96, 0x69, 0x7d, 0x00, 0xb1, 0x00, 0x18, 0x24, 0x07, 0x01, 0x24, 0x08, 0x01, 0x30, 0x09, 0x41, 0x04, 0xbb, 0x25, 0xc2, 0xa3, 0x20, 0x32, 0x39, 0xe8, 0xf9, 0x14, 0xc9, 0x47, 0x54, 0x79, 0xd5, 0x22, 0x90, 0x66, 0x89, 0xd3, 0xcf, 0x7d, 0x4b, 0xd9, 0x2b, 0xee, 0x41, 0x23, 0x99, 0xa4, 0x8a, 0xf3, 0xff, 0x5b, 0xfa, 0x48, 0x93, 0x79, 0x11, 0x32, 0xfd, 0x4f, 0x66, 0x77, 0xb9, 0x9f, 0x9f, 0x8a, 0xd0, 0x18, 0x7b, 0x17, 0xa1, 0x41, 0x6d, 0x41, 0xb0, 0x60, 0x20, 0x21, 0x66, 0xc8, 0x39, 0x7e, 0x37, 0x0a, 0x35, 0x01, 0x28, 0x01, 0x18, 0x30, 0x05, 0x14, 0xa6, 0x69, 0x0b, 0xe0, 0xfa, 0x8d, 0x52, 0x85, 0x99, 0x94, 0xf2, 0x0d, 0xab, 0x94, 0x6c, 0xa4, 0xa7, 0x41, 0xa5, 0xbe, 0x30, 0x04, 0x14, 0x43, 0x05, 0x07, 0x0d, 0xd3, 0xf2, 0xc9, 0x02, 0xab, 0xff, 0x18, 0xc1, 0xfe, 0xdf, 0x52, 0x3d, 0xbf, 0x67, 0x96, 0x5c, 0x24, 0x02, 0x01, 0x36, 0x03, 0x04, 0x02, 0x04, 0x01, 0x18, 0x18, 0x30, 0x0b, 0x40, 0x7a, 0x80, 0x77, 0x78, 0x12, 0xa3, 0x24, 0xdf, 0x74, 0x85, 0x7c, 0x7b, 0xb0, 0xed, 0x45, 0xa1, 0x18, 0x82, 0x32, 0x5c, 0x75, 0x27, 0x52, 0x48, 0x03, 0xfa, 0xe0, 0xeb, 0xa5, 0xb7, 0xc6, 0x74, 0x1b, 0xce, 0xef, 0x98, 0x66, 0x44, 0xf6, 0x88, 0x28, 0xd3, 0x7d, 0xc8, 0xca, 0x73, 0x7c, 0x79, 0x0b, 0x12, 0x2d, 0xa3, 0x08, 0x24, 0x36, 0xd6, 0x19, 0x42, 0x2d, 0x8b, 0x98, 0x1a, 0x99, 0x9e, 
[1673868805631] [20318:17564386] [DMG]              ] (278 bytes)
[1673868805631] [20318:17564386] [DMG]              0x1 = [
[1673868805631] [20318:17564386] [DMG]                      0x15, 0x30, 0x01, 0x10, 0x5a, 0xaa, 0x32, 0xf3, 0x7f, 0x64, 0x3e, 0x62, 0x7c, 0xaf, 0x3d, 0x9e, 0x8d, 0x95, 0x9f, 0x62, 0x24, 0x02, 0x01, 0x37, 0x03, 0x27, 0x14, 0xd8, 0x94, 0x47, 0x7f, 0xd1, 0x55, 0x36, 0x01, 0x18, 0x26, 0x04, 0x5f, 0x7a, 0xc7, 0x2a, 0x26, 0x05, 0xef, 0xd2, 0xfe, 0x46, 0x37, 0x06, 0x27, 0x13, 0xd8, 0x94, 0x47, 0x7f, 0xd1, 0x55, 0x36, 0x11, 0x18, 0x24, 0x07, 0x01, 0x24, 0x08, 0x01, 0x30, 0x09, 0x41, 0x04, 0x48, 0x30, 0x77, 0x9f, 0x86, 0x88, 0x2d, 0x88, 0xc2, 0xaf, 0xc4, 0xe3, 0x66, 0x56, 0xc4, 0x70, 0xc2, 0xc1, 0x65, 0xe9, 0xb0, 0x58, 0x08, 0x87, 0xa9, 0x91, 0x8a, 0x24, 0x42, 0x79, 0xa3, 0x17, 0xc1, 0x33, 0x1a, 0xde, 0x28, 0xcf, 0xa6, 0x64, 0x6e, 0xa0, 0x65, 0x68, 0x0a, 0x90, 0x78, 0xf3, 0x19, 0x4b, 0xde, 0xb4, 0xc2, 0xd0, 0x46, 0x78, 0xdb, 0xe8, 0x3c, 0x82, 0x26, 0xf3, 0xb9, 0x78, 0x37, 0x0a, 0x35, 0x01, 0x29, 0x01, 0x24, 0x02, 0x00, 0x18, 0x30, 0x05, 0x14, 0xc6, 0xe6, 0x75, 0x21, 0x9d, 0x6a, 0x1e, 0xbb, 0x8e, 0x66, 0x4f, 0x86, 0xd8, 0x0f, 0xe1, 0x1c, 0x37, 0x58, 0xb8, 0x59, 0x30, 0x04, 0x14, 0xa6, 0x69, 0x0b, 0xe0, 0xfa, 0x8d, 0x52, 0x85, 0x99, 0x94, 0xf2, 0x0d, 0xab, 0x94, 0x6c, 0xa4, 0xa7, 0x41, 0xa5, 0xbe, 0x24, 0x02, 0x61, 0x18, 0x30, 0x0b, 0x40, 0x81, 0x00, 0x55, 0x51, 0xc1, 0x11, 0x10, 0x25, 0x81, 0xb9, 0x7f, 0xca, 0x5a, 0xc6, 0x39, 0xde, 0xf2, 0x99, 0x0e, 0x90, 0x6d, 0xf3, 0x19, 0x5e, 0xdb, 0xb3, 0x82, 0x3a, 0xaf, 0xc7, 0x57, 0xed, 0x80, 0xd9, 0xbf, 0xdd, 0x3a, 0x2d, 0x7f, 0xc6, 0x83, 0x68, 0xe8, 0x19, 0xc7, 0xd4, 0xd0, 0xbd, 0x39, 0xc6, 0x8b, 0x52, 0xa7, 0x5c, 0x0c, 0x04, 0x17, 0x31, 0x69, 0xea, 0x28, 0x0b, 0x37, 0xed, 0x18, 
[1673868805631] [20318:17564386] [DMG]              ] (263 bytes)
[1673868805631] [20318:17564386] [DMG]              0x2 = [
[1673868805631] [20318:17564386] [DMG]                      0xc7, 0x9f, 0xf1, 0x66, 0xbc, 0x4f, 0x65, 0x91, 0x7b, 0xa3, 0x67, 0xea, 0xf4, 0x04, 0xfe, 0x1c, 
[1673868805632] [20318:17564386] [DMG]              ] (16 bytes)
[1673868805632] [20318:17564386] [DMG]              0x3 = 18446744060825763882, 
[1673868805632] [20318:17564386] [DMG]              0x4 = 65521, 
[1673868805632] [20318:17564386] [DMG]          },
[1673868805632] [20318:17564386] [DMG]      },
[1673868805632] [20318:17564386] [DMG]      
[1673868805632] [20318:17564386] [DMG]  ],
[1673868805632] [20318:17564386] [DMG]  
[1673868805632] [20318:17564386] [DMG]  InteractionModelRevision = 1
[1673868805632] [20318:17564386] [DMG] },
[1673868805632] [20318:17564386] [DMG] AccessControl: checking f=0 a=p s=0xFFFFFFFB00000000 t= c=0x0000_003E e=0 p=a
[1673868805632] [20318:17564386] [DMG] AccessControl: implicit admin (PASE)
[1673868805632] [20318:17564386] [DMG] Received command for Endpoint=0 Cluster=0x0000_003E Command=0x0000_0006
[1673868805632] [20318:17564386] [ZCL] OpCreds: Received an AddNOC command
[1673868805632] [20318:17564386] [EM] <<< [E:58597r M:216976930 (Ack:4891383)] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868805632] [20318:17564386] [IN] (S) Sending msg 216976930 on secure session with LSID: 56125
[1673868805632] [20318:17564386] [EM] Flushed pending ack for MessageCounter:4891383 on exchange 58597r
[1673868805633] [20318:17564386] [FP] Validating NOC chain
[1673868805634] [20318:17564386] [FP] NOC chain validation successful
[1673868805634] [20318:17564386] [FP] Added new fabric at index: 0x1
[1673868805634] [20318:17564386] [FP] Assigned compressed fabric ID: 0xE6748F7D9734AC86, node ID: 0x00B1007D699611A0
[1673868805634] [20318:17564386] [TS] Last Known Good Time: 2023-01-16T12:17:49
[1673868805634] [20318:17564386] [TS] New proposed Last Known Good Time: 2023-01-16T10:33:22
[1673868805634] [20318:17564386] [TS] Retaining current Last Known Good Time
[1673868805634] [20318:17564386] [DMG] Endpoint 0, Cluster 0x0000_003E update version to df7511b9
[1673868805634] [20318:17564386] [DMG] Endpoint 0, Cluster 0x0000_003E update version to df7511ba
[1673868805636] [20318:17564386] [DMG] AccessControl: validating f=1 p=a a=c s=1 t=0
[1673868805636] [20318:17564386] [DMG]   validating subject 0xFFFFFFFD0011002A
[1673868805637] [20318:17564386] [EVL] LogEvent event number: 0x0000000000020002 priority: 1, endpoint id:  0x0 cluster id: 0x0000_001F event id: 0x0 Sys timestamp: 0x000000008661D49E
[1673868805637] [20318:17564386] [ZCL] OpCreds: ACL entry created for Fabric index 0x1 CASE Admin Subject 0xFFFFFFFD0011002A
[1673868805637] [20318:17564386] [DL] Using wifi MAC for hostname
[1673868805637] [20318:17564386] [DIS] Advertise operational node E6748F7D9734AC86-00B1007D699611A0
[1673868805637] [20318:17564386] [DIS] Registering service E6748F7D9734AC86-00B1007D699611A0 on host 000000000000.local. with port 5540 and type: _matter._tcp,_IE6748F7D9734AC86 on interface id: 0
[1673868805637] [20318:17564386] [DMG] Endpoint 0, Cluster 0x0000_003E update version to df7511bb
[1673868805637] [20318:17564386] [DMG] Endpoint 0, Cluster 0x0000_003E update version to df7511bc
[1673868805637] [20318:17564386] [DMG] Command handler moving to [ Preparing]
[1673868805637] [20318:17564386] [DMG] Command handler moving to [AddingComm]
[1673868805637] [20318:17564386] [DMG] Command handler moving to [AddedComma]
[1673868805637] [20318:17564386] [ZCL] OpCreds: successfully created fabric index 0x1 via AddNOC
[1673868805638] [20318:17564386] [DMG] Decreasing reference count for CommandHandler, remaining 0
[1673868805638] [20318:17564386] [EM] <<< [E:58597r M:216976931 (Ack:4891383)] (S) Msg TX to 1:FFFFFFFB00000000 [AC86] --- Type 0001:09 (IM:InvokeCommandResponse)
[1673868805638] [20318:17564386] [IN] (S) Sending msg 216976931 on secure session with LSID: 56125
[1673868805638] [20318:17564386] [DMG] Command handler moving to [CommandSen]
[1673868805638] [20318:17564386] [DMG] Command handler moving to [AwaitingDe]
[1673868805649] [20318:17564386] [EM] >>> [E:58597r M:4891384 (Ack:216976931)] (S) Msg RX from 1:FFFFFFFB00000000 [AC86] --- Type 0000:10 (SecureChannel:StandaloneAck)
[1673868805649] [20318:17564386] [EM] Found matching exchange: 58597r, Delegate: 0x0
[1673868805649] [20318:17564386] [EM] Rxd Ack; Removing MessageCounter:216976931 from Retrans Table on exchange 58597r
[1673868806384] [20318:17564444] [DIS] Mdns: OnRegister name: E6748F7D9734AC86-00B1007D699611A0, type: _matter._tcp., domain: local., flags: 2
[1673868806384] [20318:17564444] [DIS] mDNS service published: _matter._tcp; instance name: E6748F7D9734AC86-00B1007D699611A0
[1673868806384] [20318:17564444] [DIS] Status: Satisfied
[1673868806384] [20318:17564444] [DIS]  lo0 (1)
[1673868806385] [20318:17564444] [DIS]      * ipv4: 127.0.0.1
[1673868806385] [20318:17564444] [DIS]      * ipv6: ::1
[1673868806385] [20318:17564444] [DIS]      * ipv6: fe80::1
[1673868806388] [20318:17564444] [DIS]  bridge0 (8 / Wired)
[1673868806388] [20318:17564444] [DIS]      * ipv4: 192.168.178.57
[1673868806388] [20318:17564444] [DIS]      * ipv6: fe80::468:655b:d4ce:4e4f
[1673868806388] [20318:17564444] [DIS]      * ipv6: 2a02:8071:2c87:399c:1cc5:8756:a18d:3ecf
[1673868806388] [20318:17564444] [DIS]      * ipv6: 2a02:8071:2c87:399c:d43c:53c3:29ae:173a
[1673868806392] [20318:17564444] [DIS]  en0 (6 / WiFi)
[1673868806392] [20318:17564444] [DIS]      * ipv4: 192.168.178.159
[1673868806392] [20318:17564444] [DIS]      * ipv6: fe80::1c30:855c:9d80:6e0c
[1673868806392] [20318:17564444] [DIS]      * ipv6: 2a02:8071:2c87:399c:8a0:8914:4763:faad
[1673868806392] [20318:17564444] [DIS]      * ipv6: 2a02:8071:2c87:399c:c143:989e:db30:1e64
[1673868806392] [20318:17564444] [DIS]      * ipv6: 2a02:8071:2c87:399c:8125:a0d:bc81:fe9
[1673868806393] [20318:17564444] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868806393] [20318:17564444] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868806393] [20318:17564444] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868806393] [20318:17564444] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868806393] [20318:17564444] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868806393] [20318:17564444] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868806393] [20318:17564444] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868806393] [20318:17564444] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868806393] [20318:17564444] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868806393] [20318:17564444] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868806393] [20318:17564444] [DIS] Mdns: OnRegisterRecord flags: 1
[1673868806394] [20318:17564444] [DIS] Mdns: OnRegisterRecord flags: 0

Bug prevalence

Bridged Devices / Amazon Alexa

GitHub hash of the SDK that was being used

b4c2827

Platform

other

Platform Version(s)

No response

Anything else?

No response

raven-worx commented 1 year ago

AFAIK Amazon Alexa only supports lights and outlets with Matter so far. Support for more device types will follow with updates.

Apollon77 commented 1 year ago

I assumed that ... I think it would make a huge sense to have a public" overveiw on what exactly is supported by "the big ones"? :-(