Door Lock Pairing Issue

Problem
Pairing of door lock is not working.
Logs:
DoorLock.txt

@sethunk The attached log shows pairing is fine.. Can you attach the correct log ?

Have recaptured the logs and attached the logs with today date
Pls note that in the previous logs also commands are not working.

Have recaptured the logs and attached the logs with today date
Pls note that in the previous logs also commands are not working.
In door lock pairing,
Scenario -1 : With ble, pairing is not working.
Scenario -2 : With ethernet, it is commissioned with a particular endpoint (eg: 0)  but when we execute the attributes for that endpoint, we get the response as 0xc3-Unsupported Cluster.
When we execute the attributes with other endpoint (eg: 1) , we get the response for that attribute.
Logs:
ble
Doorlock_cntrl_11.03.2022.txt
Doorlock_dut_11.03.2022.txt
ethernet
Doorlock_cntrl-ethernet_11.03.2022.txt
Doorlock_dut-ethernet_11.03.2022.txt

Still not able to pair DUT with Cntrl for door-lock app with out "main.cpp" work around.
Commit used : 41a431dcc7c123699818636afd01b57412a6f3a4
Error Issue :
ubuntu@matter-7:~/cntrl/connectedhomeip/examples/chip-tool/out/debug$ ./chip-tool pairing ble-wifi 1 chipsetup3 matter123 20202021 3840
[1649147087.797286][17465:17465] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_kvs
[1649147087.797609][17465:17465] CHIP:DL: writing settings to file (/tmp/chip_kvs-ddt2XS)
[1649147087.797816][17465:17465] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs)
[1649147087.798227][17465:17465] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_factory.ini
[1649147087.798380][17465:17465] CHIP:DL: writing settings to file (/tmp/chip_factory.ini-yxkW9A)
[1649147087.798524][17465:17465] CHIP:DL: renamed tmp file to file (/tmp/chip_factory.ini)
[1649147087.798610][17465:17465] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_config.ini
[1649147087.798776][17465:17465] CHIP:DL: writing settings to file (/tmp/chip_config.ini-srL8vC)
[1649147087.798912][17465:17465] CHIP:DL: renamed tmp file to file (/tmp/chip_config.ini)
[1649147087.798995][17465:17465] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_counters.ini
[1649147087.799127][17465:17465] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-iT43hS)
[1649147087.799251][17465:17465] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1649147087.799511][17465:17465] CHIP:DL: writing settings to file (/tmp/chip_factory.ini-jl1qBS)
[1649147087.800049][17465:17465] CHIP:DL: renamed tmp file to file (/tmp/chip_factory.ini)
[1649147087.800103][17465:17465] CHIP:DL: NVS set: chip-factory/unique-id = "33326BDBE2C7802A"
[1649147087.800260][17465:17465] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-INYUVb)
[1649147087.800644][17465:17465] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1649147087.800690][17465:17465] CHIP:DL: NVS set: chip-counters/reboot-count = 1 (0x1)
[1649147087.800832][17465:17465] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-Tob45T)
[1649147087.802224][17465:17465] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1649147087.802277][17465:17465] CHIP:DL: NVS set: chip-counters/total-operational-hours = 0 (0x0)
[1649147087.802436][17465:17465] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-gh4LiN)
[1649147087.803476][17465:17465] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1649147087.803535][17465:17465] CHIP:DL: NVS set: chip-counters/boot-reason = 0 (0x0)
[1649147087.803700][17465:17465] CHIP:DL: writing settings to file (/tmp/chip_config.ini-HWuFb2)
[1649147087.804085][17465:17465] CHIP:DL: renamed tmp file to file (/tmp/chip_config.ini)
[1649147087.804127][17465:17465] CHIP:DL: NVS set: chip-config/regulatory-location = 0 (0x0)
[1649147087.804258][17465:17465] CHIP:DL: writing settings to file (/tmp/chip_config.ini-es9Tdd)
[1649147087.806086][17465:17465] CHIP:DL: renamed tmp file to file (/tmp/chip_config.ini)
[1649147087.806175][17465:17465] CHIP:DL: NVS set: chip-config/location-capability = 0 (0x0)
[1649147087.807470][17465:17465] CHIP:DL: Got Ethernet interface: eth0
[1649147087.808250][17465:17465] CHIP:DL: Found the primary Ethernet interface:eth0
[1649147087.809028][17465:17465] CHIP:DL: Got WiFi interface: wlan0
[1649147087.809121][17465:17465] CHIP:DL: Failed to reset WiFi statistic counts
[1649147087.809219][17465:17465] CHIP:IN: UDP::Init bind&listen port=0
[1649147087.809383][17465:17465] CHIP:IN: UDP::Init bound to port=35354
[1649147087.809417][17465:17465] CHIP:IN: BLEBase::Init - setting/overriding transport
[1649147087.809445][17465:17465] CHIP:IN: TransportMgr initialized
[1649147087.809489][17465:17465] CHIP:DIS: Init fabric pairing table with server storage
[1649147087.809546][17465:17465] CHIP:DIS: Add fabric pairing table delegate
[1649147087.809856][17465:17465] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-Zrh6vW)
[1649147087.810609][17465:17465] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1649147087.810721][17465:17465] CHIP:DL: NVS set: chip-counters/GlobalMCTR = 1000 (0x3E8)
[1649147087.813278][17465:17465] CHIP:ZCL: Using ZAP configuration...
[1649147087.818479][17465:17465] CHIP:DL: Avahi client registered
[1649147087.820111][17465:17465] CHIP:CTL: System State Initialized...
[1649147087.820239][17465:17465] CHIP:CTL: Setting attestation nonce to random value
[1649147087.820309][17465:17465] CHIP:CTL: Setting CSR nonce to random value
[1649147087.820407][17465:17465] CHIP:IN: UDP::Init bind&listen port=5550
[1649147087.820582][17465:17465] CHIP:IN: UDP::Init bound to port=5550
[1649147087.820616][17465:17465] CHIP:IN: TransportMgr initialized
[1649147087.820719][17465:17465] CHIP:CTL: Setting attestation nonce to random value
[1649147087.820788][17465:17465] CHIP:CTL: Setting CSR nonce to random value
[1649147087.821334][17465:17465] CHIP:CTL: Couldn't get ExampleOpCredsCAKey from storage: ../../config/PersistentStorage.cpp:108: CHIP Error 0x000000A0: Value not found in the persisted storage
[1649147087.825207][17465:17465] CHIP:CTL: Couldn't get ExampleOpCredsICAKey from storage: ../../config/PersistentStorage.cpp:108: CHIP Error 0x000000A0: Value not found in the persisted storage
[1649147087.827203][17465:17465] CHIP:CTL: Generating RCAC
[1649147087.828583][17465:17465] CHIP:CTL: Generating ICAC
[1649147087.830132][17465:17465] CHIP:CTL: Generating NOC
[1649147087.831345][17465:17465] CHIP:DIS: Verifying the received credentials
[1649147087.833610][17465:17465] CHIP:DIS: Added new fabric at index: 1, Initialized: 1
[1649147087.833661][17465:17465] CHIP:DIS: Assigned compressed fabric ID: 0x208EDC6679386D73, node ID: 0x000000000001B669
[1649147087.843399][17465:17465] CHIP:DIS: Fabric (1) persisted to storage. Calling OnFabricPersistedToStorage
[1649147087.844180][17465:17465] CHIP:CTL: Joined the fabric at index 1. Compressed fabric ID is: 0x208EDC6679386D73
[1649147087.844256][17465:17465] CHIP:IN: UDP::Init bind&listen port=5550
[1649147087.844388][17465:17465] CHIP:IN: UDP::Init bound to port=5550
[1649147087.844416][17465:17465] CHIP:IN: TransportMgr initialized
[1649147087.844519][17465:17465] CHIP:CTL: Setting attestation nonce to random value
[1649147087.844588][17465:17465] CHIP:CTL: Setting CSR nonce to random value
[1649147087.845916][17465:17465] CHIP:CTL: Generating NOC
[1649147087.847189][17465:17465] CHIP:DIS: Verifying the received credentials
[1649147087.849818][17465:17465] CHIP:DIS: Added new fabric at index: 2, Initialized: 1
[1649147087.849868][17465:17465] CHIP:DIS: Assigned compressed fabric ID: 0x56626841E45A28AE, node ID: 0x000000000001B669
[1649147087.854602][17465:17465] CHIP:DIS: Fabric (2) persisted to storage. Calling OnFabricPersistedToStorage
[1649147087.855765][17465:17465] CHIP:CTL: Joined the fabric at index 2. Compressed fabric ID is: 0x56626841E45A28AE
[1649147087.855859][17465:17465] CHIP:IN: UDP::Init bind&listen port=5550
[1649147087.856033][17465:17465] CHIP:IN: UDP::Init bound to port=5550
[1649147087.856070][17465:17465] CHIP:IN: TransportMgr initialized
[1649147087.856179][17465:17465] CHIP:CTL: Setting attestation nonce to random value
[1649147087.856269][17465:17465] CHIP:CTL: Setting CSR nonce to random value
[1649147087.858075][17465:17465] CHIP:CTL: Generating NOC
[1649147087.859104][17465:17465] CHIP:DIS: Verifying the received credentials
[1649147087.860815][17465:17465] CHIP:DIS: Added new fabric at index: 3, Initialized: 1
[1649147087.860849][17465:17465] CHIP:DIS: Assigned compressed fabric ID: 0x086BC8D7B8C31981, node ID: 0x000000000001B669
[1649147087.866813][17465:17465] CHIP:DIS: Fabric (3) persisted to storage. Calling OnFabricPersistedToStorage
[1649147087.868041][17465:17465] CHIP:CTL: Joined the fabric at index 3.  Attempting to connect.
[1649147089.900673][17465:17468] CHIP:BLE: Scan complete notification without an active scan.
[1649147095.163720][17465:17468] CHIP:DL: ConnectDevice complete
[1649147096.538458][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0006
[1649147096.538628][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.538693][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0006
[1649147096.538724][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.538757][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0006
[1649147096.538786][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.538828][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.538857][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.538892][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.538920][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.538964][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0006
[1649147096.538993][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539025][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0006
[1649147096.539053][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539085][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0006
[1649147096.539112][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539151][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0006
[1649147096.539179][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539212][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0006
[1649147096.539239][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539271][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0006
[1649147096.539299][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539339][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0006
[1649147096.539368][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539400][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0006
[1649147096.539428][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539459][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0006
[1649147096.539487][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539523][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0010
[1649147096.539551][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539583][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0010
[1649147096.539610][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539642][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0010
[1649147096.539671][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539707][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539735][17465:17468] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_30_E6_82/service0019
[1649147096.539774][17465:17468] CHIP:DL: New BLE connection 0xffff6c0600f0, device E4:5F:01:30:E6:82, path /org/bluez/hci0/dev_E4_5F_01_30_E6_82
[1649147096.539917][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16385
[1649147096.539963][17465:17471] CHIP:IN: BleConnectionComplete: endPoint 0xaaaacafa0a78
[1649147096.722922][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147096.820960][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16388
[1649147096.821058][17465:17471] CHIP:BLE: subscribe complete, ep = 0xaaaacafa0a78
[1649147096.821358][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147096.821590][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147096.821668][17465:17471] CHIP:BLE: peripheral chose BTP version 4; central expected between 4 and 4
[1649147096.821730][17465:17471] CHIP:BLE: using BTP fragment sizes rx 244 / tx 244.
[1649147096.821781][17465:17471] CHIP:BLE: local and remote recv window size = 6
[1649147096.821973][17465:17471] CHIP:IN: BLE EndPoint 0xaaaacafa0a78 Connection Complete
[1649147096.917904][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147096.921033][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147096.921281][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147096.921495][17465:17471] CHIP:EM: Received message of type 0x21 with protocolId (0, 0) and MessageCounter:4089796863 on exchange 43508i
[1649147096.921569][17465:17471] CHIP:EM: Found matching exchange: 43508i, Delegate: 0xffff70001788
[1649147096.921658][17465:17471] CHIP:SC: Received PBKDF param response
[1649147096.921753][17465:17471] CHIP:SC: Peer assigned session ID 54241
[1649147096.921829][17465:17471] CHIP:SC: Found MRP parameters in the message
[1649147096.932252][17465:17471] CHIP:IN: Prepared unauthenticated message 0xffff7a7cd7e8 to 0x0000000000000000 (0)  of type 0x22 and protocolId (0, 0) on exchange 43508i with MessageCounter:3318881145.
[1649147096.932336][17465:17471] CHIP:IN: Sending unauthenticated msg 0xffff7a7cd7e8 with MessageCounter:3318881145 to 0x0000000000000000 at monotonic time:<PHONE_NUMBER>EB4BC1 msec
[1649147096.932473][17465:17471] CHIP:SC: Sent spake2p msg1
[1649147097.015766][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147097.018532][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147097.018774][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147097.018981][17465:17471] CHIP:EM: Received message of type 0x23 with protocolId (0, 0) and MessageCounter:4089796864 on exchange 43508i
[1649147097.019058][17465:17471] CHIP:EM: Found matching exchange: 43508i, Delegate: 0xffff70001788
[1649147097.019145][17465:17471] CHIP:SC: Received spake2p msg2
[1649147097.021869][17465:17471] CHIP:IN: Prepared unauthenticated message 0xffff7a7cd928 to 0x0000000000000000 (0)  of type 0x24 and protocolId (0, 0) on exchange 43508i with MessageCounter:3318881146.
[1649147097.021940][17465:17471] CHIP:IN: Sending unauthenticated msg 0xffff7a7cd928 with MessageCounter:3318881146 to 0x0000000000000000 at monotonic time:<PHONE_NUMBER>EB4C1B msec
[1649147097.022065][17465:17471] CHIP:SC: Sent spake2p msg3
[1649147097.112845][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147097.114021][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147097.114198][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147097.114364][17465:17471] CHIP:EM: Received message of type 0x40 with protocolId (0, 0) and MessageCounter:4089796865 on exchange 43508i
[1649147097.114423][17465:17471] CHIP:EM: Found matching exchange: 43508i, Delegate: 0xffff70001788
[1649147097.114508][17465:17471] CHIP:IN: New secure session created for device 0x0000000000000001, LSID:14409 PSID:54241!
[1649147097.114630][17465:17471] CHIP:CTL: Remote device completed SPAKE2+ handshake
[1649147097.114719][17465:17471] CHIP:TOO: Pairing Success
[1649147097.114769][17465:17471] CHIP:CTL: Going from commissioning step 'SecurePairing' with lastErr = '../../third_party/connectedhomeip/src/controller/AutoCommissioner.cpp:253: Success' --> 'ReadCommissioningInfo'
[1649147097.114819][17465:17471] CHIP:CTL: Performing next commissioning step 'ReadCommissioningInfo' with completion status = '../../third_party/connectedhomeip/src/controller/CommissioningDelegate.h:340: Success'
[1649147097.114861][17465:17471] CHIP:CTL: Sending request for commissioning information
[1649147097.114922][17465:17471] CHIP:DMG: SendReadRequest ReadClient[0xffff7000e410]: Sending Read Request
[1649147097.115107][17465:17471] CHIP:IN: Prepared secure message 0xffff7a7cd268 to 0x0000000000000001 (1)  of type 0x2 and protocolId (0, 1) on exchange 43509i with MessageCounter:8802811.
[1649147097.115182][17465:17471] CHIP:IN: Sending encrypted msg 0xffff7a7cd268 with MessageCounter:8802811 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>EB4C78 msec
[1649147097.115335][17465:17471] CHIP:DMG: MoveToState ReadClient[0xffff7000e410]: Moving to [AwaitingIn]
[1649147097.209884][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147097.258938][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147097.259209][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147097.356913][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147097.357163][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147097.357405][17465:17471] CHIP:EM: Received message of type 0x5 with protocolId (0, 1) and MessageCounter:7189229 on exchange 43509i
[1649147097.357485][17465:17471] CHIP:EM: Found matching exchange: 43509i, Delegate: 0xffff7000e410
[1649147097.357695][17465:17471] CHIP:DMG: ReportDataMessage =
[1649147097.357759][17465:17471] CHIP:DMG: {
[1649147097.357812][17465:17471] CHIP:DMG:      AttributeReportIBs =
[1649147097.357888][17465:17471] CHIP:DMG:      [
[1649147097.357949][17465:17471] CHIP:DMG:              AttributeReportIB =
[1649147097.358042][17465:17471] CHIP:DMG:              {
[1649147097.358107][17465:17471] CHIP:DMG:                      AttributeDataIB =
[1649147097.358190][17465:17471] CHIP:DMG:                      {
[1649147097.358272][17465:17471] CHIP:DMG:                              DataVersion = 0xdf5d2687,
[1649147097.358344][17465:17471] CHIP:DMG:                              AttributePathIB =
[1649147097.358423][17465:17471] CHIP:DMG:                              {
[1649147097.358513][17465:17471] CHIP:DMG:                                      Endpoint = 0x0,
[1649147097.358600][17465:17471] CHIP:DMG:                                      Cluster = 0x31,
[1649147097.358741][17465:17471] CHIP:DMG:                                      Attribute = 0x0000_0003,
[1649147097.358828][17465:17471] CHIP:DMG:                              }
[1649147097.358914][17465:17471] CHIP:DMG:
[1649147097.359000][17465:17471] CHIP:DMG:                                      Data = 0,
[1649147097.359088][17465:17471] CHIP:DMG:                      },
[1649147097.359172][17465:17471] CHIP:DMG:
[1649147097.359239][17465:17471] CHIP:DMG:              },
[1649147097.359327][17465:17471] CHIP:DMG:
[1649147097.359386][17465:17471] CHIP:DMG:              AttributeReportIB =
[1649147097.359468][17465:17471] CHIP:DMG:              {
[1649147097.359537][17465:17471] CHIP:DMG:                      AttributeDataIB =
[1649147097.359621][17465:17471] CHIP:DMG:                      {
[1649147097.359700][17465:17471] CHIP:DMG:                              DataVersion = 0xef4b5b60,
[1649147097.359777][17465:17471] CHIP:DMG:                              AttributePathIB =
[1649147097.359857][17465:17471] CHIP:DMG:                              {
[1649147097.359938][17465:17471] CHIP:DMG:                                      Endpoint = 0x0,
[1649147097.360024][17465:17471] CHIP:DMG:                                      Cluster = 0x28,
[1649147097.360101][17465:17471] CHIP:DMG:                                      Attribute = 0x0000_0004,
[1649147097.360183][17465:17471] CHIP:DMG:                              }
[1649147097.360268][17465:17471] CHIP:DMG:
[1649147097.360351][17465:17471] CHIP:DMG:                                      Data = 32769,
[1649147097.360438][17465:17471] CHIP:DMG:                      },
[1649147097.360521][17465:17471] CHIP:DMG:
[1649147097.360583][17465:17471] CHIP:DMG:              },
[1649147097.360670][17465:17471] CHIP:DMG:
[1649147097.360730][17465:17471] CHIP:DMG:              AttributeReportIB =
[1649147097.360812][17465:17471] CHIP:DMG:              {
[1649147097.360880][17465:17471] CHIP:DMG:                      AttributeDataIB =
[1649147097.360963][17465:17471] CHIP:DMG:                      {
[1649147097.361042][17465:17471] CHIP:DMG:                              DataVersion = 0xef4b5b60,
[1649147097.361126][17465:17471] CHIP:DMG:                              AttributePathIB =
[1649147097.361205][17465:17471] CHIP:DMG:                              {
[1649147097.361288][17465:17471] CHIP:DMG:                                      Endpoint = 0x0,
[1649147097.361357][17465:17471] CHIP:DMG:                                      Cluster = 0x28,
[1649147097.361449][17465:17471] CHIP:DMG:                                      Attribute = 0x0000_0002,
[1649147097.361536][17465:17471] CHIP:DMG:                              }
[1649147097.361620][17465:17471] CHIP:DMG:
[1649147097.361710][17465:17471] CHIP:DMG:                                      Data = 65521,
[1649147097.361792][17465:17471] CHIP:DMG:                      },
[1649147097.361875][17465:17471] CHIP:DMG:
[1649147097.361942][17465:17471] CHIP:DMG:              },
[1649147097.362033][17465:17471] CHIP:DMG:
[1649147097.362093][17465:17471] CHIP:DMG:              AttributeReportIB =
[1649147097.362175][17465:17471] CHIP:DMG:              {
[1649147097.362238][17465:17471] CHIP:DMG:                      AttributeDataIB =
[1649147097.362300][17465:17471] CHIP:DMG:                      {
[1649147097.362370][17465:17471] CHIP:DMG:                              DataVersion = 0xb7780c2d,
[1649147097.362448][17465:17471] CHIP:DMG:                              AttributePathIB =
[1649147097.362528][17465:17471] CHIP:DMG:                              {
[1649147097.362611][17465:17471] CHIP:DMG:                                      Endpoint = 0x0,
[1649147097.362715][17465:17471] CHIP:DMG:                                      Cluster = 0x30,
[1649147097.362809][17465:17471] CHIP:DMG:                                      Attribute = 0x0000_0003,
[1649147097.362893][17465:17471] CHIP:DMG:                              }
[1649147097.362985][17465:17471] CHIP:DMG:
[1649147097.363074][17465:17471] CHIP:DMG:                                      Data = 0,
[1649147097.363162][17465:17471] CHIP:DMG:                      },
[1649147097.363251][17465:17471] CHIP:DMG:
[1649147097.363313][17465:17471] CHIP:DMG:              },
[1649147097.363404][17465:17471] CHIP:DMG:
[1649147097.363464][17465:17471] CHIP:DMG:              AttributeReportIB =
[1649147097.363545][17465:17471] CHIP:DMG:              {
[1649147097.363614][17465:17471] CHIP:DMG:                      AttributeDataIB =
[1649147097.363690][17465:17471] CHIP:DMG:                      {
[1649147097.363766][17465:17471] CHIP:DMG:                              DataVersion = 0xb7780c2d,
[1649147097.363840][17465:17471] CHIP:DMG:                              AttributePathIB =
[1649147097.363919][17465:17471] CHIP:DMG:                              {
[1649147097.364000][17465:17471] CHIP:DMG:                                      Endpoint = 0x0,
[1649147097.364085][17465:17471] CHIP:DMG:                                      Cluster = 0x30,
[1649147097.364170][17465:17471] CHIP:DMG:                                      Attribute = 0x0000_0002,
[1649147097.364247][17465:17471] CHIP:DMG:                              }
[1649147097.364332][17465:17471] CHIP:DMG:
[1649147097.364406][17465:17471] CHIP:DMG:                                      Data = 0,
[1649147097.364484][17465:17471] CHIP:DMG:                      },
[1649147097.364559][17465:17471] CHIP:DMG:
[1649147097.364626][17465:17471] CHIP:DMG:              },
[1649147097.364719][17465:17471] CHIP:DMG:
[1649147097.364778][17465:17471] CHIP:DMG:              AttributeReportIB =
[1649147097.364983][17465:17471] CHIP:DMG:              {
[1649147097.365055][17465:17471] CHIP:DMG:                      AttributeDataIB =
[1649147097.365140][17465:17471] CHIP:DMG:                      {
[1649147097.365216][17465:17471] CHIP:DMG:                              DataVersion = 0xb7780c2d,
[1649147097.365295][17465:17471] CHIP:DMG:                              AttributePathIB =
[1649147097.365372][17465:17471] CHIP:DMG:                              {
[1649147097.365454][17465:17471] CHIP:DMG:                                      Endpoint = 0x0,
[1649147097.365537][17465:17471] CHIP:DMG:                                      Cluster = 0x30,
[1649147097.365629][17465:17471] CHIP:DMG:                                      Attribute = 0x0000_0001,
[1649147097.365708][17465:17471] CHIP:DMG:                              }
[1649147097.365791][17465:17471] CHIP:DMG:
[1649147097.365868][17465:17471] CHIP:DMG:                                      Data =
[1649147097.365950][17465:17471] CHIP:DMG:                                      {
[1649147097.366044][17465:17471] CHIP:DMG:                                              0x0 = 60,
[1649147097.366139][17465:17471] CHIP:DMG:                                      },
[1649147097.366219][17465:17471] CHIP:DMG:                      },
[1649147097.366302][17465:17471] CHIP:DMG:
[1649147097.366357][17465:17471] CHIP:DMG:              },
[1649147097.366450][17465:17471] CHIP:DMG:
[1649147097.366510][17465:17471] CHIP:DMG:              AttributeReportIB =
[1649147097.366586][17465:17471] CHIP:DMG:              {
[1649147097.366615][17465:17471] CHIP:DMG:                      AttributeDataIB =
[1649147097.366650][17465:17471] CHIP:DMG:                      {
[1649147097.366749][17465:17471] CHIP:DMG:                              DataVersion = 0xb7780c2d,
[1649147097.366784][17465:17471] CHIP:DMG:                              AttributePathIB =
[1649147097.366821][17465:17471] CHIP:DMG:                              {
[1649147097.366859][17465:17471] CHIP:DMG:                                      Endpoint = 0x0,
[1649147097.366896][17465:17471] CHIP:DMG:                                      Cluster = 0x30,
[1649147097.366930][17465:17471] CHIP:DMG:                                      Attribute = 0x0000_0000,
[1649147097.366964][17465:17471] CHIP:DMG:                              }
[1649147097.366997][17465:17471] CHIP:DMG:
[1649147097.367032][17465:17471] CHIP:DMG:                                      Data = 0,
[1649147097.367063][17465:17471] CHIP:DMG:                      },
[1649147097.367098][17465:17471] CHIP:DMG:
[1649147097.367126][17465:17471] CHIP:DMG:              },
[1649147097.367167][17465:17471] CHIP:DMG:
[1649147097.367193][17465:17471] CHIP:DMG:              AttributeReportIB =
[1649147097.367228][17465:17471] CHIP:DMG:              {
[1649147097.367257][17465:17471] CHIP:DMG:                      AttributeDataIB =
[1649147097.367292][17465:17471] CHIP:DMG:                      {
[1649147097.367326][17465:17471] CHIP:DMG:                              DataVersion = 0xdf5d2687,
[1649147097.367359][17465:17471] CHIP:DMG:                              AttributePathIB =
[1649147097.367396][17465:17471] CHIP:DMG:                              {
[1649147097.367435][17465:17471] CHIP:DMG:                                      Endpoint = 0x0,
[1649147097.367472][17465:17471] CHIP:DMG:                                      Cluster = 0x31,
[1649147097.367508][17465:17471] CHIP:DMG:                                      Attribute = 0x0000_FFFC,
[1649147097.367539][17465:17471] CHIP:DMG:                              }
[1649147097.367575][17465:17471] CHIP:DMG:
[1649147097.367607][17465:17471] CHIP:DMG:                                      Data = 2,
[1649147097.367641][17465:17471] CHIP:DMG:                      },
[1649147097.367673][17465:17471] CHIP:DMG:
[1649147097.367702][17465:17471] CHIP:DMG:              },
[1649147097.367734][17465:17471] CHIP:DMG:
[1649147097.367759][17465:17471] CHIP:DMG:      ],
[1649147097.367819][17465:17471] CHIP:DMG:
[1649147097.367846][17465:17471] CHIP:DMG:      SuppressResponse = true,
[1649147097.367874][17465:17471] CHIP:DMG:      InteractionModelRevision = 1
[1649147097.367898][17465:17471] CHIP:DMG: }
[1649147097.368748][17465:17471] CHIP:CTL: Finished commissioning step 'ReadCommissioningInfo' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1396: Success'
[1649147097.368791][17465:17471] CHIP:CTL: Going from commissioning step 'ReadCommissioningInfo' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1396: Success' --> 'ArmFailSafe'
[1649147097.368820][17465:17471] CHIP:CTL: Performing next commissioning step 'ArmFailSafe' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1396: Success'
[1649147097.368844][17465:17471] CHIP:CTL: Arming failsafe (60 seconds)
[1649147097.368918][17465:17471] CHIP:DMG: ICR moving to [AddingComm]
[1649147097.368951][17465:17471] CHIP:DMG: ICR moving to [AddedComma]
[1649147097.369060][17465:17471] CHIP:IN: Prepared secure message 0xffff7a7cce08 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 43510i with MessageCounter:8802812.
[1649147097.369105][17465:17471] CHIP:IN: Sending encrypted msg 0xffff7a7cce08 with MessageCounter:8802812 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>EB4D76 msec
[1649147097.369220][17465:17471] CHIP:DMG: ICR moving to [CommandSen]
[1649147097.454397][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147097.456536][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147097.456804][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147097.457129][17465:17471] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:7189230 on exchange 43510i
[1649147097.457212][17465:17471] CHIP:EM: Found matching exchange: 43510i, Delegate: 0xffff7000eab0
[1649147097.457306][17465:17471] CHIP:DMG: ICR moving to [ResponseRe]
[1649147097.457412][17465:17471] CHIP:DMG: InvokeResponseMessage =
[1649147097.457473][17465:17471] CHIP:DMG: {
[1649147097.457532][17465:17471] CHIP:DMG:      suppressResponse = false,
[1649147097.457594][17465:17471] CHIP:DMG:      InvokeResponseIBs =
[1649147097.457672][17465:17471] CHIP:DMG:      [
[1649147097.457732][17465:17471] CHIP:DMG:              InvokeResponseIB =
[1649147097.457811][17465:17471] CHIP:DMG:              {
[1649147097.457874][17465:17471] CHIP:DMG:                      CommandDataIB =
[1649147097.457954][17465:17471] CHIP:DMG:                      {
[1649147097.458026][17465:17471] CHIP:DMG:                              CommandPathIB =
[1649147097.458115][17465:17471] CHIP:DMG:                              {
[1649147097.458208][17465:17471] CHIP:DMG:                                      EndpointId = 0x0,
[1649147097.458286][17465:17471] CHIP:DMG:                                      ClusterId = 0x30,
[1649147097.458378][17465:17471] CHIP:DMG:                                      CommandId = 0x1,
[1649147097.458451][17465:17471] CHIP:DMG:                              },
[1649147097.458544][17465:17471] CHIP:DMG:
[1649147097.458612][17465:17471] CHIP:DMG:                              CommandData =
[1649147097.458741][17465:17471] CHIP:DMG:                              {
[1649147097.458822][17465:17471] CHIP:DMG:                                      0x0 = 0,
[1649147097.458920][17465:17471] CHIP:DMG:                                      0x1 = "",
[1649147097.459013][17465:17471] CHIP:DMG:                              },
[1649147097.459097][17465:17471] CHIP:DMG:                      },
[1649147097.459181][17465:17471] CHIP:DMG:
[1649147097.459252][17465:17471] CHIP:DMG:              },
[1649147097.459329][17465:17471] CHIP:DMG:
[1649147097.459387][17465:17471] CHIP:DMG:      ],
[1649147097.459463][17465:17471] CHIP:DMG:
[1649147097.459521][17465:17471] CHIP:DMG:      InteractionModelRevision = 1
[1649147097.459578][17465:17471] CHIP:DMG: },
[1649147097.459727][17465:17471] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0001
[1649147097.459812][17465:17471] CHIP:CTL: Received ArmFailSafe response
[1649147097.459880][17465:17471] CHIP:CTL: Finished commissioning step 'ArmFailSafe' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1548: Success'
[1649147097.459940][17465:17471] CHIP:CTL: Going from commissioning step 'ArmFailSafe' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1548: Success' --> 'ConfigRegulatory'
[1649147097.460001][17465:17471] CHIP:CTL: Performing next commissioning step 'ConfigRegulatory' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1548: Success'
[1649147097.460055][17465:17471] CHIP:CTL: Setting Regulatory Config
[1649147097.460105][17465:17471] CHIP:CTL: Device does not support configurable regulatory location
[1649147097.460208][17465:17471] CHIP:CTL: Unable to find country code, defaulting to XX
[1649147097.460333][17465:17471] CHIP:DMG: ICR moving to [AddingComm]
[1649147097.460411][17465:17471] CHIP:DMG: ICR moving to [AddedComma]
[1649147097.460582][17465:17471] CHIP:IN: Prepared secure message 0xffff7a7cc918 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 43511i with MessageCounter:8802813.
[1649147097.460729][17465:17471] CHIP:IN: Sending encrypted msg 0xffff7a7cc918 with MessageCounter:8802813 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>EB4DD2 msec
[1649147097.460939][17465:17471] CHIP:DMG: ICR moving to [CommandSen]
[1649147097.461062][17465:17471] CHIP:DMG: ICR moving to [AwaitingDe]
[1649147097.552017][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147097.553986][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147097.554238][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147097.554507][17465:17471] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:7189231 on exchange 43511i
[1649147097.554588][17465:17471] CHIP:EM: Found matching exchange: 43511i, Delegate: 0xffff7000ec00
[1649147097.554725][17465:17471] CHIP:DMG: ICR moving to [ResponseRe]
[1649147097.554832][17465:17471] CHIP:DMG: InvokeResponseMessage =
[1649147097.554893][17465:17471] CHIP:DMG: {
[1649147097.554951][17465:17471] CHIP:DMG:      suppressResponse = false,
[1649147097.555011][17465:17471] CHIP:DMG:      InvokeResponseIBs =
[1649147097.555089][17465:17471] CHIP:DMG:      [
[1649147097.555149][17465:17471] CHIP:DMG:              InvokeResponseIB =
[1649147097.555239][17465:17471] CHIP:DMG:              {
[1649147097.555304][17465:17471] CHIP:DMG:                      CommandDataIB =
[1649147097.555381][17465:17471] CHIP:DMG:                      {
[1649147097.555462][17465:17471] CHIP:DMG:                              CommandPathIB =
[1649147097.555551][17465:17471] CHIP:DMG:                              {
[1649147097.555640][17465:17471] CHIP:DMG:                                      EndpointId = 0x0,
[1649147097.555723][17465:17471] CHIP:DMG:                                      ClusterId = 0x30,
[1649147097.555812][17465:17471] CHIP:DMG:                                      CommandId = 0x3,
[1649147097.555892][17465:17471] CHIP:DMG:                              },
[1649147097.555984][17465:17471] CHIP:DMG:
[1649147097.556056][17465:17471] CHIP:DMG:                              CommandData =
[1649147097.556136][17465:17471] CHIP:DMG:                              {
[1649147097.556219][17465:17471] CHIP:DMG:                                      0x0 = 0,
[1649147097.556310][17465:17471] CHIP:DMG:                                      0x1 = "",
[1649147097.556394][17465:17471] CHIP:DMG:                              },
[1649147097.556468][17465:17471] CHIP:DMG:                      },
[1649147097.556550][17465:17471] CHIP:DMG:
[1649147097.556617][17465:17471] CHIP:DMG:              },
[1649147097.556695][17465:17471] CHIP:DMG:
[1649147097.556754][17465:17471] CHIP:DMG:      ],
[1649147097.556830][17465:17471] CHIP:DMG:
[1649147097.556889][17465:17471] CHIP:DMG:      InteractionModelRevision = 1
[1649147097.556947][17465:17471] CHIP:DMG: },
[1649147097.557089][17465:17471] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0003
[1649147097.557171][17465:17471] CHIP:CTL: Received SetRegulatoryConfig response
[1649147097.557237][17465:17471] CHIP:CTL: Finished commissioning step 'ConfigRegulatory' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1557: Success'
[1649147097.557295][17465:17471] CHIP:CTL: Going from commissioning step 'ConfigRegulatory' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1557: Success' --> 'SendPAICertificateRequest'
[1649147097.557357][17465:17471] CHIP:CTL: Performing next commissioning step 'SendPAICertificateRequest' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1557: Success'
[1649147097.557411][17465:17471] CHIP:CTL: Sending request for PAI certificate
[1649147097.557460][17465:17471] CHIP:CTL: Sending Certificate Chain request to 0xffff70001730 device
[1649147097.557577][17465:17471] CHIP:DMG: ICR moving to [AddingComm]
[1649147097.557699][17465:17471] CHIP:DMG: ICR moving to [AddedComma]
[1649147097.557867][17465:17471] CHIP:IN: Prepared secure message 0xffff7a7cc868 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 43512i with MessageCounter:8802814.
[1649147097.557961][17465:17471] CHIP:IN: Sending encrypted msg 0xffff7a7cc868 with MessageCounter:8802814 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>EB4E33 msec
[1649147097.558163][17465:17471] CHIP:DMG: ICR moving to [CommandSen]
[1649147097.558276][17465:17471] CHIP:DMG: ICR moving to [AwaitingDe]
[1649147097.649428][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147097.697515][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147097.697793][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147097.798477][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147097.798811][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147097.893875][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147097.894132][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147097.894411][17465:17471] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:7189232 on exchange 43512i
[1649147097.894490][17465:17471] CHIP:EM: Found matching exchange: 43512i, Delegate: 0xffff7000eab0
[1649147097.894588][17465:17471] CHIP:DMG: ICR moving to [ResponseRe]
[1649147097.894742][17465:17471] CHIP:DMG: InvokeResponseMessage =
[1649147097.894805][17465:17471] CHIP:DMG: {
[1649147097.894864][17465:17471] CHIP:DMG:      suppressResponse = false,
[1649147097.894926][17465:17471] CHIP:DMG:      InvokeResponseIBs =
[1649147097.895002][17465:17471] CHIP:DMG:      [
[1649147097.895063][17465:17471] CHIP:DMG:              InvokeResponseIB =
[1649147097.895150][17465:17471] CHIP:DMG:              {
[1649147097.895214][17465:17471] CHIP:DMG:                      CommandDataIB =
[1649147097.895289][17465:17471] CHIP:DMG:                      {
[1649147097.895360][17465:17471] CHIP:DMG:                              CommandPathIB =
[1649147097.895449][17465:17471] CHIP:DMG:                              {
[1649147097.895532][17465:17471] CHIP:DMG:                                      EndpointId = 0x0,
[1649147097.895611][17465:17471] CHIP:DMG:                                      ClusterId = 0x3e,
[1649147097.895703][17465:17471] CHIP:DMG:                                      CommandId = 0x3,
[1649147097.895784][17465:17471] CHIP:DMG:                              },
[1649147097.895870][17465:17471] CHIP:DMG:
[1649147097.895944][17465:17471] CHIP:DMG:                              CommandData =
[1649147097.896032][17465:17471] CHIP:DMG:                              {
[1649147097.896111][17465:17471] CHIP:DMG:                                      0x0 = [
[1649147097.896193][17465:17471] CHIP:DMG:                                              ... (byte string too long) ...
[1649147097.896281][17465:17471] CHIP:DMG:                              ]
[1649147097.896346][17465:17471] CHIP:DMG:                              },
[1649147097.896419][17465:17471] CHIP:DMG:                      },
[1649147097.896511][17465:17471] CHIP:DMG:
[1649147097.896579][17465:17471] CHIP:DMG:              },
[1649147097.896656][17465:17471] CHIP:DMG:
[1649147097.896715][17465:17471] CHIP:DMG:      ],
[1649147097.896790][17465:17471] CHIP:DMG:
[1649147097.896849][17465:17471] CHIP:DMG:      InteractionModelRevision = 1
[1649147097.896907][17465:17471] CHIP:DMG: },
[1649147097.897044][17465:17471] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0003
[1649147097.897122][17465:17471] CHIP:CTL: Received certificate chain from the device
[1649147097.897188][17465:17471] CHIP:CTL: Finished commissioning step 'SendPAICertificateRequest' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:888: Success'
[1649147097.897258][17465:17471] CHIP:CTL: Going from commissioning step 'SendPAICertificateRequest' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:888: Success' --> 'SendDACCertificateRequest'
[1649147097.897324][17465:17471] CHIP:CTL: Performing next commissioning step 'SendDACCertificateRequest' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:888: Success'
[1649147097.897380][17465:17471] CHIP:CTL: Sending request for DAC certificate
[1649147097.897428][17465:17471] CHIP:CTL: Sending Certificate Chain request to 0xffff70001730 device
[1649147097.897673][17465:17471] CHIP:DMG: ICR moving to [AddingComm]
[1649147097.897746][17465:17471] CHIP:DMG: ICR moving to [AddedComma]
[1649147097.897917][17465:17471] CHIP:IN: Prepared secure message 0xffff7a7cc818 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 43513i with MessageCounter:8802815.
[1649147097.898011][17465:17471] CHIP:IN: Sending encrypted msg 0xffff7a7cc818 with MessageCounter:8802815 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>EB4F87 msec
[1649147097.898219][17465:17471] CHIP:DMG: ICR moving to [CommandSen]
[1649147097.898340][17465:17471] CHIP:DMG: ICR moving to [AwaitingDe]
[1649147097.990821][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147098.039148][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147098.039418][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147098.139728][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147098.139988][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147098.235206][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147098.235462][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147098.235742][17465:17471] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:7189233 on exchange 43513i
[1649147098.235823][17465:17471] CHIP:EM: Found matching exchange: 43513i, Delegate: 0xffff7000ec00
[1649147098.235920][17465:17471] CHIP:DMG: ICR moving to [ResponseRe]
[1649147098.236025][17465:17471] CHIP:DMG: InvokeResponseMessage =
[1649147098.236086][17465:17471] CHIP:DMG: {
[1649147098.236145][17465:17471] CHIP:DMG:      suppressResponse = false,
[1649147098.236207][17465:17471] CHIP:DMG:      InvokeResponseIBs =
[1649147098.236284][17465:17471] CHIP:DMG:      [
[1649147098.236344][17465:17471] CHIP:DMG:              InvokeResponseIB =
[1649147098.236437][17465:17471] CHIP:DMG:              {
[1649147098.236502][17465:17471] CHIP:DMG:                      CommandDataIB =
[1649147098.236571][17465:17471] CHIP:DMG:                      {
[1649147098.236643][17465:17471] CHIP:DMG:                              CommandPathIB =
[1649147098.236725][17465:17471] CHIP:DMG:                              {
[1649147098.236808][17465:17471] CHIP:DMG:                                      EndpointId = 0x0,
[1649147098.236897][17465:17471] CHIP:DMG:                                      ClusterId = 0x3e,
[1649147098.236979][17465:17471] CHIP:DMG:                                      CommandId = 0x3,
[1649147098.237059][17465:17471] CHIP:DMG:                              },
[1649147098.237141][17465:17471] CHIP:DMG:
[1649147098.237222][17465:17471] CHIP:DMG:                              CommandData =
[1649147098.237303][17465:17471] CHIP:DMG:                              {
[1649147098.237384][17465:17471] CHIP:DMG:                                      0x0 = [
[1649147098.237464][17465:17471] CHIP:DMG:                                              ... (byte string too long) ...
[1649147098.237555][17465:17471] CHIP:DMG:                              ]
[1649147098.237628][17465:17471] CHIP:DMG:                              },
[1649147098.237698][17465:17471] CHIP:DMG:                      },
[1649147098.237782][17465:17471] CHIP:DMG:
[1649147098.237849][17465:17471] CHIP:DMG:              },
[1649147098.237931][17465:17471] CHIP:DMG:
[1649147098.237990][17465:17471] CHIP:DMG:      ],
[1649147098.238066][17465:17471] CHIP:DMG:
[1649147098.238126][17465:17471] CHIP:DMG:      InteractionModelRevision = 1
[1649147098.238184][17465:17471] CHIP:DMG: },
[1649147098.238328][17465:17471] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0003
[1649147098.238409][17465:17471] CHIP:CTL: Received certificate chain from the device
[1649147098.238476][17465:17471] CHIP:CTL: Finished commissioning step 'SendDACCertificateRequest' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:888: Success'
[1649147098.238543][17465:17471] CHIP:CTL: Going from commissioning step 'SendDACCertificateRequest' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:888: Success' --> 'SendAttestationRequest'
[1649147098.238606][17465:17471] CHIP:CTL: Performing next commissioning step 'SendAttestationRequest' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:888: Success'
[1649147098.238713][17465:17471] CHIP:CTL: Sending Attestation Request to the device.
[1649147098.238773][17465:17471] CHIP:CTL: Sending Attestation request to 0xffff70001730 device
[1649147098.238896][17465:17471] CHIP:DMG: ICR moving to [AddingComm]
[1649147098.238971][17465:17471] CHIP:DMG: ICR moving to [AddedComma]
[1649147098.239148][17465:17471] CHIP:IN: Prepared secure message 0xffff7a7cc7d8 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 43514i with MessageCounter:8802816.
[1649147098.239245][17465:17471] CHIP:IN: Sending encrypted msg 0xffff7a7cc7d8 with MessageCounter:8802816 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>EB50DC msec
[1649147098.239471][17465:17471] CHIP:DMG: ICR moving to [CommandSen]
[1649147098.239549][17465:17471] CHIP:CTL: Sent Attestation request, waiting for the Attestation Information
[1649147098.239657][17465:17471] CHIP:DMG: ICR moving to [AwaitingDe]
[1649147098.331798][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147098.380121][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147098.380388][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147098.480947][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147098.481220][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147098.577887][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147098.578078][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147098.578306][17465:17471] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:7189234 on exchange 43514i
[1649147098.578359][17465:17471] CHIP:EM: Found matching exchange: 43514i, Delegate: 0xffff7000eab0
[1649147098.578426][17465:17471] CHIP:DMG: ICR moving to [ResponseRe]
[1649147098.578504][17465:17471] CHIP:DMG: InvokeResponseMessage =
[1649147098.578545][17465:17471] CHIP:DMG: {
[1649147098.578584][17465:17471] CHIP:DMG:      suppressResponse = false,
[1649147098.578624][17465:17471] CHIP:DMG:      InvokeResponseIBs =
[1649147098.578732][17465:17471] CHIP:DMG:      [
[1649147098.578774][17465:17471] CHIP:DMG:              InvokeResponseIB =
[1649147098.578829][17465:17471] CHIP:DMG:              {
[1649147098.578871][17465:17471] CHIP:DMG:                      CommandDataIB =
[1649147098.578925][17465:17471] CHIP:DMG:                      {
[1649147098.578972][17465:17471] CHIP:DMG:                              CommandPathIB =
[1649147098.579027][17465:17471] CHIP:DMG:                              {
[1649147098.579083][17465:17471] CHIP:DMG:                                      EndpointId = 0x0,
[1649147098.579141][17465:17471] CHIP:DMG:                                      ClusterId = 0x3e,
[1649147098.579199][17465:17471] CHIP:DMG:                                      CommandId = 0x1,
[1649147098.579254][17465:17471] CHIP:DMG:                              },
[1649147098.579311][17465:17471] CHIP:DMG:
[1649147098.579361][17465:17471] CHIP:DMG:                              CommandData =
[1649147098.579414][17465:17471] CHIP:DMG:                              {
[1649147098.579467][17465:17471] CHIP:DMG:                                      0x0 = [
[1649147098.579521][17465:17471] CHIP:DMG:                                              ... (byte string too long) ...
[1649147098.579585][17465:17471] CHIP:DMG:                              ]
[1649147098.579643][17465:17471] CHIP:DMG:                                      0x1 = [
[1649147098.579721][17465:17471] CHIP:DMG:                                              0x3, 0x3, 0x9b, 0x8e, 0x93, 0x65, 0x51, 0x28, 0x82, 0xce, 0x75, 0x98, 0xe, 0x87, 0x96, 0xd8, 0xfb, 0xa0, 0xd3, 0xf2, 0x57, 0x9b, 0x66, 0xe, 0x8, 0xbb, 0xcb, 0x4b, 0xc3, 0x23, 0xe8, 0xf5, 0xe, 0x66, 0x83, 0x1f, 0x46, 0xdb, 0x59, 0x27, 0xd7, 0x7d, 0x6
[1649147098.579786][17465:17471] CHIP:DMG:                              ]
[1649147098.579840][17465:17471] CHIP:DMG:                              },
[1649147098.579891][17465:17471] CHIP:DMG:                      },
[1649147098.579949][17465:17471] CHIP:DMG:
[1649147098.579990][17465:17471] CHIP:DMG:              },
[1649147098.580043][17465:17471] CHIP:DMG:
[1649147098.580083][17465:17471] CHIP:DMG:      ],
[1649147098.580135][17465:17471] CHIP:DMG:
[1649147098.580174][17465:17471] CHIP:DMG:      InteractionModelRevision = 1
[1649147098.580208][17465:17471] CHIP:DMG: },
[1649147098.580304][17465:17471] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0001
[1649147098.580363][17465:17471] CHIP:CTL: Received Attestation Information from the device
[1649147098.580411][17465:17471] CHIP:CTL: Finished commissioning step 'SendAttestationRequest' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:923: Success'
[1649147098.580516][17465:17471] CHIP:CTL: Going from commissioning step 'SendAttestationRequest' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:923: Success' --> 'AttestationVerification'
[1649147098.580561][17465:17471] CHIP:CTL: Performing next commissioning step 'AttestationVerification' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:923: Success'
[1649147098.580598][17465:17471] CHIP:CTL: Verifying attestation
[1649147098.588928][17465:17471] CHIP:CTL: Successfully validated 'Attestation Information' command received from the device.
[1649147098.588994][17465:17471] CHIP:CTL: Finished commissioning step 'AttestationVerification' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:955: Success'
[1649147098.589025][17465:17471] CHIP:CTL: Going from commissioning step 'AttestationVerification' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:955: Success' --> 'SendOpCertSigningRequest'
[1649147098.589055][17465:17471] CHIP:CTL: Performing next commissioning step 'SendOpCertSigningRequest' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:955: Success'
[1649147098.589083][17465:17471] CHIP:CTL: Sending CSR request to 0xffff70001730 device
[1649147098.589165][17465:17471] CHIP:DMG: ICR moving to [AddingComm]
[1649147098.589202][17465:17471] CHIP:DMG: ICR moving to [AddedComma]
[1649147098.589321][17465:17471] CHIP:IN: Prepared secure message 0xffff7a7cbd88 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 43515i with MessageCounter:8802817.
[1649147098.589370][17465:17471] CHIP:IN: Sending encrypted msg 0xffff7a7cbd88 with MessageCounter:8802817 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>EB523A msec
[1649147098.589499][17465:17471] CHIP:DMG: ICR moving to [CommandSen]
[1649147098.589534][17465:17471] CHIP:CTL: Sent CSR request, waiting for the CSR
[1649147098.589591][17465:17471] CHIP:DMG: ICR moving to [AwaitingDe]
[1649147098.673127][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147098.721091][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147098.721310][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147098.820642][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147098.820855][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147098.821055][17465:17471] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:7189235 on exchange 43515i
[1649147098.821110][17465:17471] CHIP:EM: Found matching exchange: 43515i, Delegate: 0xffff6c07da20
[1649147098.821180][17465:17471] CHIP:DMG: ICR moving to [ResponseRe]
[1649147098.821257][17465:17471] CHIP:DMG: InvokeResponseMessage =
[1649147098.821298][17465:17471] CHIP:DMG: {
[1649147098.821337][17465:17471] CHIP:DMG:      suppressResponse = false,
[1649147098.821386][17465:17471] CHIP:DMG:      InvokeResponseIBs =
[1649147098.821439][17465:17471] CHIP:DMG:      [
[1649147098.821479][17465:17471] CHIP:DMG:              InvokeResponseIB =
[1649147098.821536][17465:17471] CHIP:DMG:              {
[1649147098.821581][17465:17471] CHIP:DMG:                      CommandDataIB =
[1649147098.821638][17465:17471] CHIP:DMG:                      {
[1649147098.821688][17465:17471] CHIP:DMG:                              CommandPathIB =
[1649147098.821747][17465:17471] CHIP:DMG:                              {
[1649147098.821809][17465:17471] CHIP:DMG:                                      EndpointId = 0x0,
[1649147098.821867][17465:17471] CHIP:DMG:                                      ClusterId = 0x3e,
[1649147098.821924][17465:17471] CHIP:DMG:                                      CommandId = 0x5,
[1649147098.821972][17465:17471] CHIP:DMG:                              },
[1649147098.822029][17465:17471] CHIP:DMG:
[1649147098.822074][17465:17471] CHIP:DMG:                              CommandData =
[1649147098.822128][17465:17471] CHIP:DMG:                              {
[1649147098.822177][17465:17471] CHIP:DMG:                                      0x0 = [
[1649147098.822266][17465:17471] CHIP:DMG:                                              0x15, 0x30, 0x1, 0xcb, 0x30, 0x81, 0xc8, 0x30, 0x70, 0x2, 0x1, 0x0, 0x30, 0xe, 0x31, 0xc, 0x30, 0xa, 0x6, 0x3, 0x55, 0x4, 0xa, 0xc, 0x3, 0x43, 0x53, 0x52, 0x30, 0x59, 0x30, 0x13, 0x6, 0x7, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x2, 0x1, 0x6, 0x8, 0x2a, 0x86
[1649147098.822331][17465:17471] CHIP:DMG:                              ]
[1649147098.822379][17465:17471] CHIP:DMG:                                      0x1 = [
[1649147098.822456][17465:17471] CHIP:DMG:                                              0x58, 0xb2, 0x18, 0x25, 0xa8, 0x31, 0xff, 0x6f, 0xfc, 0xa7, 0x2f, 0xef, 0x39, 0x68, 0xfd, 0xf2, 0xc2, 0x81, 0x37, 0xf1, 0x6, 0xe7, 0x90, 0x6f, 0x5a, 0x44, 0xf1, 0xdb, 0x1a, 0x3a, 0x33, 0x18, 0xf7, 0x96, 0xa1, 0x89, 0xe2, 0x18, 0xc8, 0x46, 0xcd, 0x6a
[1649147098.822511][17465:17471] CHIP:DMG:                              ]
[1649147098.822554][17465:17471] CHIP:DMG:                              },
[1649147098.822600][17465:17471] CHIP:DMG:                      },
[1649147098.822702][17465:17471] CHIP:DMG:
[1649147098.822754][17465:17471] CHIP:DMG:              },
[1649147098.822813][17465:17471] CHIP:DMG:
[1649147098.822854][17465:17471] CHIP:DMG:      ],
[1649147098.822906][17465:17471] CHIP:DMG:
[1649147098.822945][17465:17471] CHIP:DMG:      InteractionModelRevision = 1
[1649147098.822984][17465:17471] CHIP:DMG: },
[1649147098.823087][17465:17471] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0005
[1649147098.823145][17465:17471] CHIP:CTL: Received certificate signing request from the device
[1649147098.823192][17465:17471] CHIP:CTL: Finished commissioning step 'SendOpCertSigningRequest' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1004: Success'
[1649147098.823234][17465:17471] CHIP:CTL: Going from commissioning step 'SendOpCertSigningRequest' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1004: Success' --> 'GenerateNOCChain'
[1649147098.823277][17465:17471] CHIP:CTL: Performing next commissioning step 'GenerateNOCChain' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1004: Success'
[1649147098.823318][17465:17471] CHIP:CTL: Getting certificate chain for the device from the issuer
[1649147098.825045][17465:17471] CHIP:CTL: Verifying Certificate Signing Request
[1649147098.826347][17465:17471] CHIP:CTL: Generating NOC
[1649147098.826891][17465:17471] CHIP:CTL: Providing certificate chain to the commissioner
[1649147098.826944][17465:17471] CHIP:CTL: Received callback from the CA for NOC Chain generation. Status ../../third_party/connectedhomeip/src/controller/ExampleOperationalCredentialsIssuer.cpp:250: Success
[1649147098.826986][17465:17471] CHIP:CTL: Finished commissioning step 'GenerateNOCChain' with error '../../third_party/connectedhomeip/src/controller/ExampleOperationalCredentialsIssuer.cpp:250: Success'
[1649147098.827212][17465:17471] CHIP:CTL: Performing next commissioning step 'SendTrustedRootCert' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1004: Success'
[1649147098.827253][17465:17471] CHIP:CTL: Sending root certificate to the device
[1649147098.827343][17465:17471] CHIP:DMG: ICR moving to [AddingComm]
[1649147098.827389][17465:17471] CHIP:DMG: ICR moving to [AddedComma]
[1649147098.827534][17465:17471] CHIP:IN: Prepared secure message 0xffff7a7cbb38 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 43516i with MessageCounter:8802818.
[1649147098.827631][17465:17471] CHIP:IN: Sending encrypted msg 0xffff7a7cbb38 with MessageCounter:8802818 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>EB5328 msec
[1649147098.827783][17465:17471] CHIP:DMG: ICR moving to [CommandSen]
[1649147098.827830][17465:17471] CHIP:CTL: Sent root certificate to the device
[1649147098.828230][17465:17471] CHIP:DMG: ICR moving to [AwaitingDe]
[1649147098.916196][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147099.013878][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147099.015888][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147099.016139][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147099.016424][17465:17471] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:7189236 on exchange 43516i
[1649147099.016503][17465:17471] CHIP:EM: Found matching exchange: 43516i, Delegate: 0xffff7000eab0
[1649147099.016592][17465:17471] CHIP:DMG: ICR moving to [ResponseRe]
[1649147099.016692][17465:17471] CHIP:DMG: InvokeResponseMessage =
[1649147099.016753][17465:17471] CHIP:DMG: {
[1649147099.016815][17465:17471] CHIP:DMG:      suppressResponse = false,
[1649147099.016875][17465:17471] CHIP:DMG:      InvokeResponseIBs =
[1649147099.016951][17465:17471] CHIP:DMG:      [
[1649147099.017011][17465:17471] CHIP:DMG:              InvokeResponseIB =
[1649147099.017102][17465:17471] CHIP:DMG:              {
[1649147099.017171][17465:17471] CHIP:DMG:                      CommandStatusIB =
[1649147099.017256][17465:17471] CHIP:DMG:                      {
[1649147099.017337][17465:17471] CHIP:DMG:                              CommandPathIB =
[1649147099.017426][17465:17471] CHIP:DMG:                              {
[1649147099.017516][17465:17471] CHIP:DMG:                                      EndpointId = 0x0,
[1649147099.017604][17465:17471] CHIP:DMG:                                      ClusterId = 0x3e,
[1649147099.017689][17465:17471] CHIP:DMG:                                      CommandId = 0xb,
[1649147099.017769][17465:17471] CHIP:DMG:                              },
[1649147099.017859][17465:17471] CHIP:DMG:
[1649147099.017933][17465:17471] CHIP:DMG:                              StatusIB =
[1649147099.018011][17465:17471] CHIP:DMG:                              {
[1649147099.018095][17465:17471] CHIP:DMG:                                      status = 0x00 (SUCCESS),
[1649147099.018168][17465:17471] CHIP:DMG:                              },
[1649147099.018250][17465:17471] CHIP:DMG:
[1649147099.018316][17465:17471] CHIP:DMG:                      },
[1649147099.018399][17465:17471] CHIP:DMG:
[1649147099.018463][17465:17471] CHIP:DMG:              },
[1649147099.018542][17465:17471] CHIP:DMG:
[1649147099.018601][17465:17471] CHIP:DMG:      ],
[1649147099.018728][17465:17471] CHIP:DMG:
[1649147099.018792][17465:17471] CHIP:DMG:      InteractionModelRevision = 1
[1649147099.018849][17465:17471] CHIP:DMG: },
[1649147099.018990][17465:17471] CHIP:DMG: Received Command Response Status for Endpoint=0 Cluster=0x0000_003E Command=0x0000_000B Status=0x0
[1649147099.019056][17465:17471] CHIP:CTL: Device confirmed that it has received the root certificate
[1649147099.019120][17465:17471] CHIP:CTL: Finished commissioning step 'SendTrustedRootCert' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1179: Success'
[1649147099.019179][17465:17471] CHIP:CTL: Going from commissioning step 'SendTrustedRootCert' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1179: Success' --> 'SendNOC'
[1649147099.019242][17465:17471] CHIP:CTL: Performing next commissioning step 'SendNOC' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1179: Success'
[1649147099.019374][17465:17471] CHIP:DMG: ICR moving to [AddingComm]
[1649147099.019457][17465:17471] CHIP:DMG: ICR moving to [AddedComma]
[1649147099.019678][17465:17471] CHIP:IN: Prepared secure message 0xffff7a7cc808 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 43517i with MessageCounter:8802819.
[1649147099.019769][17465:17471] CHIP:IN: Sending encrypted msg 0xffff7a7cc808 with MessageCounter:8802819 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>EB53E9 msec
[1649147099.019965][17465:17471] CHIP:DMG: ICR moving to [CommandSen]
[1649147099.020033][17465:17471] CHIP:CTL: Sent operational certificate to the device
[1649147099.020131][17465:17471] CHIP:DMG: ICR moving to [AwaitingDe]
[1649147099.160382][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147099.257787][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147099.354943][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1649147099.502202][17465:17468] CHIP:DL: Indication received, conn = 0xffff6c0600f0
[1649147099.502462][17465:17471] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1649147099.502803][17465:17471] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:7189237 on exchange 43517i
[1649147099.502887][17465:17471] CHIP:EM: Found matching exchange: 43517i, Delegate: 0xffff6c07da20
[1649147099.502979][17465:17471] CHIP:DMG: ICR moving to [ResponseRe]
[1649147099.503087][17465:17471] CHIP:DMG: InvokeResponseMessage =
[1649147099.503148][17465:17471] CHIP:DMG: {
[1649147099.503207][17465:17471] CHIP:DMG:      suppressResponse = false,
[1649147099.503268][17465:17471] CHIP:DMG:      InvokeResponseIBs =
[1649147099.503345][17465:17471] CHIP:DMG:      [
[1649147099.503404][17465:17471] CHIP:DMG:              InvokeResponseIB =
[1649147099.503497][17465:17471] CHIP:DMG:              {
[1649147099.503560][17465:17471] CHIP:DMG:                      CommandDataIB =
[1649147099.503637][17465:17471] CHIP:DMG:                      {
[1649147099.503709][17465:17471] CHIP:DMG:                              CommandPathIB =
[1649147099.503790][17465:17471] CHIP:DMG:                              {
[1649147099.503874][17465:17471] CHIP:DMG:                                      EndpointId = 0x0,
[1649147099.503968][17465:17471] CHIP:DMG:                                      ClusterId = 0x3e,
[1649147099.504051][17465:17471] CHIP:DMG:                                      CommandId = 0x8,
[1649147099.504135][17465:17471] CHIP:DMG:                              },
[1649147099.504219][17465:17471] CHIP:DMG:
[1649147099.504291][17465:17471] CHIP:DMG:                              CommandData =
[1649147099.504370][17465:17471] CHIP:DMG:                              {
[1649147099.504453][17465:17471] CHIP:DMG:                                      0x0 = 0,
[1649147099.504546][17465:17471] CHIP:DMG:                                      0x1 = 1,
[1649147099.504628][17465:17471] CHIP:DMG:                              },
[1649147099.504704][17465:17471] CHIP:DMG:                      },
[1649147099.504787][17465:17471] CHIP:DMG:
[1649147099.504853][17465:17471] CHIP:DMG:              },
[1649147099.504929][17465:17471] CHIP:DMG:
[1649147099.504988][17465:17471] CHIP:DMG:      ],
[1649147099.505063][17465:17471] CHIP:DMG:
[1649147099.505121][17465:17471] CHIP:DMG:      InteractionModelRevision = 1
[1649147099.505179][17465:17471] CHIP:DMG: },
[1649147099.505322][17465:17471] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0008
[1649147099.505455][17465:17471] CHIP:CTL: Device returned status 0 on receiving the NOC
[1649147099.505517][17465:17471] CHIP:CTL: Operational credentials provisioned on device 0xffff70001730
[1649147099.505597][17465:17471] CHIP:TOO: Secure Pairing Success
[1649147099.505658][17465:17471] CHIP:CTL: Finished commissioning step 'SendNOC' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1205: Success'
[1649147099.505716][17465:17471] CHIP:CTL: Required network information not provided in commissioning parameters
[1649147099.505766][17465:17471] CHIP:CTL: Parameters supplied: wifi (yes) thread (no)
[1649147099.505815][17465:17471] CHIP:CTL: Device supports: wifi (no) thread(yes)
[1649147099.505877][17465:17471] CHIP:CTL: Going from commissioning step 'SendNOC' with lastErr = '../../third_party/connectedhomeip/src/controller/AutoCommissioner.cpp:167: CHIP Error 0x0000002F: Invalid argument' --> 'Cleanup'
[1649147099.505944][17465:17471] CHIP:CTL: Performing next commissioning step 'Cleanup' with completion status = '../../third_party/connectedhomeip/src/controller/AutoCommissioner.cpp:167: CHIP Error 0x0000002F: Invalid argument'
[1649147099.506006][17465:17471] CHIP:TOO: Device commissioning Failure: ../../third_party/connectedhomeip/src/controller/AutoCommissioner.cpp:167: CHIP Error 0x0000002F: Invalid argument
[1649147099.506110][17465:17471] CHIP:CTL: Finished commissioning step 'Cleanup' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1917: Success'
[1649147099.506227][17465:17471] CHIP:DMG: ICR moving to [AwaitingDe]
[1649147099.506741][17465:17465] CHIP:CTL: Shutting down the commissioner
[1649147099.506927][17465:17465] CHIP:CTL: Shutting down the controller
[1649147099.506999][17465:17465] CHIP:CTL: Shutting down the commissioner
[1649147099.507179][17465:17465] CHIP:CTL: Shutting down the controller
[1649147099.507242][17465:17465] CHIP:IN: Expiring all connections for fabric 1!!
[1649147099.507340][17465:17465] CHIP:CTL: Shutting down the commissioner
[1649147099.507469][17465:17465] CHIP:CTL: Shutting down the controller
[1649147099.507527][17465:17465] CHIP:IN: Expiring all connections for fabric 2!!
[1649147099.507605][17465:17465] CHIP:CTL: Shutting down the commissioner
[1649147099.507737][17465:17465] CHIP:CTL: Shutting down the controller
[1649147099.507793][17465:17465] CHIP:IN: Expiring all connections for fabric 3!!
[1649147099.507864][17465:17465] CHIP:CTL: Shutting down the System State, this will teardown the CHIP Stack
[1649147099.509710][17465:17465] CHIP:DMG: IM WH moving to [Uninitialized]
[1649147099.509790][17465:17465] CHIP:DMG: IM WH moving to [Uninitialized]
[1649147099.509842][17465:17465] CHIP:DMG: IM WH moving to [Uninitialized]
[1649147099.509890][17465:17465] CHIP:DMG: IM WH moving to [Uninitialized]
[1649147099.509942][17465:17465] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet
[1649147099.510086][17465:17465] CHIP:BLE: BleConnectionDelegate::CancelConnection is not implemented.
[1649147099.510149][17465:17465] CHIP:IN: Clearing BLE pending packets.
[1649147099.511349][17465:17465] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-Jw0X9o)
[1649147099.512546][17465:17465] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1649147099.512686][17465:17465] CHIP:DL: NVS set: chip-counters/total-operational-hours = 0 (0x0)
[1649147099.512751][17465:17465] CHIP:DL: Inet Layer shutdown
[1649147099.512807][17465:17465] CHIP:DL: BLE shutdown
[1649147099.512861][17465:17465] CHIP:BLE: Auto-closing end point's BLE connection.
[1649147099.512914][17465:17465] CHIP:DL: Closing BLE GATT connection (con 0xffff6c0600f0)
[1649147099.513025][17465:17468] CHIP:DL: BluezDisconnect peer=E4:5F:01:30:E6:82
[1649147099.514767][17465:17465] CHIP:DL: System Layer shutdown
[1649147099.514974][17465:17465] CHIP:TOO: Run command failure: ../../third_party/connectedhomeip/src/controller/AutoCommissioner.cpp:167: CHIP Error 0x0000002F: Invalid argument

Well if you read the log attentively you can see that those lines:
[1649147099.505716][17465:17471] CHIP:CTL: Required network information not provided in commissioning parameters
[1649147099.505766][17465:17471] CHIP:CTL: Parameters supplied: wifi (yes) thread (no)
[1649147099.505815][17465:17471] CHIP:CTL: Device supports: wifi (no) thread(yes)

Basically it states that the device does not support WiFi, so it makes sense that passing over wifi credentials does not work.

"Scenario -2 : With ethernet, it is commissioned with a particular endpoint (eg: 0) but when we execute the attributes for that endpoint, we get the response as 0xc3-Unsupported Cluster."
Is it expected that this device has a "Door Lock" cluster onto endpoint "0" ? If it works on "1" it just seems correct to me.

@vivien-apple Door lock works fine with wifi but only after a workaround in main.cpp file.
Expectation : Chiptool must have this fix default for doorlock
Pairing log after " main.cpp" workaround :
ubuntu@ubuntu:~/sethu-apr1/connectedhomeip/examples/chip-tool/out/debug$ ./chip-tool pairing ble-wifi 1 GRLPrivate_EXT matter123 20202021 3840
[1648813479.801267][11968:11968] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_kvs
[1648813479.801553][11968:11968] CHIP:DL: writing settings to file (/tmp/chip_kvs-Tm4Gsh)
[1648813479.801764][11968:11968] CHIP:DL: renamed tmp file to file (/tmp/chip_kvs)
[1648813479.802195][11968:11968] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_factory.ini
[1648813479.802341][11968:11968] CHIP:DL: writing settings to file (/tmp/chip_factory.ini-QN89af)
[1648813479.802481][11968:11968] CHIP:DL: renamed tmp file to file (/tmp/chip_factory.ini)
[1648813479.802569][11968:11968] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_config.ini
[1648813479.802689][11968:11968] CHIP:DL: writing settings to file (/tmp/chip_config.ini-MReYHZ)
[1648813479.802812][11968:11968] CHIP:DL: renamed tmp file to file (/tmp/chip_config.ini)
[1648813479.802891][11968:11968] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_counters.ini
[1648813479.802996][11968:11968] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-LAlLLe)
[1648813479.803114][11968:11968] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1648813479.803326][11968:11968] CHIP:DL: writing settings to file (/tmp/chip_factory.ini-9taG9G)
[1648813479.803837][11968:11968] CHIP:DL: renamed tmp file to file (/tmp/chip_factory.ini)
[1648813479.803884][11968:11968] CHIP:DL: NVS set: chip-factory/unique-id = "233E5FEEDDB5A43A"
[1648813479.804020][11968:11968] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-9mBofW)
[1648813479.804357][11968:11968] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1648813479.804400][11968:11968] CHIP:DL: NVS set: chip-counters/reboot-count = 1 (0x1)
[1648813479.804540][11968:11968] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-dUq19I)
[1648813479.805499][11968:11968] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1648813479.805560][11968:11968] CHIP:DL: NVS set: chip-counters/total-operational-hours = 0 (0x0)
[1648813479.805781][11968:11968] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-twOPZk)
[1648813479.806395][11968:11968] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1648813479.806449][11968:11968] CHIP:DL: NVS set: chip-counters/boot-reason = 0 (0x0)
[1648813479.806594][11968:11968] CHIP:DL: writing settings to file (/tmp/chip_config.ini-4suQSi)
[1648813479.807026][11968:11968] CHIP:DL: renamed tmp file to file (/tmp/chip_config.ini)
[1648813479.807075][11968:11968] CHIP:DL: NVS set: chip-config/regulatory-location = 0 (0x0)
[1648813479.807208][11968:11968] CHIP:DL: writing settings to file (/tmp/chip_config.ini-U3vaWE)
[1648813479.807763][11968:11968] CHIP:DL: renamed tmp file to file (/tmp/chip_config.ini)
[1648813479.807810][11968:11968] CHIP:DL: NVS set: chip-config/location-capability = 0 (0x0)
[1648813479.808788][11968:11968] CHIP:DL: Got Ethernet interface: eth0
[1648813479.809394][11968:11968] CHIP:DL: Found the primary Ethernet interface:eth0
[1648813479.810048][11968:11968] CHIP:DL: Got WiFi interface: wlan0
[1648813479.810122][11968:11968] CHIP:DL: Failed to reset WiFi statistic counts
[1648813479.810266][11968:11968] CHIP:IN: UDP::Init bind&listen port=0
[1648813479.810423][11968:11968] CHIP:IN: UDP::Init bound to port=43833
[1648813479.810450][11968:11968] CHIP:IN: BLEBase::Init - setting/overriding transport
[1648813479.810472][11968:11968] CHIP:IN: TransportMgr initialized
[1648813479.810508][11968:11968] CHIP:DIS: Init fabric pairing table with server storage
[1648813479.810556][11968:11968] CHIP:DIS: Add fabric pairing table delegate
[1648813479.810765][11968:11968] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-JHS1Zt)
[1648813479.811360][11968:11968] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1648813479.811415][11968:11968] CHIP:DL: NVS set: chip-counters/GlobalMCTR = 1000 (0x3E8)
[1648813479.812944][11968:11968] CHIP:ZCL: Using ZAP configuration...
[1648813479.817541][11968:11968] CHIP:DL: Avahi client registered
[1648813479.818878][11968:11968] CHIP:CTL: System State Initialized...
[1648813479.818974][11968:11968] CHIP:CTL: Setting attestation nonce to random value
[1648813479.819028][11968:11968] CHIP:CTL: Setting CSR nonce to random value
[1648813479.819108][11968:11968] CHIP:IN: UDP::Init bind&listen port=5550
[1648813479.819254][11968:11968] CHIP:IN: UDP::Init bound to port=5550
[1648813479.819281][11968:11968] CHIP:IN: TransportMgr initialized
[1648813479.819429][11968:11968] CHIP:CTL: Setting attestation nonce to random value
[1648813479.819482][11968:11968] CHIP:CTL: Setting CSR nonce to random value
[1648813479.819974][11968:11968] CHIP:CTL: Couldn't get ExampleOpCredsCAKey from storage: ../../config/PersistentStorage.cpp:108: CHIP Error 0x000000A0: Value not found in the persisted storage
[1648813479.823052][11968:11968] CHIP:CTL: Couldn't get ExampleOpCredsICAKey from storage: ../../config/PersistentStorage.cpp:108: CHIP Error 0x000000A0: Value not found in the persisted storage
[1648813479.824310][11968:11968] CHIP:CTL: Generating RCAC
[1648813479.825391][11968:11968] CHIP:CTL: Generating ICAC
[1648813479.826415][11968:11968] CHIP:CTL: Generating NOC
[1648813479.827542][11968:11968] CHIP:DIS: Verifying the received credentials
[1648813479.829503][11968:11968] CHIP:DIS: Added new fabric at index: 1, Initialized: 1
[1648813479.829542][11968:11968] CHIP:DIS: Assigned compressed fabric ID: 0xCBB8EF5DE80AF328, node ID: 0x000000000001B669
[1648813479.833357][11968:11968] CHIP:DIS: Fabric (1) persisted to storage. Calling OnFabricPersistedToStorage
[1648813479.834434][11968:11968] CHIP:CTL: Joined the fabric at index 1. Compressed fabric ID is: 0xCBB8EF5DE80AF328
[1648813479.834521][11968:11968] CHIP:IN: UDP::Init bind&listen port=5550
[1648813479.834664][11968:11968] CHIP:IN: UDP::Init bound to port=5550
[1648813479.834696][11968:11968] CHIP:IN: TransportMgr initialized
[1648813479.834831][11968:11968] CHIP:CTL: Setting attestation nonce to random value
[1648813479.834904][11968:11968] CHIP:CTL: Setting CSR nonce to random value
[1648813479.836266][11968:11968] CHIP:CTL: Generating NOC
[1648813479.837564][11968:11968] CHIP:DIS: Verifying the received credentials
[1648813479.839507][11968:11968] CHIP:DIS: Added new fabric at index: 2, Initialized: 1
[1648813479.839546][11968:11968] CHIP:DIS: Assigned compressed fabric ID: 0x02551B5F4885267C, node ID: 0x000000000001B669
[1648813479.843334][11968:11968] CHIP:DIS: Fabric (2) persisted to storage. Calling OnFabricPersistedToStorage
[1648813479.844137][11968:11968] CHIP:CTL: Joined the fabric at index 2. Compressed fabric ID is: 0x02551B5F4885267C
[1648813479.844211][11968:11968] CHIP:IN: UDP::Init bind&listen port=5550
[1648813479.844342][11968:11968] CHIP:IN: UDP::Init bound to port=5550
[1648813479.844370][11968:11968] CHIP:IN: TransportMgr initialized
[1648813479.844483][11968:11968] CHIP:CTL: Setting attestation nonce to random value
[1648813479.844551][11968:11968] CHIP:CTL: Setting CSR nonce to random value
[1648813479.845776][11968:11968] CHIP:CTL: Generating NOC
[1648813479.846989][11968:11968] CHIP:DIS: Verifying the received credentials
[1648813479.848933][11968:11968] CHIP:DIS: Added new fabric at index: 3, Initialized: 1
[1648813479.848971][11968:11968] CHIP:DIS: Assigned compressed fabric ID: 0xA317568FF7A510EC, node ID: 0x000000000001B669
[1648813479.855142][11968:11968] CHIP:DIS: Fabric (3) persisted to storage. Calling OnFabricPersistedToStorage
[1648813479.855882][11968:11968] CHIP:CTL: Joined the fabric at index 3.  Attempting to connect.
[1648813480.043152][11968:11971] CHIP:BLE: Scan complete notification without an active scan.
[1648813486.691553][11968:11971] CHIP:DL: ConnectDevice complete
[1648813488.284505][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.284559][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.284589][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.284612][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.284644][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0010
[1648813488.284666][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.284692][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0010
[1648813488.284714][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.284739][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0010
[1648813488.284761][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.284789][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0006
[1648813488.284833][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.284861][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0006
[1648813488.284883][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.284919][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0006
[1648813488.284941][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.284969][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0006
[1648813488.285001][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.285027][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0006
[1648813488.285048][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.285083][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0006
[1648813488.285104][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.285144][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.285167][11968:11971] CHIP:DL: Char1 /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE/service0013
[1648813488.285197][11968:11971] CHIP:DL: New BLE connection 0xffffa403f110, device E4:5F:01:0E:BE:FE, path /org/bluez/hci0/dev_E4_5F_01_0E_BE_FE
[1648813488.285324][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16385
[1648813488.285391][11968:11973] CHIP:IN: BleConnectionComplete: endPoint 0xaaaabd276aa8
[1648813488.689391][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1648813488.787748][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16388
[1648813488.787842][11968:11973] CHIP:BLE: subscribe complete, ep = 0xaaaabd276aa8
[1648813488.788101][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813488.788338][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813488.788406][11968:11973] CHIP:BLE: peripheral chose BTP version 4; central expected between 4 and 4
[1648813488.788461][11968:11973] CHIP:BLE: using BTP fragment sizes rx 244 / tx 244.
[1648813488.788510][11968:11973] CHIP:BLE: local and remote recv window size = 6
[1648813488.788699][11968:11973] CHIP:IN: BLE EndPoint 0xaaaabd276aa8 Connection Complete
[1648813488.933488][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1648813488.936352][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813488.936582][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813488.936936][11968:11973] CHIP:EM: Received message of type 0x21 with protocolId (0, 0) and MessageCounter:2543046833 on exchange 50695i
[1648813488.937017][11968:11973] CHIP:EM: Found matching exchange: 50695i, Delegate: 0xffff98001788
[1648813488.937107][11968:11973] CHIP:SC: Received PBKDF param response
[1648813488.937199][11968:11973] CHIP:SC: Peer assigned session ID 1
[1648813488.937276][11968:11973] CHIP:SC: Found MRP parameters in the message
[1648813488.947933][11968:11973] CHIP:IN: Prepared unauthenticated message 0xffffacb0f7c8 to 0x0000000000000000 (0)  of type 0x22 and protocolId (0, 0) on exchange 50695i with MessageCounter:1867231957.
[1648813488.947999][11968:11973] CHIP:IN: Sending unauthenticated msg 0xffffacb0f7c8 with MessageCounter:1867231957 to 0x0000000000000000 at monotonic time:<PHONE_NUMBER>066CC2 msec
[1648813488.948147][11968:11973] CHIP:SC: Sent spake2p msg1
[1648813489.128546][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1648813489.131388][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813489.131632][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813489.131970][11968:11973] CHIP:EM: Received message of type 0x23 with protocolId (0, 0) and MessageCounter:2543046834 on exchange 50695i
[1648813489.132048][11968:11973] CHIP:EM: Found matching exchange: 50695i, Delegate: 0xffff98001788
[1648813489.132137][11968:11973] CHIP:SC: Received spake2p msg2
[1648813489.135281][11968:11973] CHIP:IN: Prepared unauthenticated message 0xffffacb0f908 to 0x0000000000000000 (0)  of type 0x24 and protocolId (0, 0) on exchange 50695i with MessageCounter:1867231958.
[1648813489.135384][11968:11973] CHIP:IN: Sending unauthenticated msg 0xffffacb0f908 with MessageCounter:1867231958 to 0x0000000000000000 at monotonic time:<PHONE_NUMBER>066D7D msec
[1648813489.135610][11968:11973] CHIP:SC: Sent spake2p msg3
[1648813489.226045][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1648813489.227700][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813489.227936][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813489.228254][11968:11973] CHIP:EM: Received message of type 0x40 with protocolId (0, 0) and MessageCounter:2543046835 on exchange 50695i
[1648813489.228332][11968:11973] CHIP:EM: Found matching exchange: 50695i, Delegate: 0xffff98001788
[1648813489.228437][11968:11973] CHIP:IN: New secure session created for device 0x0000000000000001, LSID:1 PSID:1!
[1648813489.228774][11968:11973] CHIP:CTL: Remote device completed SPAKE2+ handshake
[1648813489.228841][11968:11973] CHIP:TOO: Pairing Success
[1648813489.228904][11968:11973] CHIP:CTL: Going from commissioning step 'SecurePairing' with lastErr = '../../third_party/connectedhomeip/src/controller/AutoCommissioner.cpp:253: Success' --> 'ReadCommissioningInfo'
[1648813489.228970][11968:11973] CHIP:CTL: Performing next commissioning step 'ReadCommissioningInfo' with completion status = '../../third_party/connectedhomeip/src/controller/CommissioningDelegate.h:340: Success'
[1648813489.229025][11968:11973] CHIP:CTL: Sending request for commissioning information
[1648813489.229099][11968:11973] CHIP:DMG: SendReadRequest ReadClient[0xffff9800e9f0]: Sending Read Request
[1648813489.229383][11968:11973] CHIP:IN: Prepared secure message 0xffffacb0f248 to 0x0000000000000001 (1)  of type 0x2 and protocolId (0, 1) on exchange 50696i with MessageCounter:5288724.
[1648813489.229478][11968:11973] CHIP:IN: Sending encrypted msg 0xffffacb0f248 with MessageCounter:5288724 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>066DDB msec
[1648813489.229715][11968:11973] CHIP:DMG: MoveToState ReadClient[0xffff9800e9f0]: Moving to [AwaitingIn]
[1648813489.420522][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1648813489.471990][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813489.472254][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813489.567153][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813489.567426][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813489.567893][11968:11973] CHIP:EM: Received message of type 0x5 with protocolId (0, 1) and MessageCounter:11880637 on exchange 50696i
[1648813489.567972][11968:11973] CHIP:EM: Found matching exchange: 50696i, Delegate: 0xffff9800e9f0
[1648813489.568179][11968:11973] CHIP:DMG: ReportDataMessage =
[1648813489.568271][11968:11973] CHIP:DMG: {
[1648813489.568324][11968:11973] CHIP:DMG:      AttributeReportIBs =
[1648813489.568400][11968:11973] CHIP:DMG:      [
[1648813489.568480][11968:11973] CHIP:DMG:              AttributeReportIB =
[1648813489.568570][11968:11973] CHIP:DMG:              {
[1648813489.568659][11968:11973] CHIP:DMG:                      AttributeDataIB =
[1648813489.568738][11968:11973] CHIP:DMG:                      {
[1648813489.568839][11968:11973] CHIP:DMG:                              DataVersion = 0xc19875c5,
[1648813489.568925][11968:11973] CHIP:DMG:                              AttributePathIB =
[1648813489.569036][11968:11973] CHIP:DMG:                              {
[1648813489.569143][11968:11973] CHIP:DMG:                                      Endpoint = 0x0,
[1648813489.569232][11968:11973] CHIP:DMG:                                      Cluster = 0x31,
[1648813489.569349][11968:11973] CHIP:DMG:                                      Attribute = 0x0000_0003,
[1648813489.569454][11968:11973] CHIP:DMG:                              }
[1648813489.569548][11968:11973] CHIP:DMG:
[1648813489.569656][11968:11973] CHIP:DMG:                                      Data = 20,
[1648813489.569754][11968:11973] CHIP:DMG:                      },
[1648813489.569838][11968:11973] CHIP:DMG:
[1648813489.569969][11968:11973] CHIP:DMG:              },
[1648813489.570069][11968:11973] CHIP:DMG:
[1648813489.570130][11968:11973] CHIP:DMG:              AttributeReportIB =
[1648813489.570211][11968:11973] CHIP:DMG:              {
[1648813489.570279][11968:11973] CHIP:DMG:                      AttributeDataIB =
[1648813489.570361][11968:11973] CHIP:DMG:                      {
[1648813489.570438][11968:11973] CHIP:DMG:                              DataVersion = 0x137c8d16,
[1648813489.570524][11968:11973] CHIP:DMG:                              AttributePathIB =
[1648813489.570609][11968:11973] CHIP:DMG:                              {
[1648813489.570697][11968:11973] CHIP:DMG:                                      Endpoint = 0x0,
[1648813489.570783][11968:11973] CHIP:DMG:                                      Cluster = 0x28,
[1648813489.570866][11968:11973] CHIP:DMG:                                      Attribute = 0x0000_0004,
[1648813489.570940][11968:11973] CHIP:DMG:                              }
[1648813489.571023][11968:11973] CHIP:DMG:
[1648813489.571090][11968:11973] CHIP:DMG:                                      Data = 32769,
[1648813489.571175][11968:11973] CHIP:DMG:                      },
[1648813489.571257][11968:11973] CHIP:DMG:
[1648813489.571323][11968:11973] CHIP:DMG:              },
[1648813489.571414][11968:11973] CHIP:DMG:
[1648813489.571475][11968:11973] CHIP:DMG:              AttributeReportIB =
[1648813489.571553][11968:11973] CHIP:DMG:              {
[1648813489.571621][11968:11973] CHIP:DMG:                      AttributeDataIB =
[1648813489.571703][11968:11973] CHIP:DMG:                      {
[1648813489.571778][11968:11973] CHIP:DMG:                              DataVersion = 0x137c8d16,
[1648813489.571862][11968:11973] CHIP:DMG:                              AttributePathIB =
[1648813489.571941][11968:11973] CHIP:DMG:                              {
[1648813489.572014][11968:11973] CHIP:DMG:                                      Endpoint = 0x0,
[1648813489.572095][11968:11973] CHIP:DMG:                                      Cluster = 0x28,
[1648813489.572175][11968:11973] CHIP:DMG:                                      Attribute = 0x0000_0002,
[1648813489.572250][11968:11973] CHIP:DMG:                              }
[1648813489.572340][11968:11973] CHIP:DMG:
[1648813489.572423][11968:11973] CHIP:DMG:                                      Data = 65521,
[1648813489.572502][11968:11973] CHIP:DMG:                      },
[1648813489.572581][11968:11973] CHIP:DMG:
[1648813489.572647][11968:11973] CHIP:DMG:              },
[1648813489.572737][11968:11973] CHIP:DMG:
[1648813489.572797][11968:11973] CHIP:DMG:              AttributeReportIB =
[1648813489.572876][11968:11973] CHIP:DMG:              {
[1648813489.572944][11968:11973] CHIP:DMG:                      AttributeDataIB =
[1648813489.573025][11968:11973] CHIP:DMG:                      {
[1648813489.573100][11968:11973] CHIP:DMG:                              DataVersion = 0x24f515bd,
[1648813489.573184][11968:11973] CHIP:DMG:                              AttributePathIB =
[1648813489.573266][11968:11973] CHIP:DMG:                              {
[1648813489.573352][11968:11973] CHIP:DMG:                                      Endpoint = 0x0,
[1648813489.573437][11968:11973] CHIP:DMG:                                      Cluster = 0x30,
[1648813489.573528][11968:11973] CHIP:DMG:                                      Attribute = 0x0000_0003,
[1648813489.573614][11968:11973] CHIP:DMG:                              }
[1648813489.573701][11968:11973] CHIP:DMG:
[1648813489.573775][11968:11973] CHIP:DMG:                                      Data = 0,
[1648813489.573861][11968:11973] CHIP:DMG:                      },
[1648813489.573968][11968:11973] CHIP:DMG:
[1648813489.574034][11968:11973] CHIP:DMG:              },
[1648813489.574117][11968:11973] CHIP:DMG:
[1648813489.574176][11968:11973] CHIP:DMG:              AttributeReportIB =
[1648813489.574254][11968:11973] CHIP:DMG:              {
[1648813489.574322][11968:11973] CHIP:DMG:                      AttributeDataIB =
[1648813489.574397][11968:11973] CHIP:DMG:                      {
[1648813489.574473][11968:11973] CHIP:DMG:                              DataVersion = 0x24f515bd,
[1648813489.574556][11968:11973] CHIP:DMG:                              AttributePathIB =
[1648813489.574639][11968:11973] CHIP:DMG:                              {
[1648813489.574720][11968:11973] CHIP:DMG:                                      Endpoint = 0x0,
[1648813489.574804][11968:11973] CHIP:DMG:                                      Cluster = 0x30,
[1648813489.574893][11968:11973] CHIP:DMG:                                      Attribute = 0x0000_0002,
[1648813489.574973][11968:11973] CHIP:DMG:                              }
[1648813489.575066][11968:11973] CHIP:DMG:
[1648813489.575147][11968:11973] CHIP:DMG:                                      Data = 0,
[1648813489.575225][11968:11973] CHIP:DMG:                      },
[1648813489.575304][11968:11973] CHIP:DMG:
[1648813489.575365][11968:11973] CHIP:DMG:              },
[1648813489.575452][11968:11973] CHIP:DMG:
[1648813489.575511][11968:11973] CHIP:DMG:              AttributeReportIB =
[1648813489.575591][11968:11973] CHIP:DMG:              {
[1648813489.575660][11968:11973] CHIP:DMG:                      AttributeDataIB =
[1648813489.575733][11968:11973] CHIP:DMG:                      {
[1648813489.575808][11968:11973] CHIP:DMG:                              DataVersion = 0x24f515bd,
[1648813489.575890][11968:11973] CHIP:DMG:                              AttributePathIB =
[1648813489.575968][11968:11973] CHIP:DMG:                              {
[1648813489.576050][11968:11973] CHIP:DMG:                                      Endpoint = 0x0,
[1648813489.576141][11968:11973] CHIP:DMG:                                      Cluster = 0x30,
[1648813489.576216][11968:11973] CHIP:DMG:                                      Attribute = 0x0000_0001,
[1648813489.576280][11968:11973] CHIP:DMG:                              }
[1648813489.576357][11968:11973] CHIP:DMG:
[1648813489.576434][11968:11973] CHIP:DMG:                                      Data =
[1648813489.576517][11968:11973] CHIP:DMG:                                      {
[1648813489.576602][11968:11973] CHIP:DMG:                                              0x0 = 60,
[1648813489.576689][11968:11973] CHIP:DMG:                                      },
[1648813489.576748][11968:11973] CHIP:DMG:                      },
[1648813489.576785][11968:11973] CHIP:DMG:
[1648813489.576816][11968:11973] CHIP:DMG:              },
[1648813489.576856][11968:11973] CHIP:DMG:
[1648813489.576879][11968:11973] CHIP:DMG:              AttributeReportIB =
[1648813489.576913][11968:11973] CHIP:DMG:              {
[1648813489.576941][11968:11973] CHIP:DMG:                      AttributeDataIB =
[1648813489.576975][11968:11973] CHIP:DMG:                      {
[1648813489.577009][11968:11973] CHIP:DMG:                              DataVersion = 0x24f515bd,
[1648813489.577044][11968:11973] CHIP:DMG:                              AttributePathIB =
[1648813489.577080][11968:11973] CHIP:DMG:                              {
[1648813489.577118][11968:11973] CHIP:DMG:                                      Endpoint = 0x0,
[1648813489.577159][11968:11973] CHIP:DMG:                                      Cluster = 0x30,
[1648813489.577198][11968:11973] CHIP:DMG:                                      Attribute = 0x0000_0000,
[1648813489.577234][11968:11973] CHIP:DMG:                              }
[1648813489.577271][11968:11973] CHIP:DMG:
[1648813489.577308][11968:11973] CHIP:DMG:                                      Data = 0,
[1648813489.577344][11968:11973] CHIP:DMG:                      },
[1648813489.577380][11968:11973] CHIP:DMG:
[1648813489.577410][11968:11973] CHIP:DMG:              },
[1648813489.577452][11968:11973] CHIP:DMG:
[1648813489.577479][11968:11973] CHIP:DMG:              AttributeReportIB =
[1648813489.577514][11968:11973] CHIP:DMG:              {
[1648813489.577545][11968:11973] CHIP:DMG:                      AttributeDataIB =
[1648813489.577579][11968:11973] CHIP:DMG:                      {
[1648813489.577617][11968:11973] CHIP:DMG:                              DataVersion = 0xc19875c5,
[1648813489.577652][11968:11973] CHIP:DMG:                              AttributePathIB =
[1648813489.577691][11968:11973] CHIP:DMG:                              {
[1648813489.577732][11968:11973] CHIP:DMG:                                      Endpoint = 0x0,
[1648813489.577772][11968:11973] CHIP:DMG:                                      Cluster = 0x31,
[1648813489.577810][11968:11973] CHIP:DMG:                                      Attribute = 0x0000_FFFC,
[1648813489.577846][11968:11973] CHIP:DMG:                              }
[1648813489.577967][11968:11973] CHIP:DMG:
[1648813489.578008][11968:11973] CHIP:DMG:                                      Data = 1,
[1648813489.578047][11968:11973] CHIP:DMG:                      },
[1648813489.578101][11968:11973] CHIP:DMG:
[1648813489.578133][11968:11973] CHIP:DMG:              },
[1648813489.578169][11968:11973] CHIP:DMG:
[1648813489.578211][11968:11973] CHIP:DMG:      ],
[1648813489.578275][11968:11973] CHIP:DMG:
[1648813489.578304][11968:11973] CHIP:DMG:      SuppressResponse = true,
[1648813489.578393][11968:11973] CHIP:DMG:      InteractionModelRevision = 1
[1648813489.578421][11968:11973] CHIP:DMG: }
[1648813489.579491][11968:11973] CHIP:CTL: Finished commissioning step 'ReadCommissioningInfo' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1401: Success'
[1648813489.579534][11968:11973] CHIP:CTL: Going from commissioning step 'ReadCommissioningInfo' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1401: Success' --> 'ArmFailSafe'
[1648813489.579564][11968:11973] CHIP:CTL: Performing next commissioning step 'ArmFailSafe' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1401: Success'
[1648813489.579590][11968:11973] CHIP:CTL: Arming failsafe (60 seconds)
[1648813489.579711][11968:11973] CHIP:DMG: ICR moving to [AddingComm]
[1648813489.579759][11968:11973] CHIP:DMG: ICR moving to [AddedComma]
[1648813489.579918][11968:11973] CHIP:IN: Prepared secure message 0xffffacb0ede8 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 50697i with MessageCounter:5288725.
[1648813489.579967][11968:11973] CHIP:IN: Sending encrypted msg 0xffffacb0ede8 with MessageCounter:5288725 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>066F3A msec
[1648813489.580125][11968:11973] CHIP:DMG: ICR moving to [CommandSen]
[1648813489.664739][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1648813489.666731][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813489.666939][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813489.667324][11968:11973] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:11880638 on exchange 50697i
[1648813489.667391][11968:11973] CHIP:EM: Found matching exchange: 50697i, Delegate: 0xffff980062b0
[1648813489.667467][11968:11973] CHIP:DMG: ICR moving to [ResponseRe]
[1648813489.667554][11968:11973] CHIP:DMG: InvokeResponseMessage =
[1648813489.667604][11968:11973] CHIP:DMG: {
[1648813489.667673][11968:11973] CHIP:DMG:      suppressResponse = false,
[1648813489.667724][11968:11973] CHIP:DMG:      InvokeResponseIBs =
[1648813489.667808][11968:11973] CHIP:DMG:      [
[1648813489.667861][11968:11973] CHIP:DMG:              InvokeResponseIB =
[1648813489.667958][11968:11973] CHIP:DMG:              {
[1648813489.668014][11968:11973] CHIP:DMG:                      CommandDataIB =
[1648813489.668099][11968:11973] CHIP:DMG:                      {
[1648813489.668180][11968:11973] CHIP:DMG:                              CommandPathIB =
[1648813489.668258][11968:11973] CHIP:DMG:                              {
[1648813489.668355][11968:11973] CHIP:DMG:                                      EndpointId = 0x0,
[1648813489.668453][11968:11973] CHIP:DMG:                                      ClusterId = 0x30,
[1648813489.668526][11968:11973] CHIP:DMG:                                      CommandId = 0x1,
[1648813489.668618][11968:11973] CHIP:DMG:                              },
[1648813489.668709][11968:11973] CHIP:DMG:
[1648813489.668780][11968:11973] CHIP:DMG:                              CommandData =
[1648813489.668867][11968:11973] CHIP:DMG:                              {
[1648813489.668964][11968:11973] CHIP:DMG:                                      0x0 = 0,
[1648813489.669042][11968:11973] CHIP:DMG:                                      0x1 = "",
[1648813489.669140][11968:11973] CHIP:DMG:                              },
[1648813489.669221][11968:11973] CHIP:DMG:                      },
[1648813489.669297][11968:11973] CHIP:DMG:
[1648813489.669368][11968:11973] CHIP:DMG:              },
[1648813489.669434][11968:11973] CHIP:DMG:
[1648813489.669500][11968:11973] CHIP:DMG:      ],
[1648813489.669566][11968:11973] CHIP:DMG:
[1648813489.669635][11968:11973] CHIP:DMG:      InteractionModelRevision = 1
[1648813489.669686][11968:11973] CHIP:DMG: },
[1648813489.669828][11968:11973] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0001
[1648813489.669943][11968:11973] CHIP:CTL: Received ArmFailSafe response
[1648813489.670002][11968:11973] CHIP:CTL: Finished commissioning step 'ArmFailSafe' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1553: Success'
[1648813489.670074][11968:11973] CHIP:CTL: Going from commissioning step 'ArmFailSafe' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1553: Success' --> 'ConfigRegulatory'
[1648813489.670129][11968:11973] CHIP:CTL: Performing next commissioning step 'ConfigRegulatory' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1553: Success'
[1648813489.670175][11968:11973] CHIP:CTL: Setting Regulatory Config
[1648813489.670237][11968:11973] CHIP:CTL: Device does not support configurable regulatory location
[1648813489.670322][11968:11973] CHIP:CTL: Unable to find country code, defaulting to XX
[1648813489.670454][11968:11973] CHIP:DMG: ICR moving to [AddingComm]
[1648813489.670540][11968:11973] CHIP:DMG: ICR moving to [AddedComma]
[1648813489.670761][11968:11973] CHIP:IN: Prepared secure message 0xffffacb0e8f8 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 50698i with MessageCounter:5288726.
[1648813489.670860][11968:11973] CHIP:IN: Sending encrypted msg 0xffffacb0e8f8 with MessageCounter:5288726 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>066F94 msec
[1648813489.671089][11968:11973] CHIP:DMG: ICR moving to [CommandSen]
[1648813489.671193][11968:11973] CHIP:DMG: ICR moving to [AwaitingDe]
[1648813489.762221][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1648813489.764334][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813489.764571][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813489.764972][11968:11973] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:11880639 on exchange 50698i
[1648813489.765072][11968:11973] CHIP:EM: Found matching exchange: 50698i, Delegate: 0xffff98002f10
[1648813489.765158][11968:11973] CHIP:DMG: ICR moving to [ResponseRe]
[1648813489.765256][11968:11973] CHIP:DMG: InvokeResponseMessage =
[1648813489.765316][11968:11973] CHIP:DMG: {
[1648813489.765398][11968:11973] CHIP:DMG:      suppressResponse = false,
[1648813489.765459][11968:11973] CHIP:DMG:      InvokeResponseIBs =
[1648813489.765558][11968:11973] CHIP:DMG:      [
[1648813489.765619][11968:11973] CHIP:DMG:              InvokeResponseIB =
[1648813489.765726][11968:11973] CHIP:DMG:              {
[1648813489.765790][11968:11973] CHIP:DMG:                      CommandDataIB =
[1648813489.765944][11968:11973] CHIP:DMG:                      {
[1648813489.766039][11968:11973] CHIP:DMG:                              CommandPathIB =
[1648813489.766131][11968:11973] CHIP:DMG:                              {
[1648813489.766238][11968:11973] CHIP:DMG:                                      EndpointId = 0x0,
[1648813489.766348][11968:11973] CHIP:DMG:                                      ClusterId = 0x30,
[1648813489.766441][11968:11973] CHIP:DMG:                                      CommandId = 0x3,
[1648813489.766545][11968:11973] CHIP:DMG:                              },
[1648813489.766657][11968:11973] CHIP:DMG:
[1648813489.766728][11968:11973] CHIP:DMG:                              CommandData =
[1648813489.766843][11968:11973] CHIP:DMG:                              {
[1648813489.766957][11968:11973] CHIP:DMG:                                      0x0 = 0,
[1648813489.767056][11968:11973] CHIP:DMG:                                      0x1 = "",
[1648813489.767164][11968:11973] CHIP:DMG:                              },
[1648813489.767262][11968:11973] CHIP:DMG:                      },
[1648813489.767357][11968:11973] CHIP:DMG:
[1648813489.767443][11968:11973] CHIP:DMG:              },
[1648813489.767527][11968:11973] CHIP:DMG:
[1648813489.767605][11968:11973] CHIP:DMG:      ],
[1648813489.767682][11968:11973] CHIP:DMG:
[1648813489.767763][11968:11973] CHIP:DMG:      InteractionModelRevision = 1
[1648813489.767821][11968:11973] CHIP:DMG: },
[1648813489.767984][11968:11973] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0003
[1648813489.768089][11968:11973] CHIP:CTL: Received SetRegulatoryConfig response
[1648813489.768154][11968:11973] CHIP:CTL: Finished commissioning step 'ConfigRegulatory' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1562: Success'
[1648813489.768213][11968:11973] CHIP:CTL: Going from commissioning step 'ConfigRegulatory' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1562: Success' --> 'SendPAICertificateRequest'
[1648813489.768300][11968:11973] CHIP:CTL: Performing next commissioning step 'SendPAICertificateRequest' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:1562: Success'
[1648813489.768354][11968:11973] CHIP:CTL: Sending request for PAI certificate
[1648813489.768402][11968:11973] CHIP:CTL: Sending Certificate Chain request to 0xffff98001730 device
[1648813489.768539][11968:11973] CHIP:DMG: ICR moving to [AddingComm]
[1648813489.768732][11968:11973] CHIP:DMG: ICR moving to [AddedComma]
[1648813489.769002][11968:11973] CHIP:IN: Prepared secure message 0xffffacb0e848 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 50699i with MessageCounter:5288727.
[1648813489.769121][11968:11973] CHIP:IN: Sending encrypted msg 0xffffacb0e848 with MessageCounter:5288727 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>066FF7 msec
[1648813489.769358][11968:11973] CHIP:DMG: ICR moving to [CommandSen]
[1648813489.769477][11968:11973] CHIP:DMG: ICR moving to [AwaitingDe]
[1648813489.859803][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1648813489.907575][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813489.907769][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813490.105926][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813490.106160][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813490.201676][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813490.201978][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813490.202602][11968:11973] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:11880640 on exchange 50699i
[1648813490.202683][11968:11973] CHIP:EM: Found matching exchange: 50699i, Delegate: 0xffff980062b0
[1648813490.202779][11968:11973] CHIP:DMG: ICR moving to [ResponseRe]
[1648813490.202880][11968:11973] CHIP:DMG: InvokeResponseMessage =
[1648813490.202940][11968:11973] CHIP:DMG: {
[1648813490.203023][11968:11973] CHIP:DMG:      suppressResponse = false,
[1648813490.203088][11968:11973] CHIP:DMG:      InvokeResponseIBs =
[1648813490.203187][11968:11973] CHIP:DMG:      [
[1648813490.203249][11968:11973] CHIP:DMG:              InvokeResponseIB =
[1648813490.203351][11968:11973] CHIP:DMG:              {
[1648813490.203421][11968:11973] CHIP:DMG:                      CommandDataIB =
[1648813490.203518][11968:11973] CHIP:DMG:                      {
[1648813490.203590][11968:11973] CHIP:DMG:                              CommandPathIB =
[1648813490.203700][11968:11973] CHIP:DMG:                              {
[1648813490.203810][11968:11973] CHIP:DMG:                                      EndpointId = 0x0,
[1648813490.203898][11968:11973] CHIP:DMG:                                      ClusterId = 0x3e,
[1648813490.204004][11968:11973] CHIP:DMG:                                      CommandId = 0x3,
[1648813490.204104][11968:11973] CHIP:DMG:                              },
[1648813490.204194][11968:11973] CHIP:DMG:
[1648813490.204285][11968:11973] CHIP:DMG:                              CommandData =
[1648813490.204373][11968:11973] CHIP:DMG:                              {
[1648813490.204478][11968:11973] CHIP:DMG:                                      0x0 = [
[1648813490.204579][11968:11973] CHIP:DMG:                                              ... (byte string too long) ...
[1648813490.204675][11968:11973] CHIP:DMG:                              ]
[1648813490.204788][11968:11973] CHIP:DMG:                              },
[1648813490.204876][11968:11973] CHIP:DMG:                      },
[1648813490.204958][11968:11973] CHIP:DMG:
[1648813490.205019][11968:11973] CHIP:DMG:              },
[1648813490.205112][11968:11973] CHIP:DMG:
[1648813490.205173][11968:11973] CHIP:DMG:      ],
[1648813490.205266][11968:11973] CHIP:DMG:
[1648813490.205327][11968:11973] CHIP:DMG:      InteractionModelRevision = 1
[1648813490.205405][11968:11973] CHIP:DMG: },
[1648813490.205548][11968:11973] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0003
[1648813490.205645][11968:11973] CHIP:CTL: Received certificate chain from the device
[1648813490.205730][11968:11973] CHIP:CTL: Finished commissioning step 'SendPAICertificateRequest' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:893: Success'
[1648813490.205797][11968:11973] CHIP:CTL: Going from commissioning step 'SendPAICertificateRequest' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:893: Success' --> 'SendDACCertificateRequest'
[1648813490.205859][11968:11973] CHIP:CTL: Performing next commissioning step 'SendDACCertificateRequest' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:893: Success'
[1648813490.205942][11968:11973] CHIP:CTL: Sending request for DAC certificate
[1648813490.205990][11968:11973] CHIP:CTL: Sending Certificate Chain request to 0xffff98001730 device
[1648813490.206122][11968:11973] CHIP:DMG: ICR moving to [AddingComm]
[1648813490.206193][11968:11973] CHIP:DMG: ICR moving to [AddedComma]
[1648813490.206470][11968:11973] CHIP:IN: Prepared secure message 0xffffacb0e7f8 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 50700i with MessageCounter:5288728.
[1648813490.206584][11968:11973] CHIP:IN: Sending encrypted msg 0xffffacb0e7f8 with MessageCounter:5288728 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>0671AC msec
[1648813490.206851][11968:11973] CHIP:DMG: ICR moving to [CommandSen]
[1648813490.206975][11968:11973] CHIP:DMG: ICR moving to [AwaitingDe]
[1648813490.346820][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1648813490.394840][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813490.394996][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813490.545071][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813490.545311][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813490.640211][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813490.640413][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813490.640859][11968:11973] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:11880641 on exchange 50700i
[1648813490.640919][11968:11973] CHIP:EM: Found matching exchange: 50700i, Delegate: 0xffff98002f10
[1648813490.640992][11968:11973] CHIP:DMG: ICR moving to [ResponseRe]
[1648813490.641071][11968:11973] CHIP:DMG: InvokeResponseMessage =
[1648813490.641117][11968:11973] CHIP:DMG: {
[1648813490.641185][11968:11973] CHIP:DMG:      suppressResponse = false,
[1648813490.641230][11968:11973] CHIP:DMG:      InvokeResponseIBs =
[1648813490.641305][11968:11973] CHIP:DMG:      [
[1648813490.641352][11968:11973] CHIP:DMG:              InvokeResponseIB =
[1648813490.641429][11968:11973] CHIP:DMG:              {
[1648813490.641481][11968:11973] CHIP:DMG:                      CommandDataIB =
[1648813490.641552][11968:11973] CHIP:DMG:                      {
[1648813490.641607][11968:11973] CHIP:DMG:                              CommandPathIB =
[1648813490.641683][11968:11973] CHIP:DMG:                              {
[1648813490.641762][11968:11973] CHIP:DMG:                                      EndpointId = 0x0,
[1648813490.641828][11968:11973] CHIP:DMG:                                      ClusterId = 0x3e,
[1648813490.641972][11968:11973] CHIP:DMG:                                      CommandId = 0x3,
[1648813490.642052][11968:11973] CHIP:DMG:                              },
[1648813490.642118][11968:11973] CHIP:DMG:
[1648813490.642194][11968:11973] CHIP:DMG:                              CommandData =
[1648813490.642271][11968:11973] CHIP:DMG:                              {
[1648813490.642337][11968:11973] CHIP:DMG:                                      0x0 = [
[1648813490.642422][11968:11973] CHIP:DMG:                                              ... (byte string too long) ...
[1648813490.642505][11968:11973] CHIP:DMG:                              ]
[1648813490.642567][11968:11973] CHIP:DMG:                              },
[1648813490.642641][11968:11973] CHIP:DMG:                      },
[1648813490.642704][11968:11973] CHIP:DMG:
[1648813490.642770][11968:11973] CHIP:DMG:              },
[1648813490.642830][11968:11973] CHIP:DMG:
[1648813490.642889][11968:11973] CHIP:DMG:      ],
[1648813490.642947][11968:11973] CHIP:DMG:
[1648813490.643008][11968:11973] CHIP:DMG:      InteractionModelRevision = 1
[1648813490.643051][11968:11973] CHIP:DMG: },
[1648813490.643176][11968:11973] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0003
[1648813490.643253][11968:11973] CHIP:CTL: Received certificate chain from the device
[1648813490.643302][11968:11973] CHIP:CTL: Finished commissioning step 'SendDACCertificateRequest' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:893: Success'
[1648813490.643353][11968:11973] CHIP:CTL: Going from commissioning step 'SendDACCertificateRequest' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:893: Success' --> 'SendAttestationRequest'
[1648813490.643418][11968:11973] CHIP:CTL: Performing next commissioning step 'SendAttestationRequest' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:893: Success'
[1648813490.643458][11968:11973] CHIP:CTL: Sending Attestation Request to the device.
[1648813490.643512][11968:11973] CHIP:CTL: Sending Attestation request to 0xffff98001730 device
[1648813490.643605][11968:11973] CHIP:DMG: ICR moving to [AddingComm]
[1648813490.643680][11968:11973] CHIP:DMG: ICR moving to [AddedComma]
[1648813490.643896][11968:11973] CHIP:IN: Prepared secure message 0xffffacb0e7b8 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 50701i with MessageCounter:5288729.
[1648813490.643965][11968:11973] CHIP:IN: Sending encrypted msg 0xffffacb0e7b8 with MessageCounter:5288729 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>067362 msec
[1648813490.644188][11968:11973] CHIP:DMG: ICR moving to [CommandSen]
[1648813490.644244][11968:11973] CHIP:CTL: Sent Attestation request, waiting for the Attestation Information
[1648813490.644320][11968:11973] CHIP:DMG: ICR moving to [AwaitingDe]
[1648813490.737310][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1648813490.882974][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813490.883200][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813490.983881][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813490.984149][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813491.081145][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813491.081391][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813491.082064][11968:11973] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:11880642 on exchange 50701i
[1648813491.082144][11968:11973] CHIP:EM: Found matching exchange: 50701i, Delegate: 0xffff980062b0
[1648813491.082242][11968:11973] CHIP:DMG: ICR moving to [ResponseRe]
[1648813491.082348][11968:11973] CHIP:DMG: InvokeResponseMessage =
[1648813491.082408][11968:11973] CHIP:DMG: {
[1648813491.082466][11968:11973] CHIP:DMG:      suppressResponse = false,
[1648813491.082525][11968:11973] CHIP:DMG:      InvokeResponseIBs =
[1648813491.082604][11968:11973] CHIP:DMG:      [
[1648813491.082664][11968:11973] CHIP:DMG:              InvokeResponseIB =
[1648813491.082746][11968:11973] CHIP:DMG:              {
[1648813491.082810][11968:11973] CHIP:DMG:                      CommandDataIB =
[1648813491.082881][11968:11973] CHIP:DMG:                      {
[1648813491.082949][11968:11973] CHIP:DMG:                              CommandPathIB =
[1648813491.083023][11968:11973] CHIP:DMG:                              {
[1648813491.083099][11968:11973] CHIP:DMG:                                      EndpointId = 0x0,
[1648813491.083179][11968:11973] CHIP:DMG:                                      ClusterId = 0x3e,
[1648813491.083258][11968:11973] CHIP:DMG:                                      CommandId = 0x1,
[1648813491.083331][11968:11973] CHIP:DMG:                              },
[1648813491.083408][11968:11973] CHIP:DMG:
[1648813491.083476][11968:11973] CHIP:DMG:                              CommandData =
[1648813491.083549][11968:11973] CHIP:DMG:                              {
[1648813491.083623][11968:11973] CHIP:DMG:                                      0x0 = [
[1648813491.083697][11968:11973] CHIP:DMG:                                              ... (byte string too long) ...
[1648813491.083779][11968:11973] CHIP:DMG:                              ]
[1648813491.083853][11968:11973] CHIP:DMG:                                      0x1 = [
[1648813491.083965][11968:11973] CHIP:DMG:                                              0xc5, 0xb4, 0x41, 0xda, 0x5a, 0x39, 0xc6, 0x7c, 0x33, 0xc8, 0x42, 0x16, 0x1c, 0x1c, 0xe, 0x12, 0x11, 0x87, 0xf8, 0xca, 0x46, 0xf, 0x9a, 0x22, 0x12, 0x4d, 0x4, 0x1f, 0xd9, 0x5f, 0xa7, 0xf7, 0x18, 0x78, 0x37, 0x91, 0x65, 0x5d, 0xef, 0x5a, 0x21, 0x33,
[1648813491.084054][11968:11973] CHIP:DMG:                              ]
[1648813491.084127][11968:11973] CHIP:DMG:                              },
[1648813491.084195][11968:11973] CHIP:DMG:                      },
[1648813491.084274][11968:11973] CHIP:DMG:
[1648813491.084337][11968:11973] CHIP:DMG:              },
[1648813491.084413][11968:11973] CHIP:DMG:
[1648813491.084471][11968:11973] CHIP:DMG:      ],
[1648813491.084545][11968:11973] CHIP:DMG:
[1648813491.084603][11968:11973] CHIP:DMG:      InteractionModelRevision = 1
[1648813491.084780][11968:11973] CHIP:DMG: },
[1648813491.085008][11968:11973] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0001
[1648813491.085094][11968:11973] CHIP:CTL: Received Attestation Information from the device
[1648813491.085164][11968:11973] CHIP:CTL: Finished commissioning step 'SendAttestationRequest' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:928: Success'
[1648813491.085309][11968:11973] CHIP:CTL: Going from commissioning step 'SendAttestationRequest' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:928: Success' --> 'AttestationVerification'
[1648813491.085377][11968:11973] CHIP:CTL: Performing next commissioning step 'AttestationVerification' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:928: Success'
[1648813491.085433][11968:11973] CHIP:CTL: Verifying attestation
[1648813491.095028][11968:11973] CHIP:CTL: Successfully validated 'Attestation Information' command received from the device.
[1648813491.095096][11968:11973] CHIP:CTL: Finished commissioning step 'AttestationVerification' with error '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:960: Success'
[1648813491.095129][11968:11973] CHIP:CTL: Going from commissioning step 'AttestationVerification' with lastErr = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:960: Success' --> 'SendOpCertSigningRequest'
[1648813491.095163][11968:11973] CHIP:CTL: Performing next commissioning step 'SendOpCertSigningRequest' with completion status = '../../third_party/connectedhomeip/src/controller/CHIPDeviceController.cpp:960: Success'
[1648813491.095193][11968:11973] CHIP:CTL: Sending CSR request to 0xffff98001730 device
[1648813491.095275][11968:11973] CHIP:DMG: ICR moving to [AddingComm]
[1648813491.095316][11968:11973] CHIP:DMG: ICR moving to [AddedComma]
[1648813491.095481][11968:11973] CHIP:IN: Prepared secure message 0xffffacb0dd68 to 0x0000000000000001 (1)  of type 0x8 and protocolId (0, 1) on exchange 50702i with MessageCounter:5288730.
[1648813491.095533][11968:11973] CHIP:IN: Sending encrypted msg 0xffffacb0dd68 with MessageCounter:5288730 to 0x0000000000000001 (1) at monotonic time:<PHONE_NUMBER>067525 msec
[1648813491.095724][11968:11973] CHIP:DMG: ICR moving to [CommandSen]
[1648813491.095765][11968:11973] CHIP:CTL: Sent CSR request, waiting for the CSR
[1648813491.095827][11968:11973] CHIP:DMG: ICR moving to [AwaitingDe]
[1648813491.176112][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1648813491.224161][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813491.224417][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813491.323938][11968:11971] CHIP:DL: Indication received, conn = 0xffffa403f110
[1648813491.324182][11968:11973] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1648813491.324670][11968:11973] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:11880643 on exchange 50702i
[1648813491.324748][11968:11973] CHIP:EM: Found matching exchange: 50702i, Delegate: 0xffffa4041380
[1648813491.324843][11968:11973] CHIP:DMG: ICR moving to [ResponseRe]
[1648813491.324945][11968:11973] CHIP:DMG: InvokeResponseMessage =
[1648813491.325005][11968:11973] CHIP:DMG: {
[1648813491.325061][11968:11973] CHIP:DMG:      suppressResponse = false,
[1648813491.325121][11968:11973] CHIP:DMG:      InvokeResponseIBs =
[1648813491.325198][11968:11973] CHIP:DMG:      [
[1648813491.325257][11968:11973] CHIP:DMG:              InvokeResponseIB =
[1648813491.325342][11968:11973] CHIP:DMG:              {
[1648813491.325410][11968:11973] CHIP:DMG:                      CommandDataIB =
[1648813491.325487][11968:11973] CHIP:DMG:                      {
[1648813491.325559][11968:11973] CHIP:DMG:                              CommandPathIB =
[1648813491.325639][11968:11973] CHIP:DMG:                              {
[1648813491.325720][11968:11973] CHIP:DMG:                                      EndpointId = 0x0,
[1648813491.325811][11968:11973] CHIP:DMG:                                      ClusterId = 0x3e,
[1648813491.325939][11968:11973] CHIP:DMG:                                      CommandId = 0x5,
[1648813491.326022][11968:11973] CHIP:DMG:                              },
[1648813491.326107][11968:11973] CHIP:DMG:
[1648813491.326178][11968:11973] CHIP:DMG:                              CommandData =
[1648813491.326258][11968:11973] CHIP:DMG:                              {
[1648813491.326338][11968:11973] CHIP:DMG:                                      0x0 = [
[1648813491.326470][11968:11973] CHIP:DMG:                                              0x15, 0x30, 0x1, 0xca, 0x30, 0x81, 0xc7, 0x30, 0x70, 0x2, 0x1, 0x0, 0x30, 0xe, 0x31, 0xc, 0x30, 0xa, 0x6, 0x3, 0x55, 0x4, 0xa, 0xc, 0x3, 0x43, 0x53, 0x52, 0x30, 0x59, 0x30, 0x13, 0x6, 0x7, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x2, 0x1, 0x6, 0x8, 0x2a, 0x86
[1648813491.326577][11968:11973] CHIP:DMG:                              ]
[1648813491.326662][11968:11973] CHIP:DMG:                                      0x1 = [
[1648813491.326776][11968:11973] CHIP:DMG:                                              0xdb, 0xaa, 0xd5, 0x75, 0xdf, 0xdf, 0xec, 0x37, 0x93, 0xfc, 0xf7, 0x58, 0xce, 0xb2, 0x48, 0x58, 0x40, 0x52, 0xa0, 0x9e, 0xcf, 0xcd, 0xc1, 0x9d, 0x4b, 0xec, 0x3e, 0x48, 0x95, 0x46, 0x7c, 0x45, 0x63, 0xcf, 0x8b, 0x88, 0x19, 0x42, 0x1d, 0x92, 0xae, 0x6
[1648813491.326875][11968:11973] CHIP:DMG:                              ]
[1648813491.326960][11968:11973] CHIP:DMG:                              },
[1648813491.327035][11968:11973] CHIP:DMG:                      },
[1648813491.327116][11968:11973] CHIP:DMG:
[1648813491.327183][11968:11973] CHIP:DMG:              },