i am using ubuntu 20.04 as a matter contoller and nrf52840 as matter devce and i am doing BLE - WIFi commssionig and i get BLE timeout error how to solve it.
i am using ubuntu 20.04 as a matter contoller and nrf52840 as matter devce and i am doing BLE - WIFi commssionig and i get BLE timeout error how to solve it.
Hi Gautam,
Do you have BLE timeout error on the Ubuntu's side ( I assume it's the central ? ) or on the nRF52840 ?
Do you have any log on the nRF52840 ?
Which sample you are running on the nRF52840 ? On the Ubuntu I assume you are running the chip-tool application ?
I would suggest to capture a sniffer trace to see what happens over the air.
Hi Gautam,
Do you have BLE timeout error on the Ubuntu's side ( I assume it's the central ? ) or on the nRF52840 ?
Do you have any log on the nRF52840 ?
Which sample you are running on the nRF52840 ? On the Ubuntu I assume you are running the chip-tool application ?
I would suggest to capture a sniffer trace to see what happens over the air.
yes i get error in ubuntu's side and i am using matter-bulb from nrf-connect-sdk 2.3.0 and yes i am using chip-tool.
this are the logs on nrf52840 when i run this command in chip-tool "sudo ./chip-tool pairing ble-wifi 1 FD 123 20202021 3840":
I: Factory Reset Triggered. Release button within 3000ms to cancel. I: Factory Reset has been Canceled I: Factory Reset Triggered. Release button within 3000ms to cancel. I: 28352 [TS]Pending Last Known Good Time: 2023-05-10T17:45:17 I: 28358 [TS]Previous Last Known Good Time: 2023-05-10T17:45:17 I: 28364 [TS]Reverted Last Known Good Time to previous value I: 28369 [DL]Performing factory reset I: 28414 [DL]Erasing Thread persistent info... I: nRF5 802154 radio initialized E: JEDEC id [00 00 00] expect [c2 28 17] I: 4 Sectors of 4096 bytes I: alloc wra: 0, 6b0 I: data wra: 0, 544 uart:~$ *** Booting Zephyr OS build v3.2.99-ncs2 *** I: Init CHIP stack I: 235 [DL]BLE address: D3:91:4F:49:9B:36 I: 245 [DL]OpenThread started: OK I: 248 [DL]Setting OpenThread device type to ROUTER I: 253 [SVR]Server initializing... I: 256 [TS]Last Known Good Time: [unknown] I: 260 [TS]Setting Last Known Good Time to firmware build time 2023-05-10T17:45:17 I: 272 [DMG]AccessControl: initializing I: 275 [DMG]Examples::AccessControlDelegate::Init I: 280 [DMG]AccessControl: setting I: 283 [DMG]DefaultAclStorage: initializing I: 287 [DMG]DefaultAclStorage: 0 entries loaded D: 291 [IN]UDP::Init bind&listen port=5540 E: 295 [IN]SO_REUSEPORT failed: 109 D: 298 [IN]UDP::Init bound to port=5540 D: 302 [IN]BLEBase::Init - setting/overriding transport D: 307 [IN]TransportMgr initialized I: 323 [ZCL]Using ZAP configuration... I: 329 [DMG]AccessControlCluster: initializing I: 333 [ZCL]Initiating Admin Commissioning cluster. I: 338 [ZCL]On/Off set value: 1 0 I: 341 [ZCL]On/off already set to new value I: 349 [ZCL]Cluster LevelControl: attribute CurrentLevel set to 1 D: 357 [IN]SecureSession[0x20003568]: Allocated Type:1 LSID:35776 I: 363 [DIS]Updating services using commissioning mode 1 I: 368 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1 E: 378 [DIS]Failed to advertise commissionable node: 3 E: 382 [DIS]Failed to finalize service update: 1c I: 387 [DIS]Updating services using commissioning mode 1 I: 393 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1 E: 402 [DIS]Failed to advertise commissionable node: 3 E: 407 [DIS]Failed to finalize service update: 1c I: 411 [DIS]Delaying proxy of operational discovery: missing delegate I: 417 [IN]CASE Server enabling CASE session setups D: 422 [IN]SecureSession[0x20003620]: Allocated Type:2 LSID:35777 I: 428 [SVR]Joining Multicast groups I: 432 [SVR]Server Listening... I: 435 [DL]Device Configuration: I: 438 [DL] Serial Number: 11223344556677889900 I: 442 [DL] Vendor Id: 65521 (0xFFF1) I: 446 [DL] Product Id: 32773 (0x8005) I: 450 [DL] Hardware Version: 0 I: 453 [DL] Setup Pin Code (0 for UNKNOWN/ERROR): 20202021 I: 458 [DL] Setup Discriminator (0xFFFF for UNKNOWN/ERROR): 3840 (0xF00) I: 465 [DL] Manufacturing Date: (not set) I: 469 [DL] Device Type: 65535 (0xFFFF) I: 473 [SVR]SetupQRCode: [MT:6FCJ142C00KA0648G00] I: 478 [SVR]Copy/paste the below URL in a browser to see the QR Code: I: 484 [SVR]https://project-chip.github.io/connectedhomeip/qrcode.html?data=MT%3A6FCJ142C00KA0648G00 I: 493 [SVR]Manual pairing code: [34970112332] I: 498 [DL]CHIP task running I: 503 [DL]CHIPoBLE advertising started I: 654 [ZCL]Cluster OnOff: attribute OnOff set to 0 I: 658 [ZCL]Cluster LevelControl: attribute CurrentLevel set to 254 E: 665 [DL]Long dispatch time: 159 ms, for event type 3 I: 670 [DL]NFC Tag emulation started I: 30506 [DL]CHIPoBLE advertising mode changed to slow I: 30513 [DL]CHIPoBLE advertising started I: 31291 [DL]BLE connection established (ConnId: 0x00) I: 31296 [DL]Current number of connections: 1/1 I: 31300 [DL]CHIPoBLE advertising stopped I: 31304 [DL]NFC Tag emulation stopped I: 41456 [DL]BLE GAP connection terminated (reason 0x28) I: 41461 [DL]Current number of connections: 0/1 I: 41467 [DL]CHIPoBLE advertising started I: 41471 [DL]NFC Tag emulation started
this are my chip-tool logs:
[1684152654.742530][105627:105627] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_kvs [1684152654.742639][105627:105627] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_factory.ini [1684152654.742672][105627:105627] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_config.ini [1684152654.742699][105627:105627] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_counters.ini [1684152654.742757][105627:105627] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-TgY6Xb) [1684152654.742847][105627:105627] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1684152654.742854][105627:105627] CHIP:DL: NVS set: chip-counters/reboot-count = 35 (0x23) [1684152654.743391][105627:105627] CHIP:DL: Got Ethernet interface: enp1s0 [1684152654.743831][105627:105627] CHIP:DL: Found the primary Ethernet interface:enp1s0 [1684152654.744295][105627:105627] CHIP:DL: Got WiFi interface: wlp3s0 [1684152654.745856][105627:105627] CHIP:DL: Found the primary WiFi interface:wlp3s0 [1684152654.745873][105627:105627] CHIP:IN: UDP::Init bind&listen port=0 [1684152654.745885][105627:105627] CHIP:IN: UDP::Init bound to port=60598 [1684152654.745888][105627:105627] CHIP:IN: UDP::Init bind&listen port=0 [1684152654.745894][105627:105627] CHIP:IN: UDP::Init bound to port=45850 [1684152654.745896][105627:105627] CHIP:IN: BLEBase::Init - setting/overriding transport [1684152654.745898][105627:105627] CHIP:IN: TransportMgr initialized [1684152654.745904][105627:105627] CHIP:FP: Initializing FabricTable from persistent storage [1684152654.745931][105627:105627] CHIP:TS: Last Known Good Time: 2023-05-15T15:02:24 [1684152654.746043][105627:105627] CHIP:FP: Fabric index 0x1 was retrieved from storage. Compressed FabricId 0x2CA210E66CF540C3, FabricId 0x0000000000000001, NodeId 0x000000000001B669, VendorId 0xFFF1 [1684152654.746385][105627:105627] CHIP:ZCL: Using ZAP configuration... [1684152654.750481][105627:105627] CHIP:CTL: System State Initialized... [1684152654.750491][105627:105627] CHIP:CTL: Stopping commissioning discovery over DNS-SD [1684152654.750497][105627:105627] CHIP:CTL: Setting attestation nonce to random value [1684152654.750502][105627:105627] CHIP:CTL: Setting CSR nonce to random value [1684152654.750509][105627:105627] CHIP:IN: UDP::Init bind&listen port=5550 [1684152654.750515][105627:105627] CHIP:IN: UDP::Init bound to port=5550 [1684152654.750518][105627:105627] CHIP:IN: UDP::Init bind&listen port=5550 [1684152654.750523][105627:105627] CHIP:IN: UDP::Init bound to port=5550 [1684152654.750524][105627:105627] CHIP:IN: TransportMgr initialized [1684152654.750589][105627:105629] CHIP:DL: CHIP task running [1684152654.750616][105627:105629] CHIP:DL: HandlePlatformSpecificBLEEvent 32784 [1684152654.750670][105627:105629] CHIP:CTL: Stopping commissioning discovery over DNS-SD [1684152654.750676][105627:105629] CHIP:CTL: Setting attestation nonce to random value [1684152654.750685][105627:105629] CHIP:CTL: Setting CSR nonce to random value [1684152654.751425][105627:105629] CHIP:CTL: Generating NOC [1684152654.751627][105627:105629] CHIP:FP: Validating NOC chain [1684152654.751962][105627:105629] CHIP:FP: NOC chain validation successful [1684152654.751996][105627:105629] CHIP:FP: Updated fabric at index: 0x1, Node ID: 0x000000000001B669 [1684152654.752000][105627:105629] CHIP:TS: Last Known Good Time: 2023-05-15T15:02:24 [1684152654.752002][105627:105629] CHIP:TS: New proposed Last Known Good Time: 2021-01-01T00:00:00 [1684152654.752004][105627:105629] CHIP:TS: Retaining current Last Known Good Time [1684152654.752261][105627:105629] CHIP:FP: Metadata for Fabric 0x1 persisted to storage. [1684152654.752476][105627:105629] CHIP:TS: Committing Last Known Good Time to storage: 2023-05-15T15:02:24 [1684152654.752673][105627:105629] CHIP:CTL: Joined the fabric at index 1. Fabric ID is 0x0000000000000001 (Compressed Fabric ID: 2CA210E66CF540C3) [1684152654.752679][105627:105629] CHIP:IN: UDP::Init bind&listen port=5550 [1684152654.752689][105627:105629] CHIP:IN: UDP::Init bound to port=5550 [1684152654.752691][105627:105629] CHIP:IN: UDP::Init bind&listen port=5550 [1684152654.752698][105627:105629] CHIP:IN: UDP::Init bound to port=5550 [1684152654.752700][105627:105629] CHIP:IN: TransportMgr initialized [1684152654.754690][105627:105629] CHIP:CTL: Setting wifi credentials from parameters [1684152654.754696][105627:105629] CHIP:CTL: Setting attestation nonce to random value [1684152654.754703][105627:105629] CHIP:CTL: Setting CSR nonce to random value [1684152654.754707][105627:105629] CHIP:CTL: Commission called for node ID 0x0000000000000001 [1684152654.755610][105627:105628] CHIP:DL: TRACE: Bus acquired for name C-9c9b [1684152654.757324][105627:105629] CHIP:DL: PlatformBlueZInit init success [1684152654.758434][105627:105628] CHIP:BLE: BLE removing known devices. [1684152654.758716][105627:105628] CHIP:BLE: BLE initiating scan. [1684152654.876034][105627:105629] CHIP:DL: Long dispatch time: 121 ms, for event type 2 [1684152654.887517][105627:105628] CHIP:BLE: Device E7:70:80:C3:AD:91 does not look like a CHIP device. [1684152654.888296][105627:105628] CHIP:BLE: Device 26:56:4A:D8:6E:9E does not look like a CHIP device. [1684152654.892176][105627:105628] CHIP:BLE: Device 06:8B:B2:DA:12:10 does not look like a CHIP device. [1684152654.904661][105627:105628] CHIP:BLE: Device 38:F5:CD:61:4A:37 does not look like a CHIP device. [1684152654.910672][105627:105628] CHIP:BLE: Device 19:88:3A:31:D6:1F does not look like a CHIP device. [1684152654.912033][105627:105628] CHIP:BLE: Device 29:88:96:2A:D7:32 does not look like a CHIP device. [1684152654.919299][105627:105628] CHIP:BLE: Device 05:E6:6C:A7:20:DA does not look like a CHIP device. [1684152654.929630][105627:105628] CHIP:BLE: New device scanned: D3:91:4F:49:9B:36 [1684152654.929654][105627:105628] CHIP:BLE: Device discriminator match. Attempting to connect. [1684152655.448250][105627:105628] CHIP:DL: ConnectDevice complete [1684152664.877072][105627:105629] CHIP:DIS: Closing all BLE connections [1684152664.877114][105627:105629] CHIP:TOO: Pairing Failure: src/platform/Linux/bluez/ChipDeviceScanner.cpp:178: CHIP Error 0x00000032: Timeout [1684152664.877132][105627:105629] CHIP:BLE: BLE scan error: src/platform/Linux/bluez/ChipDeviceScanner.cpp:178: CHIP Error 0x00000032: Timeout [1684152664.877399][105627:105627] CHIP:CTL: Shutting down the commissioner [1684152664.877420][105627:105627] CHIP:CTL: Stopping commissioning discovery over DNS-SD [1684152664.877465][105627:105627] CHIP:CTL: Shutting down the controller [1684152664.877479][105627:105627] CHIP:IN: Expiring all sessions for fabric 0x1!! [1684152664.877488][105627:105627] CHIP:FP: Forgetting fabric 0x1 [1684152664.877506][105627:105627] CHIP:TS: Pending Last Known Good Time: 2023-05-15T15:02:24 [1684152664.877621][105627:105627] CHIP:TS: Previous Last Known Good Time: 2023-05-15T15:02:24 [1684152664.877632][105627:105627] CHIP:TS: Reverted Last Known Good Time to previous value [1684152664.877657][105627:105627] CHIP:CTL: Shutting down the commissioner [1684152664.877665][105627:105627] CHIP:CTL: Stopping commissioning discovery over DNS-SD [1684152664.877698][105627:105627] CHIP:CTL: Shutting down the controller [1684152664.877708][105627:105627] CHIP:CTL: Shutting down the System State, this will teardown the CHIP Stack [1684152664.877775][105627:105627] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet [1684152664.877805][105627:105627] CHIP:BLE: BleConnectionDelegate::CancelConnection is not implemented. [1684152664.877822][105627:105627] CHIP:FP: Shutting down FabricTable [1684152664.877835][105627:105627] CHIP:TS: Pending Last Known Good Time: 2023-05-15T15:02:24 [1684152664.877902][105627:105627] CHIP:TS: Previous Last Known Good Time: 2023-05-15T15:02:24 [1684152664.877911][105627:105627] CHIP:TS: Reverted Last Known Good Time to previous value [1684152664.878051][105627:105627] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-1rytof) [1684152664.878304][105627:105627] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini) [1684152664.878334][105627:105627] CHIP:DL: NVS set: chip-counters/total-operational-hours = 0 (0x0) [1684152664.878349][105627:105627] CHIP:DL: Inet Layer shutdown [1684152664.878359][105627:105627] CHIP:DL: BLE shutdown [1684152664.878768][105627:105627] CHIP:DL: System Layer shutdown [1684152664.878938][105627:105627] CHIP:TOO: Run command failure: src/platform/Linux/bluez/ChipDeviceScanner.cpp:178: CHIP Error 0x00000032: Timeout
Hi Gautam,
I would suggest to capture a sniffer trace.
From the log on nRF52 I can see: I: 41456 [DL]BLE GAP connection terminated (reason 0x28)
Reason 28 could most likely be BLE_HCI_INSTANT_PASSED meaning it was an issue with the BLE command from the peer device. We would need to have a look at the sniffer trace to know what could be wrong here.
"No.","Time","Source","Destination","Protocol","Length","Info" "1","0.000000","host","controller","HCI_CMD","10","Sent LE Set Random Address" "2","0.119990","controller","host","HCI_EVT","7","Rcvd Command Complete (LE Set Random Address)" "3","0.120050","host","controller","HCI_CMD","11","Sent LE Set Scan Parameters" "4","0.120927","controller","host","HCI_EVT","7","Rcvd Command Complete (LE Set Scan Parameters)" "5","0.120989","host","controller","HCI_CMD","6","Sent LE Set Scan Enable" "6","0.121996","controller","host","HCI_EVT","7","Rcvd Command Complete (LE Set Scan Enable)" "7","0.142000","controller","host","HCI_EVT","23","Rcvd LE Meta (LE Advertising Report)" "8","0.153006","controller","host","HCI_EVT","32","Rcvd LE Meta (LE Advertising Report)" "9","0.162998","controller","host","HCI_EVT","46","Rcvd LE Meta (LE Advertising Report)" "10","0.173992","controller","host","HCI_EVT","46","Rcvd LE Meta (LE Advertising Report)" "11","0.178008","controller","host","HCI_EVT","45","Rcvd LE Meta (LE Advertising Report)" "12","0.178995","controller","host","HCI_EVT","15","Rcvd LE Meta (LE Advertising Report)" "13","0.185996","controller","host","HCI_EVT","45","Rcvd LE Meta (LE Advertising Report)" "14","0.186971","controller","host","HCI_EVT","15","Rcvd LE Meta (LE Advertising Report)" "15","0.188000","controller","host","HCI_EVT","46","Rcvd LE Meta (LE Advertising Report)" "16","0.190989","controller","host","HCI_EVT","46","Rcvd LE Meta (LE Advertising Report)" "17","0.199002","controller","host","HCI_EVT","44","Rcvd LE Meta (LE Advertising Report)" "18","0.210028","controller","host","HCI_EVT","46","Rcvd LE Meta (LE Advertising Report)" "19","0.211958","controller","host","HCI_EVT","46","Rcvd LE Meta (LE Advertising Report)" "20","0.222036","controller","host","HCI_EVT","32","Rcvd LE Meta (LE Advertising Report)" "21","0.222977","controller","host","HCI_EVT","15","Rcvd LE Meta (LE Advertising Report)" "22","0.224006","controller","host","HCI_EVT","46","Rcvd LE Meta (LE Advertising Report)" "23","0.227032","controller","host","HCI_EVT","30","Rcvd LE Meta (LE Advertising Report)" "24","0.228000","controller","host","HCI_EVT","28","Rcvd LE Meta (LE Advertising Report)" "25","0.230189","host","controller","HCI_CMD","6","Sent LE Set Scan Enable" "26","0.231009","controller","host","HCI_EVT","35","Rcvd LE Meta (LE Advertising Report)" "27","0.232999","controller","host","HCI_EVT","45","Rcvd LE Meta (LE Advertising Report)" "28","0.234016","controller","host","HCI_EVT","15","Rcvd LE Meta (LE Advertising Report)" "29","0.235027","controller","host","HCI_EVT","7","Rcvd Command Complete (LE Set Scan Enable)" "30","0.242512","host","controller","HCI_CMD","11","Sent LE Add Device To White List" "31","0.242929","controller","host","HCI_EVT","7","Rcvd Command Complete (LE Add Device To White List)" "32","0.242954","host","controller","HCI_CMD","11","Sent LE Set Scan Parameters" "33","0.243932","controller","host","HCI_EVT","7","Rcvd Command Complete (LE Set Scan Parameters)" "34","0.243943","host","controller","HCI_CMD","6","Sent LE Set Scan Enable" "35","0.244932","controller","host","HCI_EVT","7","Rcvd Command Complete (LE Set Scan Enable)" "36","0.384016","controller","host","HCI_EVT","30","Rcvd LE Meta (LE Advertising Report)" "37","0.384069","host","controller","HCI_CMD","6","Sent LE Set Scan Enable" "38","0.386929","controller","host","HCI_EVT","7","Rcvd Command Complete (LE Set Scan Enable)" "39","0.386975","host","controller","HCI_CMD","29","Sent LE Create Connection" "40","0.387938","controller","host","HCI_EVT","7","Rcvd Command Status (LE Create Connection)" "41","0.538997","controller","host","HCI_EVT","22","Rcvd LE Meta (LE Connection Complete)" "42","0.539093","host","controller","HCI_CMD","6","Sent LE Read Remote Features" "43","0.539977","controller","host","HCI_EVT","7","Rcvd Command Status (LE Read Remote Features)" "44","0.638964","controller","host","HCI_EVT","15","Rcvd LE Meta (LE Read Remote Features Complete)" "45","0.639348","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","12","Sent Exchange MTU Request, Client Rx MTU: 517" "46","0.688991","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "47","0.788172","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","12","Rcvd Exchange MTU Response, Server Rx MTU: 247" "48","0.788429","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","16","Sent Read By Type Request, Server Supported Features, Handles: 0x0001..0xffff" "49","0.889011","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "50","0.938357","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","14","Rcvd Error Response - Attribute Not Found, Handle: 0x0001 (Unknown)" "51","0.938536","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","16","Sent Read By Group Type Request, GATT Primary Service Declaration, Handles: 0x0001..0xffff" "52","0.988984","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "53","1.038481","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","29","Rcvd Read By Group Type Response, Attribute List Length: 3, Generic Attribute Profile, Generic Access Profile, ZigBee Alliance" "54","1.038688","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","16","Sent Read By Group Type Request, GATT Primary Service Declaration, Handles: 0x0016..0xffff" "55","1.088983","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "56","1.138334","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","14","Rcvd Error Response - Attribute Not Found, Handle: 0x0016 (ZigBee Alliance: Unknown)" "57","1.138491","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","16","Sent Read By Group Type Request, GATT Secondary Service Declaration, Handles: 0x0001..0xffff" "58","1.188981","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "59","1.238322","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","14","Rcvd Error Response - Attribute Not Found, Handle: 0x0001 (Generic Attribute Profile)" "60","1.238437","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","16","Sent Read By Type Request, GATT Include Declaration, Handles: 0x0001..0x0015" "61","1.288996","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "62","1.338329","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","14","Rcvd Error Response - Attribute Not Found, Handle: 0x0001 (Generic Attribute Profile)" "63","1.338528","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","16","Sent Read By Type Request, GATT Characteristic Declaration, Handles: 0x0001..0x0015" "64","1.388999","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "65","1.488387","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #66]" "66","1.489104","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","26","Rcvd Read By Type Response, Attribute List Length: 6, Service Changed, Client Supported Features, Database Hash, Device Name, Appearance, Peripheral Preferred Connection Parameters" "67","1.489327","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","16","Sent Read By Type Request, GATT Characteristic Declaration, Handles: 0x000f..0x0015" "68","1.538991","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "69","1.588318","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #70]" "70","1.588955","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","26","Rcvd Read By Type Response, Attribute List Length: 2, Unknown, Unknown" "71","1.589065","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","16","Sent Read By Type Request, GATT Characteristic Declaration, Handles: 0x0014..0x0015" "72","1.589789","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","L2CAP","21","Rcvd Connection Parameter Update Request" "73","1.589828","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","L2CAP","15","Sent Connection Parameter Update Response (Accepted)" "74","1.589844","host","controller","HCI_CMD","18","Sent LE Connection Update" "75","1.591012","controller","host","HCI_EVT","7","Rcvd Command Status (LE Connection Update)" "76","1.639005","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "77","1.639568","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","14","Rcvd Error Response - Attribute Not Found, Handle: 0x0014 (ZigBee Alliance: Unknown)" "78","1.639822","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","16","Sent Read By Type Request, Database Hash, Handles: 0x0001..0xffff" "79","1.639949","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "80","1.689002","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "81","1.738462","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","29","Rcvd Read By Type Response, Attribute List Length: 1" "82","1.738711","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","16","Sent Read By Type Request, Database Hash, Handles: 0x0009..0xffff" "83","1.788994","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "84","1.838351","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","14","Rcvd Error Response - Attribute Not Found, Handle: 0x0009 (Generic Access Profile)" "85","1.879630","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","13","Sent Write Request, Handle: 0x0006 (Generic Attribute Profile: Client Supported Features)" "86","1.888996","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "87","1.938305","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0006 (Generic Attribute Profile: Client Supported Features)" "88","1.938460","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","14","Sent Write Request, Handle: 0x0004 (Generic Attribute Profile: Service Changed: Unknown)" "89","1.989003","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "90","2.038289","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0004 (Generic Attribute Profile: Service Changed: Unknown)" "91","2.038419","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","12","Sent Read Request, Handle: 0x000b (Generic Access Profile: Device Name)" "92","2.089069","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "93","2.138382","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","21","Rcvd Read Response, Handle: 0x000b (Generic Access Profile: Device Name)" "94","2.138501","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","12","Sent Read Request, Handle: 0x000d (Generic Access Profile: Appearance)" "95","2.189007","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "96","2.238322","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","12","Rcvd Read Response, Handle: 0x000d (Generic Access Profile: Appearance)" "97","2.238659","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","21","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "98","2.288994","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "99","2.338296","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "100","2.339969","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","14","Sent Write Request, Handle: 0x0015 (ZigBee Alliance: Unknown: Unknown)" "101","2.389024","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "102","2.438216","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0015 (ZigBee Alliance: Unknown: Unknown)" "103","2.438904","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","18","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "104","2.439173","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "105","2.441023","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #107]" "106","2.441050","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #105] [Reassembled in #107]" "107","2.441055","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","31","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "108","2.489016","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "109","2.490022","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "110","2.490969","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "111","2.491964","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "112","2.538180","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "113","2.538863","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #118]" "114","2.539543","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #113] [Reassembled in #118]" "115","2.540243","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #113] [Reassembled in #118]" "116","2.540919","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #113] [Reassembled in #118]" "117","2.541568","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #113] [Reassembled in #118]" "118","2.542261","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","17","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "119","2.542373","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "120","2.545409","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #123]" "121","2.545425","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #120] [Reassembled in #123]" "122","2.545428","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #120] [Reassembled in #123]" "123","2.545430","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","28","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "124","2.589027","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "125","2.590023","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "126","2.591059","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "127","2.592014","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "128","2.593021","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "129","2.594029","controller","host","HCI_EVT","13","Rcvd LE Meta (LE Connection Update Complete)" "130","2.633353","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "131","4.613425","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #136]" "132","4.614085","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #131] [Reassembled in #136]" "133","4.614743","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #131] [Reassembled in #136]" "134","4.615420","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #131] [Reassembled in #136]" "135","4.616113","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #131] [Reassembled in #136]" "136","4.616713","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","9","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "137","4.616944","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "138","4.618671","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #140]" "139","4.618693","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #138] [Reassembled in #140]" "140","4.618697","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","22","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "141","4.658995","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "142","4.659977","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "143","4.660975","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "144","4.661982","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "145","4.703307","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "146","4.748398","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #147]" "147","4.749105","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","20","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "148","4.749261","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "149","4.751241","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #153]" "150","4.751271","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #149] [Reassembled in #153]" "151","4.751276","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #149] [Reassembled in #153]" "152","4.751282","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #149] [Reassembled in #153]" "153","4.751286","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","32","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "154","4.794037","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "155","4.795038","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "156","4.796026","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "157","4.797029","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "158","4.798029","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "159","4.799037","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "160","4.838232","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "161","4.838902","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #170]" "162","4.839582","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #161] [Reassembled in #170]" "163","4.840267","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #161] [Reassembled in #170]" "164","4.840937","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #161] [Reassembled in #170]" "165","4.841614","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #161] [Reassembled in #170]" "166","4.842234","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #161] [Reassembled in #170]" "167","4.842955","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #161] [Reassembled in #170]" "168","4.843668","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #161] [Reassembled in #170]" "169","4.844292","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #161] [Reassembled in #170]" "170","4.883412","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","13","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "171","4.883764","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "172","4.929038","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "173","4.973369","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #174]" "174","4.973986","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","6","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "175","4.974291","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "176","4.980193","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #178]" "177","4.980221","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #176] [Reassembled in #178]" "178","4.980227","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","28","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "179","5.018995","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "180","5.020028","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "181","5.021032","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "182","5.022037","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "183","5.063254","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "184","5.063909","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #186]" "185","5.064582","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #184] [Reassembled in #186]" "186","5.065377","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","29","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "187","5.065584","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "188","5.067963","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #191]" "189","5.067987","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #188] [Reassembled in #191]" "190","5.067991","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #188] [Reassembled in #191]" "191","5.067996","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","6","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "192","5.109059","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "193","5.110052","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "194","5.111024","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "195","5.112052","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "196","5.113051","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "197","5.153267","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "198","5.153905","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #200]" "199","5.154589","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #198] [Reassembled in #200]" "200","5.155394","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","29","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "201","5.155590","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "202","5.157809","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #204]" "203","5.157833","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #202] [Reassembled in #204]" "204","5.157837","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","25","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "205","5.199085","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "206","5.199997","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "207","5.200993","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "208","5.201995","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "209","5.243206","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "210","5.243896","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #219]" "211","5.244604","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #210] [Reassembled in #219]" "212","5.245226","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #210] [Reassembled in #219]" "213","5.245919","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #210] [Reassembled in #219]" "214","5.246600","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #210] [Reassembled in #219]" "215","5.247253","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #210] [Reassembled in #219]" "216","5.247885","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #210] [Reassembled in #219]" "217","5.248581","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #210] [Reassembled in #219]" "218","5.249251","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #210] [Reassembled in #219]" "219","5.288419","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","13","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "220","5.288573","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "221","5.334042","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "222","5.378416","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #231]" "223","5.379086","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #222] [Reassembled in #231]" "224","5.379750","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #222] [Reassembled in #231]" "225","5.380452","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #222] [Reassembled in #231]" "226","5.381108","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #222] [Reassembled in #231]" "227","5.381826","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #222] [Reassembled in #231]" "228","5.382456","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #222] [Reassembled in #231]" "229","5.383130","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #222] [Reassembled in #231]" "230","5.383831","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #222] [Reassembled in #231]" "231","5.384505","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","13","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "232","5.384837","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "233","5.424044","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "234","5.468431","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #236]" "235","5.469095","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #234] [Reassembled in #236]" "236","5.513329","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","6","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "237","5.513598","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "238","5.516164","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #240]" "239","5.516186","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #238] [Reassembled in #240]" "240","5.516190","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","25","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "241","5.561005","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "242","5.562050","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "243","5.563092","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "244","5.564057","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "245","5.603337","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "246","5.648444","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #255]" "247","5.693433","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #246] [Reassembled in #255]" "248","5.694095","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #246] [Reassembled in #255]" "249","5.694764","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #246] [Reassembled in #255]" "250","5.695485","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #246] [Reassembled in #255]" "251","5.696145","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #246] [Reassembled in #255]" "252","5.696773","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #246] [Reassembled in #255]" "253","5.697452","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #246] [Reassembled in #255]" "254","5.698156","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #246] [Reassembled in #255]" "255","5.698808","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","13","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "256","5.699164","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "257","5.739055","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "258","5.783393","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #267]" "259","5.784076","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #258] [Reassembled in #267]" "260","5.784817","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #258] [Reassembled in #267]" "261","5.785433","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #258] [Reassembled in #267]" "262","5.786099","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #258] [Reassembled in #267]" "263","5.786781","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #258] [Reassembled in #267]" "264","5.787453","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #258] [Reassembled in #267]" "265","5.788182","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #258] [Reassembled in #267]" "266","5.788803","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #258] [Reassembled in #267]" "267","5.789458","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","13","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "268","5.789638","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "269","5.873936","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #273]" "270","5.874055","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "271","5.874578","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #269] [Reassembled in #273]" "272","5.875264","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #269] [Reassembled in #273]" "273","5.875889","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","8","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "274","5.876247","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "275","5.878840","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #278]" "276","5.878866","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #275] [Reassembled in #278]" "277","5.878870","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #275] [Reassembled in #278]" "278","5.878875","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","30","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "279","5.919054","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "280","5.920051","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "281","5.921056","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "282","5.922056","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "283","5.923057","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "284","5.963347","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "285","6.008450","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #294]" "286","6.009097","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #285] [Reassembled in #294]" "287","6.009802","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #285] [Reassembled in #294]" "288","6.010439","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #285] [Reassembled in #294]" "289","6.011103","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #285] [Reassembled in #294]" "290","6.011796","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #285] [Reassembled in #294]" "291","6.012484","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #285] [Reassembled in #294]" "292","6.013139","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #285] [Reassembled in #294]" "293","6.013878","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #285] [Reassembled in #294]" "294","6.014476","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","13","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "295","6.014699","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "296","6.054051","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "297","6.098417","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #306]" "298","6.099082","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #297] [Reassembled in #306]" "299","6.099750","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #297] [Reassembled in #306]" "300","6.100475","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #297] [Reassembled in #306]" "301","6.101139","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #297] [Reassembled in #306]" "302","6.101793","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #297] [Reassembled in #306]" "303","6.102471","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #297] [Reassembled in #306]" "304","6.103155","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #297] [Reassembled in #306]" "305","6.103819","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #297] [Reassembled in #306]" "306","6.104491","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","13","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "307","6.104769","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "308","6.144044","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "309","6.188423","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #317]" "310","6.189110","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #309] [Reassembled in #317]" "311","6.189770","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #309] [Reassembled in #317]" "312","6.190448","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #309] [Reassembled in #317]" "313","6.191128","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #309] [Reassembled in #317]" "314","6.191799","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #309] [Reassembled in #317]" "315","6.192474","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #309] [Reassembled in #317]" "316","6.193177","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #309] [Reassembled in #317]" "317","6.193966","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","31","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "318","6.194287","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "319","6.200564","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #322]" "320","6.200589","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #319] [Reassembled in #322]" "321","6.200593","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #319] [Reassembled in #322]" "322","6.200596","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","30","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "323","6.234067","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "324","6.235066","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "325","6.236057","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "326","6.237066","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "327","6.238065","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "328","6.278367","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "329","6.548426","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #338]" "330","6.549136","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #329] [Reassembled in #338]" "331","6.549778","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #329] [Reassembled in #338]" "332","6.550452","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #329] [Reassembled in #338]" "333","6.551133","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #329] [Reassembled in #338]" "334","6.551802","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #329] [Reassembled in #338]" "335","6.552477","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #329] [Reassembled in #338]" "336","6.553180","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #329] [Reassembled in #338]" "337","6.553838","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #329] [Reassembled in #338]" "338","6.554488","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","13","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "339","6.554817","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "340","6.594067","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "341","6.683412","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #346]" "342","6.684093","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #341] [Reassembled in #346]" "343","6.684764","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #341] [Reassembled in #346]" "344","6.685432","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #341] [Reassembled in #346]" "345","6.686118","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #341] [Reassembled in #346]" "346","6.686812","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","14","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "347","6.686960","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "348","6.688532","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #361]" "349","6.688549","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #348] [Reassembled in #361]" "350","6.688551","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #348] [Reassembled in #361]" "351","6.688553","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #348] [Reassembled in #361]" "352","6.688555","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #348] [Reassembled in #361]" "353","6.688557","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #348] [Reassembled in #361]" "354","6.729059","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "355","6.729102","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #348] [Reassembled in #361]" "356","6.730046","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "357","6.730102","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #348] [Reassembled in #361]" "358","6.731060","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "359","6.731100","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #348] [Reassembled in #361]" "360","6.732053","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "361","6.732093","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","13","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "362","6.733064","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "363","6.734057","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "364","6.735063","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "365","6.774054","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "366","6.775053","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "367","6.776063","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "368","6.777012","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "369","6.818380","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "370","6.819917","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #372]" "371","6.819945","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #370] [Reassembled in #372]" "372","6.819950","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","14","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "373","6.864081","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "374","6.865060","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "375","6.866061","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "376","6.908388","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "377","6.998440","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #379]" "378","6.999100","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #377] [Reassembled in #379]" "379","6.999883","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","26","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "380","7.000154","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "381","7.002522","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #394]" "382","7.002549","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #381] [Reassembled in #394]" "383","7.002554","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #381] [Reassembled in #394]" "384","7.002559","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #381] [Reassembled in #394]" "385","7.002564","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #381] [Reassembled in #394]" "386","7.002569","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #381] [Reassembled in #394]" "387","7.044065","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "388","7.044137","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #381] [Reassembled in #394]" "389","7.045064","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "390","7.045118","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #381] [Reassembled in #394]" "391","7.046065","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "392","7.046118","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #381] [Reassembled in #394]" "393","7.047054","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "394","7.047106","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","13","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "395","7.048067","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "396","7.049057","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "397","7.050056","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "398","7.089067","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "399","7.090075","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "400","7.135066","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "401","7.136060","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "402","7.178376","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "403","7.179979","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #415]" "404","7.180006","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #403] [Reassembled in #415]" "405","7.180012","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #403] [Reassembled in #415]" "406","7.180017","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #403] [Reassembled in #415]" "407","7.180021","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #403] [Reassembled in #415]" "408","7.180026","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #403] [Reassembled in #415]" "409","7.180030","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #403] [Reassembled in #415]" "410","7.224087","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "411","7.224147","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #403] [Reassembled in #415]" "412","7.225076","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "413","7.225133","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #403] [Reassembled in #415]" "414","7.226091","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "415","7.226102","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","13","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "416","7.227067","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "417","7.228063","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "418","7.229083","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "419","7.230083","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "420","7.269057","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "421","7.270058","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "422","7.271073","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "423","7.313373","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "424","7.314652","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #427]" "425","7.314675","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #424] [Reassembled in #427]" "426","7.314680","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #424] [Reassembled in #427]" "427","7.314684","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","18","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "428","7.359082","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "429","7.360056","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "430","7.361011","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "431","7.362013","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "432","7.403404","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "433","7.628443","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #435]" "434","7.629095","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #433] [Reassembled in #435]" "435","7.629921","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","29","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "436","7.630102","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "437","7.632536","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Reassembled in #439]" "438","7.632566","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","HCI_ACL","32","Sent [Continuation to #437] [Reassembled in #439]" "439","7.632571","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","28","Sent Write Request, Handle: 0x0012 (ZigBee Alliance: Unknown)" "440","7.674115","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "441","7.675077","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "442","7.676109","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "443","7.677123","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "444","7.718253","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","10","Rcvd Write Response, Handle: 0x0012 (ZigBee Alliance: Unknown)" "445","7.718932","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Reassembled in #447]" "446","7.719615","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","HCI_ACL","32","Rcvd [Continuation to #445] [Reassembled in #447]" "447","7.720446","f2:97:b3:fa:2c:92 (MatterLight)","localhost ()","ATT","29","Rcvd Handle Value Indication, Handle: 0x0014 (ZigBee Alliance: Unknown)" "448","7.720768","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","10","Sent Handle Value Confirmation, Handle: 0x0014 (ZigBee Alliance: Unknown)" "449","7.722826","localhost ()","f2:97:b3:fa:2c:92 (MatterLight)","ATT","14","Sent Write Request, Handle: 0x0015 (ZigBee Alliance: Unknown: Unknown)" "450","7.764064","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "451","7.765064","controller","host","HCI_EVT","8","Rcvd Number of Completed Packets" "452","7.809100","controller","host","HCI_EVT","7","Rcvd Disconnect Complete"this are the logs that shows in wireshark.
Hi Gautam,
I don't see anything suspicious in the wireshark log. It doesn't seem it's the same as in the log from nRF52 where the connection disconnected with reason 0x28. Could you double check if you have captured a failed commission ?
And I would prefer to have the trace from the sniffer, so we can see on-air packets. Please download the sniffer from here: https://www.nordicsemi.com/Products/Development-tools/nrf-sniffer-for-bluetooth-le
You would need an extra DK to use as the sniffer.
hello,
this time when i try command i got this error in chip-tool.
[1684230718.566347][6292:6292] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_kvs
[1684230718.566428][6292:6292] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_factory.ini
[1684230718.566447][6292:6292] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_config.ini
[1684230718.566459][6292:6292] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_counters.ini
[1684230718.566516][6292:6292] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-inDG7Z)
[1684230718.566640][6292:6292] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1684230718.566646][6292:6292] CHIP:DL: NVS set: chip-counters/reboot-count = 2 (0x2)
[1684230718.567540][6292:6292] CHIP:DL: Got Ethernet interface: enp1s0
[1684230718.568349][6292:6292] CHIP:DL: Found the primary Ethernet interface:enp1s0
[1684230718.569145][6292:6292] CHIP:DL: Got WiFi interface: wlp3s0
[1684230718.570589][6292:6292] CHIP:DL: Found the primary WiFi interface:wlp3s0
[1684230718.570609][6292:6292] CHIP:IN: UDP::Init bind&listen port=0
[1684230718.570621][6292:6292] CHIP:IN: UDP::Init bound to port=35225
[1684230718.570623][6292:6292] CHIP:IN: UDP::Init bind&listen port=0
[1684230718.570632][6292:6292] CHIP:IN: UDP::Init bound to port=57223
[1684230718.570635][6292:6292] CHIP:IN: BLEBase::Init - setting/overriding transport
[1684230718.570638][6292:6292] CHIP:IN: TransportMgr initialized
[1684230718.570644][6292:6292] CHIP:FP: Initializing FabricTable from persistent storage
[1684230718.570674][6292:6292] CHIP:TS: Last Known Good Time: 2023-05-15T15:02:24
[1684230718.570783][6292:6292] CHIP:FP: Fabric index 0x1 was retrieved from storage. Compressed FabricId 0x9E54AB3775C029E2, FabricId 0x0000000000000001, NodeId 0x000000000001B669, VendorId 0xFFF1
[1684230718.571095][6292:6292] CHIP:ZCL: Using ZAP configuration...
[1684230718.580035][6292:6292] CHIP:CTL: System State Initialized...
[1684230718.580049][6292:6292] CHIP:CTL: Stopping commissioning discovery over DNS-SD
[1684230718.580057][6292:6292] CHIP:CTL: Setting attestation nonce to random value
[1684230718.580063][6292:6292] CHIP:CTL: Setting CSR nonce to random value
[1684230718.580072][6292:6292] CHIP:IN: UDP::Init bind&listen port=5550
[1684230718.580081][6292:6292] CHIP:IN: UDP::Init bound to port=5550
[1684230718.580084][6292:6292] CHIP:IN: UDP::Init bind&listen port=5550
[1684230718.580089][6292:6292] CHIP:IN: UDP::Init bound to port=5550
[1684230718.580091][6292:6292] CHIP:IN: TransportMgr initialized
[1684230718.580171][6292:6294] CHIP:DL: CHIP task running
[1684230718.580188][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 32784
[1684230718.580249][6292:6294] CHIP:CTL: Stopping commissioning discovery over DNS-SD
[1684230718.580257][6292:6294] CHIP:CTL: Setting attestation nonce to random value
[1684230718.580271][6292:6294] CHIP:CTL: Setting CSR nonce to random value
[1684230718.581064][6292:6294] CHIP:CTL: Generating NOC
[1684230718.581298][6292:6294] CHIP:FP: Validating NOC chain
[1684230718.581685][6292:6294] CHIP:FP: NOC chain validation successful
[1684230718.581724][6292:6294] CHIP:FP: Updated fabric at index: 0x1, Node ID: 0x000000000001B669
[1684230718.581728][6292:6294] CHIP:TS: Last Known Good Time: 2023-05-15T15:02:24
[1684230718.581731][6292:6294] CHIP:TS: New proposed Last Known Good Time: 2021-01-01T00:00:00
[1684230718.581732][6292:6294] CHIP:TS: Retaining current Last Known Good Time
[1684230718.582098][6292:6294] CHIP:FP: Metadata for Fabric 0x1 persisted to storage.
[1684230718.582342][6292:6294] CHIP:TS: Committing Last Known Good Time to storage: 2023-05-15T15:02:24
[1684230718.582548][6292:6294] CHIP:CTL: Joined the fabric at index 1. Fabric ID is 0x0000000000000001 (Compressed Fabric ID: 9E54AB3775C029E2)
[1684230718.582555][6292:6294] CHIP:IN: UDP::Init bind&listen port=5550
[1684230718.582566][6292:6294] CHIP:IN: UDP::Init bound to port=5550
[1684230718.582569][6292:6294] CHIP:IN: UDP::Init bind&listen port=5550
[1684230718.582577][6292:6294] CHIP:IN: UDP::Init bound to port=5550
[1684230718.582579][6292:6294] CHIP:IN: TransportMgr initialized
[1684230718.584709][6292:6294] CHIP:CTL: Setting wifi credentials from parameters
[1684230718.584715][6292:6294] CHIP:CTL: Setting attestation nonce to random value
[1684230718.584721][6292:6294] CHIP:CTL: Setting CSR nonce to random value
[1684230718.584725][6292:6294] CHIP:CTL: Commission called for node ID 0x0000000000000001
[1684230718.585744][6292:6293] CHIP:DL: TRACE: Bus acquired for name C-1894
[1684230718.587298][6292:6294] CHIP:DL: PlatformBlueZInit init success
[1684230718.588347][6292:6293] CHIP:BLE: BLE removing known devices.
[1684230718.588720][6292:6293] CHIP:BLE: BLE initiating scan.
[1684230718.705438][6292:6294] CHIP:DL: Long dispatch time: 120 ms, for event type 2
[1684230718.710072][6292:6293] CHIP:BLE: Device 0B:5B:28:CE:6D:3E does not look like a CHIP device.
[1684230718.717314][6292:6293] CHIP:BLE: Device 07:42:1D:BD:03:B9 does not look like a CHIP device.
[1684230718.722222][6292:6293] CHIP:BLE: Device 4F:21:E8:36:57:6E does not look like a CHIP device.
[1684230718.726946][6292:6293] CHIP:BLE: Device 04:E3:A7:D7:AE:7C does not look like a CHIP device.
[1684230718.732020][6292:6293] CHIP:BLE: Device 73:3A:B1:23:5F:0A does not look like a CHIP device.
[1684230718.746817][6292:6293] CHIP:BLE: Device CF:4F:81:F5:7D:55 does not look like a CHIP device.
[1684230718.747659][6292:6293] CHIP:BLE: Device 23:E7:6C:82:1E:88 does not look like a CHIP device.
[1684230718.750666][6292:6293] CHIP:BLE: Device 31:6D:B6:CA:BE:31 does not look like a CHIP device.
[1684230718.752190][6292:6293] CHIP:BLE: Device 31:16:44:6F:10:F8 does not look like a CHIP device.
[1684230718.764212][6292:6293] CHIP:BLE: Device 2A:79:29:6C:05:85 does not look like a CHIP device.
[1684230718.776483][6292:6293] CHIP:BLE: Device 1E:66:4F:16:1C:57 does not look like a CHIP device.
[1684230718.785696][6292:6293] CHIP:BLE: Device C8:74:00:1C:D2:D7 does not look like a CHIP device.
[1684230718.787414][6292:6293] CHIP:BLE: Device C3:B4:CA:7C:C4:31 does not look like a CHIP device.
[1684230718.792258][6292:6293] CHIP:BLE: Device 09:6D:AF:75:5F:77 does not look like a CHIP device.
[1684230718.807426][6292:6293] CHIP:BLE: Device C1:C8:16:AE:FD:1D does not look like a CHIP device.
[1684230718.811389][6292:6293] CHIP:BLE: Device 66:6C:EA:A6:B3:38 does not look like a CHIP device.
[1684230718.857189][6292:6293] CHIP:BLE: Device 73:01:BB:FC:F8:62 does not look like a CHIP device.
[1684230718.878114][6292:6293] CHIP:BLE: Device 54:44:A3:07:D5:79 does not look like a CHIP device.
[1684230718.900972][6292:6293] CHIP:BLE: New device scanned: FA:97:EA:11:13:83
[1684230718.900985][6292:6293] CHIP:BLE: Device discriminator match. Attempting to connect.
[1684230719.283789][6292:6293] CHIP:DL: ConnectDevice complete
[1684230720.560238][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0001
[1684230720.560250][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560255][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0001
[1684230720.560260][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560264][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0001
[1684230720.560267][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560271][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0001
[1684230720.560274][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560278][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0001
[1684230720.560281][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560285][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0001
[1684230720.560287][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560293][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560295][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560301][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0001
[1684230720.560304][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560308][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0001
[1684230720.560310][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560314][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0001
[1684230720.560316][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560322][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560325][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560329][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560332][6292:6293] CHIP:DL: Char1 /org/bluez/hci0/dev_FA_97_EA_11_13_83/service0010
[1684230720.560337][6292:6293] CHIP:DL: New BLE connection 0x7fc59c03bd20, device FA:97:EA:11:13:83, path /org/bluez/hci0/dev_FA_97_EA_11_13_83
[1684230720.560364][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16385
[1684230720.560373][6292:6294] CHIP:DIS: Closing all BLE connections
[1684230720.560388][6292:6294] CHIP:IN: BleConnectionComplete: endPoint 0x55a0155d5da0
[1684230720.560481][6292:6294] CHIP:IN: SecureSession[0x7fc594021970]: Allocated Type:1 LSID:1813
[1684230720.560489][6292:6294] CHIP:SC: Assigned local session key ID 1813
[1684230720.560515][6292:6294] CHIP:EM: <<< [E:36612i S:0 M:181178120] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest)
[1684230720.560530][6292:6294] CHIP:IN: (U) Sending msg 181178120 to IP address 'BLE'
[1684230720.560537][6292:6294] CHIP:IN: Message appended to BLE send queue
[1684230720.560541][6292:6294] CHIP:SC: Sent PBKDF param request
[1684230720.982907][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230721.083632][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16388
[1684230721.083656][6292:6294] CHIP:BLE: subscribe complete, ep = 0x55a0155d5da0
[1684230721.084021][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230721.084144][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230721.084160][6292:6294] CHIP:BLE: peripheral chose BTP version 4; central expected between 4 and 4
[1684230721.084166][6292:6294] CHIP:BLE: using BTP fragment sizes rx 244 / tx 244.
[1684230721.084169][6292:6294] CHIP:BLE: local and remote recv window size = 5
[1684230721.084348][6292:6294] CHIP:IN: BLE EndPoint 0x55a0155d5da0 Connection Complete
[1684230721.183056][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230721.187629][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230721.187729][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230721.187826][6292:6294] CHIP:EM: >>> [E:36612i S:0 M:96624967] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:21 (SecureChannel:PBKDFParamResponse)
[1684230721.187846][6292:6294] CHIP:EM: Found matching exchange: 36612i, Delegate: 0x7fc594023f50
[1684230721.187862][6292:6294] CHIP:SC: Received PBKDF param response
[1684230721.187884][6292:6294] CHIP:SC: Peer assigned session ID 1039
[1684230721.187902][6292:6294] CHIP:SC: Found MRP parameters in the message
[1684230721.193835][6292:6294] CHIP:EM: <<< [E:36612i S:0 M:181178121] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:22 (SecureChannel:PASE_Pake1)
[1684230721.193858][6292:6294] CHIP:IN: (U) Sending msg 181178121 to IP address 'BLE'
[1684230721.194131][6292:6294] CHIP:SC: Sent spake2p msg1
[1684230721.277908][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230723.307448][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230723.307596][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230723.307679][6292:6294] CHIP:EM: >>> [E:36612i S:0 M:96624968] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:23 (SecureChannel:PASE_Pake2)
[1684230723.307698][6292:6294] CHIP:EM: Found matching exchange: 36612i, Delegate: 0x7fc594023f50
[1684230723.307714][6292:6294] CHIP:SC: Received spake2p msg2
[1684230723.308570][6292:6294] CHIP:EM: <<< [E:36612i S:0 M:181178122] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:24 (SecureChannel:PASE_Pake3)
[1684230723.308597][6292:6294] CHIP:IN: (U) Sending msg 181178122 to IP address 'BLE'
[1684230723.308915][6292:6294] CHIP:SC: Sent spake2p msg3
[1684230723.393225][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230723.394895][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230723.395029][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230723.395106][6292:6294] CHIP:EM: >>> [E:36612i S:0 M:96624969] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:40 (SecureChannel:StatusReport)
[1684230723.395123][6292:6294] CHIP:EM: Found matching exchange: 36612i, Delegate: 0x7fc594023f50
[1684230723.395178][6292:6294] CHIP:SC: SecureSession[0x7fc594021970, LSID:1813]: State change 'kEstablishing' --> 'kActive'
[1684230723.395187][6292:6294] CHIP:IN: SecureSession[0x7fc594021970]: Activated - Type:1 LSID:1813
[1684230723.395194][6292:6294] CHIP:IN: New secure session activated for device <FFFFFFFB00000000, 0>, LSID:1813 PSID:1039!
[1684230723.395204][6292:6294] CHIP:CTL: Remote device completed SPAKE2+ handshake
[1684230723.395211][6292:6294] CHIP:TOO: Pairing Success
[1684230723.395215][6292:6294] CHIP:TOO: PASE establishment successful
[1684230723.395223][6292:6294] CHIP:CTL: Commissioning stage next step: 'SecurePairing' -> 'ReadCommissioningInfo'
[1684230723.395231][6292:6294] CHIP:CTL: Performing next commissioning step 'ReadCommissioningInfo'
[1684230723.395237][6292:6294] CHIP:CTL: Sending request for commissioning information
[1684230723.395255][6292:6294] CHIP:DMG: SendReadRequest ReadClient[0x7fc59402c3d0]: Sending Read Request
[1684230723.395323][6292:6294] CHIP:EM: <<< [E:36613i S:1813 M:185546708] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
[1684230723.395340][6292:6294] CHIP:IN: (S) Sending msg 185546708 on secure session with LSID: 1813
[1684230723.395546][6292:6294] CHIP:DMG: MoveToState ReadClient[0x7fc59402c3d0]: Moving to [AwaitingIn]
[1684230723.527884][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230723.574049][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230723.574131][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230723.664564][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230723.664623][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230723.664678][6292:6294] CHIP:EM: >>> [E:36613i S:1813 M:68342278] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
[1684230723.664690][6292:6294] CHIP:EM: Found matching exchange: 36613i, Delegate: 0x7fc59402c3e0
[1684230723.664733][6292:6294] CHIP:DMG: ReportDataMessage =
[1684230723.664738][6292:6294] CHIP:DMG: {
[1684230723.664741][6292:6294] CHIP:DMG: AttributeReportIBs =
[1684230723.664750][6292:6294] CHIP:DMG: [
[1684230723.664753][6292:6294] CHIP:DMG: AttributeReportIB =
[1684230723.664762][6292:6294] CHIP:DMG: {
[1684230723.664766][6292:6294] CHIP:DMG: AttributeDataIB =
[1684230723.664772][6292:6294] CHIP:DMG: {
[1684230723.664778][6292:6294] CHIP:DMG: DataVersion = 0x822639a4,
[1684230723.664782][6292:6294] CHIP:DMG: AttributePathIB =
[1684230723.664787][6292:6294] CHIP:DMG: {
[1684230723.664792][6292:6294] CHIP:DMG: Endpoint = 0x0,
[1684230723.664798][6292:6294] CHIP:DMG: Cluster = 0x31,
[1684230723.664804][6292:6294] CHIP:DMG: Attribute = 0x0000_0003,
[1684230723.664808][6292:6294] CHIP:DMG: }
[1684230723.664815][6292:6294] CHIP:DMG:
[1684230723.664821][6292:6294] CHIP:DMG: Data = 20,
[1684230723.664827][6292:6294] CHIP:DMG: },
[1684230723.664833][6292:6294] CHIP:DMG:
[1684230723.664837][6292:6294] CHIP:DMG: },
[1684230723.664849][6292:6294] CHIP:DMG:
[1684230723.664852][6292:6294] CHIP:DMG: AttributeReportIB =
[1684230723.664860][6292:6294] CHIP:DMG: {
[1684230723.664864][6292:6294] CHIP:DMG: AttributeDataIB =
[1684230723.664868][6292:6294] CHIP:DMG: {
[1684230723.664873][6292:6294] CHIP:DMG: DataVersion = 0x2c4d208d,
[1684230723.664880][6292:6294] CHIP:DMG: AttributePathIB =
[1684230723.664884][6292:6294] CHIP:DMG: {
[1684230723.664889][6292:6294] CHIP:DMG: Endpoint = 0x0,
[1684230723.664894][6292:6294] CHIP:DMG: Cluster = 0x28,
[1684230723.664899][6292:6294] CHIP:DMG: Attribute = 0x0000_0004,
[1684230723.664904][6292:6294] CHIP:DMG: }
[1684230723.664909][6292:6294] CHIP:DMG:
[1684230723.664915][6292:6294] CHIP:DMG: Data = 32773,
[1684230723.664919][6292:6294] CHIP:DMG: },
[1684230723.664926][6292:6294] CHIP:DMG:
[1684230723.664930][6292:6294] CHIP:DMG: },
[1684230723.664939][6292:6294] CHIP:DMG:
[1684230723.664943][6292:6294] CHIP:DMG: AttributeReportIB =
[1684230723.664949][6292:6294] CHIP:DMG: {
[1684230723.664953][6292:6294] CHIP:DMG: AttributeDataIB =
[1684230723.664959][6292:6294] CHIP:DMG: {
[1684230723.664964][6292:6294] CHIP:DMG: DataVersion = 0x2c4d208d,
[1684230723.664968][6292:6294] CHIP:DMG: AttributePathIB =
[1684230723.664973][6292:6294] CHIP:DMG: {
[1684230723.664977][6292:6294] CHIP:DMG: Endpoint = 0x0,
[1684230723.664982][6292:6294] CHIP:DMG: Cluster = 0x28,
[1684230723.664987][6292:6294] CHIP:DMG: Attribute = 0x0000_0002,
[1684230723.664992][6292:6294] CHIP:DMG: }
[1684230723.664997][6292:6294] CHIP:DMG:
[1684230723.665002][6292:6294] CHIP:DMG: Data = 65521,
[1684230723.665006][6292:6294] CHIP:DMG: },
[1684230723.665014][6292:6294] CHIP:DMG:
[1684230723.665017][6292:6294] CHIP:DMG: },
[1684230723.665027][6292:6294] CHIP:DMG:
[1684230723.665031][6292:6294] CHIP:DMG: AttributeReportIB =
[1684230723.665039][6292:6294] CHIP:DMG: {
[1684230723.665043][6292:6294] CHIP:DMG: AttributeDataIB =
[1684230723.665049][6292:6294] CHIP:DMG: {
[1684230723.665053][6292:6294] CHIP:DMG: DataVersion = 0x915d7a9a,
[1684230723.665057][6292:6294] CHIP:DMG: AttributePathIB =
[1684230723.665062][6292:6294] CHIP:DMG: {
[1684230723.665067][6292:6294] CHIP:DMG: Endpoint = 0x0,
[1684230723.665072][6292:6294] CHIP:DMG: Cluster = 0x30,
[1684230723.665076][6292:6294] CHIP:DMG: Attribute = 0x0000_0003,
[1684230723.665081][6292:6294] CHIP:DMG: }
[1684230723.665087][6292:6294] CHIP:DMG:
[1684230723.665091][6292:6294] CHIP:DMG: Data = 0,
[1684230723.665096][6292:6294] CHIP:DMG: },
[1684230723.665102][6292:6294] CHIP:DMG:
[1684230723.665106][6292:6294] CHIP:DMG: },
[1684230723.665116][6292:6294] CHIP:DMG:
[1684230723.665120][6292:6294] CHIP:DMG: AttributeReportIB =
[1684230723.665128][6292:6294] CHIP:DMG: {
[1684230723.665132][6292:6294] CHIP:DMG: AttributeDataIB =
[1684230723.665137][6292:6294] CHIP:DMG: {
[1684230723.665141][6292:6294] CHIP:DMG: DataVersion = 0x915d7a9a,
[1684230723.665145][6292:6294] CHIP:DMG: AttributePathIB =
[1684230723.665150][6292:6294] CHIP:DMG: {
[1684230723.665155][6292:6294] CHIP:DMG: Endpoint = 0x0,
[1684230723.665160][6292:6294] CHIP:DMG: Cluster = 0x30,
[1684230723.665165][6292:6294] CHIP:DMG: Attribute = 0x0000_0002,
[1684230723.665169][6292:6294] CHIP:DMG: }
[1684230723.665176][6292:6294] CHIP:DMG:
[1684230723.665180][6292:6294] CHIP:DMG: Data = 0,
[1684230723.665184][6292:6294] CHIP:DMG: },
[1684230723.665191][6292:6294] CHIP:DMG:
[1684230723.665194][6292:6294] CHIP:DMG: },
[1684230723.665204][6292:6294] CHIP:DMG:
[1684230723.665208][6292:6294] CHIP:DMG: AttributeReportIB =
[1684230723.665216][6292:6294] CHIP:DMG: {
[1684230723.665219][6292:6294] CHIP:DMG: AttributeDataIB =
[1684230723.665225][6292:6294] CHIP:DMG: {
[1684230723.665229][6292:6294] CHIP:DMG: DataVersion = 0x915d7a9a,
[1684230723.665234][6292:6294] CHIP:DMG: AttributePathIB =
[1684230723.665238][6292:6294] CHIP:DMG: {
[1684230723.665243][6292:6294] CHIP:DMG: Endpoint = 0x0,
[1684230723.665248][6292:6294] CHIP:DMG: Cluster = 0x30,
[1684230723.665253][6292:6294] CHIP:DMG: Attribute = 0x0000_0001,
[1684230723.665257][6292:6294] CHIP:DMG: }
[1684230723.665263][6292:6294] CHIP:DMG:
[1684230723.665268][6292:6294] CHIP:DMG: Data =
[1684230723.665272][6292:6294] CHIP:DMG: {
[1684230723.665278][6292:6294] CHIP:DMG: 0x0 = 60,
[1684230723.665283][6292:6294] CHIP:DMG: 0x1 = 900,
[1684230723.665288][6292:6294] CHIP:DMG: },
[1684230723.665292][6292:6294] CHIP:DMG: },
[1684230723.665299][6292:6294] CHIP:DMG:
[1684230723.665303][6292:6294] CHIP:DMG: },
[1684230723.665314][6292:6294] CHIP:DMG:
[1684230723.665318][6292:6294] CHIP:DMG: AttributeReportIB =
[1684230723.665326][6292:6294] CHIP:DMG: {
[1684230723.665329][6292:6294] CHIP:DMG: AttributeDataIB =
[1684230723.665334][6292:6294] CHIP:DMG: {
[1684230723.665339][6292:6294] CHIP:DMG: DataVersion = 0x915d7a9a,
[1684230723.665343][6292:6294] CHIP:DMG: AttributePathIB =
[1684230723.665348][6292:6294] CHIP:DMG: {
[1684230723.665352][6292:6294] CHIP:DMG: Endpoint = 0x0,
[1684230723.665357][6292:6294] CHIP:DMG: Cluster = 0x30,
[1684230723.665362][6292:6294] CHIP:DMG: Attribute = 0x0000_0000,
[1684230723.665367][6292:6294] CHIP:DMG: }
[1684230723.665372][6292:6294] CHIP:DMG:
[1684230723.665377][6292:6294] CHIP:DMG: Data = 0,
[1684230723.665381][6292:6294] CHIP:DMG: },
[1684230723.665388][6292:6294] CHIP:DMG:
[1684230723.665391][6292:6294] CHIP:DMG: },
[1684230723.665415][6292:6294] CHIP:DMG:
[1684230723.665420][6292:6294] CHIP:DMG: AttributeReportIB =
[1684230723.665427][6292:6294] CHIP:DMG: {
[1684230723.665432][6292:6294] CHIP:DMG: AttributeDataIB =
[1684230723.665436][6292:6294] CHIP:DMG: {
[1684230723.665441][6292:6294] CHIP:DMG: DataVersion = 0x822639a4,
[1684230723.665445][6292:6294] CHIP:DMG: AttributePathIB =
[1684230723.665449][6292:6294] CHIP:DMG: {
[1684230723.665454][6292:6294] CHIP:DMG: Endpoint = 0x0,
[1684230723.665459][6292:6294] CHIP:DMG: Cluster = 0x31,
[1684230723.665464][6292:6294] CHIP:DMG: Attribute = 0x0000_FFFC,
[1684230723.665469][6292:6294] CHIP:DMG: }
[1684230723.665475][6292:6294] CHIP:DMG:
[1684230723.665479][6292:6294] CHIP:DMG: Data = 2,
[1684230723.665483][6292:6294] CHIP:DMG: },
[1684230723.665490][6292:6294] CHIP:DMG:
[1684230723.665495][6292:6294] CHIP:DMG: },
[1684230723.665502][6292:6294] CHIP:DMG:
[1684230723.665505][6292:6294] CHIP:DMG: ],
[1684230723.665532][6292:6294] CHIP:DMG:
[1684230723.665536][6292:6294] CHIP:DMG: SuppressResponse = true,
[1684230723.665540][6292:6294] CHIP:DMG: InteractionModelRevision = 1
[1684230723.665544][6292:6294] CHIP:DMG: }
[1684230723.665927][6292:6294] CHIP:CTL: ----- NetworkCommissioning Features: has Thread. endpointid = 0
[1684230723.665955][6292:6294] CHIP:CTL: Successfully finished commissioning step 'ReadCommissioningInfo'
[1684230723.665964][6292:6294] CHIP:CTL: Commissioning stage next step: 'ReadCommissioningInfo' -> 'ArmFailSafe'
[1684230723.665973][6292:6294] CHIP:CTL: Performing next commissioning step 'ArmFailSafe'
[1684230723.665979][6292:6294] CHIP:CTL: Arming failsafe (60 seconds)
[1684230723.666000][6292:6294] CHIP:DMG: ICR moving to [AddingComm]
[1684230723.666014][6292:6294] CHIP:DMG: ICR moving to [AddedComma]
[1684230723.666041][6292:6294] CHIP:EM: <<< [E:36614i S:1813 M:185546709] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1684230723.666051][6292:6294] CHIP:IN: (S) Sending msg 185546709 on secure session with LSID: 1813
[1684230723.666175][6292:6294] CHIP:DMG: ICR moving to [CommandSen]
[1684230723.753231][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230723.755807][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230723.755858][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230723.755928][6292:6294] CHIP:EM: >>> [E:36614i S:1813 M:68342279] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1684230723.755941][6292:6294] CHIP:EM: Found matching exchange: 36614i, Delegate: 0x7fc59c002c08
[1684230723.755953][6292:6294] CHIP:DMG: ICR moving to [ResponseRe]
[1684230723.755973][6292:6294] CHIP:DMG: InvokeResponseMessage =
[1684230723.755978][6292:6294] CHIP:DMG: {
[1684230723.755985][6292:6294] CHIP:DMG: suppressResponse = false,
[1684230723.755990][6292:6294] CHIP:DMG: InvokeResponseIBs =
[1684230723.756000][6292:6294] CHIP:DMG: [
[1684230723.756006][6292:6294] CHIP:DMG: InvokeResponseIB =
[1684230723.756018][6292:6294] CHIP:DMG: {
[1684230723.756025][6292:6294] CHIP:DMG: CommandDataIB =
[1684230723.756033][6292:6294] CHIP:DMG: {
[1684230723.756038][6292:6294] CHIP:DMG: CommandPathIB =
[1684230723.756044][6292:6294] CHIP:DMG: {
[1684230723.756050][6292:6294] CHIP:DMG: EndpointId = 0x0,
[1684230723.756056][6292:6294] CHIP:DMG: ClusterId = 0x30,
[1684230723.756061][6292:6294] CHIP:DMG: CommandId = 0x1,
[1684230723.756066][6292:6294] CHIP:DMG: },
[1684230723.756072][6292:6294] CHIP:DMG:
[1684230723.756078][6292:6294] CHIP:DMG: CommandFields =
[1684230723.756083][6292:6294] CHIP:DMG: {
[1684230723.756091][6292:6294] CHIP:DMG: 0x0 = 0,
[1684230723.756099][6292:6294] CHIP:DMG: 0x1 = "" (0 chars),
[1684230723.756106][6292:6294] CHIP:DMG: },
[1684230723.756110][6292:6294] CHIP:DMG: },
[1684230723.756118][6292:6294] CHIP:DMG:
[1684230723.756122][6292:6294] CHIP:DMG: },
[1684230723.756130][6292:6294] CHIP:DMG:
[1684230723.756134][6292:6294] CHIP:DMG: ],
[1684230723.756142][6292:6294] CHIP:DMG:
[1684230723.756147][6292:6294] CHIP:DMG: InteractionModelRevision = 1
[1684230723.756150][6292:6294] CHIP:DMG: },
[1684230723.756176][6292:6294] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0001
[1684230723.756197][6292:6294] CHIP:CTL: Received ArmFailSafe response errorCode=0
[1684230723.756205][6292:6294] CHIP:CTL: Successfully finished commissioning step 'ArmFailSafe'
[1684230723.756210][6292:6294] CHIP:CTL: Commissioning stage next step: 'ArmFailSafe' -> 'ConfigRegulatory'
[1684230723.756217][6292:6294] CHIP:CTL: Performing next commissioning step 'ConfigRegulatory'
[1684230723.756221][6292:6294] CHIP:CTL: Setting Regulatory Config
[1684230723.756225][6292:6294] CHIP:CTL: Device does not support configurable regulatory location
[1684230723.756245][6292:6294] CHIP:DMG: ICR moving to [AddingComm]
[1684230723.756258][6292:6294] CHIP:DMG: ICR moving to [AddedComma]
[1684230723.756285][6292:6294] CHIP:EM: <<< [E:36615i S:1813 M:185546710] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1684230723.756296][6292:6294] CHIP:IN: (S) Sending msg 185546710 on secure session with LSID: 1813
[1684230723.756435][6292:6294] CHIP:DMG: ICR moving to [CommandSen]
[1684230723.756471][6292:6294] CHIP:DMG: ICR moving to [AwaitingDe]
[1684230723.843455][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230723.846226][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230723.846316][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230723.846403][6292:6294] CHIP:EM: >>> [E:36615i S:1813 M:68342280] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1684230723.846420][6292:6294] CHIP:EM: Found matching exchange: 36615i, Delegate: 0x7fc594020e18
[1684230723.846438][6292:6294] CHIP:DMG: ICR moving to [ResponseRe]
[1684230723.846467][6292:6294] CHIP:DMG: InvokeResponseMessage =
[1684230723.846475][6292:6294] CHIP:DMG: {
[1684230723.846484][6292:6294] CHIP:DMG: suppressResponse = false,
[1684230723.846493][6292:6294] CHIP:DMG: InvokeResponseIBs =
[1684230723.846511][6292:6294] CHIP:DMG: [
[1684230723.846517][6292:6294] CHIP:DMG: InvokeResponseIB =
[1684230723.846535][6292:6294] CHIP:DMG: {
[1684230723.846542][6292:6294] CHIP:DMG: CommandDataIB =
[1684230723.846555][6292:6294] CHIP:DMG: {
[1684230723.846566][6292:6294] CHIP:DMG: CommandPathIB =
[1684230723.846578][6292:6294] CHIP:DMG: {
[1684230723.846590][6292:6294] CHIP:DMG: EndpointId = 0x0,
[1684230723.846602][6292:6294] CHIP:DMG: ClusterId = 0x30,
[1684230723.846612][6292:6294] CHIP:DMG: CommandId = 0x3,
[1684230723.846622][6292:6294] CHIP:DMG: },
[1684230723.846637][6292:6294] CHIP:DMG:
[1684230723.846646][6292:6294] CHIP:DMG: CommandFields =
[1684230723.846660][6292:6294] CHIP:DMG: {
[1684230723.846672][6292:6294] CHIP:DMG: 0x0 = 0,
[1684230723.846685][6292:6294] CHIP:DMG: 0x1 = "" (0 chars),
[1684230723.846696][6292:6294] CHIP:DMG: },
[1684230723.846704][6292:6294] CHIP:DMG: },
[1684230723.846721][6292:6294] CHIP:DMG:
[1684230723.846728][6292:6294] CHIP:DMG: },
[1684230723.846744][6292:6294] CHIP:DMG:
[1684230723.846750][6292:6294] CHIP:DMG: ],
[1684230723.846766][6292:6294] CHIP:DMG:
[1684230723.846774][6292:6294] CHIP:DMG: InteractionModelRevision = 1
[1684230723.846781][6292:6294] CHIP:DMG: },
[1684230723.846826][6292:6294] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0003
[1684230723.846857][6292:6294] CHIP:CTL: Received SetRegulatoryConfig response errorCode=0
[1684230723.846870][6292:6294] CHIP:CTL: Successfully finished commissioning step 'ConfigRegulatory'
[1684230723.846878][6292:6294] CHIP:CTL: Commissioning stage next step: 'ConfigRegulatory' -> 'SendPAICertificateRequest'
[1684230723.846890][6292:6294] CHIP:CTL: Performing next commissioning step 'SendPAICertificateRequest'
[1684230723.846897][6292:6294] CHIP:CTL: Sending request for PAI certificate
[1684230723.846905][6292:6294] CHIP:CTL: Sending Certificate Chain request to 0x7fc594023f00 device
[1684230723.846936][6292:6294] CHIP:DMG: ICR moving to [AddingComm]
[1684230723.846947][6292:6294] CHIP:DMG: ICR moving to [AddedComma]
[1684230723.846983][6292:6294] CHIP:EM: <<< [E:36616i S:1813 M:185546711] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1684230723.846997][6292:6294] CHIP:IN: (S) Sending msg 185546711 on secure session with LSID: 1813
[1684230723.847222][6292:6294] CHIP:DMG: ICR moving to [CommandSen]
[1684230723.847266][6292:6294] CHIP:DMG: ICR moving to [AwaitingDe]
[1684230723.932799][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230723.978176][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230723.978235][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230724.075305][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230724.075412][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230724.160492][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230724.160604][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230724.160716][6292:6294] CHIP:EM: >>> [E:36616i S:1813 M:68342281] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1684230724.160738][6292:6294] CHIP:EM: Found matching exchange: 36616i, Delegate: 0x7fc59c002c08
[1684230724.160758][6292:6294] CHIP:DMG: ICR moving to [ResponseRe]
[1684230724.160791][6292:6294] CHIP:DMG: InvokeResponseMessage =
[1684230724.160800][6292:6294] CHIP:DMG: {
[1684230724.160809][6292:6294] CHIP:DMG: suppressResponse = false,
[1684230724.160819][6292:6294] CHIP:DMG: InvokeResponseIBs =
[1684230724.160835][6292:6294] CHIP:DMG: [
[1684230724.160843][6292:6294] CHIP:DMG: InvokeResponseIB =
[1684230724.160857][6292:6294] CHIP:DMG: {
[1684230724.160865][6292:6294] CHIP:DMG: CommandDataIB =
[1684230724.160876][6292:6294] CHIP:DMG: {
[1684230724.160884][6292:6294] CHIP:DMG: CommandPathIB =
[1684230724.160895][6292:6294] CHIP:DMG: {
[1684230724.160906][6292:6294] CHIP:DMG: EndpointId = 0x0,
[1684230724.160918][6292:6294] CHIP:DMG: ClusterId = 0x3e,
[1684230724.160936][6292:6294] CHIP:DMG: CommandId = 0x3,
[1684230724.160945][6292:6294] CHIP:DMG: },
[1684230724.160957][6292:6294] CHIP:DMG:
[1684230724.160966][6292:6294] CHIP:DMG: CommandFields =
[1684230724.160976][6292:6294] CHIP:DMG: {
[1684230724.160987][6292:6294] CHIP:DMG: 0x0 = [
[1684230724.161075][6292:6294] CHIP:DMG: 0x30, 0x82, 0x01, 0xcb, 0x30, 0x82, 0x01, 0x71, 0xa0, 0x03, 0x02, 0x01, 0x02, 0x02, 0x08, 0x56, 0xad, 0x82, 0x22, 0xad, 0x94, 0x5b, 0x64, 0x30, 0x0a, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x04, 0x03, 0x02, 0x30, 0x30, 0x31, 0x18, 0x30, 0x16, 0x06, 0x03, 0x55, 0x04, 0x03, 0x0c, 0x0f, 0x4d, 0x61, 0x74, 0x74, 0x65, 0x72, 0x20, 0x54, 0x65, 0x73, 0x74, 0x20, 0x50, 0x41, 0x41, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x01, 0x0c, 0x04, 0x46, 0x46, 0x46, 0x31, 0x30, 0x20, 0x17, 0x0d, 0x32, 0x32, 0x30, 0x32, 0x30, 0x35, 0x30, 0x30, 0x30, 0x30, 0x30, 0x30, 0x5a, 0x18, 0x0f, 0x39, 0x39, 0x39, 0x39, 0x31, 0x32, 0x33, 0x31, 0x32, 0x33, 0x35, 0x39, 0x35, 0x39, 0x5a, 0x30, 0x3d, 0x31, 0x25, 0x30, 0x23, 0x06, 0x03, 0x55, 0x04, 0x03, 0x0c, 0x1c, 0x4d, 0x61, 0x74, 0x74, 0x65, 0x72, 0x20, 0x44, 0x65, 0x76, 0x20, 0x50, 0x41, 0x49, 0x20, 0x30, 0x78, 0x46, 0x46, 0x46, 0x31, 0x20, 0x6e, 0x6f, 0x20, 0x50, 0x49, 0x44, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x01, 0x0c, 0x04, 0x46, 0x46, 0x46, 0x31, 0x30, 0x59, 0x30, 0x13, 0x06, 0x07, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x02, 0x01, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x03, 0x01, 0x07, 0x03, 0x42, 0x00, 0x04, 0x41, 0x9a, 0x93, 0x15, 0xc2, 0x17, 0x3e, 0x0c, 0x8c, 0x87, 0x6d, 0x03, 0xcc, 0xfc, 0x94, 0x48, 0x52, 0x64, 0x7f, 0x7f, 0xec, 0x5e, 0x50, 0x82, 0xf4, 0x05, 0x99, 0x28, 0xec, 0xa8, 0x94, 0xc5, 0x94, 0x15, 0x13, 0x09, 0xac, 0x63, 0x1e, 0x4c, 0xb0, 0x33, 0x92, 0xaf, 0x68, 0x4b, 0x0b, 0xaf, 0xb7, 0xe6, 0x5b, 0x3b, 0x81, 0x62, 0xc2, 0xf5, 0x2b, 0xf9, 0x31, 0xb8, 0xe7, 0x7a, 0xaa, 0x82, 0xa3, 0x66, 0x30, 0x64, 0x30, 0x12, 0x06, 0x03, 0x55, 0x1d, 0x
[1684230724.161112][6292:6294] CHIP:DMG: ] (463 bytes)
[1684230724.161124][6292:6294] CHIP:DMG: },
[1684230724.161132][6292:6294] CHIP:DMG: },
[1684230724.161146][6292:6294] CHIP:DMG:
[1684230724.161154][6292:6294] CHIP:DMG: },
[1684230724.161169][6292:6294] CHIP:DMG:
[1684230724.161176][6292:6294] CHIP:DMG: ],
[1684230724.161191][6292:6294] CHIP:DMG:
[1684230724.161199][6292:6294] CHIP:DMG: InteractionModelRevision = 1
[1684230724.161207][6292:6294] CHIP:DMG: },
[1684230724.161257][6292:6294] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0003
[1684230724.161274][6292:6294] CHIP:CTL: Received certificate chain from the device
[1684230724.161290][6292:6294] CHIP:CTL: Successfully finished commissioning step 'SendPAICertificateRequest'
[1684230724.161301][6292:6294] CHIP:CTL: Commissioning stage next step: 'SendPAICertificateRequest' -> 'SendDACCertificateRequest'
[1684230724.161313][6292:6294] CHIP:CTL: Performing next commissioning step 'SendDACCertificateRequest'
[1684230724.161321][6292:6294] CHIP:CTL: Sending request for DAC certificate
[1684230724.161328][6292:6294] CHIP:CTL: Sending Certificate Chain request to 0x7fc594023f00 device
[1684230724.161362][6292:6294] CHIP:DMG: ICR moving to [AddingComm]
[1684230724.161374][6292:6294] CHIP:DMG: ICR moving to [AddedComma]
[1684230724.161449][6292:6294] CHIP:EM: <<< [E:36617i S:1813 M:185546712] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1684230724.161475][6292:6294] CHIP:IN: (S) Sending msg 185546712 on secure session with LSID: 1813
[1684230724.161715][6292:6294] CHIP:DMG: ICR moving to [CommandSen]
[1684230724.161772][6292:6294] CHIP:DMG: ICR moving to [AwaitingDe]
[1684230724.293522][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230724.345272][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230724.345372][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230724.435132][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230724.435251][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230724.521386][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230724.521505][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230724.521606][6292:6294] CHIP:EM: >>> [E:36617i S:1813 M:68342282] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1684230724.521628][6292:6294] CHIP:EM: Found matching exchange: 36617i, Delegate: 0x7fc59c061058
[1684230724.521646][6292:6294] CHIP:DMG: ICR moving to [ResponseRe]
[1684230724.521677][6292:6294] CHIP:DMG: InvokeResponseMessage =
[1684230724.521686][6292:6294] CHIP:DMG: {
[1684230724.521695][6292:6294] CHIP:DMG: suppressResponse = false,
[1684230724.521704][6292:6294] CHIP:DMG: InvokeResponseIBs =
[1684230724.521722][6292:6294] CHIP:DMG: [
[1684230724.521730][6292:6294] CHIP:DMG: InvokeResponseIB =
[1684230724.521744][6292:6294] CHIP:DMG: {
[1684230724.521756][6292:6294] CHIP:DMG: CommandDataIB =
[1684230724.521767][6292:6294] CHIP:DMG: {
[1684230724.521775][6292:6294] CHIP:DMG: CommandPathIB =
[1684230724.521786][6292:6294] CHIP:DMG: {
[1684230724.521797][6292:6294] CHIP:DMG: EndpointId = 0x0,
[1684230724.521808][6292:6294] CHIP:DMG: ClusterId = 0x3e,
[1684230724.521818][6292:6294] CHIP:DMG: CommandId = 0x3,
[1684230724.521827][6292:6294] CHIP:DMG: },
[1684230724.521838][6292:6294] CHIP:DMG:
[1684230724.521847][6292:6294] CHIP:DMG: CommandFields =
[1684230724.521857][6292:6294] CHIP:DMG: {
[1684230724.521869][6292:6294] CHIP:DMG: 0x0 = [
[1684230724.521957][6292:6294] CHIP:DMG: 0x30, 0x82, 0x01, 0xe8, 0x30, 0x82, 0x01, 0x8e, 0xa0, 0x03, 0x02, 0x01, 0x02, 0x02, 0x08, 0x6f, 0xdc, 0xb6, 0xed, 0x06, 0xf3, 0x58, 0xf9, 0x30, 0x0a, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x04, 0x03, 0x02, 0x30, 0x3d, 0x31, 0x25, 0x30, 0x23, 0x06, 0x03, 0x55, 0x04, 0x03, 0x0c, 0x1c, 0x4d, 0x61, 0x74, 0x74, 0x65, 0x72, 0x20, 0x44, 0x65, 0x76, 0x20, 0x50, 0x41, 0x49, 0x20, 0x30, 0x78, 0x46, 0x46, 0x46, 0x31, 0x20, 0x6e, 0x6f, 0x20, 0x50, 0x49, 0x44, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x01, 0x0c, 0x04, 0x46, 0x46, 0x46, 0x31, 0x30, 0x20, 0x17, 0x0d, 0x32, 0x32, 0x30, 0x32, 0x30, 0x35, 0x30, 0x30, 0x30, 0x30, 0x30, 0x30, 0x5a, 0x18, 0x0f, 0x39, 0x39, 0x39, 0x39, 0x31, 0x32, 0x33, 0x31, 0x32, 0x33, 0x35, 0x39, 0x35, 0x39, 0x5a, 0x30, 0x53, 0x31, 0x25, 0x30, 0x23, 0x06, 0x03, 0x55, 0x04, 0x03, 0x0c, 0x1c, 0x4d, 0x61, 0x74, 0x74, 0x65, 0x72, 0x20, 0x44, 0x65, 0x76, 0x20, 0x44, 0x41, 0x43, 0x20, 0x30, 0x78, 0x46, 0x46, 0x46, 0x31, 0x2f, 0x30, 0x78, 0x38, 0x30, 0x30, 0x35, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x01, 0x0c, 0x04, 0x46, 0x46, 0x46, 0x31, 0x31, 0x14, 0x30, 0x12, 0x06, 0x0a, 0x2b, 0x06, 0x01, 0x04, 0x01, 0x82, 0xa2, 0x7c, 0x02, 0x02, 0x0c, 0x04, 0x38, 0x30, 0x30, 0x35, 0x30, 0x59, 0x30, 0x13, 0x06, 0x07, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x02, 0x01, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x03, 0x01, 0x07, 0x03, 0x42, 0x00, 0x04, 0x7e, 0xf2, 0xf1, 0x08, 0x2b, 0x2a, 0x56, 0x4a, 0x05, 0x44, 0xc0, 0xa6, 0x13, 0xd2, 0x1b, 0x15, 0x75, 0x00, 0x55, 0x2d, 0x03, 0x5f, 0x23, 0x02, 0x25, 0x2f, 0xce, 0xe8, 0x1d, 0x6e, 0xc6, 0x74, 0x17, 0x34, 0x18, 0xa9, 0x4a, 0x88, 0xdb, 0x
[1684230724.521996][6292:6294] CHIP:DMG: ] (492 bytes)
[1684230724.522006][6292:6294] CHIP:DMG: },
[1684230724.522014][6292:6294] CHIP:DMG: },
[1684230724.522028][6292:6294] CHIP:DMG:
[1684230724.522036][6292:6294] CHIP:DMG: },
[1684230724.522052][6292:6294] CHIP:DMG:
[1684230724.522059][6292:6294] CHIP:DMG: ],
[1684230724.522075][6292:6294] CHIP:DMG:
[1684230724.522083][6292:6294] CHIP:DMG: InteractionModelRevision = 1
[1684230724.522092][6292:6294] CHIP:DMG: },
[1684230724.522143][6292:6294] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0003
[1684230724.522160][6292:6294] CHIP:CTL: Received certificate chain from the device
[1684230724.522173][6292:6294] CHIP:CTL: Successfully finished commissioning step 'SendDACCertificateRequest'
[1684230724.522184][6292:6294] CHIP:CTL: Commissioning stage next step: 'SendDACCertificateRequest' -> 'SendAttestationRequest'
[1684230724.522195][6292:6294] CHIP:CTL: Performing next commissioning step 'SendAttestationRequest'
[1684230724.522201][6292:6294] CHIP:CTL: Sending Attestation Request to the device.
[1684230724.522206][6292:6294] CHIP:CTL: Sending Attestation request to 0x7fc594023f00 device
[1684230724.522254][6292:6294] CHIP:DMG: ICR moving to [AddingComm]
[1684230724.522265][6292:6294] CHIP:DMG: ICR moving to [AddedComma]
[1684230724.522305][6292:6294] CHIP:EM: <<< [E:36618i S:1813 M:185546713] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1684230724.522321][6292:6294] CHIP:IN: (S) Sending msg 185546713 on secure session with LSID: 1813
[1684230724.522584][6292:6294] CHIP:DMG: ICR moving to [CommandSen]
[1684230724.522599][6292:6294] CHIP:CTL: Sent Attestation request, waiting for the Attestation Information
[1684230724.522622][6292:6294] CHIP:DMG: ICR moving to [AwaitingDe]
[1684230724.608623][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230724.659927][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230724.659991][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230724.749989][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230724.750064][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230724.839896][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230724.839995][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230724.840087][6292:6294] CHIP:EM: >>> [E:36618i S:1813 M:68342283] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1684230724.840107][6292:6294] CHIP:EM: Found matching exchange: 36618i, Delegate: 0x7fc59c061318
[1684230724.840128][6292:6294] CHIP:DMG: ICR moving to [ResponseRe]
[1684230724.840161][6292:6294] CHIP:DMG: InvokeResponseMessage =
[1684230724.840170][6292:6294] CHIP:DMG: {
[1684230724.840179][6292:6294] CHIP:DMG: suppressResponse = false,
[1684230724.840188][6292:6294] CHIP:DMG: InvokeResponseIBs =
[1684230724.840204][6292:6294] CHIP:DMG: [
[1684230724.840212][6292:6294] CHIP:DMG: InvokeResponseIB =
[1684230724.840230][6292:6294] CHIP:DMG: {
[1684230724.840239][6292:6294] CHIP:DMG: CommandDataIB =
[1684230724.840251][6292:6294] CHIP:DMG: {
[1684230724.840259][6292:6294] CHIP:DMG: CommandPathIB =
[1684230724.840270][6292:6294] CHIP:DMG: {
[1684230724.840281][6292:6294] CHIP:DMG: EndpointId = 0x0,
[1684230724.840291][6292:6294] CHIP:DMG: ClusterId = 0x3e,
[1684230724.840305][6292:6294] CHIP:DMG: CommandId = 0x1,
[1684230724.840314][6292:6294] CHIP:DMG: },
[1684230724.840327][6292:6294] CHIP:DMG:
[1684230724.840336][6292:6294] CHIP:DMG: CommandFields =
[1684230724.840347][6292:6294] CHIP:DMG: {
[1684230724.840358][6292:6294] CHIP:DMG: 0x0 = [
[1684230724.840453][6292:6294] CHIP:DMG: 0x15, 0x31, 0x01, 0x1b, 0x02, 0x30, 0x82, 0x02, 0x17, 0x06, 0x09, 0x2a, 0x86, 0x48, 0x86, 0xf7, 0x0d, 0x01, 0x07, 0x02, 0xa0, 0x82, 0x02, 0x08, 0x30, 0x82, 0x02, 0x04, 0x02, 0x01, 0x03, 0x31, 0x0d, 0x30, 0x0b, 0x06, 0x09, 0x60, 0x86, 0x48, 0x01, 0x65, 0x03, 0x04, 0x02, 0x01, 0x30, 0x82, 0x01, 0x70, 0x06, 0x09, 0x2a, 0x86, 0x48, 0x86, 0xf7, 0x0d, 0x01, 0x07, 0x01, 0xa0, 0x82, 0x01, 0x61, 0x04, 0x82, 0x01, 0x5d, 0x15, 0x24, 0x00, 0x01, 0x25, 0x01, 0xf1, 0xff, 0x36, 0x02, 0x05, 0x00, 0x80, 0x05, 0x01, 0x80, 0x05, 0x02, 0x80, 0x05, 0x03, 0x80, 0x05, 0x04, 0x80, 0x05, 0x05, 0x80, 0x05, 0x06, 0x80, 0x05, 0x07, 0x80, 0x05, 0x08, 0x80, 0x05, 0x09, 0x80, 0x05, 0x0a, 0x80, 0x05, 0x0b, 0x80, 0x05, 0x0c, 0x80, 0x05, 0x0d, 0x80, 0x05, 0x0e, 0x80, 0x05, 0x0f, 0x80, 0x05, 0x10, 0x80, 0x05, 0x11, 0x80, 0x05, 0x12, 0x80, 0x05, 0x13, 0x80, 0x05, 0x14, 0x80, 0x05, 0x15, 0x80, 0x05, 0x16, 0x80, 0x05, 0x17, 0x80, 0x05, 0x18, 0x80, 0x05, 0x19, 0x80, 0x05, 0x1a, 0x80, 0x05, 0x1b, 0x80, 0x05, 0x1c, 0x80, 0x05, 0x1d, 0x80, 0x05, 0x1e, 0x80, 0x05, 0x1f, 0x80, 0x05, 0x20, 0x80, 0x05, 0x21, 0x80, 0x05, 0x22, 0x80, 0x05, 0x23, 0x80, 0x05, 0x24, 0x80, 0x05, 0x25, 0x80, 0x05, 0x26, 0x80, 0x05, 0x27, 0x80, 0x05, 0x28, 0x80, 0x05, 0x29, 0x80, 0x05, 0x2a, 0x80, 0x05, 0x2b, 0x80, 0x05, 0x2c, 0x80, 0x05, 0x2d, 0x80, 0x05, 0x2e, 0x80, 0x05, 0x2f, 0x80, 0x05, 0x30, 0x80, 0x05, 0x31, 0x80, 0x05, 0x32, 0x80, 0x05, 0x33, 0x80, 0x05, 0x34, 0x80, 0x05, 0x35, 0x80, 0x05, 0x36, 0x80, 0x05, 0x37, 0x80, 0x05, 0x38, 0x80, 0x05, 0x39, 0x80, 0x05, 0x3a, 0x80, 0x05, 0x3b, 0x80, 0x05, 0x3c, 0x80, 0x05, 0x3d, 0x80, 0x05, 0x3e, 0x80, 0x05, 0x3f, 0x80, 0x05, 0x40, 0x80, 0x05, 0x41, 0x80, 0x05, 0x42, 0x80, 0x05, 0x43, 0x80, 0x
[1684230724.840510][6292:6294] CHIP:DMG: ] (583 bytes)
[1684230724.840524][6292:6294] CHIP:DMG: 0x1 = [
[1684230724.840562][6292:6294] CHIP:DMG: 0x95, 0xb0, 0xbf, 0xff, 0xe9, 0x86, 0xb2, 0x65, 0x9d, 0x5c, 0xac, 0xc4, 0xf7, 0xcc, 0xb8, 0x45, 0x28, 0x45, 0x7f, 0x86, 0xd4, 0xa1, 0x0b, 0xed, 0x0e, 0x5c, 0xb1, 0x7a, 0x87, 0x8b, 0x57, 0xbc, 0x8b, 0x36, 0xf6, 0x21, 0x80, 0xe0, 0x9e, 0xea, 0x68, 0x78, 0xf2, 0x83, 0x9e, 0xc2, 0x68, 0xec, 0x09, 0xb2, 0xb0, 0x23, 0x0c, 0xd4, 0x17, 0xc9, 0xc3, 0x7a, 0x1a, 0xeb, 0xc5, 0x7d, 0xcc, 0x3e,
[1684230724.840579][6292:6294] CHIP:DMG: ] (64 bytes)
[1684230724.840589][6292:6294] CHIP:DMG: },
[1684230724.840597][6292:6294] CHIP:DMG: },
[1684230724.840614][6292:6294] CHIP:DMG:
[1684230724.840621][6292:6294] CHIP:DMG: },
[1684230724.840637][6292:6294] CHIP:DMG:
[1684230724.840644][6292:6294] CHIP:DMG: ],
[1684230724.840661][6292:6294] CHIP:DMG:
[1684230724.840669][6292:6294] CHIP:DMG: InteractionModelRevision = 1
[1684230724.840677][6292:6294] CHIP:DMG: },
[1684230724.840731][6292:6294] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0001
[1684230724.840750][6292:6294] CHIP:CTL: Received Attestation Information from the device
[1684230724.840763][6292:6294] CHIP:CTL: Successfully finished commissioning step 'SendAttestationRequest'
[1684230724.840773][6292:6294] CHIP:CTL: AutoCommissioner setting attestationElements buffer size 583/583
[1684230724.840797][6292:6294] CHIP:CTL: Commissioning stage next step: 'SendAttestationRequest' -> 'AttestationVerification'
[1684230724.840811][6292:6294] CHIP:CTL: Performing next commissioning step 'AttestationVerification'
[1684230724.840816][6292:6294] CHIP:CTL: Verifying attestation
[1684230724.844947][6292:6294] CHIP:CTL: Successfully validated 'Attestation Information' command received from the device.
[1684230724.844971][6292:6294] CHIP:CTL: Successfully finished commissioning step 'AttestationVerification'
[1684230724.844980][6292:6294] CHIP:CTL: Commissioning stage next step: 'AttestationVerification' -> 'SendOpCertSigningRequest'
[1684230724.844991][6292:6294] CHIP:CTL: Performing next commissioning step 'SendOpCertSigningRequest'
[1684230724.845000][6292:6294] CHIP:CTL: Sending CSR request to 0x7fc594023f00 device
[1684230724.845054][6292:6294] CHIP:DMG: ICR moving to [AddingComm]
[1684230724.845074][6292:6294] CHIP:DMG: ICR moving to [AddedComma]
[1684230724.845118][6292:6294] CHIP:EM: <<< [E:36619i S:1813 M:185546714] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1684230724.845135][6292:6294] CHIP:IN: (S) Sending msg 185546714 on secure session with LSID: 1813
[1684230724.845374][6292:6294] CHIP:DMG: ICR moving to [CommandSen]
[1684230724.845389][6292:6294] CHIP:CTL: Sent CSR request, waiting for the CSR
[1684230724.845453][6292:6294] CHIP:DMG: ICR moving to [AwaitingDe]
[1684230724.923799][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230725.200157][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230725.200230][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230725.288004][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230725.288103][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230725.288199][6292:6294] CHIP:EM: >>> [E:36619i S:1813 M:68342284] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1684230725.288220][6292:6294] CHIP:EM: Found matching exchange: 36619i, Delegate: 0x7fc59c061478
[1684230725.288240][6292:6294] CHIP:DMG: ICR moving to [ResponseRe]
[1684230725.288276][6292:6294] CHIP:DMG: InvokeResponseMessage =
[1684230725.288286][6292:6294] CHIP:DMG: {
[1684230725.288296][6292:6294] CHIP:DMG: suppressResponse = false,
[1684230725.288307][6292:6294] CHIP:DMG: InvokeResponseIBs =
[1684230725.288328][6292:6294] CHIP:DMG: [
[1684230725.288336][6292:6294] CHIP:DMG: InvokeResponseIB =
[1684230725.288352][6292:6294] CHIP:DMG: {
[1684230725.288361][6292:6294] CHIP:DMG: CommandDataIB =
[1684230725.288371][6292:6294] CHIP:DMG: {
[1684230725.288380][6292:6294] CHIP:DMG: CommandPathIB =
[1684230725.288393][6292:6294] CHIP:DMG: {
[1684230725.288405][6292:6294] CHIP:DMG: EndpointId = 0x0,
[1684230725.288416][6292:6294] CHIP:DMG: ClusterId = 0x3e,
[1684230725.288428][6292:6294] CHIP:DMG: CommandId = 0x5,
[1684230725.288438][6292:6294] CHIP:DMG: },
[1684230725.288451][6292:6294] CHIP:DMG:
[1684230725.288461][6292:6294] CHIP:DMG: CommandFields =
[1684230725.288471][6292:6294] CHIP:DMG: {
[1684230725.288484][6292:6294] CHIP:DMG: 0x0 = [
[1684230725.288566][6292:6294] CHIP:DMG: 0x15, 0x30, 0x01, 0xce, 0x30, 0x81, 0xcb, 0x30, 0x70, 0x02, 0x01, 0x00, 0x30, 0x0e, 0x31, 0x0c, 0x30, 0x0a, 0x06, 0x03, 0x55, 0x04, 0x0a, 0x0c, 0x03, 0x43, 0x53, 0x52, 0x30, 0x59, 0x30, 0x13, 0x06, 0x07, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x02, 0x01, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x03, 0x01, 0x07, 0x03, 0x42, 0x00, 0x04, 0x9a, 0x8b, 0x14, 0xdc, 0x68, 0x21, 0x0b, 0x10, 0xc2, 0x84, 0x69, 0x65, 0xff, 0xd6, 0xcc, 0x3c, 0x1f, 0xfa, 0x37, 0xaa, 0xbc, 0x7c, 0xb8, 0x0f, 0xa1, 0x5d, 0xaa, 0xd7, 0xc0, 0x97, 0xc4, 0xbb, 0xa7, 0x2a, 0xb6, 0x5b, 0x52, 0x1e, 0xf0, 0x26, 0xb0, 0x2e, 0x95, 0xf7, 0xb5, 0x45, 0xc7, 0xf8, 0xd0, 0xcc, 0x4c, 0xd2, 0x25, 0x58, 0x07, 0x0d, 0x13, 0x2f, 0x1f, 0x60, 0x59, 0x4d, 0xfa, 0x74, 0xa0, 0x00, 0x30, 0x0c, 0x06, 0x08, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x04, 0x03, 0x02, 0x05, 0x00, 0x03, 0x49, 0x00, 0x30, 0x46, 0x02, 0x21, 0x00, 0xda, 0x2f, 0x62, 0x33, 0x7a, 0x3e, 0x12, 0x23, 0x61, 0x11, 0xd2, 0x3d, 0xb4, 0x55, 0x93, 0x40, 0xdf, 0xb1, 0x3e, 0x63, 0x70, 0x47, 0x04, 0xf4, 0x25, 0x4e, 0x56, 0xc9, 0xf7, 0x00, 0xfb, 0xf6, 0x02, 0x21, 0x00, 0x98, 0xa7, 0x94, 0xac, 0xb6, 0x86, 0xa7, 0xc7, 0x4f, 0xbd, 0xee, 0xde, 0x5d, 0xdf, 0xb9, 0x07, 0x5b, 0xd1, 0x09, 0xbf, 0x29, 0xff, 0xd6, 0x2f, 0x7f, 0x17, 0xa7, 0x60, 0xe5, 0x24, 0xef, 0x4b, 0x30, 0x02, 0x20, 0x8e, 0x94, 0x54, 0x13, 0xe7, 0xfa, 0x23, 0x4a, 0x51, 0xfe, 0xab, 0xc1, 0x41, 0x45, 0xf5, 0x16, 0xea, 0x49, 0x6b, 0x00, 0x5f, 0xc6, 0x21, 0x92, 0x2e, 0xe2, 0x77, 0xec, 0xf4, 0x51, 0x5b, 0xaf, 0x18,
[1684230725.288603][6292:6294] CHIP:DMG: ] (246 bytes)
[1684230725.288614][6292:6294] CHIP:DMG: 0x1 = [
[1684230725.288641][6292:6294] CHIP:DMG: 0x50, 0xf8, 0x21, 0x2b, 0x30, 0xb4, 0xf3, 0x8e, 0xd9, 0x52, 0x7a, 0x0c, 0xb2, 0x34, 0x24, 0xfc, 0x23, 0x99, 0xdf, 0xe2, 0xb0, 0x68, 0x6a, 0x0a, 0x78, 0xf8, 0x37, 0x0e, 0xc5, 0x69, 0x76, 0xee, 0x33, 0x8c, 0x67, 0x75, 0x82, 0x08, 0xa0, 0x85, 0xb3, 0x4c, 0x62, 0xcf, 0xe8, 0x43, 0x0e, 0xf0, 0x9f, 0x53, 0xd6, 0x8d, 0x48, 0xf5, 0xaa, 0xcf, 0x7f, 0x71, 0xea, 0x23, 0x57, 0x57, 0xf2, 0xb5,
[1684230725.288658][6292:6294] CHIP:DMG: ] (64 bytes)
[1684230725.288669][6292:6294] CHIP:DMG: },
[1684230725.288679][6292:6294] CHIP:DMG: },
[1684230725.288696][6292:6294] CHIP:DMG:
[1684230725.288704][6292:6294] CHIP:DMG: },
[1684230725.288722][6292:6294] CHIP:DMG:
[1684230725.288730][6292:6294] CHIP:DMG: ],
[1684230725.288748][6292:6294] CHIP:DMG:
[1684230725.288757][6292:6294] CHIP:DMG: InteractionModelRevision = 1
[1684230725.288764][6292:6294] CHIP:DMG: },
[1684230725.288820][6292:6294] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0005
[1684230725.288841][6292:6294] CHIP:CTL: Received certificate signing request from the device
[1684230725.288858][6292:6294] CHIP:CTL: Successfully finished commissioning step 'SendOpCertSigningRequest'
[1684230725.288869][6292:6294] CHIP:CTL: Commissioning stage next step: 'SendOpCertSigningRequest' -> 'ValidateCSR'
[1684230725.288882][6292:6294] CHIP:CTL: Performing next commissioning step 'ValidateCSR'
[1684230725.289815][6292:6294] CHIP:CTL: Successfully finished commissioning step 'ValidateCSR'
[1684230725.289832][6292:6294] CHIP:CTL: Commissioning stage next step: 'ValidateCSR' -> 'GenerateNOCChain'
[1684230725.289843][6292:6294] CHIP:CTL: Performing next commissioning step 'GenerateNOCChain'
[1684230725.289853][6292:6294] CHIP:CTL: Getting certificate chain for the device from the issuer
[1684230725.290042][6292:6294] CHIP:CTL: Verifying Certificate Signing Request
[1684230725.290672][6292:6294] CHIP:CTL: Generating NOC
[1684230725.290883][6292:6294] CHIP:CTL: Providing certificate chain to the commissioner
[1684230725.290894][6292:6294] CHIP:CTL: Received callback from the CA for NOC Chain generation. Status src/controller/ExampleOperationalCredentialsIssuer.cpp:396: Success
[1684230725.290904][6292:6294] CHIP:CTL: Successfully finished commissioning step 'GenerateNOCChain'
[1684230725.291010][6292:6294] CHIP:CTL: Performing next commissioning step 'SendTrustedRootCert'
[1684230725.291016][6292:6294] CHIP:CTL: Sending root certificate to the device
[1684230725.291041][6292:6294] CHIP:DMG: ICR moving to [AddingComm]
[1684230725.291060][6292:6294] CHIP:DMG: ICR moving to [AddedComma]
[1684230725.291092][6292:6294] CHIP:EM: <<< [E:36620i S:1813 M:185546715] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1684230725.291105][6292:6294] CHIP:IN: (S) Sending msg 185546715 on secure session with LSID: 1813
[1684230725.291361][6292:6294] CHIP:DMG: ICR moving to [CommandSen]
[1684230725.291374][6292:6294] CHIP:CTL: Sent root certificate to the device
[1684230725.291492][6292:6294] CHIP:DMG: ICR moving to [AwaitingDe]
[1684230725.418751][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230725.508634][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230725.600998][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230725.601109][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230725.601242][6292:6294] CHIP:EM: >>> [E:36620i S:1813 M:68342285] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1684230725.601273][6292:6294] CHIP:EM: Found matching exchange: 36620i, Delegate: 0x7fc59c061318
[1684230725.601298][6292:6294] CHIP:DMG: ICR moving to [ResponseRe]
[1684230725.601335][6292:6294] CHIP:DMG: InvokeResponseMessage =
[1684230725.601345][6292:6294] CHIP:DMG: {
[1684230725.601355][6292:6294] CHIP:DMG: suppressResponse = false,
[1684230725.601363][6292:6294] CHIP:DMG: InvokeResponseIBs =
[1684230725.601386][6292:6294] CHIP:DMG: [
[1684230725.601418][6292:6294] CHIP:DMG: InvokeResponseIB =
[1684230725.601442][6292:6294] CHIP:DMG: {
[1684230725.601454][6292:6294] CHIP:DMG: CommandStatusIB =
[1684230725.601468][6292:6294] CHIP:DMG: {
[1684230725.601480][6292:6294] CHIP:DMG: CommandPathIB =
[1684230725.601495][6292:6294] CHIP:DMG: {
[1684230725.601510][6292:6294] CHIP:DMG: EndpointId = 0x0,
[1684230725.601525][6292:6294] CHIP:DMG: ClusterId = 0x3e,
[1684230725.601539][6292:6294] CHIP:DMG: CommandId = 0xb,
[1684230725.601553][6292:6294] CHIP:DMG: },
[1684230725.601574][6292:6294] CHIP:DMG:
[1684230725.601586][6292:6294] CHIP:DMG: StatusIB =
[1684230725.601602][6292:6294] CHIP:DMG: {
[1684230725.601617][6292:6294] CHIP:DMG: status = 0x00 (SUCCESS),
[1684230725.601631][6292:6294] CHIP:DMG: },
[1684230725.601647][6292:6294] CHIP:DMG:
[1684230725.601659][6292:6294] CHIP:DMG: },
[1684230725.601679][6292:6294] CHIP:DMG:
[1684230725.601709][6292:6294] CHIP:DMG: },
[1684230725.601720][6292:6294] CHIP:DMG:
[1684230725.601725][6292:6294] CHIP:DMG: ],
[1684230725.601737][6292:6294] CHIP:DMG:
[1684230725.601743][6292:6294] CHIP:DMG: InteractionModelRevision = 1
[1684230725.601748][6292:6294] CHIP:DMG: },
[1684230725.601794][6292:6294] CHIP:DMG: Received Command Response Status for Endpoint=0 Cluster=0x0000_003E Command=0x0000_000B Status=0x0
[1684230725.601803][6292:6294] CHIP:CTL: Device confirmed that it has received the root certificate
[1684230725.601812][6292:6294] CHIP:CTL: Successfully finished commissioning step 'SendTrustedRootCert'
[1684230725.601817][6292:6294] CHIP:CTL: Commissioning stage next step: 'SendTrustedRootCert' -> 'SendNOC'
[1684230725.601825][6292:6294] CHIP:CTL: Performing next commissioning step 'SendNOC'
[1684230725.601853][6292:6294] CHIP:DMG: ICR moving to [AddingComm]
[1684230725.601865][6292:6294] CHIP:DMG: ICR moving to [AddedComma]
[1684230725.601898][6292:6294] CHIP:EM: <<< [E:36621i S:1813 M:185546716] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1684230725.601910][6292:6294] CHIP:IN: (S) Sending msg 185546716 on secure session with LSID: 1813
[1684230725.602128][6292:6294] CHIP:DMG: ICR moving to [CommandSen]
[1684230725.602149][6292:6294] CHIP:CTL: Sent operational certificate to the device
[1684230725.602181][6292:6294] CHIP:DMG: ICR moving to [AwaitingDe]
[1684230725.733703][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230725.868645][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230725.958519][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230726.184836][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230726.184872][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230726.184915][6292:6294] CHIP:EM: >>> [E:36621i S:1813 M:68342286] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1684230726.184924][6292:6294] CHIP:EM: Found matching exchange: 36621i, Delegate: 0x7fc59c061478
[1684230726.184931][6292:6294] CHIP:DMG: ICR moving to [ResponseRe]
[1684230726.184941][6292:6294] CHIP:DMG: InvokeResponseMessage =
[1684230726.184943][6292:6294] CHIP:DMG: {
[1684230726.184945][6292:6294] CHIP:DMG: suppressResponse = false,
[1684230726.184946][6292:6294] CHIP:DMG: InvokeResponseIBs =
[1684230726.184951][6292:6294] CHIP:DMG: [
[1684230726.184952][6292:6294] CHIP:DMG: InvokeResponseIB =
[1684230726.184958][6292:6294] CHIP:DMG: {
[1684230726.184961][6292:6294] CHIP:DMG: CommandDataIB =
[1684230726.184965][6292:6294] CHIP:DMG: {
[1684230726.184969][6292:6294] CHIP:DMG: CommandPathIB =
[1684230726.184973][6292:6294] CHIP:DMG: {
[1684230726.184977][6292:6294] CHIP:DMG: EndpointId = 0x0,
[1684230726.184982][6292:6294] CHIP:DMG: ClusterId = 0x3e,
[1684230726.184986][6292:6294] CHIP:DMG: CommandId = 0x8,
[1684230726.184991][6292:6294] CHIP:DMG: },
[1684230726.184996][6292:6294] CHIP:DMG:
[1684230726.184999][6292:6294] CHIP:DMG: CommandFields =
[1684230726.185003][6292:6294] CHIP:DMG: {
[1684230726.185008][6292:6294] CHIP:DMG: 0x0 = 0,
[1684230726.185012][6292:6294] CHIP:DMG: 0x1 = 1,
[1684230726.185016][6292:6294] CHIP:DMG: },
[1684230726.185020][6292:6294] CHIP:DMG: },
[1684230726.185025][6292:6294] CHIP:DMG:
[1684230726.185028][6292:6294] CHIP:DMG: },
[1684230726.185034][6292:6294] CHIP:DMG:
[1684230726.185037][6292:6294] CHIP:DMG: ],
[1684230726.185043][6292:6294] CHIP:DMG:
[1684230726.185046][6292:6294] CHIP:DMG: InteractionModelRevision = 1
[1684230726.185051][6292:6294] CHIP:DMG: },
[1684230726.185068][6292:6294] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0008
[1684230726.185076][6292:6294] CHIP:CTL: Device returned status 0 on receiving the NOC
[1684230726.185080][6292:6294] CHIP:CTL: Operational credentials provisioned on device 0x7fc594023f00
[1684230726.185083][6292:6294] CHIP:TOO: Secure Pairing Success
[1684230726.185086][6292:6294] CHIP:TOO: CASE establishment successful
[1684230726.185092][6292:6294] CHIP:CTL: Successfully finished commissioning step 'SendNOC'
[1684230726.185096][6292:6294] CHIP:CTL: No NetworkScan enabled or WiFi/Thread endpoint not specified, skipping ScanNetworks
[1684230726.185099][6292:6294] CHIP:CTL: Required network information not provided in commissioning parameters
[1684230726.185102][6292:6294] CHIP:CTL: Parameters supplied: wifi (yes) thread (no)
[1684230726.185105][6292:6294] CHIP:CTL: Device supports: wifi (no) thread(yes)
[1684230726.185111][6292:6294] CHIP:CTL: Going from commissioning step 'SendNOC' with lastErr = 'src/controller/AutoCommissioner.cpp:218: CHIP Error 0x0000002F: Invalid argument' -> 'Cleanup'
[1684230726.185117][6292:6294] CHIP:CTL: Performing next commissioning step 'Cleanup' with completion status = 'src/controller/AutoCommissioner.cpp:218: CHIP Error 0x0000002F: Invalid argument'
[1684230726.185121][6292:6294] CHIP:CTL: Expiring failsafe on proxy 0x7fc594023f00
[1684230726.185136][6292:6294] CHIP:DMG: ICR moving to [AddingComm]
[1684230726.185140][6292:6294] CHIP:DMG: ICR moving to [AddedComma]
[1684230726.185159][6292:6294] CHIP:EM: <<< [E:36622i S:1813 M:185546717] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
[1684230726.185166][6292:6294] CHIP:IN: (S) Sending msg 185546717 on secure session with LSID: 1813
[1684230726.185232][6292:6294] CHIP:DMG: ICR moving to [CommandSen]
[1684230726.185247][6292:6294] CHIP:DMG: ICR moving to [AwaitingDe]
[1684230726.273296][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16387
[1684230726.275716][6292:6293] CHIP:DL: Indication received, conn = 0x7fc59c03bd20
[1684230726.275767][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16389
[1684230726.275830][6292:6294] CHIP:EM: >>> [E:36622i S:1813 M:68342287] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
[1684230726.275842][6292:6294] CHIP:EM: Found matching exchange: 36622i, Delegate: 0x7fc59c061318
[1684230726.275851][6292:6294] CHIP:DMG: ICR moving to [ResponseRe]
[1684230726.275875][6292:6294] CHIP:DMG: InvokeResponseMessage =
[1684230726.275881][6292:6294] CHIP:DMG: {
[1684230726.275887][6292:6294] CHIP:DMG: suppressResponse = false,
[1684230726.275892][6292:6294] CHIP:DMG: InvokeResponseIBs =
[1684230726.275902][6292:6294] CHIP:DMG: [
[1684230726.275906][6292:6294] CHIP:DMG: InvokeResponseIB =
[1684230726.275915][6292:6294] CHIP:DMG: {
[1684230726.275919][6292:6294] CHIP:DMG: CommandDataIB =
[1684230726.275924][6292:6294] CHIP:DMG: {
[1684230726.275928][6292:6294] CHIP:DMG: CommandPathIB =
[1684230726.275934][6292:6294] CHIP:DMG: {
[1684230726.275940][6292:6294] CHIP:DMG: EndpointId = 0x0,
[1684230726.275947][6292:6294] CHIP:DMG: ClusterId = 0x30,
[1684230726.275953][6292:6294] CHIP:DMG: CommandId = 0x1,
[1684230726.275958][6292:6294] CHIP:DMG: },
[1684230726.275964][6292:6294] CHIP:DMG:
[1684230726.275969][6292:6294] CHIP:DMG: CommandFields =
[1684230726.275974][6292:6294] CHIP:DMG: {
[1684230726.275980][6292:6294] CHIP:DMG: 0x0 = 0,
[1684230726.275986][6292:6294] CHIP:DMG: 0x1 = "" (0 chars),
[1684230726.275992][6292:6294] CHIP:DMG: },
[1684230726.275997][6292:6294] CHIP:DMG: },
[1684230726.276005][6292:6294] CHIP:DMG:
[1684230726.276009][6292:6294] CHIP:DMG: },
[1684230726.276017][6292:6294] CHIP:DMG:
[1684230726.276021][6292:6294] CHIP:DMG: ],
[1684230726.276029][6292:6294] CHIP:DMG:
[1684230726.276034][6292:6294] CHIP:DMG: InteractionModelRevision = 1
[1684230726.276038][6292:6294] CHIP:DMG: },
[1684230726.276063][6292:6294] CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0001
[1684230726.276074][6292:6294] CHIP:CTL: Failsafe disarmed
[1684230726.276083][6292:6294] CHIP:CTL: Successfully finished commissioning step 'Cleanup'
[1684230726.276095][6292:6294] CHIP:TOO: Device commissioning Failure: src/controller/AutoCommissioner.cpp:218: CHIP Error 0x0000002F: Invalid argument
[1684230726.276108][6292:6294] CHIP:DIS: Closing all BLE connections
[1684230726.276112][6292:6294] CHIP:IN: Clearing BLE pending packets.
[1684230726.276220][6292:6294] CHIP:BLE: Auto-closing end point's BLE connection.
[1684230726.276229][6292:6294] CHIP:DL: Closing BLE GATT connection (con 0x7fc59c03bd20)
[1684230726.276251][6292:6293] CHIP:DL: BluezDisconnect peer=FA:97:EA:11:13:83
[1684230726.364557][6292:6294] CHIP:IN: SecureSession[0x7fc594021970]: MarkForEviction Type:1 LSID:1813
[1684230726.364577][6292:6294] CHIP:SC: SecureSession[0x7fc594021970, LSID:1813]: State change 'kActive' --> 'kPendingEviction'
[1684230726.364871][6292:6294] CHIP:DMG: ICR moving to [AwaitingDe]
[1684230726.364896][6292:6294] CHIP:IN: SecureSession[0x7fc594021970]: Released - Type:1 LSID:1813
[1684230726.364916][6292:6294] CHIP:DL: HandlePlatformSpecificBLEEvent 16388
[1684230726.364924][6292:6294] CHIP:BLE: no endpoint for unsub complete
[1684230726.364934][6292:6293] CHIP:DL: Bluez disconnected
[1684230726.364951][6292:6293] CHIP:DL: Bluez notify CHIPoBluez connection disconnected
[1684230726.365038][6292:6292] CHIP:CTL: Shutting down the commissioner
[1684230726.365051][6292:6292] CHIP:CTL: Stopping commissioning discovery over DNS-SD
[1684230726.365086][6292:6292] CHIP:CTL: Shutting down the controller
[1684230726.365096][6292:6292] CHIP:IN: Expiring all sessions for fabric 0x1!!
[1684230726.365104][6292:6292] CHIP:FP: Forgetting fabric 0x1
[1684230726.365117][6292:6292] CHIP:TS: Pending Last Known Good Time: 2023-05-15T15:02:24
[1684230726.365227][6292:6292] CHIP:TS: Previous Last Known Good Time: 2023-05-15T15:02:24
[1684230726.365236][6292:6292] CHIP:TS: Reverted Last Known Good Time to previous value
[1684230726.365255][6292:6292] CHIP:CTL: Shutting down the commissioner
[1684230726.365264][6292:6292] CHIP:CTL: Stopping commissioning discovery over DNS-SD
[1684230726.365287][6292:6292] CHIP:CTL: Shutting down the controller
[1684230726.365293][6292:6292] CHIP:CTL: Shutting down the System State, this will teardown the CHIP Stack
[1684230726.365349][6292:6292] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet
[1684230726.365374][6292:6292] CHIP:BLE: BleConnectionDelegate::CancelConnection is not implemented.
[1684230726.365388][6292:6292] CHIP:FP: Shutting down FabricTable
[1684230726.365412][6292:6292] CHIP:TS: Pending Last Known Good Time: 2023-05-15T15:02:24
[1684230726.365472][6292:6292] CHIP:TS: Previous Last Known Good Time: 2023-05-15T15:02:24
[1684230726.365480][6292:6292] CHIP:TS: Reverted Last Known Good Time to previous value
[1684230726.365603][6292:6292] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-CnETlW)
[1684230726.365830][6292:6292] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
[1684230726.365852][6292:6292] CHIP:DL: NVS set: chip-counters/total-operational-hours = 0 (0x0)
[1684230726.365861][6292:6292] CHIP:DL: Inet Layer shutdown
[1684230726.365869][6292:6292] CHIP:DL: BLE shutdown
[1684230726.366460][6292:6292] CHIP:DL: System Layer shutdown
[1684230726.366609][6292:6292] CHIP:TOO: Run command failure: src/controller/AutoCommissioner.cpp:218: CHIP Error 0x0000002F: Invalid argument
so, is that possible that my pc bluez version which is 5.53 create a problem.