• State Verified Answer
  • Replies 15 replies
  • Subscribers 86 subscribers
  • Views 1003 views
  • Users 0 members are here
Attachments (2) Download All
Nordic Case Info
  • Case ID: 350707
Options

Matter Door Lock sample fails after changing PRODUCT_ID to 0x8007 (NCS 3.0.2)

LukaWer

Hi,

I’m working with the Matter Door Lock sample in NCS 3.0.2. With the default PRODUCT_ID = 0x8006, everything works as expected: commissioning to Apple Home and Google Home succeeds, and chip-tool operates without issues. However, when I change the PRODUCT_ID to 0x8007, it stops working.

I also tested with a custom DAC (PID 0x8006) generated via the PKI provider. The DAC, private key, and related artifacts appear to be correctly linked by the Matter build scripts.

What could be causing this behavior? Below are chip-tool logs from a build configured with PID 0x8007.

Thanks,
Lukasz

Fullscreen chip-tool_logs.txt Download 
[1756729182.855] [4637:4665] [DL] ConnectDevice retry: 1 out of 4
[1756729183.135] [4637:4665] [DL] ConnectDevice complete
[1756729183.135] [4637:4665] [BLE] New device connected: F8:11:F3:72:95:B3
[1756729184.193] [4637:4665] [DL] CHIP service found
[1756729184.193] [4637:4665] [DL] Valid C2 characteristic found
[1756729184.193] [4637:4665] [DL] Valid C1 characteristic found
[1756729184.193] [4637:4665] [DL] New BLE connection: conn=0x559d170f30 device=F8:11:F3:72:95:B3 path=/org/bluez/hci0/dev_F8_11_F3_72_95_B3
[1756729184.193] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16387
[1756729184.193] [4637:4666] [DIS] Closing all BLE connections
[1756729184.194] [4637:4666] [IN] BleConnectionComplete: endPoint 0x5586c61980
[1756729184.194] [4637:4666] [IN] SecureSession[0x7f8c013400]: Allocated Type:1 LSID:55443
[1756729184.195] [4637:4666] [SC] Assigned local session key ID 55443
[1756729184.195] [4637:4666] [EM] <<< [E:62475i S:0 M:104807131] (U) Msg TX from 7BAB2C28A239BDC5 to 0:0000000000000000 [0000] [BLE] --- Type 0000:20 (SecureChannel:PBKDFParamRequest) (B:98)
[1756729184.196] [4637:4666] [IN] Message appended to BLE send queue
[1756729184.196] [4637:4666] [SC] Sent PBKDF param request [II:500ms AI:300ms AT:4000ms)
[1756729184.572] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16389
[1756729184.663] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16390
[1756729184.663] [4637:4666] [BLE] subscribe complete, ep = 0x5586c61980
[1756729184.665] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729184.665] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729184.665] [4637:4666] [BLE] peripheral chose BTP version 4; central expected between 4 and 4
[1756729184.665] [4637:4666] [BLE] using BTP fragment sizes rx 244 / tx 244.
[1756729184.665] [4637:4666] [BLE] local and remote recv window size = 5
[1756729184.666] [4637:4666] [IN] BLE EndPoint 0x5586c61980 Connection Complete
[1756729184.797] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16389
[1756729184.846] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729184.846] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729184.846] [4637:4666] [EM] >>> [E:62475i S:0 M:83346254] (U) Msg RX from 0:0000000000000000 [0000] to 7BAB2C28A239BDC5 --- Type 0000:21 (SecureChannel:PBKDFParamResponse) (B:154)
[1756729184.846] [4637:4666] [EM] Found matching exchange: 62475i, Delegate: 0x7f8c041d08
[1756729184.847] [4637:4666] [SC] Received PBKDF param response
[1756729184.847] [4637:4666] [SC] Peer assigned session ID 31551
[1756729184.847] [4637:4666] [SC] Found MRP parameters in the message
[1756729184.862] [4637:4666] [EM] <<< [E:62475i S:0 M:104807132] (U) Msg TX from 7BAB2C28A239BDC5 to 0:0000000000000000 [0000] [BLE] --- Type 0000:22 (SecureChannel:PASE_Pake1) (B:92)
[1756729184.863] [4637:4666] [SC] Sent spake2p msg1
[1756729184.977] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16389
[1756729185.158] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729185.158] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729185.158] [4637:4666] [EM] >>> [E:62475i S:0 M:83346255] (U) Msg RX from 0:0000000000000000 [0000] to 7BAB2C28A239BDC5 --- Type 0000:23 (SecureChannel:PASE_Pake2) (B:127)
[1756729185.158] [4637:4666] [EM] Found matching exchange: 62475i, Delegate: 0x7f8c041d08
[1756729185.158] [4637:4666] [SC] Received spake2p msg2
[1756729185.161] [4637:4666] [EM] <<< [E:62475i S:0 M:104807133] (U) Msg TX from 7BAB2C28A239BDC5 to 0:0000000000000000 [0000] [BLE] --- Type 0000:24 (SecureChannel:PASE_Pake3) (B:59)
[1756729185.162] [4637:4666] [SC] Sent spake2p msg3
[1756729185.247] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16389
[1756729185.249] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729185.250] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729185.250] [4637:4666] [EM] >>> [E:62475i S:0 M:83346256] (U) Msg RX from 0:0000000000000000 [0000] to 7BAB2C28A239BDC5 --- Type 0000:40 (SecureChannel:StatusReport) (B:30)
[1756729185.250] [4637:4666] [EM] Found matching exchange: 62475i, Delegate: 0x7f8c041d08
[1756729185.250] [4637:4666] [SC] SecureSession[0x7f8c013400, LSID:55443]: State change 'kEstablishing' --> 'kActive'
[1756729185.250] [4637:4666] [IN] SecureSession[0x7f8c013400]: Activated - Type:1 LSID:55443
[1756729185.250] [4637:4666] [IN] New secure session activated for device <FFFFFFFB00000000, 0>, LSID:55443 PSID:31551!
[1756729185.250] [4637:4666] [CTL] Remote device completed SPAKE2+ handshake
[1756729185.250] [4637:4666] [TOO] Pairing Success
[1756729185.250] [4637:4666] [TOO] PASE establishment successful
[1756729185.250] [4637:4666] [CTL] Commissioning stage next step: 'SecurePairing' -> 'ReadCommissioningInfo'
[1756729185.250] [4637:4666] [CTL] Performing next commissioning step 'ReadCommissioningInfo'
[1756729185.250] [4637:4666] [CTL] Sending read requests for commissioning information
[1756729185.251] [4637:4666] [DMG] SendReadRequest ReadClient[0x7f8c017800]: Sending Read Request
[1756729185.251] [4637:4666] [DMG] 0 data version filters provided, 0 not relevant, 0 encoded, 0 skipped due to lack of space
[1756729185.251] [4637:4666] [EM] <<< [E:62476i S:55443 M:88078146] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:02 (IM:ReadRequest) (B:134)
[1756729185.252] [4637:4666] [DMG] MoveToState ReadClient[0x7f8c017800]: Moving to [AwaitingIn]
[1756729185.252] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 32792
[1756729185.382] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16389
[1756729185.473] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729185.473] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729185.564] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729185.564] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729185.564] [4637:4666] [EM] >>> [E:62476i S:55443 M:189832959] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:05 (IM:ReportData) (B:257)
[1756729185.564] [4637:4666] [EM] Found matching exchange: 62476i, Delegate: 0x7f8c017810
[1756729185.565] [4637:4666] [DMG] ReportDataMessage =
[1756729185.565] [4637:4666] [DMG] {
[1756729185.565] [4637:4666] [DMG]      AttributeReportIBs =
[1756729185.565] [4637:4666] [DMG]      [
[1756729185.565] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.565] [4637:4666] [DMG]              {
[1756729185.565] [4637:4666] [DMG]                      AttributeDataIB =
[1756729185.565] [4637:4666] [DMG]                      {
[1756729185.565] [4637:4666] [DMG]                              DataVersion = 0x96cc64bf,
[1756729185.565] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.565] [4637:4666] [DMG]                              {
[1756729185.565] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.565] [4637:4666] [DMG]                                      Cluster = 0x31,
[1756729185.565] [4637:4666] [DMG]                                      Attribute = 0x0000_FFFC,
[1756729185.565] [4637:4666] [DMG]                              }
[1756729185.565] [4637:4666] [DMG]
[1756729185.565] [4637:4666] [DMG]                              Data = 2 (unsigned),
[1756729185.565] [4637:4666] [DMG]                      },
[1756729185.565] [4637:4666] [DMG]
[1756729185.565] [4637:4666] [DMG]              },
[1756729185.565] [4637:4666] [DMG]
[1756729185.565] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.565] [4637:4666] [DMG]              {
[1756729185.565] [4637:4666] [DMG]                      AttributeDataIB =
[1756729185.565] [4637:4666] [DMG]                      {
[1756729185.566] [4637:4666] [DMG]                              DataVersion = 0xb0fb55ae,
[1756729185.566] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.566] [4637:4666] [DMG]                              {
[1756729185.566] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.566] [4637:4666] [DMG]                                      Cluster = 0x28,
[1756729185.566] [4637:4666] [DMG]                                      Attribute = 0x0000_0004,
[1756729185.566] [4637:4666] [DMG]                              }
[1756729185.566] [4637:4666] [DMG]
[1756729185.566] [4637:4666] [DMG]                              Data = 32775 (unsigned),
[1756729185.566] [4637:4666] [DMG]                      },
[1756729185.566] [4637:4666] [DMG]
[1756729185.566] [4637:4666] [DMG]              },
[1756729185.566] [4637:4666] [DMG]
[1756729185.566] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.566] [4637:4666] [DMG]              {
[1756729185.566] [4637:4666] [DMG]                      AttributeDataIB =
[1756729185.566] [4637:4666] [DMG]                      {
[1756729185.566] [4637:4666] [DMG]                              DataVersion = 0xb0fb55ae,
[1756729185.566] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.566] [4637:4666] [DMG]                              {
[1756729185.566] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.566] [4637:4666] [DMG]                                      Cluster = 0x28,
[1756729185.566] [4637:4666] [DMG]                                      Attribute = 0x0000_0002,
[1756729185.566] [4637:4666] [DMG]                              }
[1756729185.566] [4637:4666] [DMG]
[1756729185.566] [4637:4666] [DMG]                              Data = 65521 (unsigned),
[1756729185.566] [4637:4666] [DMG]                      },
[1756729185.566] [4637:4666] [DMG]
[1756729185.566] [4637:4666] [DMG]              },
[1756729185.566] [4637:4666] [DMG]
[1756729185.566] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.566] [4637:4666] [DMG]              {
[1756729185.566] [4637:4666] [DMG]                      AttributeDataIB =
[1756729185.566] [4637:4666] [DMG]                      {
[1756729185.566] [4637:4666] [DMG]                              DataVersion = 0x8c803ba9,
[1756729185.566] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.566] [4637:4666] [DMG]                              {
[1756729185.566] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.566] [4637:4666] [DMG]                                      Cluster = 0x30,
[1756729185.566] [4637:4666] [DMG]                                      Attribute = 0x0000_0003,
[1756729185.566] [4637:4666] [DMG]                              }
[1756729185.566] [4637:4666] [DMG]
[1756729185.566] [4637:4666] [DMG]                              Data = 0 (unsigned),
[1756729185.566] [4637:4666] [DMG]                      },
[1756729185.566] [4637:4666] [DMG]
[1756729185.566] [4637:4666] [DMG]              },
[1756729185.566] [4637:4666] [DMG]
[1756729185.566] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.566] [4637:4666] [DMG]              {
[1756729185.566] [4637:4666] [DMG]                      AttributeDataIB =
[1756729185.567] [4637:4666] [DMG]                      {
[1756729185.567] [4637:4666] [DMG]                              DataVersion = 0x8c803ba9,
[1756729185.567] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.567] [4637:4666] [DMG]                              {
[1756729185.567] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.567] [4637:4666] [DMG]                                      Cluster = 0x30,
[1756729185.567] [4637:4666] [DMG]                                      Attribute = 0x0000_0002,
[1756729185.567] [4637:4666] [DMG]                              }
[1756729185.567] [4637:4666] [DMG]
[1756729185.567] [4637:4666] [DMG]                              Data = 0 (unsigned),
[1756729185.567] [4637:4666] [DMG]                      },
[1756729185.567] [4637:4666] [DMG]
[1756729185.567] [4637:4666] [DMG]              },
[1756729185.567] [4637:4666] [DMG]
[1756729185.567] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.568] [4637:4666] [DMG]              {
[1756729185.568] [4637:4666] [DMG]                      AttributeDataIB =
[1756729185.568] [4637:4666] [DMG]                      {
[1756729185.568] [4637:4666] [DMG]                              DataVersion = 0x8c803ba9,
[1756729185.568] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.568] [4637:4666] [DMG]                              {
[1756729185.568] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.568] [4637:4666] [DMG]                                      Cluster = 0x30,
[1756729185.568] [4637:4666] [DMG]                                      Attribute = 0x0000_0001,
[1756729185.569] [4637:4666] [DMG]                              }
[1756729185.569] [4637:4666] [DMG]
[1756729185.569] [4637:4666] [DMG]                              Data =
[1756729185.569] [4637:4666] [DMG]                              {
[1756729185.569] [4637:4666] [DMG]                                      0x0 = 60 (unsigned),
[1756729185.569] [4637:4666] [DMG]                                      0x1 = 900 (unsigned),
[1756729185.569] [4637:4666] [DMG]                              },
[1756729185.569] [4637:4666] [DMG]                      },
[1756729185.569] [4637:4666] [DMG]
[1756729185.569] [4637:4666] [DMG]              },
[1756729185.569] [4637:4666] [DMG]
[1756729185.569] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.569] [4637:4666] [DMG]              {
[1756729185.569] [4637:4666] [DMG]                      AttributeDataIB =
[1756729185.569] [4637:4666] [DMG]                      {
[1756729185.569] [4637:4666] [DMG]                              DataVersion = 0x8c803ba9,
[1756729185.569] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.569] [4637:4666] [DMG]                              {
[1756729185.569] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.569] [4637:4666] [DMG]                                      Cluster = 0x30,
[1756729185.569] [4637:4666] [DMG]                                      Attribute = 0x0000_0000,
[1756729185.569] [4637:4666] [DMG]                              }
[1756729185.569] [4637:4666] [DMG]
[1756729185.569] [4637:4666] [DMG]                              Data = 0 (unsigned),
[1756729185.569] [4637:4666] [DMG]                      },
[1756729185.569] [4637:4666] [DMG]
[1756729185.569] [4637:4666] [DMG]              },
[1756729185.569] [4637:4666] [DMG]
[1756729185.569] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.569] [4637:4666] [DMG]              {
[1756729185.569] [4637:4666] [DMG]                      AttributeDataIB =
[1756729185.569] [4637:4666] [DMG]                      {
[1756729185.569] [4637:4666] [DMG]                              DataVersion = 0x8c803ba9,
[1756729185.569] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.569] [4637:4666] [DMG]                              {
[1756729185.569] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.569] [4637:4666] [DMG]                                      Cluster = 0x30,
[1756729185.569] [4637:4666] [DMG]                                      Attribute = 0x0000_0004,
[1756729185.569] [4637:4666] [DMG]                              }
[1756729185.569] [4637:4666] [DMG]
[1756729185.569] [4637:4666] [DMG]                              Data = true,
[1756729185.569] [4637:4666] [DMG]                      },
[1756729185.569] [4637:4666] [DMG]
[1756729185.569] [4637:4666] [DMG]              },
[1756729185.569] [4637:4666] [DMG]
[1756729185.569] [4637:4666] [DMG]      ],
[1756729185.570] [4637:4666] [DMG]
[1756729185.570] [4637:4666] [DMG]      SuppressResponse = true,
[1756729185.570] [4637:4666] [DMG]      InteractionModelRevision = 12
[1756729185.570] [4637:4666] [DMG] }
[1756729185.571] [4637:4666] [DMG] SendReadRequest ReadClient[0x7f8c017800]: Sending Read Request
[1756729185.571] [4637:4666] [DMG] 0 data version filters provided, 0 not relevant, 0 encoded, 0 skipped due to lack of space
[1756729185.572] [4637:4666] [EM] <<< [E:62477i S:55443 M:88078147] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:02 (IM:ReadRequest) (B:103)
[1756729185.573] [4637:4666] [DMG] MoveToState ReadClient[0x7f8c017800]: Moving to [AwaitingIn]
[1756729185.697] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16389
[1756729185.790] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729185.790] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729185.790] [4637:4666] [EM] >>> [E:62477i S:55443 M:189832960] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:05 (IM:ReportData) (B:192)
[1756729185.791] [4637:4666] [EM] Found matching exchange: 62477i, Delegate: 0x7f8c017810
[1756729185.791] [4637:4666] [DMG] ReportDataMessage =
[1756729185.791] [4637:4666] [DMG] {
[1756729185.791] [4637:4666] [DMG]      AttributeReportIBs =
[1756729185.791] [4637:4666] [DMG]      [
[1756729185.791] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.791] [4637:4666] [DMG]              {
[1756729185.791] [4637:4666] [DMG]                      AttributeDataIB =
[1756729185.791] [4637:4666] [DMG]                      {
[1756729185.791] [4637:4666] [DMG]                              DataVersion = 0xd11f275b,
[1756729185.791] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.791] [4637:4666] [DMG]                              {
[1756729185.791] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.791] [4637:4666] [DMG]                                      Cluster = 0x46,
[1756729185.791] [4637:4666] [DMG]                                      Attribute = 0x0000_0002,
[1756729185.791] [4637:4666] [DMG]                              }
[1756729185.791] [4637:4666] [DMG]
[1756729185.791] [4637:4666] [DMG]                              Data = 300 (unsigned),
[1756729185.792] [4637:4666] [DMG]                      },
[1756729185.792] [4637:4666] [DMG]
[1756729185.792] [4637:4666] [DMG]              },
[1756729185.792] [4637:4666] [DMG]
[1756729185.792] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.792] [4637:4666] [DMG]              {
[1756729185.792] [4637:4666] [DMG]                      AttributeDataIB =
[1756729185.792] [4637:4666] [DMG]                      {
[1756729185.792] [4637:4666] [DMG]                              DataVersion = 0xd11f275b,
[1756729185.792] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.792] [4637:4666] [DMG]                              {
[1756729185.792] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.792] [4637:4666] [DMG]                                      Cluster = 0x46,
[1756729185.792] [4637:4666] [DMG]                                      Attribute = 0x0000_0001,
[1756729185.792] [4637:4666] [DMG]                              }
[1756729185.792] [4637:4666] [DMG]
[1756729185.792] [4637:4666] [DMG]                              Data = 300 (unsigned),
[1756729185.792] [4637:4666] [DMG]                      },
[1756729185.792] [4637:4666] [DMG]
[1756729185.792] [4637:4666] [DMG]              },
[1756729185.792] [4637:4666] [DMG]
[1756729185.792] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.792] [4637:4666] [DMG]              {
[1756729185.792] [4637:4666] [DMG]                      AttributeDataIB =
[1756729185.792] [4637:4666] [DMG]                      {
[1756729185.792] [4637:4666] [DMG]                              DataVersion = 0xd11f275b,
[1756729185.792] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.792] [4637:4666] [DMG]                              {
[1756729185.792] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.792] [4637:4666] [DMG]                                      Cluster = 0x46,
[1756729185.792] [4637:4666] [DMG]                                      Attribute = 0x0000_0000,
[1756729185.792] [4637:4666] [DMG]                              }
[1756729185.792] [4637:4666] [DMG]
[1756729185.792] [4637:4666] [DMG]                              Data = 120 (unsigned),
[1756729185.792] [4637:4666] [DMG]                      },
[1756729185.792] [4637:4666] [DMG]
[1756729185.792] [4637:4666] [DMG]              },
[1756729185.792] [4637:4666] [DMG]
[1756729185.792] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.792] [4637:4666] [DMG]              {
[1756729185.792] [4637:4666] [DMG]                      AttributeStatusIB =
[1756729185.792] [4637:4666] [DMG]                      {
[1756729185.792] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.792] [4637:4666] [DMG]                              {
[1756729185.792] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.792] [4637:4666] [DMG]                                      Cluster = 0x46,
[1756729185.792] [4637:4666] [DMG]                                      Attribute = 0x0000_0007,
[1756729185.792] [4637:4666] [DMG]                              }
[1756729185.792] [4637:4666] [DMG]
[1756729185.793] [4637:4666] [DMG]                              StatusIB =
[1756729185.793] [4637:4666] [DMG]                              {
[1756729185.793] [4637:4666] [DMG]                                      status = 0x86 (UNSUPPORTED_ATTRIBUTE),
[1756729185.793] [4637:4666] [DMG]                              },
[1756729185.793] [4637:4666] [DMG]
[1756729185.793] [4637:4666] [DMG]                      },
[1756729185.793] [4637:4666] [DMG]
[1756729185.793] [4637:4666] [DMG]              },
[1756729185.793] [4637:4666] [DMG]
[1756729185.793] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.793] [4637:4666] [DMG]              {
[1756729185.793] [4637:4666] [DMG]                      AttributeStatusIB =
[1756729185.793] [4637:4666] [DMG]                      {
[1756729185.793] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.793] [4637:4666] [DMG]                              {
[1756729185.793] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.793] [4637:4666] [DMG]                                      Cluster = 0x46,
[1756729185.793] [4637:4666] [DMG]                                      Attribute = 0x0000_0006,
[1756729185.793] [4637:4666] [DMG]                              }
[1756729185.793] [4637:4666] [DMG]
[1756729185.793] [4637:4666] [DMG]                              StatusIB =
[1756729185.793] [4637:4666] [DMG]                              {
[1756729185.793] [4637:4666] [DMG]                                      status = 0x86 (UNSUPPORTED_ATTRIBUTE),
[1756729185.793] [4637:4666] [DMG]                              },
[1756729185.793] [4637:4666] [DMG]
[1756729185.793] [4637:4666] [DMG]                      },
[1756729185.793] [4637:4666] [DMG]
[1756729185.793] [4637:4666] [DMG]              },
[1756729185.793] [4637:4666] [DMG]
[1756729185.793] [4637:4666] [DMG]              AttributeReportIB =
[1756729185.793] [4637:4666] [DMG]              {
[1756729185.793] [4637:4666] [DMG]                      AttributeDataIB =
[1756729185.793] [4637:4666] [DMG]                      {
[1756729185.793] [4637:4666] [DMG]                              DataVersion = 0x96cc64bf,
[1756729185.793] [4637:4666] [DMG]                              AttributePathIB =
[1756729185.793] [4637:4666] [DMG]                              {
[1756729185.793] [4637:4666] [DMG]                                      Endpoint = 0x0,
[1756729185.793] [4637:4666] [DMG]                                      Cluster = 0x31,
[1756729185.793] [4637:4666] [DMG]                                      Attribute = 0x0000_0003,
[1756729185.793] [4637:4666] [DMG]                              }
[1756729185.793] [4637:4666] [DMG]
[1756729185.793] [4637:4666] [DMG]                              Data = 20 (unsigned),
[1756729185.793] [4637:4666] [DMG]                      },
[1756729185.793] [4637:4666] [DMG]
[1756729185.793] [4637:4666] [DMG]              },
[1756729185.793] [4637:4666] [DMG]
[1756729185.794] [4637:4666] [DMG]      ],
[1756729185.794] [4637:4666] [DMG]
[1756729185.794] [4637:4666] [DMG]      SuppressResponse = true,
[1756729185.794] [4637:4666] [DMG]      InteractionModelRevision = 12
[1756729185.794] [4637:4666] [DMG] }
[1756729185.795] [4637:4666] [CTL] NetworkCommissioning Features: has Thread. endpointid = 0
[1756729185.795] [4637:4666] [SVR] OnReadCommissioningInfo - vendorId=0xFFF1 productId=0x8007
[1756729185.795] [4637:4666] [SVR] OnReadCommissioningInfo ICD - IdleModeDuration=0 activeModeDuration=0 activeModeThreshold=0
[1756729185.795] [4637:4666] [CTL] Successfully finished commissioning step 'ReadCommissioningInfo'
[1756729185.795] [4637:4666] [CTL] Commissioning stage next step: 'ReadCommissioningInfo' -> 'ArmFailSafe'
[1756729185.795] [4637:4666] [CTL] Performing next commissioning step 'ArmFailSafe'
[1756729185.795] [4637:4666] [CTL] Arming failsafe (60 seconds)
[1756729185.795] [4637:4666] [DMG] ICR moving to [AddingComm]
[1756729185.795] [4637:4666] [DMG] ICR moving to [AddedComma]
[1756729185.796] [4637:4666] [EM] <<< [E:62478i S:55443 M:88078148] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:08 (IM:InvokeCommandRequest) (B:65)
[1756729185.797] [4637:4666] [DMG] ICR moving to [AwaitingRe]
[1756729185.877] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16389
[1756729185.880] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729185.880] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729185.881] [4637:4666] [EM] >>> [E:62478i S:55443 M:189832961] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:09 (IM:InvokeCommandResponse) (B:66)
[1756729185.881] [4637:4666] [EM] Found matching exchange: 62478i, Delegate: 0x7f8c008628
[1756729185.881] [4637:4666] [DMG] ICR moving to [ResponseRe]
[1756729185.881] [4637:4666] [DMG] InvokeResponseMessage =
[1756729185.881] [4637:4666] [DMG] {
[1756729185.881] [4637:4666] [DMG]      suppressResponse = false,
[1756729185.881] [4637:4666] [DMG]      InvokeResponseIBs =
[1756729185.881] [4637:4666] [DMG]      [
[1756729185.881] [4637:4666] [DMG]              InvokeResponseIB =
[1756729185.881] [4637:4666] [DMG]              {
[1756729185.881] [4637:4666] [DMG]                      CommandDataIB =
[1756729185.881] [4637:4666] [DMG]                      {
[1756729185.881] [4637:4666] [DMG]                              CommandPathIB =
[1756729185.881] [4637:4666] [DMG]                              {
[1756729185.881] [4637:4666] [DMG]                                      EndpointId = 0x0,
[1756729185.881] [4637:4666] [DMG]                                      ClusterId = 0x30,
[1756729185.881] [4637:4666] [DMG]                                      CommandId = 0x1,
[1756729185.881] [4637:4666] [DMG]                              },
[1756729185.881] [4637:4666] [DMG]
[1756729185.881] [4637:4666] [DMG]                              CommandFields =
[1756729185.881] [4637:4666] [DMG]                              {
[1756729185.881] [4637:4666] [DMG]                                      0x0 = 0 (unsigned),
[1756729185.881] [4637:4666] [DMG]                                      0x1 = "" (0 chars),
[1756729185.881] [4637:4666] [DMG]                              },
[1756729185.881] [4637:4666] [DMG]                      },
[1756729185.881] [4637:4666] [DMG]
[1756729185.881] [4637:4666] [DMG]              },
[1756729185.881] [4637:4666] [DMG]
[1756729185.881] [4637:4666] [DMG]      ],
[1756729185.881] [4637:4666] [DMG]
[1756729185.881] [4637:4666] [DMG]      InteractionModelRevision = 12
[1756729185.881] [4637:4666] [DMG] },
[1756729185.882] [4637:4666] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0001
[1756729185.882] [4637:4666] [CTL] Received ArmFailSafe response errorCode=0
[1756729185.882] [4637:4666] [CTL] Successfully finished commissioning step 'ArmFailSafe'
[1756729185.882] [4637:4666] [CTL] Commissioning stage next step: 'ArmFailSafe' -> 'ConfigRegulatory'
[1756729185.882] [4637:4666] [CTL] Performing next commissioning step 'ConfigRegulatory'
[1756729185.882] [4637:4666] [CTL] Setting Regulatory Config
[1756729185.882] [4637:4666] [CTL] Device does not support configurable regulatory location
[1756729185.882] [4637:4666] [DMG] ICR moving to [AddingComm]
[1756729185.882] [4637:4666] [DMG] ICR moving to [AddedComma]
[1756729185.882] [4637:4666] [EM] <<< [E:62479i S:55443 M:88078149] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:08 (IM:InvokeCommandRequest) (B:70)
[1756729185.883] [4637:4666] [DMG] ICR moving to [AwaitingRe]
[1756729185.883] [4637:4666] [DMG] ICR moving to [AwaitingDe]
[1756729186.012] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16389
[1756729186.060] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729186.061] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729186.061] [4637:4666] [EM] >>> [E:62479i S:55443 M:189832962] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:09 (IM:InvokeCommandResponse) (B:66)
[1756729186.061] [4637:4666] [EM] Found matching exchange: 62479i, Delegate: 0x7f8c008478
[1756729186.061] [4637:4666] [DMG] ICR moving to [ResponseRe]
[1756729186.061] [4637:4666] [DMG] InvokeResponseMessage =
[1756729186.061] [4637:4666] [DMG] {
[1756729186.061] [4637:4666] [DMG]      suppressResponse = false,
[1756729186.061] [4637:4666] [DMG]      InvokeResponseIBs =
[1756729186.061] [4637:4666] [DMG]      [
[1756729186.061] [4637:4666] [DMG]              InvokeResponseIB =
[1756729186.061] [4637:4666] [DMG]              {
[1756729186.061] [4637:4666] [DMG]                      CommandDataIB =
[1756729186.061] [4637:4666] [DMG]                      {
[1756729186.061] [4637:4666] [DMG]                              CommandPathIB =
[1756729186.061] [4637:4666] [DMG]                              {
[1756729186.061] [4637:4666] [DMG]                                      EndpointId = 0x0,
[1756729186.062] [4637:4666] [DMG]                                      ClusterId = 0x30,
[1756729186.062] [4637:4666] [DMG]                                      CommandId = 0x3,
[1756729186.062] [4637:4666] [DMG]                              },
[1756729186.062] [4637:4666] [DMG]
[1756729186.062] [4637:4666] [DMG]                              CommandFields =
[1756729186.062] [4637:4666] [DMG]                              {
[1756729186.062] [4637:4666] [DMG]                                      0x0 = 0 (unsigned),
[1756729186.062] [4637:4666] [DMG]                                      0x1 = "" (0 chars),
[1756729186.062] [4637:4666] [DMG]                              },
[1756729186.062] [4637:4666] [DMG]                      },
[1756729186.062] [4637:4666] [DMG]
[1756729186.062] [4637:4666] [DMG]              },
[1756729186.062] [4637:4666] [DMG]
[1756729186.062] [4637:4666] [DMG]      ],
[1756729186.062] [4637:4666] [DMG]
[1756729186.062] [4637:4666] [DMG]      InteractionModelRevision = 12
[1756729186.062] [4637:4666] [DMG] },
[1756729186.062] [4637:4666] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0003
[1756729186.062] [4637:4666] [CTL] Received SetRegulatoryConfig response errorCode=0
[1756729186.062] [4637:4666] [CTL] Successfully finished commissioning step 'ConfigRegulatory'
[1756729186.062] [4637:4666] [CTL] Commissioning stage next step: 'ConfigRegulatory' -> 'ConfigureTCAcknowledgments'
[1756729186.062] [4637:4666] [CTL] Performing next commissioning step 'ConfigureTCAcknowledgments'
[1756729186.062] [4637:4666] [CTL] Setting Terms and Conditions
[1756729186.062] [4637:4666] [CTL] Setting Terms and Conditions: Skipped
[1756729186.062] [4637:4666] [CTL] Successfully finished commissioning step 'ConfigureTCAcknowledgments'
[1756729186.062] [4637:4666] [CTL] Commissioning stage next step: 'ConfigureTCAcknowledgments' -> 'SendPAICertificateRequest'
[1756729186.062] [4637:4666] [CTL] Performing next commissioning step 'SendPAICertificateRequest'
[1756729186.062] [4637:4666] [CTL] Sending request for PAI certificate
[1756729186.062] [4637:4666] [CTL] Sending Certificate Chain request to 0x7f8c041cb0 device
[1756729186.062] [4637:4666] [DMG] ICR moving to [AddingComm]
[1756729186.062] [4637:4666] [DMG] ICR moving to [AddedComma]
[1756729186.062] [4637:4666] [EM] <<< [E:62480i S:55443 M:88078150] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:08 (IM:InvokeCommandRequest) (B:62)
[1756729186.063] [4637:4666] [DMG] ICR moving to [AwaitingRe]
[1756729186.063] [4637:4666] [DMG] ICR moving to [AwaitingDe]
[1756729186.147] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16389
[1756729186.241] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729186.241] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729186.376] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729186.376] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729186.464] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729186.465] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729186.465] [4637:4666] [EM] >>> [E:62480i S:55443 M:189832963] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:09 (IM:InvokeCommandResponse) (B:527)
[1756729186.465] [4637:4666] [EM] Found matching exchange: 62480i, Delegate: 0x7f8c008628
[1756729186.465] [4637:4666] [DMG] ICR moving to [ResponseRe]
[1756729186.465] [4637:4666] [DMG] InvokeResponseMessage =
[1756729186.465] [4637:4666] [DMG] {
[1756729186.465] [4637:4666] [DMG]      suppressResponse = false,
[1756729186.465] [4637:4666] [DMG]      InvokeResponseIBs =
[1756729186.465] [4637:4666] [DMG]      [
[1756729186.465] [4637:4666] [DMG]              InvokeResponseIB =
[1756729186.465] [4637:4666] [DMG]              {
[1756729186.465] [4637:4666] [DMG]                      CommandDataIB =
[1756729186.465] [4637:4666] [DMG]                      {
[1756729186.465] [4637:4666] [DMG]                              CommandPathIB =
[1756729186.465] [4637:4666] [DMG]                              {
[1756729186.465] [4637:4666] [DMG]                                      EndpointId = 0x0,
[1756729186.465] [4637:4666] [DMG]                                      ClusterId = 0x3e,
[1756729186.465] [4637:4666] [DMG]                                      CommandId = 0x3,
[1756729186.465] [4637:4666] [DMG]                              },
[1756729186.465] [4637:4666] [DMG]
[1756729186.465] [4637:4666] [DMG]                              CommandFields =
[1756729186.465] [4637:4666] [DMG]                              {
[1756729186.465] [4637:4666] [DMG]                                      0x0 = [
[1756729186.466] [4637:4666] [DMG]                                                      0x30, 0x82, 0x01, 0xcb, 0x30, 0x82, 0x01, 0x71, 0xa0, 0x03, 0x02, 0x01, 0x02, 0x02, 0x08, 0x56, 0xad, 0x82, 0x22, 0xad, 0x94, 0x5b, 0x64, 0x30, 0x0a, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x04, 0x03, 0x02, 0x30, 0x30, 0x31, 0x18, 0x30, 0x16, 0x06, 0x03, 0x55, 0x04, 0x03, 0x0c, 0x0f, 0x4d, 0x61, 0x74, 0x74, 0x65, 0x72, 0x20, 0x54, 0x65, 0x73, 0x74, 0x20, 0x50, 0x41, 0x41, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x01, 0x0c, 0x04, 0x46, 0x46, 0x46, 0x31, 0x30, 0x20, 0x17, 0x0d, 0x32, 0x32, 0x30, 0x32, 0x30, 0x35, 0x30, 0x30, 0x30, 0x30, 0x30, 0x30, 0x5a, 0x18, 0x0f, 0x39, 0x39, 0x39, 0x39, 0x31, 0x32, 0x33, 0x31, 0x32, 0x33, 0x35, 0x39, 0x35, 0x39, 0x5a, 0x30, 0x3d, 0x31, 0x25, 0x30, 0x23, 0x06, 0x03, 0x55, 0x04, 0x03, 0x0c, 0x1c, 0x4d, 0x61, 0x74, 0x74, 0x65, 0x72, 0x20, 0x44, 0x65, 0x76, 0x20, 0x50, 0x41, 0x49, 0x20, 0x30, 0x78, 0x46, 0x46, 0x46, 0x31, 0x20, 0x6e, 0x6f, 0x20, 0x50, 0x49, 0x44, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x01, 0x0c, 0x04, 0x46, 0x46, 0x46, 0x31, 0x30, 0x59, 0x30, 0x13, 0x06, 0x07, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x02, 0x01, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x03, 0x01, 0x07, 0x03, 0x42, 0x00, 0x04, 0x41, 0x9a, 0x93, 0x15, 0xc2, 0x17, 0x3e, 0x0c, 0x8c, 0x87, 0x6d, 0x03, 0xcc, 0xfc, 0x94, 0x48, 0x52, 0x64, 0x7f, 0x7f, 0xec, 0x5e, 0x50, 0x82, 0xf4, 0x05, 0x99, 0x28, 0xec, 0xa8, 0x94, 0xc5, 0x94, 0x15, 0x13, 0x09, 0xac, 0x63, 0x1e, 0x4c, 0xb0, 0x33, 0x92, 0xaf, 0x68, 0x4b, 0x0b, 0xaf, 0xb7, 0xe6, 0x5b, 0x3b, 0x81, 0x62, 0xc2, 0xf5, 0x2b, 0xf9, 0x31, 0xb8, 0xe7, 0x7a, 0xaa, 0x82, 0xa3, 0x66, 0x30, 0x64, 0x30, 0x12, 0x06, 0x03, 0x55, 0x1d, 0x
[1756729186.466] [4637:4666] [DMG]                                      ] (463 bytes)
[1756729186.466] [4637:4666] [DMG]                              },
[1756729186.466] [4637:4666] [DMG]                      },
[1756729186.466] [4637:4666] [DMG]
[1756729186.466] [4637:4666] [DMG]              },
[1756729186.466] [4637:4666] [DMG]
[1756729186.466] [4637:4666] [DMG]      ],
[1756729186.466] [4637:4666] [DMG]
[1756729186.466] [4637:4666] [DMG]      InteractionModelRevision = 12
[1756729186.466] [4637:4666] [DMG] },
[1756729186.466] [4637:4666] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0003
[1756729186.466] [4637:4666] [CTL] Received certificate chain from the device
[1756729186.466] [4637:4666] [CTL] Successfully finished commissioning step 'SendPAICertificateRequest'
[1756729186.466] [4637:4666] [CTL] Commissioning stage next step: 'SendPAICertificateRequest' -> 'SendDACCertificateRequest'
[1756729186.466] [4637:4666] [CTL] Performing next commissioning step 'SendDACCertificateRequest'
[1756729186.466] [4637:4666] [CTL] Sending request for DAC certificate
[1756729186.466] [4637:4666] [CTL] Sending Certificate Chain request to 0x7f8c041cb0 device
[1756729186.466] [4637:4666] [DMG] ICR moving to [AddingComm]
[1756729186.466] [4637:4666] [DMG] ICR moving to [AddedComma]
[1756729186.466] [4637:4666] [EM] <<< [E:62481i S:55443 M:88078151] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:08 (IM:InvokeCommandRequest) (B:62)
[1756729186.467] [4637:4666] [DMG] ICR moving to [AwaitingRe]
[1756729186.467] [4637:4666] [DMG] ICR moving to [AwaitingDe]
[1756729186.552] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16389
[1756729186.645] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729186.646] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729186.781] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729186.781] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729186.870] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729186.871] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729186.871] [4637:4666] [EM] >>> [E:62481i S:55443 M:189832964] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:09 (IM:InvokeCommandResponse) (B:555)
[1756729186.871] [4637:4666] [EM] Found matching exchange: 62481i, Delegate: 0x7f8c008478
[1756729186.871] [4637:4666] [DMG] ICR moving to [ResponseRe]
[1756729186.871] [4637:4666] [DMG] InvokeResponseMessage =
[1756729186.871] [4637:4666] [DMG] {
[1756729186.871] [4637:4666] [DMG]      suppressResponse = false,
[1756729186.871] [4637:4666] [DMG]      InvokeResponseIBs =
[1756729186.872] [4637:4666] [DMG]      [
[1756729186.872] [4637:4666] [DMG]              InvokeResponseIB =
[1756729186.872] [4637:4666] [DMG]              {
[1756729186.872] [4637:4666] [DMG]                      CommandDataIB =
[1756729186.872] [4637:4666] [DMG]                      {
[1756729186.872] [4637:4666] [DMG]                              CommandPathIB =
[1756729186.872] [4637:4666] [DMG]                              {
[1756729186.872] [4637:4666] [DMG]                                      EndpointId = 0x0,
[1756729186.872] [4637:4666] [DMG]                                      ClusterId = 0x3e,
[1756729186.872] [4637:4666] [DMG]                                      CommandId = 0x3,
[1756729186.872] [4637:4666] [DMG]                              },
[1756729186.872] [4637:4666] [DMG]
[1756729186.872] [4637:4666] [DMG]                              CommandFields =
[1756729186.872] [4637:4666] [DMG]                              {
[1756729186.872] [4637:4666] [DMG]                                      0x0 = [
[1756729186.872] [4637:4666] [DMG]                                                      0x30, 0x82, 0x01, 0xe7, 0x30, 0x82, 0x01, 0x8e, 0xa0, 0x03, 0x02, 0x01, 0x02, 0x02, 0x08, 0x58, 0x48, 0xb6, 0x4f, 0xbd, 0x0c, 0x9a, 0x6b, 0x30, 0x0a, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x04, 0x03, 0x02, 0x30, 0x3d, 0x31, 0x25, 0x30, 0x23, 0x06, 0x03, 0x55, 0x04, 0x03, 0x0c, 0x1c, 0x4d, 0x61, 0x74, 0x74, 0x65, 0x72, 0x20, 0x44, 0x65, 0x76, 0x20, 0x50, 0x41, 0x49, 0x20, 0x30, 0x78, 0x46, 0x46, 0x46, 0x31, 0x20, 0x6e, 0x6f, 0x20, 0x50, 0x49, 0x44, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x01, 0x0c, 0x04, 0x46, 0x46, 0x46, 0x31, 0x30, 0x20, 0x17, 0x0d, 0x32, 0x32, 0x30, 0x32, 0x30, 0x35, 0x30, 0x30, 0x30, 0x30, 0x30, 0x30, 0x5a, 0x18, 0x0f, 0x39, 0x39, 0x39, 0x39, 0x31, 0x32, 0x33, 0x31, 0x32, 0x33, 0x35, 0x39, 0x35, 0x39, 0x5a, 0x30, 0x53, 0x31, 0x25, 0x30, 0x23, 0x06, 0x03, 0x55, 0x04, 0x03, 0x0c, 0x1c, 0x4d, 0x61, 0x74, 0x74, 0x65, 0x72, 0x20, 0x44, 0x65, 0x76, 0x20, 0x44, 0x41, 0x43, 0x20, 0x30, 0x78, 0x46, 0x46, 0x46, 0x31, 0x2f, 0x30, 0x78, 0x38, 0x30, 0x30, 0x37, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x01, 0x0c, 0x04, 0x46, 0x46, 0x46, 0x31, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x02, 0x0c, 0x04, 0x38, 0x30, 0x30, 0x37, 0x30, 0x59, 0x30, 0x13, 0x06, 0x07, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x02, 0x01, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x03, 0x01, 0x07, 0x03, 0x42, 0x00, 0x04, 0x1b, 0x68, 0x65, 0x0f, 0x97, 0xaa, 0xda, 0x54, 0x62, 0xa0, 0xd4, 0xdb, 0x5f, 0xd7, 0x84, 0x41, 0xb1, 0x48, 0x95, 0xd8, 0xd3, 0xc6, 0x20, 0x18, 0x33, 0x7f, 0x15, 0x23, 0xbb, 0xea, 0xb6, 0xd5, 0xf0, 0xdd, 0x6e, 0xed, 0x28, 0x83, 0x2e, 0x
[1756729186.872] [4637:4666] [DMG]                                      ] (491 bytes)
[1756729186.872] [4637:4666] [DMG]                              },
[1756729186.872] [4637:4666] [DMG]                      },
[1756729186.872] [4637:4666] [DMG]
[1756729186.872] [4637:4666] [DMG]              },
[1756729186.872] [4637:4666] [DMG]
[1756729186.872] [4637:4666] [DMG]      ],
[1756729186.872] [4637:4666] [DMG]
[1756729186.872] [4637:4666] [DMG]      InteractionModelRevision = 12
[1756729186.872] [4637:4666] [DMG] },
[1756729186.872] [4637:4666] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0003
[1756729186.872] [4637:4666] [CTL] Received certificate chain from the device
[1756729186.872] [4637:4666] [CTL] Successfully finished commissioning step 'SendDACCertificateRequest'
[1756729186.872] [4637:4666] [CTL] Commissioning stage next step: 'SendDACCertificateRequest' -> 'SendAttestationRequest'
[1756729186.873] [4637:4666] [CTL] Performing next commissioning step 'SendAttestationRequest'
[1756729186.873] [4637:4666] [CTL] Sending Attestation Request to the device.
[1756729186.873] [4637:4666] [CTL] Sending Attestation request to 0x7f8c041cb0 device
[1756729186.873] [4637:4666] [DMG] ICR moving to [AddingComm]
[1756729186.873] [4637:4666] [DMG] ICR moving to [AddedComma]
[1756729186.873] [4637:4666] [EM] <<< [E:62482i S:55443 M:88078152] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:08 (IM:InvokeCommandRequest) (B:94)
[1756729186.874] [4637:4666] [DMG] ICR moving to [AwaitingRe]
[1756729186.874] [4637:4666] [CTL] Sent Attestation request, waiting for the Attestation Information
[1756729186.874] [4637:4666] [DMG] ICR moving to [AwaitingDe]
[1756729187.092] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16389
[1756729187.186] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729187.186] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729187.321] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729187.321] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729187.456] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729187.457] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729187.457] [4637:4666] [EM] >>> [E:62482i S:55443 M:189832965] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:09 (IM:InvokeCommandResponse) (B:716)
[1756729187.457] [4637:4666] [EM] Found matching exchange: 62482i, Delegate: 0x7f8c008628
[1756729187.457] [4637:4666] [DMG] ICR moving to [ResponseRe]
[1756729187.457] [4637:4666] [DMG] InvokeResponseMessage =
[1756729187.457] [4637:4666] [DMG] {
[1756729187.457] [4637:4666] [DMG]      suppressResponse = false,
[1756729187.457] [4637:4666] [DMG]      InvokeResponseIBs =
[1756729187.457] [4637:4666] [DMG]      [
[1756729187.457] [4637:4666] [DMG]              InvokeResponseIB =
[1756729187.457] [4637:4666] [DMG]              {
[1756729187.457] [4637:4666] [DMG]                      CommandDataIB =
[1756729187.457] [4637:4666] [DMG]                      {
[1756729187.457] [4637:4666] [DMG]                              CommandPathIB =
[1756729187.457] [4637:4666] [DMG]                              {
[1756729187.457] [4637:4666] [DMG]                                      EndpointId = 0x0,
[1756729187.457] [4637:4666] [DMG]                                      ClusterId = 0x3e,
[1756729187.457] [4637:4666] [DMG]                                      CommandId = 0x1,
[1756729187.457] [4637:4666] [DMG]                              },
[1756729187.457] [4637:4666] [DMG]
[1756729187.457] [4637:4666] [DMG]                              CommandFields =
[1756729187.457] [4637:4666] [DMG]                              {
[1756729187.458] [4637:4666] [DMG]                                      0x0 = [
[1756729187.458] [4637:4666] [DMG]                                                      0x15, 0x31, 0x01, 0x1d, 0x02, 0x30, 0x82, 0x02, 0x19, 0x06, 0x09, 0x2a, 0x86, 0x48, 0x86, 0xf7, 0x0d, 0x01, 0x07, 0x02, 0xa0, 0x82, 0x02, 0x0a, 0x30, 0x82, 0x02, 0x06, 0x02, 0x01, 0x03, 0x31, 0x0d, 0x30, 0x0b, 0x06, 0x09, 0x60, 0x86, 0x48, 0x01, 0x65, 0x03, 0x04, 0x02, 0x01, 0x30, 0x82, 0x01, 0x71, 0x06, 0x09, 0x2a, 0x86, 0x48, 0x86, 0xf7, 0x0d, 0x01, 0x07, 0x01, 0xa0, 0x82, 0x01, 0x62, 0x04, 0x82, 0x01, 0x5e, 0x15, 0x24, 0x00, 0x01, 0x25, 0x01, 0xf1, 0xff, 0x36, 0x02, 0x05, 0x00, 0x80, 0x05, 0x01, 0x80, 0x05, 0x02, 0x80, 0x05, 0x03, 0x80, 0x05, 0x04, 0x80, 0x05, 0x05, 0x80, 0x05, 0x06, 0x80, 0x05, 0x07, 0x80, 0x05, 0x08, 0x80, 0x05, 0x09, 0x80, 0x05, 0x0a, 0x80, 0x05, 0x0b, 0x80, 0x05, 0x0c, 0x80, 0x05, 0x0d, 0x80, 0x05, 0x0e, 0x80, 0x05, 0x0f, 0x80, 0x05, 0x10, 0x80, 0x05, 0x11, 0x80, 0x05, 0x12, 0x80, 0x05, 0x13, 0x80, 0x05, 0x14, 0x80, 0x05, 0x15, 0x80, 0x05, 0x16, 0x80, 0x05, 0x17, 0x80, 0x05, 0x18, 0x80, 0x05, 0x19, 0x80, 0x05, 0x1a, 0x80, 0x05, 0x1b, 0x80, 0x05, 0x1c, 0x80, 0x05, 0x1d, 0x80, 0x05, 0x1e, 0x80, 0x05, 0x1f, 0x80, 0x05, 0x20, 0x80, 0x05, 0x21, 0x80, 0x05, 0x22, 0x80, 0x05, 0x23, 0x80, 0x05, 0x24, 0x80, 0x05, 0x25, 0x80, 0x05, 0x26, 0x80, 0x05, 0x27, 0x80, 0x05, 0x28, 0x80, 0x05, 0x29, 0x80, 0x05, 0x2a, 0x80, 0x05, 0x2b, 0x80, 0x05, 0x2c, 0x80, 0x05, 0x2d, 0x80, 0x05, 0x2e, 0x80, 0x05, 0x2f, 0x80, 0x05, 0x30, 0x80, 0x05, 0x31, 0x80, 0x05, 0x32, 0x80, 0x05, 0x33, 0x80, 0x05, 0x34, 0x80, 0x05, 0x35, 0x80, 0x05, 0x36, 0x80, 0x05, 0x37, 0x80, 0x05, 0x38, 0x80, 0x05, 0x39, 0x80, 0x05, 0x3a, 0x80, 0x05, 0x3b, 0x80, 0x05, 0x3c, 0x80, 0x05, 0x3d, 0x80, 0x05, 0x3e, 0x80, 0x05, 0x3f, 0x80, 0x05, 0x40, 0x80, 0x05, 0x41, 0x80, 0x05, 0x42, 0x80, 0x05, 0x43, 0x80, 0x
[1756729187.458] [4637:4666] [DMG]                                      ] (585 bytes)
[1756729187.458] [4637:4666] [DMG]                                      0x1 = [
[1756729187.458] [4637:4666] [DMG]                                                      0x9f, 0x45, 0x9e, 0x15, 0xa5, 0x84, 0x57, 0xe4, 0xfa, 0x27, 0x5f, 0x76, 0xef, 0x1a, 0x9a, 0xa3, 0xec, 0xb5, 0x5f, 0x3a, 0xd2, 0x23, 0xd6, 0x5d, 0x68, 0x89, 0xa2, 0x28, 0x93, 0x62, 0x51, 0x76, 0x05, 0x50, 0x47, 0xb4, 0x9d, 0xe8, 0x78, 0x4b, 0x03, 0x2b, 0x07, 0x58, 0xcc, 0x0b, 0x18, 0x0f, 0x46, 0xbf, 0xbf, 0x1a, 0x20, 0xd9, 0x9c, 0xde, 0x03, 0xf1, 0x53, 0x32, 0xff, 0x52, 0x5a, 0xb4,
[1756729187.458] [4637:4666] [DMG]                                      ] (64 bytes)
[1756729187.458] [4637:4666] [DMG]                              },
[1756729187.458] [4637:4666] [DMG]                      },
[1756729187.458] [4637:4666] [DMG]
[1756729187.458] [4637:4666] [DMG]              },
[1756729187.458] [4637:4666] [DMG]
[1756729187.458] [4637:4666] [DMG]      ],
[1756729187.458] [4637:4666] [DMG]
[1756729187.458] [4637:4666] [DMG]      InteractionModelRevision = 12
[1756729187.458] [4637:4666] [DMG] },
[1756729187.458] [4637:4666] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0001
[1756729187.458] [4637:4666] [CTL] Received Attestation Information from the device
[1756729187.458] [4637:4666] [CTL] Successfully finished commissioning step 'SendAttestationRequest'
[1756729187.458] [4637:4666] [CTL] AutoCommissioner setting attestationElements buffer size 585/585
[1756729187.458] [4637:4666] [CTL] Commissioning stage next step: 'SendAttestationRequest' -> 'AttestationVerification'
[1756729187.458] [4637:4666] [CTL] Performing next commissioning step 'AttestationVerification'
[1756729187.458] [4637:4666] [CTL] Verifying Device Attestation information received from the device
[1756729187.478] [4637:4666] [-] Device candidate DAC chain details:
[1756729187.478] [4637:4666] [-] --> DAC's VID: 0xFFF1, PID: 0x8007
[1756729187.478] [4637:4666] [-] ==== DAC certificate considered (491 bytes) ====
[1756729187.478] [4637:4666] [-] -----BEGIN CERTIFICATE-----
[1756729187.478] [4637:4666] [-] MIIB5zCCAY6gAwIBAgIIWEi2T70MmmswCgYIKoZIzj0EAwIwPTElMCMGA1UEAwwc
[1756729187.478] [4637:4666] [-] TWF0dGVyIERldiBQQUkgMHhGRkYxIG5vIFBJRDEUMBIGCisGAQQBgqJ8AgEMBEZG
[1756729187.478] [4637:4666] [-] RjEwIBcNMjIwMjA1MDAwMDAwWhgPOTk5OTEyMzEyMzU5NTlaMFMxJTAjBgNVBAMM
[1756729187.478] [4637:4666] [-] HE1hdHRlciBEZXYgREFDIDB4RkZGMS8weDgwMDcxFDASBgorBgEEAYKifAIBDARG
[1756729187.478] [4637:4666] [-] RkYxMRQwEgYKKwYBBAGConwCAgwEODAwNzBZMBMGByqGSM49AgEGCCqGSM49AwEH
[1756729187.478] [4637:4666] [-] A0IABBtoZQ+XqtpUYqDU21/XhEGxSJXY08YgGDN/FSO76rbV8N1u7SiDLvlIiRuX
[1756729187.478] [4637:4666] [-] aoMb6oLbmnfj6klHtB2Hagji3WKjYDBeMAwGA1UdEwEB/wQCMAAwDgYDVR0PAQH/
[1756729187.478] [4637:4666] [-] BAQDAgeAMB0GA1UdDgQWBBShgQsewlHhuLRFNTSRqRhdV1IRRzAfBgNVHSMEGDAW
[1756729187.478] [4637:4666] [-] gBRjVA5H9kscONE4hKRi0WwZXY/7PDAKBggqhkjOPQQDAgNHADBEAiBIldL+9SOX
[1756729187.478] [4637:4666] [-] PHjbxgV9RPzHbiHjUlNuiRDzLuwZ/im8JAIgCMwbPSElYHRxX7xZ6Qdn/iLuXxW7
[1756729187.478] [4637:4666] [-] +glAsd/WUkT1UWM=
[1756729187.478] [4637:4666] [-] -----END CERTIFICATE-----
[1756729187.481] [4637:4666] [-] --> DAC certificate SKID: A1:81:0B:1E:C2:51:E1:B8:B4:45:35:34:91:A9:18:5D:57:52:11:47
[1756729187.483] [4637:4666] [-] --> DAC certificate AKID: 63:54:0E:47:F6:4B:1C:38:D1:38:84:A4:62:D1:6C:19:5D:8F:FB:3C
[1756729187.483] [4637:4666] [-] ==== PAI certificate considered (463 bytes) ====
[1756729187.483] [4637:4666] [-] -----BEGIN CERTIFICATE-----
[1756729187.483] [4637:4666] [-] MIIByzCCAXGgAwIBAgIIVq2CIq2UW2QwCgYIKoZIzj0EAwIwMDEYMBYGA1UEAwwP
[1756729187.483] [4637:4666] [-] TWF0dGVyIFRlc3QgUEFBMRQwEgYKKwYBBAGConwCAQwERkZGMTAgFw0yMjAyMDUw
[1756729187.483] [4637:4666] [-] MDAwMDBaGA85OTk5MTIzMTIzNTk1OVowPTElMCMGA1UEAwwcTWF0dGVyIERldiBQ
[1756729187.483] [4637:4666] [-] QUkgMHhGRkYxIG5vIFBJRDEUMBIGCisGAQQBgqJ8AgEMBEZGRjEwWTATBgcqhkjO
[1756729187.483] [4637:4666] [-] PQIBBggqhkjOPQMBBwNCAARBmpMVwhc+DIyHbQPM/JRIUmR/f+xeUIL0BZko7KiU
[1756729187.483] [4637:4666] [-] xZQVEwmsYx5MsDOSr2hLC6+35ls7gWLC9Sv5MbjneqqCo2YwZDASBgNVHRMBAf8E
[1756729187.483] [4637:4666] [-] CDAGAQH/AgEAMA4GA1UdDwEB/wQEAwIBBjAdBgNVHQ4EFgQUY1QOR/ZLHDjROISk
[1756729187.483] [4637:4666] [-] YtFsGV2P+zwwHwYDVR0jBBgwFoAUav0idx9RH+y/FkGXZxDc3DGhcX4wCgYIKoZI
[1756729187.483] [4637:4666] [-] zj0EAwIDSAAwRQIhALLvJ/Sa6bUPuR7qyUxNC9u415KcbLiPrOUpNo0SBUwMAiBl
[1756729187.483] [4637:4666] [-] Xckrhr2QmIKmxiF3uCXX0F7b58Ivn+pxIg5+pwP4kQ==
[1756729187.483] [4637:4666] [-] -----END CERTIFICATE-----
[1756729187.486] [4637:4666] [-] --> PAI certificate SKID: 63:54:0E:47:F6:4B:1C:38:D1:38:84:A4:62:D1:6C:19:5D:8F:FB:3C
[1756729187.488] [4637:4666] [-] --> PAI certificate AKID: 6A:FD:22:77:1F:51:1F:EC:BF:16:41:97:67:10:DC:DC:31:A1:71:7E
[1756729187.495] [4637:4666] [CTL] Error on commissioning step 'AttestationVerification': 'src/controller/CHIPDeviceController.cpp:1291: CHIP Error 0x00000020: Failed Device Attestation'
[1756729187.495] [4637:4666] [CTL] Failed verifying attestation information. Now checking DAC chain revoked status.
[1756729187.495] [4637:4666] [CTL] Commissioning stage next step: 'AttestationVerification' -> 'AttestationRevocationCheck'
[1756729187.495] [4637:4666] [CTL] Performing next commissioning step 'AttestationRevocationCheck' with completion status = 'src/controller/CHIPDeviceController.cpp:1291: CHIP Error 0x00000020: Failed Device Attestation'
[1756729187.495] [4637:4666] [CTL] Verifying the device's DAC chain revocation status
[1756729187.495] [4637:4666] [-] WARNING: No revocation delegate available. Revocation checks will be skipped!
[1756729187.495] [4637:4666] [CTL] Failed in verifying 'Attestation Information' command received from the device: err 500 (Attestation signature failed to validate against DAC subject public key)
[1756729187.495] [4637:4666] [CTL] Error on commissioning step 'AttestationRevocationCheck': 'src/controller/CHIPDeviceController.cpp:1338: CHIP Error 0x00000020: Failed Device Attestation'
[1756729187.495] [4637:4666] [CTL] Going from commissioning step 'AttestationRevocationCheck' with lastErr = 'src/controller/CHIPDeviceController.cpp:1338: CHIP Error 0x00000020: Failed Device Attestation' -> 'Cleanup'
[1756729187.495] [4637:4666] [CTL] Performing next commissioning step 'Cleanup' with completion status = 'src/controller/CHIPDeviceController.cpp:1338: CHIP Error 0x00000020: Failed Device Attestation'
[1756729187.496] [4637:4666] [CTL] Disarming failsafe on device 0x7f8c041cb0
[1756729187.496] [4637:4666] [DMG] ICR moving to [AddingComm]
[1756729187.496] [4637:4666] [DMG] ICR moving to [AddedComma]
[1756729187.496] [4637:4666] [EM] <<< [E:62483i S:55443 M:88078153] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:08 (IM:InvokeCommandRequest) (B:65)
[1756729187.497] [4637:4666] [DMG] ICR moving to [AwaitingRe]
[1756729187.497] [4637:4666] [DMG] ICR moving to [AwaitingDe]
[1756729187.588] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16389
[1756729187.592] [4637:4665] [DL] Indication received, conn = 0x559d170f30
[1756729187.592] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16391
[1756729187.593] [4637:4666] [EM] >>> [E:62483i S:55443 M:189832966] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:09 (IM:InvokeCommandResponse) (B:66)
[1756729187.593] [4637:4666] [EM] Found matching exchange: 62483i, Delegate: 0x7f8c008478
[1756729187.593] [4637:4666] [DMG] ICR moving to [ResponseRe]
[1756729187.593] [4637:4666] [DMG] InvokeResponseMessage =
[1756729187.593] [4637:4666] [DMG] {
[1756729187.593] [4637:4666] [DMG]      suppressResponse = false,
[1756729187.593] [4637:4666] [DMG]      InvokeResponseIBs =
[1756729187.593] [4637:4666] [DMG]      [
[1756729187.593] [4637:4666] [DMG]              InvokeResponseIB =
[1756729187.593] [4637:4666] [DMG]              {
[1756729187.593] [4637:4666] [DMG]                      CommandDataIB =
[1756729187.593] [4637:4666] [DMG]                      {
[1756729187.593] [4637:4666] [DMG]                              CommandPathIB =
[1756729187.593] [4637:4666] [DMG]                              {
[1756729187.594] [4637:4666] [DMG]                                      EndpointId = 0x0,
[1756729187.594] [4637:4666] [DMG]                                      ClusterId = 0x30,
[1756729187.594] [4637:4666] [DMG]                                      CommandId = 0x1,
[1756729187.594] [4637:4666] [DMG]                              },
[1756729187.594] [4637:4666] [DMG]
[1756729187.594] [4637:4666] [DMG]                              CommandFields =
[1756729187.594] [4637:4666] [DMG]                              {
[1756729187.594] [4637:4666] [DMG]                                      0x0 = 0 (unsigned),
[1756729187.594] [4637:4666] [DMG]                                      0x1 = "" (0 chars),
[1756729187.594] [4637:4666] [DMG]                              },
[1756729187.594] [4637:4666] [DMG]                      },
[1756729187.594] [4637:4666] [DMG]
[1756729187.594] [4637:4666] [DMG]              },
[1756729187.594] [4637:4666] [DMG]
[1756729187.594] [4637:4666] [DMG]      ],
[1756729187.594] [4637:4666] [DMG]
[1756729187.594] [4637:4666] [DMG]      InteractionModelRevision = 12
[1756729187.594] [4637:4666] [DMG] },
[1756729187.595] [4637:4666] [DMG] Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0001
[1756729187.595] [4637:4666] [CTL] Failsafe disarmed
[1756729187.595] [4637:4666] [CTL] Successfully finished commissioning step 'Cleanup'
[1756729187.595] [4637:4666] [DIS] Closing all BLE connections
[1756729187.595] [4637:4666] [IN] Clearing BLE pending packets.
[1756729187.597] [4637:4666] [BLE] Auto-closing end point's BLE connection.
[1756729187.597] [4637:4666] [DL] Closing BLE GATT connection (con 0x559d170f30)
[1756729187.597] [4637:4665] [DL] Close BLE connection: peer=F8:11:F3:72:95:B3
[1756729187.818] [4637:4666] [IN] SecureSession[0x7f8c013400]: MarkForEviction Type:1 LSID:55443
[1756729187.818] [4637:4666] [SC] SecureSession[0x7f8c013400, LSID:55443]: State change 'kActive' --> 'kPendingEviction'
[1756729187.818] [4637:4666] [CTL] Commissioning complete for node ID 0x0000000000000001: src/controller/CHIPDeviceController.cpp:1338: CHIP Error 0x00000020: Failed Device Attestation
[1756729187.818] [4637:4666] [TOO] Device commissioning Failure: src/controller/CHIPDeviceController.cpp:1338: CHIP Error 0x00000020: Failed Device Attestation
[1756729187.818] [4637:4666] [TOO] Run command failure: src/controller/CHIPDeviceController.cpp:1338: CHIP Error 0x00000020: Failed Device Attestation
[1756729187.818] [4637:4666] [DMG] ICR moving to [AwaitingDe]
[1756729187.818] [4637:4666] [IN] SecureSession[0x7f8c013400]: Released - Type:1 LSID:55443
[1756729187.818] [4637:4666] [DL] Long dispatch time: 226 ms, for event type 16391
[1756729187.819] [4637:4666] [DL] HandlePlatformSpecificBLEEvent 16390
[1756729187.819] [4637:4666] [BLE] No endpoint for unsubscribe complete
[1756729187.822] [4637:4665] [DL] BLE connection closed: conn=0x559d170f30
[1756729187.823] [4637:4666] [BLE] No endpoint for connection error

