#Has anyone seen ERROR Commissioning

1 messages · Page 1 of 1 (latest)

ripe vigil
#

How did you try to commission ? Using the HA Companion app ?
It shouldnt be using the bluetooth commissioning unless you are manually calling the underlying websocket command on the matter server which is not yet ready for prime time due to the collision with HA's builtin bluetooth integration

rapid dawn
#

Yes using the HA companion app on my iPhone. The BLE failure always happens ever since I can remember looking at the logs...but up until 2 weeks ago it was harmless and the device would commmission just fine after the bluetooth failure.

#

if it makes any difference, i'm using the test flight 2023.7/2023.471 version on my iphone.

#

Here's the full log from a SUCCESSFUL commissioning from my iPhone via the HA companion app. This is after the HAOS restart:
2023-10-10 20:09:48 core-matter-server matter_server.server.helpers.paa_certificates[125] INFO Fetching the latest PAA root certificates from DCL.
2023-10-10 20:09:48 core-matter-server matter_server.server.helpers.paa_certificates[125] INFO Fetched 0 PAA root certificates from DCL.
2023-10-10 20:09:48 core-matter-server matter_server.server.helpers.paa_certificates[125] INFO Fetching the latest PAA root certificates from Git.
2023-10-10 20:09:48 core-matter-server matter_server.server.helpers.paa_certificates[125] INFO Fetched 0 PAA root certificates from Git.
2023-10-10 20:09:48 core-matter-server chip.CTL[125] ERROR Commissioning discovery over BLE failed: src/platform/Linux/BLEManagerImpl.cpp:682: CHIP Error 0x00000003: Incorrect state
2023-10-10 20:09:48 core-matter-server chip.-[125] ERROR src/platform/Linux/BLEManagerImpl.cpp:682: CHIP Error 0x00000003: Incorrect state at src/controller/SetUpCodePairer.cpp:299
2023-10-10 20:09:48 core-matter-server chip.BLE[125] ERROR No adapter available for new connection establishment
2023-10-10 20:10:01 core-matter-server PersistentStorage[125] INFO SetSdkKey: f/1/s/0000000000000033 = b'\x150\x03\x10\xc7a\xfb\xcbb\xfb_l\x93\xfcPOc\x8dP\xc40\x04 \xe8\x95\x9c\xa2\x9eD\x91\xd4,\xe7\xc0\xe2\xe8\xd0\x1bD,\xe7\xff#\xe9\xb4\r\x90\x9e\xd0\xf9\x9c\xb8\xa3\x88\xcf0\x05\x0c\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x18'
2023-10-10 20:10:01 core-matter-server PersistentStorage[125] INFO Committing...
2023-10-10 20:10:01 core-matter-server PersistentStorage[125] INFO SetSdkKey: g/s/x2H7y2L7X2yT/FBPY41QxA== = b'\x15$\x01\x01$\x023\x18'

#

2023-10-10 20:10:01 core-matter-server PersistentStorage[125] INFO Committing...
2023-10-10 20:10:01 core-matter-server PersistentStorage[125] INFO SetSdkKey: g/sri = b"\x16\x15$\x01\x01$\x02\x02\x18\x15$\x01\x01$\x02\x03\x18\x15$\x01\x01$\x02\x07\x18\x15$\x01\x01$\x02\t\x18\x15$\x01\x01$\x02\x0e\x18\x15$\x01\x01$\x02\x1a\x18\x15$\x01\x01$\x02\x1b\x18\x15$\x01\x01$\x02\x1c\x18\x15$\x01\x01$\x02\x1d\x18\x15$\x01\x01$\x02\x1e\x18\x15$\x01\x01$\x02 \x18\x15$\x01\x01$\x02'\x18\x15$\x01\x01$\x02\x04\x18\x15$\x01\x01$\x02\x08\x18\x15$\x01\x01$\x02!\x18\x15$\x01\x01$\x02-\x18\x15$\x01\x01$\x023\x18\x18"
2023-10-10 20:10:01 core-matter-server PersistentStorage[125] INFO Committing...
2023-10-10 20:10:10 core-matter-server matter_server.server.device_controller.[node 51][125] INFO Subscription succeeded

#

And here's the full log from the same device commissionging pre-HAOS restart where it failed:
2023-10-10 19:50:59 core-matter-server matter_server.server.helpers.paa_certificates[125] INFO Fetching the latest PAA root certificates from DCL.
2023-10-10 19:51:00 core-matter-server matter_server.server.helpers.paa_certificates[125] INFO Fetched 0 PAA root certificates from DCL.
2023-10-10 19:51:00 core-matter-server matter_server.server.helpers.paa_certificates[125] INFO Fetching the latest PAA root certificates from Git.
2023-10-10 19:51:00 core-matter-server matter_server.server.helpers.paa_certificates[125] INFO Fetched 0 PAA root certificates from Git.
2023-10-10 19:51:00 core-matter-server chip.CTL[125] ERROR Commissioning discovery over BLE failed: src/platform/Linux/BLEManagerImpl.cpp:682: CHIP Error 0x00000003: Incorrect state
2023-10-10 19:51:00 core-matter-server chip.-[125] ERROR src/platform/Linux/BLEManagerImpl.cpp:682: CHIP Error 0x00000003: Incorrect state at src/controller/SetUpCodePairer.cpp:299
2023-10-10 19:51:00 core-matter-server chip.BLE[125] ERROR No adapter available for new connection establishment
2023-10-10 19:51:30 core-matter-server chip.CTL[125] ERROR Discovery timed out

#

2023-10-10 19:51:30 core-matter-server chip.ZCL[125] ERROR Secure Pairing Failed
2023-10-10 19:51:30 core-matter-server matter_server.server.client_handler[125] ERROR [140122594534224] Error handling message: CommandMessage(message_id='0aace43d7a4f4e7999f65e3124f30dd3', command='commission_with_code', args={'code': '25497520062'})
Traceback (most recent call last):
File "/usr/local/lib/python3.11/site-packages/matter_server/server/client_handler.py", line 188, in _run_handler
result = await result
^^^^^^^^^^^^
File "/usr/local/lib/python3.11/site-packages/matter_server/server/device_controller.py", line 171, in commission_with_code
raise NodeCommissionFailed(
matter_server.common.errors.NodeCommissionFailed: Commission with code failed for node 50
2023-10-10 19:51:31 core-matter-server chip.DIS[125] ERROR Timeout waiting for mDNS resolution.

ripe vigil
#

strange, why its trying to do bluetooth commissioning ?!