./out/debug/chip-tool pairing ble-thread 1 hex:0E08000064B84AA90000000300001935060004001FFFC002087F6AB13A1EC540AE0708FD8569D7C4E71B5A0510BDD9D8B4F1B9615724FE139A5BB5BF1E030F4D79486F6D65353538323834363534010242DC04102B21CC39D83FE3D12235FB64E3541B870C0402A0F7F8 20202021 3840 --paa-trust-store-path ./credentials/development/paa-root-certs [1689870245045] [41213:17677933] [DL] KVS will be written to: file:///tmp/chip_kvs [1689870245053] [41213:17677933] [DL] _Init [1689870245053] [41213:17677933] [IN] UDP::Init bind&listen port=0 [1689870245053] [41213:17677933] [IN] UDP::Init bound to port=50833 [1689870245053] [41213:17677933] [IN] BLEBase::Init - setting/overriding transport [1689870245053] [41213:17677933] [IN] TransportMgr initialized [1689870245053] [41213:17677933] [FP] Initializing FabricTable from persistent storage [1689870245054] [41213:17677933] [TS] Last Known Good Time: 2023-07-19T16:18:47 [1689870245054] [41213:17677933] [FP] Fabric index 0x1 was retrieved from storage. Compressed FabricId 0x789F7F9EEE0456D1, FabricId 0x0000000000000001, NodeId 0x000000000001B669, VendorId 0xFFF1 [1689870245055] [41213:17677933] [ZCL] Using ZAP configuration... [1689870245055] [41213:17677933] [CTL] System State Initialized... [1689870245066] [41213:17677933] [CTL] Stopping commissioning discovery over DNS-SD [1689870245066] [41213:17677933] [CTL] Setting attestation nonce to random value [1689870245066] [41213:17677933] [CTL] Setting CSR nonce to random value [1689870245066] [41213:17677957] [DL] _OnPlatformEvent [1689870245066] [41213:17677957] [CTL] Stopping commissioning discovery over DNS-SD [1689870245066] [41213:17677957] [CTL] Setting attestation nonce to random value [1689870245066] [41213:17677957] [CTL] Setting CSR nonce to random value [1689870245068] [41213:17677957] [CTL] Generating NOC [1689870245071] [41213:17677957] [FP] Validating NOC chain [1689870245079] [41213:17677957] [FP] NOC chain validation successful [1689870245079] [41213:17677957] [FP] Updated fabric at index: 0x1, Node ID: 0x000000000001B669 [1689870245079] [41213:17677957] [TS] Last Known Good Time: 2023-07-19T16:18:47 [1689870245079] [41213:17677957] [TS] New proposed Last Known Good Time: 2021-01-01T00:00:00 [1689870245079] [41213:17677957] [TS] Retaining current Last Known Good Time [1689870245080] [41213:17677957] [FP] Metadata for Fabric 0x1 persisted to storage. [1689870245081] [41213:17677957] [TS] Committing Last Known Good Time to storage: 2023-07-19T16:18:47 [1689870245081] [41213:17677957] [CTL] Joined the fabric at index 1. Fabric ID is 0x0000000000000001 (Compressed Fabric ID: 789F7F9EEE0456D1) [1689870245085] [41213:17677957] [BLE] NewConnection [1689870245085] [41213:17677957] [CTL] Setting thread operational dataset from parameters [1689870245085] [41213:17677957] [CTL] Setting attestation nonce to random value [1689870245085] [41213:17677957] [CTL] Setting CSR nonce to random value [1689870245085] [41213:17677957] [CTL] Commission called for node ID 0x0000000000000001 [1689870245110] [41213:17677958] [BLE] CBManagerState: ON [1689870245204] [41213:17677958] [BLE] Connecting to device 0x6000034b81a0 with discriminator: 3840 [1689870245701] [41213:17677957] [DIS] Closing all BLE connections [1689870245701] [41213:17677957] [BLE] CancelConnection [1689870245701] [41213:17677957] [IN] BleConnectionComplete: endPoint 0x105af47c0 [1689870245701] [41213:17677957] [BLE] ATT MTU = 247 [1689870245702] [41213:17677957] [IN] SecureSession[0x6000030b0000]: Allocated Type:1 LSID:60397 [1689870245702] [41213:17677957] [SC] Assigned local session key ID 60397 [1689870245703] [41213:17677957] [EM] <<< [E:4366i S:0 M:174544067] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest) [1689870245703] [41213:17677957] [IN] (U) Sending msg 174544067 to IP address 'BLE' [1689870245703] [41213:17677957] [IN] Message appended to BLE send queue [1689870245703] [41213:17677957] [SC] Sent PBKDF param request [1689870245703] [41213:17677958] [BLE] CancelConnection [1689870245703] [41213:17677958] [IN] Clearing BLE pending packets. [1689870245703] [41213:17677958] [BLE] Auto-closing end point's BLE connection. [1689870262705] [41213:17677989] [SC] PASESession timed out while waiting for a response from the peer. Expected message type was 33 [1689870262705] [41213:17677989] [IN] SecureSession[0x6000030b0000]: Released - Type:1 LSID:60397 [1689870262705] [41213:17677989] [TOO] Secure Pairing Failed [1689870262705] [41213:17677989] [DIS] Closing all BLE connections [1689870262705] [41213:17677989] [BLE] CancelConnection [1689870262705] [41213:17677989] [TOO] Pairing Failure: src/protocols/secure_channel/PASESession.cpp:255: CHIP Error 0x00000032: Timeout [1689870262707] [41213:17677933] [CTL] Shutting down the commissioner [1689870262707] [41213:17677933] [CTL] Stopping commissioning discovery over DNS-SD [1689870262707] [41213:17677933] [CTL] Shutting down the controller [1689870262707] [41213:17677933] [IN] Expiring all sessions for fabric 0x1!! [1689870262707] [41213:17677933] [FP] Forgetting fabric 0x1 [1689870262707] [41213:17677933] [TS] Pending Last Known Good Time: 2023-07-19T16:18:47 [1689870262707] [41213:17677933] [TS] Previous Last Known Good Time: 2023-07-19T16:18:47 [1689870262707] [41213:17677933] [TS] Reverted Last Known Good Time to previous value [1689870262707] [41213:17677933] [CTL] Shutting down the commissioner [1689870262707] [41213:17677933] [CTL] Stopping commissioning discovery over DNS-SD [1689870262707] [41213:17677933] [CTL] Shutting down the controller [1689870262707] [41213:17677933] [CTL] Shutting down the System State, this will teardown the CHIP Stack [1689870262708] [41213:17677933] [DMG] All ReadHandler-s are clean, clear GlobalDirtySet [1689870262708] [41213:17677933] [BLE] CancelConnection [1689870262708] [41213:17677933] [FP] Shutting down FabricTable [1689870262708] [41213:17677933] [TS] Pending Last Known Good Time: 2023-07-19T16:18:47 [1689870262708] [41213:17677933] [TS] Previous Last Known Good Time: 2023-07-19T16:18:47 [1689870262708] [41213:17677933] [TS] Reverted Last Known Good Time to previous value [1689870262708] [41213:17677933] [DL] Inet Layer shutdown [1689870262708] [41213:17677933] [DL] BLE shutdown [1689870262708] [41213:17677933] [BLE] CancelBleIncompleteConnection() failed, err = src/ble/BleLayer.cpp:372: CHIP Error 0x00000003: Incorrect state [1689870262708] [41213:17677933] [DL] System Layer shutdown [1689870262708] [41213:17677933] [TOO] Run command failure: src/protocols/secure_channel/PASESession.cpp:255: CHIP Error 0x00000032: Timeout