Parents
  • 0

    Hello Lukasz,

    when I change the PRODUCT_ID to 0x8007, it stops working.

    Just FYI, 0x8007 is already the OTA provider (https://github.com/nrfconnect/sdk-connectedhomeip/blob/v3.1.0/docs/examples/discussion/PID_allocation_for_example_apps.md?plain=1#L30) 

    The errors during commissioning (Failed Device Attestation, and "Attestation signature failed to validate against DAC subject public key" are typically thrown when there's a mismatch between PID you program into the device and the PID encoded in the Device Attestation Certificate. I.e the DAC does not expect 0x8007. 

    A summary from another discussion:

    Why does this happen?

    • The DAC contains information about the Vendor ID (VID) and Product ID (PID) for the device. During the Device Attestation step, the commissioner (chip-tool) checks that the device's reported VID and PID match those in the DAC.
    • If you change the PID on the device (for example, from 0x8006 to 0x8007) but do not regenerate the DAC to include the new PID, the attestation will fail because the information is inconsistent. The signature validation will also fail if the attestation elements (including PID) do not match what is in the DAC, leading to the error you see.

    How to resolve:

    • When you change the PID, you must also regenerate the DAC (and possibly the PAI) to include the new PID. The factory data written to the device must be consistent with the certificates provided.
    • The Nordic documentation explains that the DAC is created using the PAI and contains the VID and PID for the given device. These are checked and validated by the commissioner at the start of commissioning.
    • If you use mismatched or default certificates, or only change the PID in the device configuration but not in the DAC, commissioning will fail at the attestation step, as you are experiencing.

    References:

    • "The DAC is a DER-encoded X.509v3-compliant certificate... and contains information about Vendor ID and Product ID for the given device. It is provided in the factory data... These are the elements that are checked and validated by the commissioner at the start of the commissioning procedure."
      Device Attestation data overview
    • "During the validation, the commissioner confirms the attestation information received against information contained on the device. For example, the Vendor ID from the attestation information packet is vetted against the Vendor ID in the DAC and the Basic Information cluster..."
      Device Attestation procedure

    Summary:
    You must regenerate the DAC (and update the factory data) whenever you change the PID. The PID in the device configuration, the factory data, and the DAC must all match for successful commissioning. If they do not, attestation will fail as you observed.

    Kind regards,
    Andreas

  • 0 in reply to AHaug

    Hi AHaug,

    Thanks for the quick reply and clarification. I tried the suggestion, but the issue persists. Here’s a concise summary of what I tested on NCS 3.0.2:

    Tested scenarios

    • Door Lock sample (as-is, PID 0x8006 / 32774): commissions fine (Apple Home, Google Home, chip-tool).

    • Door Lock sample with CONFIG_CHIP_DEVICE_PRODUCT_ID=32775 (0x8007): build regenerates factory data (DAC/PAI/key) as expected (visible in build/build.ninja); flashed full image to nRF52840; commissioning fails.

    • Custom Door Lock app, PID 0x8006 / 32774: works like the sample.

    • Custom Door Lock app, PID 0x8006 / 32774 with custom DAC/PAI: DAC PID/VID = 0x8006/0xFFF1, PAI for VID 0xFFF1 (from PKI provider). Subject/Authority Key IDs look correct and are printed by chip-tool, but commissioning still fails (same as the 0x8007 case).

    • Light Switch sample (default PID): commissions fine.

    • Light Switch sample with CONFIG_CHIP_DEVICE_PRODUCT_ID=32774 (0x8006): fails during attestation

    Questions

    1. Besides CONFIG_CHIP_DEVICE_PRODUCT_ID, are there other Kconfig/CMake/factory-data items that must be kept in sync (e.g., PID/VID in factory data, certificate templates, Certification Declaration, or build-time attestation artifacts)?

    2. Are there any known limitations or issues in NCS 3.0.2 when changing PID between samples?

    3. What would help most for diagnosis?

    Best regards,
    Lukasz

  • 0 in reply to LukaWer

    Hi,

    I've requeried the Matter team.

    Do you have the new certificates included in the chip-tool pairing command? Chip-tool uses the default certificates unless you specify the path to the new certificates with --paa-trust-store-path

    https://docs.nordicsemi.com/bundle/ncs-latest/page/matter/chip_tool_guide.html#attestation-related_…

    Kind regards,
    Andreas

  • +1 in reply to AHaug

    Some more input from the Matter team

    cd samples/matter/lock

west build -p -b <board>
west flash --erase --skip-rebuild

# Commissioning works

west build -p -b <board> -- -DCONFIG_CHIP_DEVICE_PRODUCT_ID=32775
west flash --erase --skip-rebuild

# Commissioning works

     

    Then they saw that you and I haven't discussed the --erase flag.. And when performing this test, they got the exactly same error that signature is incorrect.

     

    cd samples/matter/lock

west build -p -b <board>
west flash --erase --skip-rebuild

# Commissioning works

west build -p -b <board> -- -DCONFIG_CHIP_DEVICE_PRODUCT_ID=32775
west flash --skip-rebuild

# Commissioning fails

    They believe the reason for this is the following feature (and its KConfig option): CHIP_CRYPTO_PSA_MIGRATE_DAC_PRIV_KEY.

    This option is enabled by default. On the first boot, the DAC is copied to either ITS (Settings) or KMU (the KMU peripheral on nRF54LX).

    Note that neither Settings nor KMU is cleared when flashing without --erase. Thus different PID is in the FW and different DAC Private Key is in the Settings/KMU.

    Does this make sense? Could you check if this resolves the issue? I know you  also had some questions regarding the Certificate Declaration, but let’s first focus on the original problem, as the CD issue might be resolved automatically as well.

    Kind regards,
    Andreas

  • 0 in reply to AHaug

      Thank you so much! 
    CHIP_CRYPTO_PSA_MIGRATE_DAC_PRIV_KEY did the trick.

    Does it make sense to have it turned on using nrf52840?

    Do you have any documentation how to get custom CD from test net? Distributed Compliance Ledger

  • 0 in reply to LukaWer

    Hi,

    Glad to hear that it helped!

    LukaWer said:
    Does it make sense to have it turned on using nrf52840?

    Yes, for the nRF52840 the DAC Private Key is migrated to ITS (settings) instead of KMU. But the mechanism is the same i.e --erase does not erase the old DAC Private Key and new DAC Private Key from factory data partition, will not replace the old one.

    LukaWer said:
    Do you have any documentation how to get custom CD from test net? Distributed Compliance Ledger

    The Nordic documentation does not provide a full walkthrough for fetching a CD from the DCL testnet, but it does cover generating test CDs and interacting with the DCL for vendor/device recordsGenerating Certification Declaration for integration testing, DCL usage, but step-by-step instructions should be found here DCL Quick Start Guide 

    Kind regards,
    Andreas

Reply Children
No Data
Related
Terms of service