Regarding commissioning a matter device

I'm getting the following error when I'm trying to commission my matter device using chip-tool downloaded from https://snapcraft.io/install/chip-tool/ubuntu, into the thread network formed by OTBR in docker.

"Failed in verifying 'Attestation Information' command received from the device: err 101. Look at AttestationVerificationResult enum to understand the errors".

Also OTBR and chip-tool are in linux x86 machine.

And I'm trying to commission Nanoleaf matter bulb.

Could anyone please help me to get rid of this error ?

  • Hi,

    I recommend you follow the documentation at https://developer.nordicsemi.com/nRF_Connect_SDK/doc/latest/nrf/protocols/matter/index.html so we can follow you through the process of supporting you. It makes it easier to support you if you use the documentation and supported procedure that we have tested and verified are working on our end.

    Let me know if you are able to commission the device after going through the Subpages (and corresponding webinars).

    If you don't want to follow the documentation and guides we have, I recommend you to go through the vendors support channels, i.e the snapcraft and Nanoleaf

    Kind regards,
    Andreas

  • Hey AHaug, Thanks for your help.

    Can I ask you one more doubt ?

  • I'm trying to commission Tapo Mini Smart Wi-Fi Plug using chip-tool downloaded from https://github.com/nrfconnect/sdk-connectedhomeip/releases V2.4.0 chip-tool-linux_aarch64.zip , and my Linux machine is connected to local Wi-Fi.

    The command I used is ./chip-tool-debug pairing code-wifi 0xA874 TP-Link_4722 77189462 MT:YZ7A00C-035AO14GV10

    where TP-LINK_4722 is my Wi-Fi SSID, 77189462 is Password of my Wi-Fi and MT:YZ7A00C-035AO14GV10 is my smart plug payload

    But I'm getting error as shown below

    [1687270353.218157][18285:18285] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_kvs
    [1687270353.218284][18285:18285] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_factory.ini
    [1687270353.218312][18285:18285] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_config.ini
    [1687270353.218329][18285:18285] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_counters.ini
    [1687270353.218415][18285:18285] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-HI4tsf)
    [1687270353.218549][18285:18285] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
    [1687270353.218559][18285:18285] CHIP:DL: NVS set: chip-counters/reboot-count = 9 (0x9)
    [1687270353.218734][18285:18285] CHIP:DL: Got Ethernet interface: enp2s0
    [1687270353.218840][18285:18285] CHIP:DL: Found the primary Ethernet interface:enp2s0
    [1687270353.218933][18285:18285] CHIP:DL: Got WiFi interface: wlp3s0
    [1687270353.219048][18285:18285] CHIP:DL: Found the primary WiFi interface:wlp3s0
    [1687270353.219063][18285:18285] CHIP:IN: UDP::Init bind&listen port=0
    [1687270353.219083][18285:18285] CHIP:IN: UDP::Init bound to port=51027
    [1687270353.219087][18285:18285] CHIP:IN: UDP::Init bind&listen port=0
    [1687270353.219101][18285:18285] CHIP:IN: UDP::Init bound to port=58610
    [1687270353.219104][18285:18285] CHIP:IN: BLEBase::Init - setting/overriding transport
    [1687270353.219107][18285:18285] CHIP:IN: TransportMgr initialized
    [1687270353.219117][18285:18285] CHIP:FP: Initializing FabricTable from persistent storage
    [1687270353.219161][18285:18285] CHIP:TS: Last Known Good Time: 2023-06-14T13:57:05
    [1687270353.219268][18285:18285] CHIP:FP: Fabric index 0x1 was retrieved from storage. Compressed FabricId 0xBC18D1F1B58BDA4C, FabricId 0x0000000000000001, NodeId 0x000000000001B669, VendorId 0xFFF1
    [1687270353.219652][18285:18285] CHIP:ZCL: Using ZAP configuration...
    [1687270353.220892][18285:18285] CHIP:DL: Avahi client registered
    [1687270353.221092][18285:18285] CHIP:CTL: System State Initialized...
    [1687270353.221115][18285:18285] CHIP:CTL: Stopping commissioning discovery over DNS-SD
    [1687270353.221124][18285:18285] CHIP:CTL: Setting attestation nonce to random value
    [1687270353.221128][18285:18285] CHIP:CTL: Setting CSR nonce to random value
    [1687270353.221234][18285:18287] CHIP:DL: CHIP task running
    [1687270353.221279][18285:18287] CHIP:DL: HandlePlatformSpecificBLEEvent 32784
    [1687270353.221350][18285:18287] CHIP:CTL: Stopping commissioning discovery over DNS-SD
    [1687270353.221357][18285:18287] CHIP:CTL: Setting attestation nonce to random value
    [1687270353.221361][18285:18287] CHIP:CTL: Setting CSR nonce to random value
    [1687270353.224120][18285:18287] CHIP:CTL: Generating NOC
    [1687270353.227173][18285:18287] CHIP:FP: Validating NOC chain
    [1687270353.238424][18285:18287] CHIP:FP: NOC chain validation successful
    [1687270353.238435][18285:18287] CHIP:FP: Updated fabric at index: 0x1, Node ID: 0x000000000001B669
    [1687270353.238440][18285:18287] CHIP:TS: Last Known Good Time: 2023-06-14T13:57:05
    [1687270353.238442][18285:18287] CHIP:TS: New proposed Last Known Good Time: 2021-01-01T00:00:00
    [1687270353.238444][18285:18287] CHIP:TS: Retaining current Last Known Good Time
    [1687270353.239022][18285:18287] CHIP:FP: Metadata for Fabric 0x1 persisted to storage.
    [1687270353.239322][18285:18287] CHIP:TS: Committing Last Known Good Time to storage: 2023-06-14T13:57:05
    [1687270353.239622][18285:18287] CHIP:CTL: Joined the fabric at index 1. Fabric ID is 0x0000000000000001 (Compressed Fabric ID: BC18D1F1B58BDA4C)
    [1687270353.241663][18285:18287] CHIP:CTL: Setting wifi credentials from parameters
    [1687270353.241668][18285:18287] CHIP:CTL: Setting attestation nonce to random value
    [1687270353.241673][18285:18287] CHIP:CTL: Setting CSR nonce to random value
    [1687270353.241708][18285:18287] CHIP:CTL: Stopping commissioning discovery over DNS-SD
    [1687270353.241711][18285:18287] CHIP:CTL: Starting commissioning discovery over BLE
    [1687270353.241719][18285:18287] CHIP:CTL: Starting commissioning discovery over DNS-SD
    [1687270353.243006][18285:18286] CHIP:DL: TRACE: Bus acquired for name C-476d
    [1687270353.244596][18285:18287] CHIP:DL: PlatformBlueZInit init success
    [1687270353.245579][18285:18286] CHIP:BLE: BLE removing known devices.
    [1687270353.245825][18285:18286] CHIP:BLE: BLE initiating scan.
    [1687270353.362881][18285:18287] CHIP:DL: Long dispatch time: 121 ms, for event type 2
    [1687270353.363042][18285:18287] CHIP:DL: Avahi browse: cache exhausted
    [1687270353.377857][18285:18286] CHIP:BLE: Device 28:E6:38:3C:18:93 does not look like a CHIP device.
    [1687270353.559761][18285:18286] CHIP:BLE: Device 7E:98:15:B0:D1:A8 does not look like a CHIP device.
    [1687270353.561606][18285:18286] CHIP:BLE: Device 48:22:54:5F:2B:F3 does not look like a CHIP device.
    [1687270354.245744][18285:18286] CHIP:BLE: Device 24:FC:E5:99:C2:69 does not look like a CHIP device.
    [1687270354.246605][18285:18286] CHIP:BLE: Device 09:23:E7:DB:26:0F does not look like a CHIP device.
    [1687270354.253582][18285:18287] CHIP:DL: Avahi browse: all for now
    [1687270354.601103][18285:18286] CHIP:BLE: Device 08:7C:85:05:34:4B does not look like a CHIP device.
    [1687270354.766759][18285:18286] CHIP:BLE: Device 24:FC:E5:99:C2:69 does not look like a CHIP device.
    [1687270354.767085][18285:18286] CHIP:BLE: Device 09:23:E7:DB:26:0F does not look like a CHIP device.
    [1687270355.492434][18285:18286] CHIP:BLE: Device 28:E6:38:3C:18:93 does not look like a CHIP device.
    [1687270356.268395][18285:18286] CHIP:BLE: Device 24:FC:E5:99:C2:69 does not look like a CHIP device.
    [1687270359.929839][18285:18286] CHIP:BLE: Device D5:D0:B4:6C:40:03 does not look like a CHIP device.
    [1687270360.034205][18285:18286] CHIP:BLE: Device 24:FC:E5:99:C2:69 does not look like a CHIP device.
    [1687270360.034383][18285:18286] CHIP:BLE: Device 09:23:E7:DB:26:0F does not look like a CHIP device.
    [1687270363.368003][18285:18287] CHIP:BLE: BLE scan error: src/platform/Linux/bluez/ChipDeviceScanner.cpp:154: CHIP Error 0x00000032: Timeout
    [1687270363.485400][18285:18286] CHIP:BLE: Scan complete. No matching device found.
    [1687270383.259484][18285:18287] CHIP:CTL: Discovery timed out
    [1687270383.259514][18285:18287] CHIP:CTL: Stopping commissioning discovery over BLE
    [1687270383.259519][18285:18287] CHIP:BLE: BleConnectionDelegate::CancelConnection is not implemented.
    [1687270383.259530][18285:18287] CHIP:-: src/platform/Linux/BLEManagerImpl.cpp:732: CHIP Error 0x0000002D: Not Implemented at src/controller/SetUpCodePairer.cpp:551
    [1687270383.259535][18285:18287] CHIP:CTL: Stopping commissioning discovery over DNS-SD
    [1687270383.259543][18285:18287] CHIP:TOO: Secure Pairing Failed
    [1687270383.259837][18285:18285] CHIP:CTL: Shutting down the commissioner
    [1687270383.259862][18285:18285] CHIP:CTL: Stopping commissioning discovery over DNS-SD
    [1687270383.259870][18285:18285] CHIP:CTL: Shutting down the controller
    [1687270383.259880][18285:18285] CHIP:IN: Expiring all sessions for fabric 0x1!!
    [1687270383.259888][18285:18285] CHIP:FP: Forgetting fabric 0x1
    [1687270383.259903][18285:18285] CHIP:TS: Pending Last Known Good Time: 2023-06-14T13:57:05
    [1687270383.260008][18285:18285] CHIP:TS: Previous Last Known Good Time: 2023-06-14T13:57:05
    [1687270383.260019][18285:18285] CHIP:TS: Reverted Last Known Good Time to previous value
    [1687270383.260037][18285:18285] CHIP:CTL: Shutting down the commissioner
    [1687270383.260041][18285:18285] CHIP:CTL: Stopping commissioning discovery over DNS-SD
    [1687270383.260047][18285:18285] CHIP:CTL: Shutting down the controller
    [1687270383.260052][18285:18285] CHIP:CTL: Shutting down the System State, this will teardown the CHIP Stack
    [1687270383.260984][18285:18285] CHIP:DMG: All ReadHandler-s are clean, clear GlobalDirtySet
    [1687270383.261035][18285:18285] CHIP:BLE: BleConnectionDelegate::CancelConnection is not implemented.
    [1687270383.261058][18285:18285] CHIP:FP: Shutting down FabricTable
    [1687270383.261073][18285:18285] CHIP:TS: Pending Last Known Good Time: 2023-06-14T13:57:05
    [1687270383.261166][18285:18285] CHIP:TS: Previous Last Known Good Time: 2023-06-14T13:57:05
    [1687270383.261174][18285:18285] CHIP:TS: Reverted Last Known Good Time to previous value
    [1687270383.261332][18285:18285] CHIP:DL: writing settings to file (/tmp/chip_counters.ini-DBdfXb)
    [1687270383.261752][18285:18285] CHIP:DL: renamed tmp file to file (/tmp/chip_counters.ini)
    [1687270383.261782][18285:18285] CHIP:DL: NVS set: chip-counters/total-operational-hours = 0 (0x0)
    [1687270383.261790][18285:18285] CHIP:DL: Inet Layer shutdown
    [1687270383.261794][18285:18285] CHIP:DL: BLE shutdown
    [1687270383.262181][18285:18285] CHIP:DL: System Layer shutdown
    [1687270383.262329][18285:18285] CHIP:TOO: Run command failure: examples/chip-tool/commands/pairing/PairingCommand.cpp:240: CHIP Error 0x00000003: Incorrect state

  • Hi,

    Based on the lines below it looks like your commissioner can not find any devices that are a Matter device while scanning for one. You should verify and check if the Matter device you want to commission actually is advertising

    [1687270353.245825][18285:18286] CHIP:BLE: BLE initiating scan.
    [1687270353.362881][18285:18287] CHIP:DL: Long dispatch time: 121 ms, for event type 2
    [1687270353.363042][18285:18287] CHIP:DL: Avahi browse: cache exhausted
    [1687270353.377857][18285:18286] CHIP:BLE: Device 28:E6:38:3C:18:93 does not look like a CHIP device.
    [1687270353.559761][18285:18286] CHIP:BLE: Device 7E:98:15:B0:D1:A8 does not look like a CHIP device.
    [1687270353.561606][18285:18286] CHIP:BLE: Device 48:22:54:5F:2B:F3 does not look like a CHIP device.
    [1687270354.245744][18285:18286] CHIP:BLE: Device 24:FC:E5:99:C2:69 does not look like a CHIP device.
    [1687270354.246605][18285:18286] CHIP:BLE: Device 09:23:E7:DB:26:0F does not look like a CHIP device.
    [1687270354.253582][18285:18287] CHIP:DL: Avahi browse: all for now
    [1687270354.601103][18285:18286] CHIP:BLE: Device 08:7C:85:05:34:4B does not look like a CHIP device.
    [1687270354.766759][18285:18286] CHIP:BLE: Device 24:FC:E5:99:C2:69 does not look like a CHIP device.
    [1687270354.767085][18285:18286] CHIP:BLE: Device 09:23:E7:DB:26:0F does not look like a CHIP device.
    [1687270355.492434][18285:18286] CHIP:BLE: Device 28:E6:38:3C:18:93 does not look like a CHIP device.
    [1687270356.268395][18285:18286] CHIP:BLE: Device 24:FC:E5:99:C2:69 does not look like a CHIP device.
    [1687270359.929839][18285:18286] CHIP:BLE: Device D5:D0:B4:6C:40:03 does not look like a CHIP device.
    [1687270360.034205][18285:18286] CHIP:BLE: Device 24:FC:E5:99:C2:69 does not look like a CHIP device.
    [1687270360.034383][18285:18286] CHIP:BLE: Device 09:23:E7:DB:26:0F does not look like a CHIP device.
    [1687270363.368003][18285:18287] CHIP:BLE: BLE scan error: src/platform/Linux/bluez/ChipDeviceScanner.cpp:154: CHIP Error 0x00000032: Timeout
    [1687270363.485400][18285:18286] CHIP:BLE: Scan complete. No matching device found.
    [1687270383.259484][18285:18287] CHIP:CTL: Discovery timed out
    [1687270383.259514][18285:18287] CHIP:CTL: Stopping commissioning discovery over BLE

    Kind regards,
    Andreas

Related