Android app failed to commission EFR32 Light App(CHIP over Thread device)

[virupaksha]

I have Matter Over Thread device and I would like to commission it & control it by Android app But Unfortunately commission is not working.

Please find the logs below.

2021-06-13 01:09:23.813 28025-28025/com.google.chip.chiptool D/Camera: app passed NULL surface
2021-06-13 01:09:24.089 28025-28025/com.google.chip.chiptool D/SPL: JNI_OnLoad() called
2021-06-13 01:09:24.204 28025-28025/com.google.chip.chiptool D/SurfaceView: onWindowVisibilityChanged(8) false android.view.SurfaceView{2b5879a V.E...... ........ 0,0-1080,1884} of ViewRootImpl@11d6f65[CHIPToolActivity]
2021-06-13 01:09:24.205 28025-28025/com.google.chip.chiptool D/SurfaceView: surfaceDestroyed callback.size 1 #2 android.view.SurfaceView{2b5879a V.E...... ........ 0,0-1080,1884}
2021-06-13 01:09:24.205 28025-28025/com.google.chip.chiptool D/SurfaceView: remove() android.view.SurfaceView{2b5879a V.E...... ........ 0,0-1080,1884} Surface(name=SurfaceView - com.google.chip.chiptool/com.google.chip.chiptool.CHIPToolActivity@2b5879a@0)/@0xedb0180
2021-06-13 01:09:24.229 28025-28025/com.google.chip.chiptool D/CTL: JNI_OnLoad() called
2021-06-13 01:09:24.229 28025-28025/com.google.chip.chiptool D/CTL: Loading Java class references.
2021-06-13 01:09:24.230 28025-28025/com.google.chip.chiptool D/CTL: Java class references loaded.
2021-06-13 01:09:24.230 28025-28025/com.google.chip.chiptool D/CTL: Inet layer initialized.
2021-06-13 01:09:24.230 28025-28025/com.google.chip.chiptool D/CTL: BLE Layer being configured.
2021-06-13 01:09:24.231 28025-28025/com.google.chip.chiptool D/CTL: Asking for BLE Layer initialization.
2021-06-13 01:09:24.231 28025-28025/com.google.chip.chiptool D/CTL: BLE was initialized.
2021-06-13 01:09:24.231 28025-28025/com.google.chip.chiptool D/CTL: newDeviceController() called
2021-06-13 01:09:24.231 28025-28025/com.google.chip.chiptool D/TOO: KVS: Getting key ExampleOpCredsCAKey
2021-06-13 01:09:24.231 28025-28305/com.google.chip.chiptool D/CTL: IO thread starting
2021-06-13 01:09:24.232 28025-28025/com.google.chip.chiptool D/IN: TransportMgr initialized
2021-06-13 01:09:24.232 28025-28025/com.google.chip.chiptool D/DIS: Init admin pairing table with server storage
2021-06-13 01:09:24.232 28025-28025/com.google.chip.chiptool D/TOO: KVS: Getting key CHIPAdmin0
2021-06-13 01:09:24.232 28025-28025/com.google.chip.chiptool D/IN: Loading certs from KVS
2021-06-13 01:09:24.232 28025-28025/com.google.chip.chiptool D/IN: local node id is 0x000000000001B669
2021-06-13 01:09:24.232 28025-28025/com.google.chip.chiptool D/ZCL: Using ZAP configuration...
2021-06-13 01:09:24.232 28025-28025/com.google.chip.chiptool D/ZCL: deactivate report event
2021-06-13 01:09:24.233 28025-28025/com.google.chip.chiptool D/CTL: Getting operational keys
2021-06-13 01:09:24.233 28025-28025/com.google.chip.chiptool D/CTL: Generating credentials
2021-06-13 01:09:24.233 28025-28025/com.google.chip.chiptool D/CTL: Loaded credentials successfully
2021-06-13 01:09:24.233 28025-28025/com.google.chip.chiptool D/TOO: KVS: Getting key StartKeyID
2021-06-13 01:09:24.253 28025-28025/com.google.chip.chiptool D/BluetoothAdapter: STATE_ON
2021-06-13 01:09:24.286 28025-28025/com.google.chip.chiptool D/ViewRootImpl@c99b357[Toast]: setView = android.widget.LinearLayout@e600e44 TM=true MM=false
2021-06-13 01:09:24.286 28025-28025/com.google.chip.chiptool V/Toast: Text: Tcan in android.widget.Toast$TN@fd6fb2d
2021-06-13 01:09:24.286 28025-28025/com.google.chip.chiptool I/chip.BluetoothManager: Starting Bluetooth scan
2021-06-13 01:09:24.287 28025-28025/com.google.chip.chiptool D/BluetoothAdapter: STATE_ON
2021-06-13 01:09:24.287 28025-28025/com.google.chip.chiptool D/BluetoothAdapter: STATE_ON
2021-06-13 01:09:24.288 28025-28025/com.google.chip.chiptool D/BluetoothAdapter: BLE support array set: 010011
2021-06-13 01:09:24.288 28025-28025/com.google.chip.chiptool D/BluetoothLeScanner: Start Scan with callback
2021-06-13 01:09:24.290 28025-28058/com.google.chip.chiptool D/BluetoothLeScanner: onScannerRegistered() - status=0 scannerId=12 mScannerId=0
2021-06-13 01:09:24.307 28025-28025/com.google.chip.chiptool D/ViewRootImpl@c99b357[Toast]: Relayout returned: old=(0,63,1080,2094) new=(209,1810,871,1926) req=(662,116)0 dur=8 res=0x7 s={true 481337339904} ch=true
2021-06-13 01:09:24.307 28025-28142/com.google.chip.chiptool D/OpenGLRenderer: createReliableSurface : 0x6f9fe0a400, 0x7011f0f000
2021-06-13 01:09:24.308 28025-28142/com.google.chip.chiptool D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
2021-06-13 01:09:24.346 28025-28025/com.google.chip.chiptool D/ViewRootImpl@c99b357[Toast]: MSG_RESIZED: frame=(209,1810,871,1926) ci=(0,0,0,0) vi=(0,0,662,116) or=1
2021-06-13 01:09:24.433 28025-28025/com.google.chip.chiptool I/chip.BluetoothManager: Bluetooth Device Scanned Addr: 6C:67:1D:49:A1:9D, Name EFR32_LIGHT
2021-06-13 01:09:24.495 28025-28025/com.google.chip.chiptool D/BluetoothAdapter: STATE_ON
2021-06-13 01:09:24.495 28025-28025/com.google.chip.chiptool D/BluetoothLeScanner: Stop Scan with callback
2021-06-13 01:09:24.524 28025-28025/com.google.chip.chiptool I/chip.BluetoothManager: Connecting
2021-06-13 01:09:24.525 28025-28025/com.google.chip.chiptool D/BluetoothAdapter: STATE_ON
2021-06-13 01:09:24.527 28025-28025/com.google.chip.chiptool D/BluetoothGatt: connect() - device: 6C:67:1D:49:A1:9D, auto: false
2021-06-13 01:09:24.527 28025-28025/com.google.chip.chiptool D/BluetoothAdapter: isSecureModeEnabled
2021-06-13 01:09:24.527 28025-28025/com.google.chip.chiptool D/BluetoothGatt: registerApp()
2021-06-13 01:09:24.528 28025-28025/com.google.chip.chiptool D/BluetoothGatt: registerApp() - UUID=38366e39-0d7b-4ea4-9eaf-97a9484d951c
2021-06-13 01:09:24.533 28025-28058/com.google.chip.chiptool D/BluetoothGatt: onClientRegistered() - status=0 clientIf=12
2021-06-13 01:09:24.828 28025-28058/com.google.chip.chiptool D/BluetoothGatt: onClientConnectionState() - status=0 clientIf=12 device=6C:67:1D:49:A1:9D
2021-06-13 01:09:24.842 28025-28058/com.google.chip.chiptool I/chip.BluetoothManager|onConnectionStateChange: Discovering Services...
2021-06-13 01:09:24.843 28025-28058/com.google.chip.chiptool D/BluetoothGatt: discoverServices() - device: 6C:67:1D:49:A1:9D
2021-06-13 01:09:25.568 28025-28058/com.google.chip.chiptool D/BluetoothGatt: onConnectionUpdated() - Device=6C:67:1D:49:A1:9D interval=6 latency=0 timeout=500 status=0
2021-06-13 01:09:25.793 28025-28058/com.google.chip.chiptool D/BluetoothGatt: onSearchComplete() = Device=6C:67:1D:49:A1:9D Status=0
2021-06-13 01:09:25.794 28025-28058/com.google.chip.chiptool I/chip.BluetoothManager|onServicesDiscovered: Services Discovered
2021-06-13 01:09:25.794 28025-28058/com.google.chip.chiptool D/BluetoothGatt: configureMTU() - device: 6C:67:1D:49:A1:9D mtu: 131
2021-06-13 01:09:25.815 28025-28058/com.google.chip.chiptool D/BluetoothGatt: onConfigureMTU() - Device=6C:67:1D:49:A1:9D mtu=131 status=0
2021-06-13 01:09:25.816 28025-28058/com.google.chip.chiptool D/chip.BluetoothManager: MTU changed: connecting to CHIP device
2021-06-13 01:09:25.890 28025-28058/com.google.chip.chiptool D/BluetoothGatt: onConnectionUpdated() - Device=6C:67:1D:49:A1:9D interval=39 latency=0 timeout=500 status=0
2021-06-13 01:09:25.893 28025-28025/com.google.chip.chiptool D/ChipDeviceController: Bluetooth connection added with ID: 1
2021-06-13 01:09:25.893 28025-28025/com.google.chip.chiptool D/ChipDeviceController: Pairing device with ID: 2
2021-06-13 01:09:25.894 28025-28025/com.google.chip.chiptool D/CTL: pairDevice() called with device ID, connection object, and pincode
2021-06-13 01:09:25.894 28025-28025/com.google.chip.chiptool D/TOO: KVS: Getting key ListPairedDevices0
2021-06-13 01:09:25.894 28025-28025/com.google.chip.chiptool D/KeyValueStoreManager: Key 'ListPairedDevices0' not found in shared preferences
2021-06-13 01:09:25.895 28025-28025/com.google.chip.chiptool D/IN: BleConnectionComplete: endPoint 0x700f718ef8
2021-06-13 01:09:25.895 28025-28025/com.google.chip.chiptool D/CTL: Received GetMTU
2021-06-13 01:09:25.895 28025-28025/com.google.chip.chiptool D/CTL: Calling Java onGetMTU
2021-06-13 01:09:25.896 28025-28025/com.google.chip.chiptool D/AndroidChipStack: Android Manufacturer: (samsung)
2021-06-13 01:09:25.896 28025-28025/com.google.chip.chiptool D/AndroidChipStack: Android Model: (SM-G965F)
2021-06-13 01:09:25.897 28025-28025/com.google.chip.chiptool D/CTL: Received SendCharacteristic
2021-06-13 01:09:25.907 28025-28025/com.google.chip.chiptool D/CTL: Calling Java SendCharacteristic
2021-06-13 01:09:25.911 28025-28025/com.google.chip.chiptool D/SC: Assigned local session key ID 1
2021-06-13 01:09:25.913 28025-28025/com.google.chip.chiptool D/IN: Message appended to BLE send queue
2021-06-13 01:09:25.913 28025-28025/com.google.chip.chiptool D/SC: Sent PBKDF param request
2021-06-13 01:09:25.913 28025-28025/com.google.chip.chiptool D/TOO: KVS: Setting key StartKeyID
2021-06-13 01:09:26.050 28025-28058/com.google.chip.chiptool D/chip.BluetoothManager: EFR32_LIGHT.onCharacteristicWrite: 18ee2ef5-263d-4559-959f-4f9c429f9d11 -> 0
2021-06-13 01:09:26.051 28025-28058/com.google.chip.chiptool D/CTL: Received SubscribeCharacteristic
2021-06-13 01:09:26.051 28025-28058/com.google.chip.chiptool D/CTL: Calling Java SubscribeCharacteristic
2021-06-13 01:09:26.059 28025-28058/com.google.chip.chiptool D/BluetoothGatt: setCharacteristicNotification() - uuid: 18ee2ef5-263d-4559-959f-4f9c429f9d12 enable: true
2021-06-13 01:09:26.141 28025-28058/com.google.chip.chiptool D/chip.BluetoothManager: EFR32_LIGHT.onDescriptorWrite: 00002902-0000-1000-8000-00805f9b34fb -> 0
2021-06-13 01:09:26.142 28025-28058/com.google.chip.chiptool D/BLE: subscribe complete, ep = 0x700f718ef8
2021-06-13 01:09:26.294 28025-28142/com.google.chip.chiptool W/libEGL: EGLNativeWindowType 0x6f9fe0a410 disconnect failed
2021-06-13 01:09:26.295 28025-28025/com.google.chip.chiptool D/ViewRootImpl@c99b357[Toast]: dispatchDetachedFromWindow
2021-06-13 01:09:26.326 28025-28025/com.google.chip.chiptool D/InputTransport: Input channel destroyed: 'e12c93f', fd=99
2021-06-13 01:09:26.389 28025-28025/com.google.chip.chiptool D/ViewRootImpl@a0e1dc[Toast]: setView = android.widget.LinearLayout@57962e5 TM=true MM=false
2021-06-13 01:09:26.390 28025-28025/com.google.chip.chiptool V/Toast: Text: Donn in android.widget.Toast$TN@2ef11ba
2021-06-13 01:09:26.430 28025-28025/com.google.chip.chiptool D/ViewRootImpl@a0e1dc[Toast]: Relayout returned: old=(0,63,1080,2094) new=(223,1810,857,1926) req=(634,116)0 dur=31 res=0x7 s={true 481408880640} ch=true
2021-06-13 01:09:26.432 28025-28142/com.google.chip.chiptool D/OpenGLRenderer: createReliableSurface : 0x6f9fe0a400, 0x7016349000
2021-06-13 01:09:26.441 28025-28142/com.google.chip.chiptool D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
2021-06-13 01:09:26.499 28025-28025/com.google.chip.chiptool D/ViewRootImpl@a0e1dc[Toast]: MSG_RESIZED: frame=(223,1810,857,1926) ci=(0,0,0,0) vi=(0,0,634,116) or=1
2021-06-13 01:09:28.372 28025-28142/com.google.chip.chiptool W/libEGL: EGLNativeWindowType 0x6f9fe0a410 disconnect failed
2021-06-13 01:09:28.373 28025-28025/com.google.chip.chiptool D/ViewRootImpl@a0e1dc[Toast]: dispatchDetachedFromWindow
2021-06-13 01:09:28.408 28025-28025/com.google.chip.chiptool D/InputTransport: Input channel destroyed: '9fbd2e9', fd=99
2021-06-13 01:09:28.468 28025-28025/com.google.chip.chiptool D/ViewRootImpl@2e24861[Toast]: setView = android.widget.LinearLayout@86c8f86 TM=true MM=false
2021-06-13 01:09:28.469 28025-28025/com.google.chip.chiptool V/Toast: Text: Qair in android.widget.Toast$TN@1982047
2021-06-13 01:09:28.510 28025-28025/com.google.chip.chiptool D/ViewRootImpl@2e24861[Toast]: Relayout returned: old=(0,63,1080,2094) new=(411,1810,668,1926) req=(257,116)0 dur=28 res=0x7 s={true 481409118208} ch=true
2021-06-13 01:09:28.512 28025-28142/com.google.chip.chiptool D/OpenGLRenderer: createReliableSurface : 0x6f9fe0a400, 0x7016383000
2021-06-13 01:09:28.514 28025-28142/com.google.chip.chiptool D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
2021-06-13 01:09:28.550 28025-28025/com.google.chip.chiptool D/ViewRootImpl@2e24861[Toast]: MSG_RESIZED: frame=(411,1810,668,1926) ci=(0,0,0,0) vi=(0,0,257,116) or=1
2021-06-13 01:09:30.445 28025-28142/com.google.chip.chiptool W/libEGL: EGLNativeWindowType 0x6f9fe0a410 disconnect failed
2021-06-13 01:09:30.446 28025-28025/com.google.chip.chiptool D/ViewRootImpl@2e24861[Toast]: dispatchDetachedFromWindow
2021-06-13 01:09:30.473 28025-28025/com.google.chip.chiptool D/InputTransport: Input channel destroyed: '4cc84d2', fd=99
2021-06-13 01:09:40.899 28025-28305/com.google.chip.chiptool E/BLE: connect handshake timed out, closing ep 0x700f718ef8
2021-06-13 01:09:40.899 28025-28305/com.google.chip.chiptool E/IN: Failed to establish BLE connection: Ble Error 6021 (0x00001785): Connect handshake timed out
2021-06-13 01:09:40.899 28025-28305/com.google.chip.chiptool D/IN: Clearing BLE pending packets.
2021-06-13 01:09:40.899 28025-28305/com.google.chip.chiptool D/CTL: Received UnsubscribeCharacteristic
2021-06-13 01:09:40.900 28025-28305/com.google.chip.chiptool D/CTL: Calling Java UnsubscribeCharacteristic
2021-06-13 01:09:40.901 28025-28305/com.google.chip.chiptool D/BluetoothGatt: setCharacteristicNotification() - uuid: 18ee2ef5-263d-4559-959f-4f9c429f9d12 enable: false
2021-06-13 01:09:41.008 28025-28058/com.google.chip.chiptool D/chip.BluetoothManager: EFR32_LIGHT.onDescriptorWrite: 00002902-0000-1000-8000-00805f9b34fb -> 0
2021-06-13 01:09:41.009 28025-28058/com.google.chip.chiptool D/BLE: Auto-closing end point's BLE connection.
2021-06-13 01:09:41.010 28025-28058/com.google.chip.chiptool D/CTL: Received CloseConnection
2021-06-13 01:09:41.010 28025-28058/com.google.chip.chiptool D/CTL: Calling Java CloseConnection
2021-06-13 01:09:41.010 28025-28058/com.google.chip.chiptool D/ChipDeviceController: Closing GATT and removing connection for 1
2021-06-13 01:09:41.010 28025-28058/com.google.chip.chiptool D/BluetoothGatt: close()
2021-06-13 01:09:41.025 28025-28058/com.google.chip.chiptool D/BluetoothGatt: unregisterApp() - mClientIf=12
2021-06-13 01:09:41.032 28025-28058/com.google.chip.chiptool D/ChipDeviceController: Calling onCloseBleComplete()
2021-06-13 01:09:41.033 28025-28058/com.google.chip.chiptool D/DeviceProvisioningFragment: onCloseBleComplete
2021-06-13 01:09:55.897 28025-28305/com.google.chip.chiptool D/TOO: KVS: Setting key StartKeyID
2021-06-13 01:09:55.899 28025-28305/com.google.chip.chiptool D/CTL: FindMethod:: javaClass exists? 1
2021-06-13 01:09:55.899 28025-28305/com.google.chip.chiptool D/CTL: FindMethod Returning 0
2021-06-13 01:09:55.899 28025-28305/com.google.chip.chiptool D/DeviceProvisioningFragment: onPairingComplete: 4050
2021-06-13 01:09:55.913 28025-28305/com.google.chip.chiptool E/SC: PASESession timed out while waiting for a response from the peer. Expected message type was 33
2021-06-13 01:09:55.913 28025-28305/com.google.chip.chiptool D/CTL: FindMethod:: javaClass exists? 1
2021-06-13 01:09:55.913 28025-28305/com.google.chip.chiptool D/CTL: FindMethod Returning 0
2021-06-13 01:09:55.914 28025-28305/com.google.chip.chiptool D/DeviceProvisioningFragment: Pairing status update: 1
2021-06-13 01:09:55.914 28025-28305/com.google.chip.chiptool D/TOO: KVS: Setting key StartKeyID
2021-06-13 01:09:55.915 28025-28305/com.google.chip.chiptool D/CTL: FindMethod:: javaClass exists? 1
2021-06-13 01:09:55.915 28025-28305/com.google.chip.chiptool D/CTL: FindMethod Returning 0
2021-06-13 01:09:55.916 28025-28305/com.google.chip.chiptool D/DeviceProvisioningFragment: onPairingComplete: 4050
2021-06-13 01:09:56.038 28025-28025/com.google.chip.chiptool D/ViewRootImpl@1f21e12[Toast]: setView = android.widget.LinearLayout@d2c79e3 TM=true MM=false
2021-06-13 01:09:56.039 28025-28025/com.google.chip.chiptool V/Toast: Text: Qair in android.widget.Toast$TN@1a53fe0
2021-06-13 01:09:56.076 28025-28025/com.google.chip.chiptool D/ViewRootImpl@1f21e12[Toast]: Relayout returned: old=(0,63,1080,2094) new=(356,1810,723,1926) req=(367,116)0 dur=29 res=0x7 s={true 481203310592} ch=true
2021-06-13 01:09:56.078 28025-28142/com.google.chip.chiptool D/OpenGLRenderer: createReliableSurface : 0x6f9fe0a400, 0x7009f3d000
2021-06-13 01:09:56.080 28025-28142/com.google.chip.chiptool D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
2021-06-13 01:09:56.120 28025-28025/com.google.chip.chiptool D/ViewRootImpl@1f21e12[Toast]: MSG_RESIZED: frame=(356,1810,723,1926) ci=(0,0,0,0) vi=(0,0,367,116) or=1
2021-06-13 01:09:57.984 28025-28142/com.google.chip.chiptool W/libEGL: EGLNativeWindowType 0x6f9fe0a410 disconnect failed
2021-06-13 01:09:57.985 28025-28025/com.google.chip.chiptool D/ViewRootImpl@1f21e12[Toast]: dispatchDetachedFromWindow
2021-06-13 01:09:58.020 28025-28025/com.google.chip.chiptool D/InputTransport: Input channel destroyed: '36c01bb', fd=99
2021-06-13 01:09:58.079 28025-28025/com.google.chip.chiptool D/ViewRootImpl@c22d13f[Toast]: setView = android.widget.LinearLayout@c4e7a0c TM=true MM=false
2021-06-13 01:09:58.080 28025-28025/com.google.chip.chiptool V/Toast: Text: Qair in android.widget.Toast$TN@7e1cf55
2021-06-13 01:09:58.114 28025-28025/com.google.chip.chiptool D/ViewRootImpl@c22d13f[Toast]: Relayout returned: old=(0,63,1080,2094) new=(356,1810,723,1926) req=(367,116)0 dur=26 res=0x7 s={true 481408204800} ch=true
2021-06-13 01:09:58.116 28025-28142/com.google.chip.chiptool D/OpenGLRenderer: createReliableSurface : 0x6f9fe0a400, 0x70162a4000
2021-06-13 01:09:58.118 28025-28142/com.google.chip.chiptool D/mali_winsys: EGLint new_window_surface(egl_winsys_display *, void *, EGLSurface, EGLConfig, egl_winsys_surface **, EGLBoolean) returns 0x3000
2021-06-13 01:09:58.151 28025-28025/com.google.chip.chiptool D/ViewRootImpl@c22d13f[Toast]: MSG_RESIZED: frame=(356,1810,723,1926) ci=(0,0,0,0) vi=(0,0,367,116) or=1
2021-06-13 01:10:00.052 28025-28142/com.google.chip.chiptool W/libEGL: EGLNativeWindowType 0x6f9fe0a410 disconnect failed
2021-06-13 01:10:00.053 28025-28025/com.google.chip.chiptool D/ViewRootImpl@c22d13f[Toast]: dispatchDetachedFromWindow
2021-06-13 01:10:00.077 28025-28025/com.google.chip.chiptool D/InputTransport: Input channel destroyed: '3be0e69', fd=99

[leasual]

i have the same issue. it says "connect handshake timed out, closing ep." have you solved it?

[jmartinez-silabs]

Fixed with #8666