I am attempting to connect a Matter device (Arduino Nano Matter) to Home Assistant, using Google Nest Hub 2nd gen as the Thread border router.
When I attempt to commission the Matter device in Home Assistant from my Android phone, the setup flow is able to find the device, but then it fails with the error “Failed generating device credentials”.
These are the specific steps I’m taking: Settings → Devices & services → Devices → Add device → Add Matter device → No. It’s new. → Scan QR code → I’m ready
If I follow the same flow using the Google Home app, everything works and the device gets added to Google Home. Which makes me believe the problem has to do with Home Assistant and not the Matter device.
These are the Matter Server logs (after changing log level to verbose):
Matter Server Logs
s6-rc: info: service s6rc-oneshot-runner: starting
s6-rc: info: service s6rc-oneshot-runner successfully started
s6-rc: info: service fix-attrs: starting
s6-rc: info: service banner: starting
s6-rc: info: service fix-attrs successfully started
s6-rc: info: service legacy-cont-init: starting
s6-rc: info: service legacy-cont-init successfully started
-----------------------------------------------------------
Add-on: Matter Server
Matter WebSocket Server for Home Assistant Matter support.
-----------------------------------------------------------
Add-on version: 7.0.0
You are running the latest version of this add-on.
System: Home Assistant OS 14.1 (amd64 / qemux86-64)
Home Assistant Core: 2024.12.5
Home Assistant Supervisor: 2024.12.3
-----------------------------------------------------------
Please, share the above information when looking for help
or support in, e.g., GitHub, forums or the Discord chat.
-----------------------------------------------------------
s6-rc: info: service banner successfully started
s6-rc: info: service matter-server: starting
s6-rc: info: service matter-server successfully started
s6-rc: info: service legacy-services: starting
[17:15:22] INFO: Starting Matter Server...
s6-rc: info: service legacy-services successfully started
[17:15:22] INFO: Using 'enp0s3' as primary network interface.
[17:15:22] INFO: Successfully send discovery information to Home Assistant.
2025-01-20 17:15:24.811 (MainThread) INFO [matter_server.server.stack] Initializing CHIP/Matter Logging...
2025-01-20 17:15:24.811 (MainThread) INFO [matter_server.server.stack] Initializing CHIP/Matter Controller Stack...
2025-01-20 17:15:24.811 (MainThread) DEBUG [matter_server.server.stack] Using storage file: /data/chip.json - Bluetooth commissioning enabled: NO
[1737389724.838922][117:117] CHIP:CTL: Setting attestation nonce to random value
[1737389724.839484][117:117] CHIP:CTL: Setting CSR nonce to random value
[1737389724.840586][117:117] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /tmp/chip_kvs
[1737389724.848747][117:117] CHIP:DL: Wrote settings to /tmp/chip_kvs
[1737389724.849035][117:117] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /data/chip_factory.ini
[1737389724.849210][117:117] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /data/chip_config.ini
[1737389724.849375][117:117] CHIP:DL: ChipLinuxStorage::Init: Using KVS config file: /data/chip_counters.ini
[1737389724.853778][117:117] CHIP:DL: Wrote settings to /data/chip_counters.ini
[1737389724.853828][117:117] CHIP:DL: NVS set: chip-counters/reboot-count = 8 (0x8)
[1737389724.854167][117:117] CHIP:DL: Got Ethernet interface: enp0s3
[1737389724.854458][117:117] CHIP:DL: Found the primary Ethernet interface:enp0s3
[1737389724.855070][117:117] CHIP:DL: Failed to get WiFi interface
[1737389724.855100][117:117] CHIP:DL: Failed to reset WiFi statistic counts
2025-01-20 17:15:24.855 (MainThread) INFO [chip.storage] Initializing persistent storage from file: /data/chip.json
2025-01-20 17:15:24.855 (MainThread) INFO [chip.storage] Loading configuration from /data/chip.json...
2025-01-20 17:15:24.856 (MainThread) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = g/icdfl, Value = 0x55fc98301430 (512)
2025-01-20 17:15:24.856 (MainThread) CHIP_DETAIL [chip.native.CTL] Key Found 4
2025-01-20 17:15:24.857 (MainThread) CHIP_DETAIL [chip.native.IN] UDP::Init bind&listen port=0
2025-01-20 17:15:24.857 (MainThread) CHIP_DETAIL [chip.native.IN] UDP::Init bound to port=55484
2025-01-20 17:15:24.857 (MainThread) CHIP_DETAIL [chip.native.IN] UDP::Init bind&listen port=0
2025-01-20 17:15:24.857 (MainThread) CHIP_DETAIL [chip.native.IN] UDP::Init bound to port=52085
2025-01-20 17:15:24.857 (MainThread) CHIP_DETAIL [chip.native.IN] BLEBase::Init - setting/overriding transport
2025-01-20 17:15:24.857 (MainThread) CHIP_DETAIL [chip.native.IN] TransportMgr initialized
2025-01-20 17:15:24.858 (MainThread) CHIP_DETAIL [chip.native.FP] Initializing FabricTable from persistent storage
2025-01-20 17:15:24.858 (MainThread) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = g/lkgt, Value = 0x7ffee0b0cb60 (18)
2025-01-20 17:15:24.858 (MainThread) CHIP_DETAIL [chip.native.CTL] Key Found 8
2025-01-20 17:15:24.858 (MainThread) CHIP_PROGRESS [chip.native.TS] Last Known Good Time: 2023-10-14T01:16:48
2025-01-20 17:15:24.858 (MainThread) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = g/fidx, Value = 0x7ffee0b0cde0 (44)
2025-01-20 17:15:24.858 (MainThread) CHIP_DETAIL [chip.native.CTL] Key Found 10
2025-01-20 17:15:24.858 (MainThread) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = f/1/n, Value = 0x7ffee0b0c840 (400)
2025-01-20 17:15:24.858 (MainThread) CHIP_DETAIL [chip.native.CTL] Key Found 244
2025-01-20 17:15:24.859 (MainThread) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = f/1/r, Value = 0x7ffee0b0c6a0 (400)
2025-01-20 17:15:24.859 (MainThread) CHIP_DETAIL [chip.native.CTL] Key Found 231
2025-01-20 17:15:24.859 (MainThread) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = f/1/m, Value = 0x7ffee0b0c3b0 (44)
2025-01-20 17:15:24.859 (MainThread) CHIP_DETAIL [chip.native.CTL] Key Found 9
2025-01-20 17:15:24.859 (MainThread) CHIP_PROGRESS [chip.native.FP] Fabric index 0x1 was retrieved from storage. Compressed FabricId 0x9F4F72D9A6C94F2D, FabricId 0x0000000000000002, NodeId 0x000000000001B669, VendorId 0x134B
2025-01-20 17:15:24.859 (MainThread) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = g/fs/c, Value = 0x7ffee0b0cc90 (36)
2025-01-20 17:15:24.860 (MainThread) CHIP_DETAIL [chip.native.CTL] Key Not Found
2025-01-20 17:15:24.860 (MainThread) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = g/gcc, Value = 0x7ffee0b0cd38 (4)
2025-01-20 17:15:24.860 (MainThread) CHIP_DETAIL [chip.native.CTL] Key Found 4
2025-01-20 17:15:24.860 (MainThread) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = g/gdc, Value = 0x7ffee0b0cd38 (4)
2025-01-20 17:15:24.860 (MainThread) CHIP_DETAIL [chip.native.CTL] Key Found 4
2025-01-20 17:15:24.860 (MainThread) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = g/gcc, Value = 0x7ffee0b0cd38 (4)
2025-01-20 17:15:24.861 (MainThread) DEBUG [chip.storage] SetSdkKey: g/gcc = b'b%\xe3\x07'
2025-01-20 17:15:24.861 (MainThread) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = g/gdc, Value = 0x7ffee0b0cd38 (4)
2025-01-20 17:15:24.861 (MainThread) DEBUG [chip.storage] SetSdkKey: g/gdc = b'\x00\xef!\x05'
2025-01-20 17:15:24.862 (MainThread) CHIP_PROGRESS [chip.native.ZCL] Using ZAP configuration...
2025-01-20 17:15:24.864 (MainThread) CHIP_PROGRESS [chip.native.IN] CASE Server enabling CASE session setups
2025-01-20 17:15:24.864 (MainThread) CHIP_DETAIL [chip.native.IN] SecureSession[0x55fc9824d900]: Allocated Type:2 LSID:29149
2025-01-20 17:15:24.864 (MainThread) CHIP_DETAIL [chip.native.SC] Allocated SecureSession (0x55fc9824d900) - waiting for Sigma1 msg
2025-01-20 17:15:24.864 (MainThread) CHIP_DETAIL [chip.native.CTL] System State Initialized...
2025-01-20 17:15:24.870 (Dummy-2) CHIP_DETAIL [chip.native.DL] CHIP task running
2025-01-20 17:15:24.876 (Dummy-2) CHIP_DETAIL [chip.native.DL] HandlePlatformSpecificBLEEvent 32786
2025-01-20 17:15:24.951 (MainThread) INFO [chip.CertificateAuthority] Loading certificate authorities from storage...
2025-01-20 17:15:24.951 (MainThread) INFO [chip.CertificateAuthority] New CertificateAuthority at index 1
2025-01-20 17:15:24.951 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = ExampleOpCredsCAKey1, Value = 0x7f38157fcf90 (97)
2025-01-20 17:15:24.952 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 97
2025-01-20 17:15:24.952 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = ExampleOpCredsICAKey1, Value = 0x7f38157fcf90 (97)
2025-01-20 17:15:24.952 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 97
2025-01-20 17:15:24.952 (MainThread) INFO [chip.CertificateAuthority] Loading fabric admins from storage...
2025-01-20 17:15:24.952 (MainThread) INFO [chip.FabricAdmin] New FabricAdmin: FabricId: 0x0000000000000002, VendorId = 0x134B
2025-01-20 17:15:24.953 (MainThread) DEBUG [chip.storage] SetReplKey: caList = {'1': [{'fabricId': 2, 'vendorId': 4939}]}
2025-01-20 17:15:24.953 (MainThread) INFO [matter_server.server.stack] CHIP Controller Stack initialized.
2025-01-20 17:15:24.953 (MainThread) DEBUG [aiorun] Entering run()
2025-01-20 17:15:24.953 (MainThread) DEBUG [asyncio] Using selector: EpollSelector
2025-01-20 17:15:24.954 (MainThread) DEBUG [aiorun] Creating default executor
2025-01-20 17:15:24.954 (MainThread) INFO [matter_server.server.server] Starting the Matter Server...
2025-01-20 17:15:24.957 (MainThread) INFO [matter_server.server.helpers.paa_certificates] Skip fetching certificates (already fetched within the last 24h).
2025-01-20 17:15:24.958 (MainThread) INFO [chip.FabricAdmin] Allocating new controller with CaIndex: 1, FabricId: 0x0000000000000002, NodeId: 0x000000000001B669, CatTags: []
2025-01-20 17:15:24.959 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Creating New Device Controller
2025-01-20 17:15:24.959 (Dummy-2) CHIP_PROGRESS [chip.native.CTL] Setting attestation nonce to random value
2025-01-20 17:15:24.960 (Dummy-2) CHIP_PROGRESS [chip.native.CTL] Setting CSR nonce to random value
2025-01-20 17:15:24.960 (Dummy-2) CHIP_PROGRESS [chip.native.SPT] Using device attestation PAA trust store path /data/credentials.
2025-01-20 17:15:24.992 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = ExampleCARootCert1, Value = 0x7f38080169e0 (600)
2025-01-20 17:15:24.992 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 410
2025-01-20 17:15:24.993 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = ExampleCAIntermediateCert1, Value = 0x7f3808016780 (600)
2025-01-20 17:15:24.993 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 410
2025-01-20 17:15:24.994 (Dummy-2) CHIP_PROGRESS [chip.native.CTL] Generating NOC
2025-01-20 17:15:24.995 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = f/1/r, Value = 0x7f38157fbce0 (400)
2025-01-20 17:15:24.996 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 231
2025-01-20 17:15:24.996 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = f/1/n, Value = 0x7f38157fbce0 (400)
2025-01-20 17:15:24.997 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 244
2025-01-20 17:15:24.997 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = f/1/r, Value = 0x7f38080171e0 (400)
2025-01-20 17:15:24.997 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 231
2025-01-20 17:15:24.998 (Dummy-2) CHIP_PROGRESS [chip.native.FP] Validating NOC chain
2025-01-20 17:15:25.003 (Dummy-2) CHIP_PROGRESS [chip.native.FP] NOC chain validation successful
2025-01-20 17:15:25.003 (Dummy-2) CHIP_PROGRESS [chip.native.FP] Updated fabric at index: 0x1, Node ID: 0x000000000001B669
2025-01-20 17:15:25.003 (Dummy-2) CHIP_PROGRESS [chip.native.TS] Last Known Good Time: 2023-10-14T01:16:48
2025-01-20 17:15:25.003 (Dummy-2) CHIP_PROGRESS [chip.native.TS] New proposed Last Known Good Time: 2021-01-01T00:00:00
2025-01-20 17:15:25.003 (Dummy-2) CHIP_PROGRESS [chip.native.TS] Retaining current Last Known Good Time
2025-01-20 17:15:25.004 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = g/sri, Value = 0x7f38157fb410 (966)
2025-01-20 17:15:25.004 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Not Found
2025-01-20 17:15:25.004 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = g/fs/c, Value = 0x7f38157fbce0 (7)
2025-01-20 17:15:25.004 (Dummy-2) DEBUG [chip.storage] SetSdkKey: g/fs/c = b'\x15$\x00\x01(\x01\x18'
2025-01-20 17:15:25.005 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = f/1/m, Value = 0x7f38157fbbb0 (9)
2025-01-20 17:15:25.005 (Dummy-2) DEBUG [chip.storage] SetSdkKey: f/1/m = b'\x15%\x00K\x13,\x01\x00\x18'
2025-01-20 17:15:25.006 (Dummy-2) CHIP_PROGRESS [chip.native.FP] Metadata for Fabric 0x1 persisted to storage.
2025-01-20 17:15:25.006 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = f/1/n, Value = 0x7f380800f960 (244)
2025-01-20 17:15:25.006 (Dummy-2) DEBUG [chip.storage] SetSdkKey: f/1/n = b'\x150\x01\x01\x01$\x02\x017\x03$\x13\x02\x18&\x04\x80"\x81\'&\x05\x80%M:7\x06$\x15\x02&\x11i\xb6\x01\x00\x18$\x07\x01$\x08\x010\tA\x04Ir\xee(!\x03\x1e\xc5\x9eK\x08\xa6S\xc6\xdc\x90\xeet\xbb\xa2"\x12&\xae\xa5\x19\xcc6\x94\x10\xde!\x0c+r\x94\x89a\xed^\xadW\x0c\x9baj(q\x9b]\xf7\x82#\xb5\xe3U\xf3d\xc5u\x90\x8b!h7\n5\x01(\x01\x18$\x02\x016\x03\x04\x02\x04\x01\x180\x04\x14\xf2\xca\xba,\xb7<\xc6$\xba\xe3\x8fv\xcd\xa8\xdcQ=V\xa4\x110\x05\x14\xd8\xe9\xd2\x05\x05s\xf0*1\xf6\x83\x83u\xd4p\x14\xce"\xbc\x94\x180\x0b@\xa2Zf\xb6\xd9\xd0\x92\x8d\xff\x84\x13c\xee1\xc6GN\xcd!\xd3\xa2P\x11\xd9XnO\xef\xe7\xb3\xef\x94\x98\x08\x99;6A\t\x8c\xee<?\x06\xa4\x8b8\xc9!\xf6\xc4|\x8a\xfeF:l6e\xed\xdb\xfeF\xb4\x18'
2025-01-20 17:15:25.006 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = f/1/i, Value = 0x7f380800e910 (231)
2025-01-20 17:15:25.006 (Dummy-2) DEBUG [chip.storage] SetSdkKey: f/1/i = b'\x150\x01\x01\x01$\x02\x017\x03$\x14\x01\x18&\x04\x80"\x81\'&\x05\x80%M:7\x06$\x13\x02\x18$\x07\x01$\x08\x010\tA\x04C\xe2\x99+:\x1e\xe4\xa2\xaev\xf9\x05r\xb7\x9b\xe3j^\xc8u\x01\xb9s\xa6\xc3m*\xc4\xb9\x06V{\x04\xb6\x80\\\xea\x8d\xd4\xc8\xbb"\xa1v\xdf\xca\x8b\x15\x18\xce\x88-d\x06\xf5\xdc\x18\x84y\x11\x13\x0f\r&7\n5\x01)\x01\x18$\x02`0\x04\x14\xd8\xe9\xd2\x05\x05s\xf0*1\xf6\x83\x83u\xd4p\x14\xce"\xbc\x940\x05\x14o\x91\xfd]/\xef\xd4\xe8\xcez\xac\xe7\xbe\xf6\xba\x97q\n?\x8d\x180\x0b@\xe8\xb48^\xda\xb3HC\xea\xa5;~m\xabP\xf2\xefe\x9a4q\xcc\xac\x05O\x99\xa7\xd4\xe3\xd8\t\xc8\x0eyv\x13G\xd2\x99\xd8 -f\xb4\xba\xc37C$@C\x18s_\x86\x85\x05\xc1\xbd\x9a\xbae\x0e\xdd\x18'
2025-01-20 17:15:25.006 (Dummy-2) CHIP_PROGRESS [chip.native.TS] Committing Last Known Good Time to storage: 2023-10-14T01:16:48
2025-01-20 17:15:25.006 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = g/lkgt, Value = 0x7f38157fbc70 (8)
2025-01-20 17:15:25.007 (Dummy-2) DEBUG [chip.storage] SetSdkKey: g/lkgt = b'\x15&\x00\x80\xa8\xbc,\x18'
2025-01-20 17:15:25.007 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = g/fs/c, Value = 0x7f38157fbcbf (0)
2025-01-20 17:15:25.007 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Buf not big enough
2025-01-20 17:15:25.007 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::DeleteKeyValue: Key = g/fs/c
2025-01-20 17:15:25.007 (Dummy-2) DEBUG [chip.storage] DeleteSdkKey: g/fs/c
2025-01-20 17:15:25.007 (Dummy-2) CHIP_PROGRESS [chip.native.CTL] Joined the fabric at index 1. Fabric ID is 0x0000000000000002 (Compressed Fabric ID: 9F4F72D9A6C94F2D)
2025-01-20 17:15:25.007 (Dummy-2) CHIP_PROGRESS [chip.native.DIS] Updating services using commissioning mode 0
2025-01-20 17:15:25.010 (Dummy-2) CHIP_PROGRESS [chip.native.DIS] CHIP minimal mDNS started advertising.
2025-01-20 17:15:25.011 (Dummy-2) CHIP_DETAIL [chip.native.DL] Using WiFi MAC for hostname
2025-01-20 17:15:25.011 (Dummy-2) CHIP_PROGRESS [chip.native.DIS] Advertise operational node 9F4F72D9A6C94F2D-000000000001B669
2025-01-20 17:15:25.011 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Responding with _matter._tcp.local
2025-01-20 17:15:25.011 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Responding with 9F4F72D9A6C94F2D-000000000001B669._matter._tcp.local
2025-01-20 17:15:25.011 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Responding with 9F4F72D9A6C94F2D-000000000001B669._matter._tcp.local
2025-01-20 17:15:25.011 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Responding with 0800276623600000.local
2025-01-20 17:15:25.011 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Responding with 0800276623600000.local
2025-01-20 17:15:25.011 (Dummy-2) CHIP_DETAIL [chip.native.DIS] Responding with _I9F4F72D9A6C94F2D._sub._matter._tcp.local
2025-01-20 17:15:25.011 (Dummy-2) CHIP_PROGRESS [chip.native.DIS] CHIP minimal mDNS configured as 'Operational device'; instance name: 9F4F72D9A6C94F2D-000000000001B669.
2025-01-20 17:15:25.017 (Dummy-2) CHIP_PROGRESS [chip.native.DIS] mDNS service published: _matter._tcp
2025-01-20 17:15:25.017 (Dummy-2) CHIP_PROGRESS [chip.native.SPT] Setting up group data for Fabric Index 1 with Compressed Fabric ID:
2025-01-20 17:15:25.017 (Dummy-2) CHIP_DETAIL [chip.native.SPT] 0x9f, 0x4f, 0x72, 0xd9, 0xa6, 0xc9, 0x4f, 0x2d,
2025-01-20 17:15:25.017 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = f/1/g, Value = 0x7f38157fc710 (128)
2025-01-20 17:15:25.017 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 23
2025-01-20 17:15:25.017 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::GetKeyValue: Key = f/1/k/0, Value = 0x7f38157fc5e0 (128)
2025-01-20 17:15:25.018 (Dummy-2) CHIP_DETAIL [chip.native.CTL] Key Found 97
2025-01-20 17:15:25.018 (Dummy-2) CHIP_DETAIL [chip.native.CTL] StorageAdapter::SetKeyValue: Key = f/1/k/0, Value = 0x7f38157fc5e0 (97)
2025-01-20 17:15:25.018 (Dummy-2) DEBUG [chip.storage] SetSdkKey: f/1/k/0 = b'\x15$\x01\x00$\x02\x016\x03\x15$\x04\x00%\x05\xd8\\0\x06\x10\x08\x9e\xba\xd5\xedOn\xb9\x1f\xfe\xb7\xb4\xaeiz\xc3\x18\x15$\x04\x00$\x05\x000\x06\x10\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x18\x15$\x04\x00$\x05\x000\x06\x10\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x18\x18%\x07\xff\xff\x18'
2025-01-20 17:15:25.027 (MainThread) DEBUG [matter_server.server.sdk] CHIP Device Controller Initialized
2025-01-20 17:15:25.033 (ThreadPoolExecutor-0_0) DEBUG [matter_server.server.storage] Loading persistent settings from /data/11479520254322364205.json
2025-01-20 17:15:25.036 (MainThread) DEBUG [matter_server.server.storage] Started.
2025-01-20 17:15:25.036 (MainThread) INFO [matter_server.server.vendor_info] Loading vendor info from storage.
2025-01-20 17:15:25.040 (MainThread) INFO [matter_server.server.vendor_info] Loaded 280 vendors from storage.
2025-01-20 17:15:25.041 (MainThread) INFO [matter_server.server.vendor_info] Fetching the latest vendor info from DCL.
2025-01-20 17:15:25.366 (MainThread) INFO [matter_server.server.vendor_info] Fetched 279 vendors from DCL.
2025-01-20 17:15:25.366 (MainThread) INFO [matter_server.server.vendor_info] Saving vendor info to storage.
2025-01-20 17:15:25.373 (MainThread) INFO [matter_server.server.device_controller] Loaded 0 nodes from stored configuration
2025-01-20 17:15:25.380 (MainThread) DEBUG [matter_server.server.server] Detected dashboard files on /usr/local/lib/python3.12/site-packages/matter_server/dashboard
2025-01-20 17:15:25.382 (MainThread) INFO [matter_server.server.server] Matter Server successfully initialized.
2025-01-20 17:15:25.457 (MainThread) WARNING [zeroconf] Error with socket 48 (('::1', 5353, 0, 0))): [Errno 101] Network is unreachable
Traceback (most recent call last):
File "/usr/local/lib/python3.12/asyncio/selector_events.py", line 1275, in sendto
self._sock.sendto(data, addr)
OSError: [Errno 101] Network is unreachable
2025-01-20 17:15:26.516 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:26.517 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:26.517 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:26.517 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:26.517 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:26.517 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:30.530 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:30.530 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:30.530 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:30.531 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:30.531 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:30.532 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:33.293 (MainThread) DEBUG [matter_server.server.client_handler] [139878838351440] Connected from 192.168.1.101
2025-01-20 17:15:33.296 (MainThread) VERBOSE [matter_server.server.client_handler] [139878838351440] Received: {
"message_id": "dbbd724edaf64f2c8198e08f06c15de5",
"command": "start_listening",
"args": null
}
2025-01-20 17:15:33.296 (MainThread) VERBOSE [matter_server.server.client_handler] [139878838351440] Received CommandMessage(message_id='dbbd724edaf64f2c8198e08f06c15de5', command='start_listening', args=None)
2025-01-20 17:15:33.298 (MainThread) VERBOSE [matter_server.server.client_handler] [139878838351440] Handling command start_listening
2025-01-20 17:15:33.299 (MainThread) VERBOSE [matter_server.server.client_handler] [139878838351440] Received: {
"message_id": "285e952db6014c9784ea50731b95d23e",
"command": "set_default_fabric_label",
"args": {
"label": "Home"
}
}
2025-01-20 17:15:33.300 (MainThread) VERBOSE [matter_server.server.client_handler] [139878838351440] Received CommandMessage(message_id='285e952db6014c9784ea50731b95d23e', command='set_default_fabric_label', args={'label': 'Home'})
2025-01-20 17:15:33.300 (MainThread) VERBOSE [matter_server.server.client_handler] [139878838351440] Handling command set_default_fabric_label
2025-01-20 17:15:39.546 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:39.546 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:39.546 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:39.547 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:39.547 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:15:39.548 (Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
2025-01-20 17:17:25.396 (ThreadPoolExecutor-0_0) DEBUG [matter_server.server.storage] Saved data to persistent storage
2025-01-20 17:17:25.396 (ThreadPoolExecutor-0_0) DEBUG [matter_server.server.storage] Saved data to persistent storage
Nothing new gets printed when trying to commission the device, but there’s a suspicious error which gets printed periodically:
(Dummy-2) CHIP_ERROR [chip.native.DIS] DNSSD parse error: src/lib/dnssd/IncrementalResolve.cpp:285: CHIP Error 0x0000002F: Invalid argument
Has anyone else faced this error before? Any ideas about what’s going on? How can I debug it further?