Matter Light Bulb fail commissioning in HA or Google Home

[vorrias]

Hi,
I am preparing my project for “MAKE IT MATTER” contest and I am running out of time.
So please help me if you can

Problems:
1 - I can not see the nRF7002-DK to be part of the Thread network
2 - I can not commission on the Matter Server the nRF7002-DK  running the Matter:Light bulb Application

In OTBR web  JOIN I can not see any connected  device. I suppose I must see the nRF7002-DK running Matter:Light bulb  
How can I achieve that?

What I have done:

1 - Build  Matter:Light bulb Application  following the example:
docs.nordicsemi.com/.../README.html

Board is working, buttons and LED s are working as in example.
LED is blinking slow waiting to commission.

2 - Configure OpenThread Radio Co-processor (RCP) on nRF52840 Dongle
Plug it into Raspberry Pi (running the OTBR)

3 - OTBR installed. Web page can be seen. OTBR  is LEADER
Looks that the nRF52840 dongle recognized as seen from WEB interface

Then I started the commissioning procedure using smartphone in two different Matter servers
I have the same results commissioning with NFC or QR code
The commissioning is going well until a point that reports unable to connect

Tests running on:

A) Home Assistant Mater Server.
HA is running in my local network. OTBR + nRF82540 dongle is connected on that network as well
This server is working OK . I have already commissioned a commercial plug using the QR without any problems

B) Google Home app in my smartphone

Results:

IN HOME ASSISTANT
- (LED blinking slow)
- Connect with the device  (LED blinking fast)
- Create Matter credentials (LED blinking fast)
- Check network connectivity (LED solid)
- inability to connect to the device. Make sure your phone is connected to Wi-Fi

IN GOOGLE HOME APP
- (LED blinking slow)
- Connect with the device  (LED blinking fast)
- Create Matter credentials (LED blinking fast)
- Uncertified device. It is not possible to configure this device with Google

What am I doing wrong?

Thank you

Vasilis

Some screenshots from OTBR web

[Maria Gilje]

Hello Vasilis,

Have you seen this blog on how to test NCS Matter samples in existing ecosystems?  Matter: Testing the nRF Connect platform with Apple, Google and Samsung ecosystems

Also, is your OTBR connected to your network via Wi-Fi?

Our Matter samples are not certified, so the log showing this is expected. Read more on Matter certification here.

Best regards,

Maria

[vorrias]

Hi Maria,

First of all Happy New Year.
Last year i was trying hard to make it work. First of all I received a new nRF7002-DK . On the old one I broke by accident the micro USB port.
On the new one I put some more solder on the USB connector to be sure and I start treating it with more kindness. I can not afford to loose it again. Contest closing date is close and time is ticking.
Let us see where I am standing.
I was following your directions and now I am able to see nRF7002-DK recognized by Google Home. That achieved by creating in Google development console a matter device NordicPico, as Light Bulb. An Bulb image added as well. test VID = 0XFFF1 and product id = 0x8005.
So far so good by pressing the Reset button for more that six seconds:
Placing smart phone into NFC tag I get the following messages on the smartphone:
1 - searching for the device (LED blinking slow)
2 - "Connecting with the device"  (LED blinking fast. The Bulb icon appears)
3 - "Create Matter credentials" (LED blinking fast)
4 - "Check network connectivity "
5 - "Not possible to connect with LAB1"

Note that smartphone with Google app is connected to LAB1 SSID
Rading  the terminal output I see that nRF7002-DK scaner locates LAB1 but the not able to connect.

Do I ave to provide any password during the firmware flash?

here is the a part of the log scanning for Wi-Fi

***

D: 33488 [DL]Connecting to WiFi network: LAB1
D: 33495 [DL]WiFi scanning started...
D: 35977 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 36114 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
I: 38106 [DL]Wi-Fi scan done (0)
OK
OK
OK
OK
OK
E: 38118 [DL]Connection request failed

***

The full log file is provided.
Please help me on that. Looks a minor but crucial detail is missing

The flashed firmware is the Light Bulb unchanged.
Thank you

Fullscreen nrf7002 matter commissioning logfile.txt Download

 478 [DL]  Product Id: 32773 (0x8005)
I: 482 [DL]  Product Name: not-specified
I: 486 [DL]  Hardware Version: 0
I: 489 [DL]  Setup Pin Code (0 for UNKNOWN/ERROR): 20202021
I: 494 [DL]  Setup Discriminator (0xFFFF for UNKNOWN/ERROR): 3840 (0xF00)
I: 500 [DL]  Manufacturing Date: 2022-01-01
I: 504 [DL]  Device Type: 65535 (0xFFFF)
I: 508 [SVR]SetupQRCode: [MT:6FCJ142C00KA0648G00]
I: 512 [SVR]Copy/paste the below URL in a browser to see the QR Code:
I: 518 [SVR]https://project-chip.github.io/connectedhomeip/qrcode.html?data=MT%3A6FCJ142C00KA0648G00
I: 527 [SVR]Manual pairing code: [34970112332]
I: 532 [DL]CHIP task running
I: 538 [DL]CHIPoBLE advertising started
I: 543 [ZCL]Cluster OnOff: attribute OnOff set to 0
I: 548 [ZCL]Cluster LevelControl: attribute CurrentLevel set to 254
I: 554 [DL]NFC Tag emulation started
I: 20887 [DL]BLE connection established (ConnId: 0x00)
I: 20892 [DL]Current number of connections: 1/1
I: 20896 [DL]CHIPoBLE advertising stopped
I: 20900 [DL]NFC Tag emulation stopped
D: 21819 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 21826 [BLE]local and remote recv window sizes = 5
I: 21831 [BLE]selected BTP version 4
I: 21835 [BLE]using BTP fragment sizes rx 128 / tx 128.
D: 21842 [DL]ConnId: 0x00, New CCCD value: 0x0002
D: 21846 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6)
D: 21854 [IN]BLE EndPoint 0x2000ae00 Connection Complete
I: 21859 [DL]CHIPoBLE connection established (ConnId: 0x00, GATT MTU: 131)
D: 21986 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 22121 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 22128 [EM]>>> [E:20237r S:0 M:18801333] (U) Msg RX from 0:4B1C031A7F9243EE [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest)
I: 22141 [EM]<<< [E:20237r S:0 M:94567296] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:21 (SecureChannel:PBKDFParamResponse)
I: 22153 [IN](U) Sending msg 94567296 to IP address 'BLE'
D: 22158 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 22256 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 22263 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 14)
D: 22346 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 22354 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 22361 [EM]>>> [E:20237r S:0 M:18801334] (U) Msg RX from 0:4B1C031A7F9243EE [0000] --- Type 0000:22 (SecureChannel:PASE_Pake1)
I: 23734 [EM]<<< [E:20237r S:0 M:94567297] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:23 (SecureChannel:PASE_Pake2)
I: 23745 [IN](U) Sending msg 94567297 to IP address 'BLE'
D: 23750 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
E: 23757 [DL]Long dispatch time: 1403 ms, for event type 16388
D: 23874 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 23882 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6)
D: 23964 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 23972 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 23980 [EM]>>> [E:20237r S:0 M:18801335] (U) Msg RX from 0:4B1C031A7F9243EE [0000] --- Type 0000:24 (SecureChannel:PASE_Pake3)
I: 23992 [EM]<<< [E:20237r S:0 M:94567298] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:40 (SecureChannel:StatusReport)
I: 24003 [IN](U) Sending msg 94567298 to IP address 'BLE'
D: 24008 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 35)
I: 24017 [SC]SecureSession[0x200041e0]: Moving from state 'kEstablishing' --> 'kActive'
D: 24024 [IN]SecureSession[0x200041e0]: Activated - Type:1 LSID:10566
D: 24031 [IN]New secure session activated for device <FFFFFFFB00000000, 0>, LSID:10566 PSID:9911!
I: 24039 [SVR]Commissioning completed session establishment step
I: 24045 [DIS]Updating services using commissioning mode 0
I: 24050 [DIS]CHIP minimal mDNS started advertising.
D: 24056 [DL]CHIPoBLE advertising set to off
I: 24060 [SVR]Device completed Rendezvous process
D: 24099 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 24107 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 24115 [EM]>>> [E:20238r S:10566 M:142210312] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 24126 [IM]Received Read request
I: 24131 [EM]<<< [E:20238r S:10566 M:23921818] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 24142 [IN](S) Sending msg 23921818 on secure session with LSID: 10566
D: 24148 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 97)
D: 24234 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 24242 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 24250 [EM]>>> [E:20239r S:10566 M:142210313] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 24261 [IM]Received Read request
I: 24266 [EM]<<< [E:20239r S:10566 M:23921819] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 24276 [IN](S) Sending msg 23921819 on secure session with LSID: 10566
D: 24283 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72)
D: 24369 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 24377 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 24385 [EM]>>> [E:20240r S:10566 M:142210314] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 24396 [IM]Received Read request
I: 24401 [EM]<<< [E:20240r S:10566 M:23921820] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 24411 [IN](S) Sending msg 23921820 on secure session with LSID: 10566
D: 24418 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72)
D: 24504 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 24512 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 24520 [EM]>>> [E:20241r S:10566 M:142210315] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 24531 [IM]Received Read request
I: 24536 [EM]<<< [E:20241r S:10566 M:23921821] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 24546 [IN](S) Sending msg 23921821 on secure session with LSID: 10566
D: 24553 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72)
D: 24639 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 24647 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 24655 [EM]>>> [E:20242r S:10566 M:142210316] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 24666 [IM]Received Read request
I: 24671 [EM]<<< [E:20242r S:10566 M:23921822] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 24681 [IN](S) Sending msg 23921822 on secure session with LSID: 10566
D: 24688 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 24774 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 24782 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 24790 [EM]>>> [E:20243r S:10566 M:142210317] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 24801 [IM]Received Read request
I: 24806 [EM]<<< [E:20243r S:10566 M:23921823] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 24816 [IN](S) Sending msg 23921823 on secure session with LSID: 10566
D: 24823 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 24909 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 24917 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 24925 [EM]>>> [E:20244r S:10566 M:142210318] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 24936 [IM]Received Read request
I: 24941 [EM]<<< [E:20244r S:10566 M:23921824] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 24952 [IN](S) Sending msg 23921824 on secure session with LSID: 10566
D: 24958 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 97)
D: 25044 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 25052 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 25060 [EM]>>> [E:20245r S:10566 M:142210319] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 25071 [IM]Received Read request
I: 25076 [EM]<<< [E:20245r S:10566 M:23921825] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 25086 [IN](S) Sending msg 23921825 on secure session with LSID: 10566
D: 25093 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72)
D: 25179 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 25187 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 25195 [EM]>>> [E:20246r S:10566 M:142210320] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 25206 [IM]Received Read request
I: 25211 [EM]<<< [E:20246r S:10566 M:23921826] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 25221 [IN](S) Sending msg 23921826 on secure session with LSID: 10566
D: 25228 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 25314 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 25630 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 25638 [EM]>>> [E:20247r S:10566 M:142210321] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
I: 25649 [EM]<<< [E:20247r S:10566 M:23921827] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
I: 25660 [IN](S) Sending msg 23921827 on secure session with LSID: 10566
D: 25666 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 43)
D: 25764 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 25772 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 25780 [EM]>>> [E:20247r S:10566 M:142210322] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 25792 [FS]GeneralCommissioning: Received ArmFailSafe (120s)
I: 25799 [EM]<<< [E:20247r S:10566 M:23921828] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 25811 [IN](S) Sending msg 23921828 on secure session with LSID: 10566
D: 25817 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 25899 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 25907 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 25915 [EM]>>> [E:20248r S:10566 M:142210323] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 25926 [IM]Received Read request
I: 25931 [EM]<<< [E:20248r S:10566 M:23921829] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 25942 [IN](S) Sending msg 23921829 on secure session with LSID: 10566
D: 25948 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 26034 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 26042 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 26050 [EM]>>> [E:20249r S:10566 M:142210324] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
I: 26062 [EM]<<< [E:20249r S:10566 M:23921830] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
I: 26073 [IN](S) Sending msg 23921830 on secure session with LSID: 10566
D: 26079 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 43)
D: 26169 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 26177 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 26185 [EM]>>> [E:20249r S:10566 M:142210325] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 26200 [EM]<<< [E:20249r S:10566 M:23921831] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 26212 [IN](S) Sending msg 23921831 on secure session with LSID: 10566
D: 26218 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 26304 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 26312 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 26320 [EM]>>> [E:20250r S:10566 M:142210326] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 26333 [ZCL]OpCreds: Certificate Chain request received for DAC
I: 26342 [EM]<<< [E:20250r S:10566 M:23921832] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 26353 [IN](S) Sending msg 23921832 on secure session with LSID: 10566
D: 26360 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 26439 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 26447 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 26529 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 26537 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 26709 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 26717 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 26799 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 26807 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 26815 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 57)
D: 26889 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 26897 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 26905 [EM]>>> [E:20251r S:10566 M:142210327] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 26917 [ZCL]OpCreds: Certificate Chain request received for PAI
I: 26926 [EM]<<< [E:20251r S:10566 M:23921833] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 26938 [IN](S) Sending msg 23921833 on secure session with LSID: 10566
D: 26944 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 27069 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 27077 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 27160 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 27167 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 27250 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 27257 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 27340 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 27347 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 27355 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 28)
D: 27429 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 27437 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 27446 [EM]>>> [E:20252r S:10566 M:142210328] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 27458 [ZCL]OpCreds: Received an AttestationRequest command
I: 27493 [ZCL]OpCreds: AttestationRequest successful.
I: 27502 [EM]<<< [E:20252r S:10566 M:23921834] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 27513 [IN](S) Sending msg 23921834 on secure session with LSID: 10566
D: 27520 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 27609 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 27617 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 27699 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 27707 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 27790 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 27797 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 27880 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 27887 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 27895 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 28014 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 28022 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 92)
D: 28104 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 28112 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 28121 [EM]>>> [E:20253r S:10566 M:142210329] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 28133 [ZCL]OpCreds: Received a CSRRequest command
I: 28278 [ZCL]OpCreds: AllocatePendingOperationalKey succeeded
I: 28313 [ZCL]OpCreds: CSRRequest successful.
I: 28319 [EM]<<< [E:20253r S:10566 M:23921835] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 28331 [IN](S) Sending msg 23921835 on secure session with LSID: 10566
D: 28337 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
E: 28345 [DL]Long dispatch time: 233 ms, for event type 16388
D: 28420 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 28427 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 28510 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 28517 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 28599 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 30939 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 31930 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 32021 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 32111 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 32118 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
I: 32127 [EM]>>> [E:20254r S:10566 M:142210330] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 32140 [ZCL]OpCreds: Received an AddTrustedRootCertificate command
I: 32200 [ZCL]OpCreds: AddTrustedRootCertificate successful.
I: 32206 [EM]<<< [E:20254r S:10566 M:23921836] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 32217 [IN](S) Sending msg 23921836 on secure session with LSID: 10566
E: 32224 [DL]Long dispatch time: 113 ms, for event type 16388
D: 32229 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 32237 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 67)
D: 32334 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 32342 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 32426 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 32561 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 32651 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 32658 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 32739 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 32747 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 32830 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 32842 [EM]>>> [E:20255r S:10566 M:142210331] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 32854 [ZCL]OpCreds: Received an AddNOC command
I: 32860 [FP]Validating NOC chain
I: 32971 [FP]NOC chain validation successful
I: 32975 [FP]Added new fabric at index: 0x1
I: 32979 [FP]Assigned compressed fabric ID: 0x7CC7E5A580FB757C, node ID: 0x00000000422FA9E5
I: 32987 [TS]Last Known Good Time: 2023-12-28T16:25:22
I: 32992 [TS]New proposed Last Known Good Time: 2024-01-02T14:34:44
I: 32998 [TS]Updating pending Last Known Good Time to 2024-01-02T14:34:44
I: 33012 [ZCL]OpCreds: ACL entry created for Fabric index 0x1 CASE Admin Subject 0xFFFFFFFD00010001
D: 33021 [DL]Using wifi MAC for hostname
I: 33025 [DIS]Advertise operational node 7CC7E5A580FB757C-00000000422FA9E5
D: 33032 [DIS]Responding with _matter._tcp.local
D: 33036 [DIS]Responding with 7CC7E5A580FB757C-00000000422FA9E5._matter._tcp.local
D: 33043 [DIS]Responding with 7CC7E5A580FB757C-00000000422FA9E5._matter._tcp.local
D: 33051 [DIS]Responding with F4CE36001DFE.local
D: 33055 [DIS]Responding with F4CE36001DFE.local
D: 33059 [DIS]Responding with _I7CC7E5A580FB757C._sub._matter._tcp.local
I: 33066 [DIS]CHIP minimal mDNS configured as 'Operational device'; instance name: 7CC7E5A580FB757C-00000000422FA9E5.
I: 33076 [DIS]mDNS service published: _matter._tcp
I: 33081 [ZCL]OpCreds: successfully created fabric index 0x1 via AddNOC
I: 33088 [EM]<<< [E:20255r S:10566 M:23921837] (S) Msg TX to 1:FFFFFFFB00000000 [757C] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 33100 [IN](S) Sending msg 23921837 on secure session with LSID: 10566
D: 33106 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
E: 33114 [DL]Long dispatch time: 283 ms, for event type 16388
D: 33189 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 33197 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 33206 [EM]>>> [E:20256r S:10566 M:142210332] (S) Msg RX from 1:FFFFFFFB00000000 [757C] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 33219 [EM]<<< [E:20256r S:10566 M:23921838] (S) Msg TX to 1:FFFFFFFB00000000 [757C] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 33230 [IN](S) Sending msg 23921838 on secure session with LSID: 10566
D: 33237 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 33324 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 33332 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 33340 [EM]>>> [E:20257r S:10566 M:142210333] (S) Msg RX from 1:FFFFFFFB00000000 [757C] --- Type 0001:02 (IM:ReadRequest)
D: 33351 [IM]Received Read request
I: 33356 [EM]<<< [E:20257r S:10566 M:23921839] (S) Msg TX to 1:FFFFFFFB00000000 [757C] --- Type 0001:05 (IM:ReportData)
I: 33367 [IN](S) Sending msg 23921839 on secure session with LSID: 10566
D: 33373 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 33459 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 33468 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 33476 [EM]>>> [E:20258r S:10566 M:142210334] (S) Msg RX from 1:FFFFFFFB00000000 [757C] --- Type 0001:08 (IM:InvokeCommandRequest)
D: 33488 [DL]Connecting to WiFi network: LAB1
D: 33495 [DL]WiFi scanning started...
D: 35977 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 36114 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
I: 38106 [DL]Wi-Fi scan done (0)
OK
OK
OK
OK
OK
E: 38118 [DL]Connection request failed
I: 38122 [EM]<<< [E:20258r S:10566 M:23921840] (S) Msg TX to 1:FFFFFFFB00000000 [757C] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 38134 [IN](S) Sending msg 23921840 on secure session with LSID: 10566
D: 38140 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 70)
D: 38274 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 38282 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 38290 [EM]>>> [E:20259r S:10566 M:142210335] (S) Msg RX from 1:FFFFFFFB00000000 [757C] --- Type 0001:0a (IM:TimedRequest)
I: 38302 [EM]<<< [E:20259r S:10566 M:23921841] (S) Msg TX to 1:FFFFFFFB00000000 [757C] --- Type 0001:01 (IM:StatusResponse)
I: 38313 [IN](S) Sending msg 23921841 on secure session with LSID: 10566
D: 38319 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 43)
D: 38409 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 38417 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 38425 [EM]>>> [E:20259r S:10566 M:142210336] (S) Msg RX from 1:FFFFFFFB00000000 [757C] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 38438 [FS]GeneralCommissioning: Received ArmFailSafe (1s)
I: 38444 [EM]<<< [E:20259r S:10566 M:23921842] (S) Msg TX to 1:FFFFFFFB00000000 [757C] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 38455 [IN](S) Sending msg 23921842 on secure session with LSID: 10566
D: 38462 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 38545 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
I: 39443 [FS]Fail-safe timer expired
E: 39447 [SVR]Failsafe timer expired
D: 39450 [IN]SecureSession[0x200041e0]: MarkForEviction Type:1 LSID:10566
I: 39456 [SC]SecureSession[0x200041e0]: Moving from state 'kActive' --> 'kPendingEviction'
D: 39464 [IN]SecureSession[0x200041e0]: Released - Type:1 LSID:10566
E: 39470 [SVR]Commissioning failed (attempt 1): 32
D: 39475 [IN]Clearing BLE pending packets.
I: 39479 [BLE]Releasing end point's BLE connection back to application.
I: 39485 [DL]Closing BLE GATT connection (ConnId 00)
D: 39491 [IN]SecureSession[0x200041e0]: Allocated Type:1 LSID:10568
D: 39497 [DL]CHIPoBLE advertising set to on
I: 39501 [DIS]Updating services using commissioning mode 1
I: 39506 [DIS]CHIP minimal mDNS started advertising.
D: 39511 [DL]Using wifi MAC for hostname
I: 39515 [DIS]Advertise operational node 7CC7E5A580FB757C-00000000422FA9E5
D: 39522 [DIS]Responding with _matter._tcp.local
D: 39526 [DIS]Responding with 7CC7E5A580FB757C-00000000422FA9E5._matter._tcp.local
D: 39533 [DIS]Responding with 7CC7E5A580FB757C-00000000422FA9E5._matter._tcp.local
D: 39541 [DIS]Responding with F4CE36001DFE.local
D: 39545 [DIS]Responding with F4CE36001DFE.local
D: 39549 [DIS]Responding with _I7CC7E5A580FB757C._sub._matter._tcp.local
I: 39556 [DIS]CHIP minimal mDNS configured as 'Operational device'; instance name: 7CC7E5A580FB757C-00000000422FA9E5.
I: 39566 [DIS]mDNS service published: _matter._tcp
D: 39571 [DL]Using wifi MAC for hostname
I: 39574 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1
D: 39584 [DIS]Responding with _matterc._udp.local
D: 39588 [DIS]Responding with 50CB78FD3161FEEC._matterc._udp.local
D: 39594 [DIS]Responding with F4CE36001DFE.local
D: 39598 [DIS]Responding with F4CE36001DFE.local
D: 39603 [DIS]Responding with _V65521._sub._matterc._udp.local
D: 39608 [DIS]Responding with _S15._sub._matterc._udp.local
D: 39614 [DIS]Responding with _L3840._sub._matterc._udp.local
D: 39619 [DIS]Responding with _CM._sub._matterc._udp.local
D: 39625 [DIS]Responding with 50CB78FD3161FEEC._matterc._udp.local
I: 39631 [DIS]CHIP minimal mDNS configured as 'Commissionable node device'; instance name: 50CB78FD3161FEEC.
I: 39640 [DIS]mDNS service published: _matterc._udp
E: 39645 [ZCL]OpCreds: Got FailSafeTimerExpired
E: 39649 [ZCL]OpCreds: Proceeding to FailSafeCleanup on fail-safe expiry!
D: 39656 [IN]Expiring all sessions for fabric 0x1!!
E: 39660 [FP]Reverting pending fabric data for fabric 0x1
E: 39666 [FP]Warning: metadata not found during delete of fabric 0x1
I: 39675 [FP]Fabric (0x1) deleted.
I: 39678 [ZCL]OpCreds: Fabric index 0x1 was removed
I: 39683 [DIS]Updating services using commissioning mode 1
I: 39688 [DIS]CHIP minimal mDNS started advertising.
D: 39694 [DL]Using wifi MAC for hostname
I: 39697 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1
D: 39707 [DIS]Responding with _matterc._udp.local
D: 39711 [DIS]Responding with 50CB78FD3161FEEC._matterc._udp.local
D: 39717 [DIS]Responding with F4CE36001DFE.local
D: 39721 [DIS]Responding with F4CE36001DFE.local
D: 39726 [DIS]Responding with _V65521._sub._matterc._udp.local
D: 39731 [DIS]Responding with _S15._sub._matterc._udp.local
D: 39736 [DIS]Responding with _L3840._sub._matterc._udp.local
D: 39742 [DIS]Responding with _CM._sub._matterc._udp.local
D: 39747 [DIS]Responding with 50CB78FD3161FEEC._matterc._udp.local
I: 39753 [DIS]CHIP minimal mDNS configured as 'Commissionable node device'; instance name: 50CB78FD3161FEEC.
I: 39763 [DIS]mDNS service published: _matterc._udp
I: 39777 [TS]Pending Last Known Good Time: 2024-01-02T14:34:44
I: 39783 [TS]Previous Last Known Good Time: 2023-12-28T16:25:22
I: 39789 [TS]Reverted Last Known Good Time to previous value
E: 39794 [FP]Warning: metadata not found during delete of fabric 0x1
E: 39802 [ZCL]OpCreds: failed to delete fabric at index 1: d8
E: 39808 [DL]Long dispatch time: 361 ms, for event type 32782
I: 39813 [FS]Fail-safe cleanly disarmed
I: 39817 [DL]BLE GAP connection terminated (reason 0x16)
I: 39822 [DL]Current number of connections: 0/1
I: 39829 [DL]CHIPoBLE advertising started
I: 39833 [DL]NFC Tag emulation started
I: 40679 [TS]Pending Last Known Good Time: 2023-12-28T16:25:22
I: 40685 [TS]Previous Last Known Good Time: 2023-12-28T16:25:22
I: 40690 [TS]Reverted Last Known Good Time to previous value
I: 40696 [DL]Performing factory reset


uart:~$ *** Booting nRF Connect SDK v2.5.0 ***
I: Init CHIP stack
I: 152 [DL]BLE address: E3:2D:8F:61:9C:50
OK
D: 183 [DL]WiFiManager has been initialized
I: 187 [SVR]Subscription persistence not supported
I: 192 [SVR]Server initializing...
I: 195 [TS]Last Known Good Time: [unknown]
I: 199 [TS]Setting Last Known Good Time to firmware build time 2023-12-28T16:25:22
I: 207 [DMG]AccessControl: initializing
I: 211 [DMG]Examples::AccessControlDelegate::Init
I: 215 [DMG]AccessControl: setting
I: 218 [DMG]DefaultAclStorage: initializing
I: 222 [DMG]DefaultAclStorage: 0 entries loaded
D: 226 [IN]UDP::Init bind&listen port=5540
E: 230 [IN]SO_REUSEPORT failed: 109
D: 234 [IN]UDP::Init bound to port=5540
D: 237 [IN]BLEBase::Init - setting/overriding transport
D: 242 [IN]TransportMgr initialized
I: 248 [ZCL]Using ZAP configuration...
I: 254 [DMG]AccessControlCluster: initializing
D: 258 [DL]Boot reason: 6
I: 261 [ZCL]Initiating Admin Commissioning cluster.
I: 265 [ZCL]Endpoint 1 On/off already set to new value
I: 271 [ZCL]Cluster LevelControl: attribute CurrentLevel set to 1
D: 278 [IN]SecureSession[0x200041e0]: Allocated Type:1 LSID:15131
D: 284 [DL]CHIPoBLE advertising set to on
I: 287 [DIS]Updating services using commissioning mode 1
I: 293 [DIS]CHIP minimal mDNS started advertising.
D: 297 [DL]Using wifi MAC for hostname
I: 301 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1
D: 310 [DIS]Responding with _matterc._udp.local
D: 314 [DIS]Responding with F37AF31BAB74AD86._matterc._udp.local
D: 320 [DIS]Responding with F4CE36001DFE.local
D: 324 [DIS]Responding with F4CE36001DFE.local
D: 328 [DIS]Responding with _V65521._sub._matterc._udp.local
D: 334 [DIS]Responding with _S15._sub._matterc._udp.local
D: 339 [DIS]Responding with _L3840._sub._matterc._udp.local
D: 344 [DIS]Responding with _CM._sub._matterc._udp.local
D: 349 [DIS]Responding with F37AF31BAB74AD86._matterc._udp.local
I: 355 [DIS]CHIP minimal mDNS configured as 'Commissionable node device'; instance name: F37AF31BAB74AD86.
I: 365 [DIS]mDNS service published: _matterc._udp
I: 369 [DIS]Updating services using commissioning mode 1
I: 374 [DIS]CHIP minimal mDNS started advertising.
D: 379 [DL]Using wifi MAC for hostname
I: 382 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1
D: 391 [DIS]Responding with _matterc._udp.local
D: 396 [DIS]Responding with F37AF31BAB74AD86._matterc._udp.local
D: 401 [DIS]Responding with F4CE36001DFE.local
D: 406 [DIS]Responding with F4CE36001DFE.local
D: 410 [DIS]Responding with _V65521._sub._matterc._udp.local
D: 415 [DIS]Responding with _S15._sub._matterc._udp.local
D: 420 [DIS]Responding with _L3840._sub._matterc._udp.local
D: 426 [DIS]Responding with _CM._sub._matterc._udp.local
D: 431 [DIS]Responding with F37AF31BAB74AD86._matterc._udp.local
I: 437 [DIS]CHIP minimal mDNS configured as 'Commissionable node device'; instance name: F37AF31BAB74AD86.
I: 446 [DIS]mDNS service published: _matterc._udp
I: 450 [IN]CASE Server enabling CASE session setups
D: 455 [IN]SecureSession[0x20004298]: Allocated Type:2 LSID:15132
I: 461 [SVR]Joining Multicast groups
I: 465 [SVR]Server Listening...
I: 467 [DL]Device Configuration:
I: 470 [DL]  Serial Number: 11223344556677889900
I: 475 [DL]  Vendor Id: 65521 (0xFFF1)
I: 478 [DL]  Product Id: 32773 (0x8005)
I: 482 [DL]  Product Name: not-specified
I: 485 [DL]  Hardware Version: 0
I: 488 [DL]  Setup Pin Code (0 for UNKNOWN/ERROR): 20202021
I: 494 [DL]  Setup Discriminator (0xFFFF for UNKNOWN/ERROR): 3840 (0xF00)
I: 500 [DL]  Manufacturing Date: 2022-01-01
I: 504 [DL]  Device Type: 65535 (0xFFFF)
I: 508 [SVR]SetupQRCode: [MT:6FCJ142C00KA0648G00]
I: 512 [SVR]Copy/paste the below URL in a browser to see the QR Code:
I: 518 [SVR]https://project-chip.github.io/connectedhomeip/qrcode.html?data=MT%3A6FCJ142C00KA0648G00
I: 527 [SVR]Manual pairing code: [34970112332]
I: 532 [DL]CHIP task running
I: 538 [DL]CHIPoBLE advertising started
I: 543 [ZCL]Cluster OnOff: attribute OnOff set to 0
I: 547 [ZCL]Cluster LevelControl: attribute CurrentLevel set to 254
I: 553 [DL]NFC Tag emulation started
I: 30543 [DL]CHIPoBLE advertising mode changed to slow
I: 30551 [DL]CHIPoBLE advertising started

Vasilis

[Maria Gilje]

vorrias said:

First of all Happy New Year.

Happy new year!

vorrias said:

Do I ave to provide any password during the firmware flash?

You can with the Kconfig symbols CONFIG_WIFI_CREDENTIALS_STATIC, CONFIG_WIFI_CREDENTIALS_STATIC_PASSWORD and CONFIG_WIFI_CREDENTIALS_STATIC_SSID. If you don't provide the password statically, you can enter the SSID and password with shell commands. See the Wi-Fi Shell sample for how to use the shell.

The error in the log is 32 = CHIP_ERROR_TIMEOUT. The full list of error codes can be found here.

BR,

Maria

[vorrias]

Hi Maria
I did the following changes to Kconfig file:

config WIFI_CREDENTIALS_STATIC
    bool "Static Wi-Fi network configuration"

if WIFI_CREDENTIALS_STATIC

78 config WIFI_CREDENTIALS_STATIC_SSID
79    string "LAB1"

81 config WIFI_CREDENTIALS_STATIC_PASSWORD
82    string "Password of statically configured Wi-Fi network"
83    default "pasword"

Still reports Can't connect to LAB1
Do I have to correct the lines:?

config WIFI_CREDENTIALS_STATIC
    bool "Static Wi-Fi network configuration"

Still unable to commission (In both Home Assistant and Google Home)
I am attaching the commissioning log files for both Home Automation.
I really can't spot the problem

Fullscreen log file commissionning in ha.txt Download

I: Factory Reset Triggered. Release button within 3000ms to cancel.
I: 58044 [TS]Pending Last Known Good Time: 2024-01-16T17:23:49
I: 58050 [TS]Previous Last Known Good Time: 2024-01-16T17:23:49
I: 58056 [TS]Reverted Last Known Good Time to previous value
I: 58062 [DL]Performing factory reset


uart:~$ *** Booting nRF Connect SDK v2.5.1 ***
I: Init CHIP stack
I: 152 [DL]BLE address: F0:CF:25:9C:46:12
OK
D: 182 [DL]WiFiManager has been initialized
I: 187 [SVR]Subscription persistence not supported
I: 191 [SVR]Server initializing...
I: 194 [TS]Last Known Good Time: [unknown]
I: 198 [TS]Setting Last Known Good Time to firmware build time 2024-01-16T17:23:49
I: 207 [DMG]AccessControl: initializing
I: 210 [DMG]Examples::AccessControlDelegate::Init
I: 215 [DMG]AccessControl: setting
I: 218 [DMG]DefaultAclStorage: initializing
I: 222 [DMG]DefaultAclStorage: 0 entries loaded
D: 226 [IN]UDP::Init bind&listen port=5540
E: 230 [IN]SO_REUSEPORT failed: 109
D: 233 [IN]UDP::Init bound to port=5540
D: 236 [IN]BLEBase::Init - setting/overriding transport
D: 241 [IN]TransportMgr initialized
I: 248 [ZCL]Using ZAP configuration...
I: 253 [DMG]AccessControlCluster: initializing
D: 258 [DL]Boot reason: 6
I: 260 [ZCL]Initiating Admin Commissioning cluster.
I: 265 [ZCL]Endpoint 1 On/off already set to new value
I: 270 [ZCL]Cluster LevelControl: attribute CurrentLevel set to 1
D: 277 [IN]SecureSession[0x200041e0]: Allocated Type:1 LSID:41640
D: 283 [DL]CHIPoBLE advertising set to on
I: 287 [DIS]Updating services using commissioning mode 1
I: 292 [DIS]CHIP minimal mDNS started advertising.
D: 297 [DL]Using wifi MAC for hostname
I: 300 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1
D: 309 [DIS]Responding with _matterc._udp.local
D: 313 [DIS]Responding with 069A85E02BE0EE81._matterc._udp.local
D: 319 [DIS]Responding with F4CE36001DFE.local
D: 323 [DIS]Responding with F4CE36001DFE.local
D: 328 [DIS]Responding with _V65521._sub._matterc._udp.local
D: 333 [DIS]Responding with _S15._sub._matterc._udp.local
D: 338 [DIS]Responding with _L3840._sub._matterc._udp.local
D: 344 [DIS]Responding with _CM._sub._matterc._udp.local
D: 349 [DIS]Responding with 069A85E02BE0EE81._matterc._udp.local
I: 354 [DIS]CHIP minimal mDNS configured as 'Commissionable node device'; instance name: 069A85E02BE0EE81.
I: 364 [DIS]mDNS service published: _matterc._udp
I: 368 [DIS]Updating services using commissioning mode 1
I: 373 [DIS]CHIP minimal mDNS started advertising.
D: 378 [DL]Using wifi MAC for hostname
I: 382 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1
D: 391 [DIS]Responding with _matterc._udp.local
D: 395 [DIS]Responding with 069A85E02BE0EE81._matterc._udp.local
D: 401 [DIS]Responding with F4CE36001DFE.local
D: 405 [DIS]Responding with F4CE36001DFE.local
D: 409 [DIS]Responding with _V65521._sub._matterc._udp.local
D: 415 [DIS]Responding with _S15._sub._matterc._udp.local
D: 420 [DIS]Responding with _L3840._sub._matterc._udp.local
D: 425 [DIS]Responding with _CM._sub._matterc._udp.local
D: 430 [DIS]Responding with 069A85E02BE0EE81._matterc._udp.local
I: 436 [DIS]CHIP minimal mDNS configured as 'Commissionable node device'; instance name: 069A85E02BE0EE81.
I: 445 [DIS]mDNS service published: _matterc._udp
I: 450 [IN]CASE Server enabling CASE session setups
D: 455 [IN]SecureSession[0x20004298]: Allocated Type:2 LSID:41641
I: 461 [SVR]Joining Multicast groups
I: 464 [SVR]Server Listening...
I: 467 [DL]Device Configuration:
I: 470 [DL]  Serial Number: 11223344556677889900
I: 474 [DL]  Vendor Id: 65521 (0xFFF1)
I: 478 [DL]  Product Id: 32773 (0x8005)
I: 481 [DL]  Product Name: not-specified
I: 485 [DL]  Hardware Version: 0
I: 488 [DL]  Setup Pin Code (0 for UNKNOWN/ERROR): 20202021
I: 493 [DL]  Setup Discriminator (0xFFFF for UNKNOWN/ERROR): 3840 (0xF00)
I: 500 [DL]  Manufacturing Date: 2022-01-01
I: 503 [DL]  Device Type: 65535 (0xFFFF)
I: 507 [SVR]SetupQRCode: [MT:6FCJ142C00KA0648G00]
I: 512 [SVR]Copy/paste the below URL in a browser to see the QR Code:
I: 518 [SVR]https://project-chip.github.io/connectedhomeip/qrcode.html?data=MT%3A6FCJ142C00KA0648G00
I: 527 [SVR]Manual pairing code: [34970112332]
I: 531 [DL]CHIP task running
I: 538 [DL]CHIPoBLE advertising started
I: 542 [ZCL]Cluster OnOff: attribute OnOff set to 0
I: 547 [ZCL]Cluster LevelControl: attribute CurrentLevel set to 254
I: 553 [DL]NFC Tag emulation started
I: 12427 [DL]BLE connection established (ConnId: 0x00)
I: 12432 [DL]Current number of connections: 1/1
I: 12436 [DL]CHIPoBLE advertising stopped
I: 12440 [DL]NFC Tag emulation stopped
D: 13371 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 13379 [BLE]local and remote recv window sizes = 5
I: 13383 [BLE]selected BTP version 4
I: 13387 [BLE]using BTP fragment sizes rx 128 / tx 128.
D: 13392 [DL]ConnId: 0x00, New CCCD value: 0x0002
D: 13397 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6)
D: 13404 [IN]BLE EndPoint 0x2000ae00 Connection Complete
I: 13409 [DL]CHIPoBLE connection established (ConnId: 0x00, GATT MTU: 131)
D: 13500 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 13680 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 13688 [EM]>>> [E:13189r S:0 M:54730544] (U) Msg RX from 0:E121A0177141FF62 [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest)
I: 13701 [EM]<<< [E:13189r S:0 M:181269441] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:21 (SecureChannel:PBKDFParamResponse)
I: 13713 [IN](U) Sending msg 181269441 to IP address 'BLE'
D: 13718 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 13815 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 13823 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 14)
D: 13905 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 13913 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 13921 [EM]>>> [E:13189r S:0 M:54730545] (U) Msg RX from 0:E121A0177141FF62 [0000] --- Type 0000:22 (SecureChannel:PASE_Pake1)
I: 15290 [EM]<<< [E:13189r S:0 M:181269442] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:23 (SecureChannel:PASE_Pake2)
I: 15301 [IN](U) Sending msg 181269442 to IP address 'BLE'
D: 15306 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
E: 15314 [DL]Long dispatch time: 1401 ms, for event type 16388
D: 15434 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 15441 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6)
D: 15569 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 15577 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 15584 [EM]>>> [E:13189r S:0 M:54730546] (U) Msg RX from 0:E121A0177141FF62 [0000] --- Type 0000:24 (SecureChannel:PASE_Pake3)
I: 15596 [EM]<<< [E:13189r S:0 M:181269443] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:40 (SecureChannel:StatusReport)
I: 15608 [IN](U) Sending msg 181269443 to IP address 'BLE'
D: 15613 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 35)
I: 15621 [SC]SecureSession[0x200041e0]: Moving from state 'kEstablishing' --> 'kActive'
D: 15629 [IN]SecureSession[0x200041e0]: Activated - Type:1 LSID:41640
D: 15635 [IN]New secure session activated for device <FFFFFFFB00000000, 0>, LSID:41640 PSID:43697!
I: 15644 [SVR]Commissioning completed session establishment step
I: 15650 [DIS]Updating services using commissioning mode 0
I: 15655 [DIS]CHIP minimal mDNS started advertising.
D: 15660 [DL]CHIPoBLE advertising set to off
I: 15665 [SVR]Device completed Rendezvous process
D: 15704 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 15712 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 15720 [EM]>>> [E:13190r S:41640 M:78121246] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 15731 [IM]Received Read request
I: 15736 [EM]<<< [E:13190r S:41640 M:213702686] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 15746 [IN](S) Sending msg 213702686 on secure session with LSID: 41640
D: 15753 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 97)
D: 15839 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 15847 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 15855 [EM]>>> [E:13191r S:41640 M:78121247] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 15866 [IM]Received Read request
I: 15870 [EM]<<< [E:13191r S:41640 M:213702687] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 15881 [IN](S) Sending msg 213702687 on secure session with LSID: 41640
D: 15888 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72)
D: 15974 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 15982 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 15990 [EM]>>> [E:13192r S:41640 M:78121248] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 16001 [IM]Received Read request
I: 16005 [EM]<<< [E:13192r S:41640 M:213702688] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 16016 [IN](S) Sending msg 213702688 on secure session with LSID: 41640
D: 16022 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72)
D: 16109 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 16117 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 16125 [EM]>>> [E:13193r S:41640 M:78121249] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 16136 [IM]Received Read request
I: 16140 [EM]<<< [E:13193r S:41640 M:213702689] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 16151 [IN](S) Sending msg 213702689 on secure session with LSID: 41640
D: 16158 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72)
D: 16244 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 16252 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 16260 [EM]>>> [E:13194r S:41640 M:78121250] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 16271 [IM]Received Read request
I: 16275 [EM]<<< [E:13194r S:41640 M:213702690] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 16286 [IN](S) Sending msg 213702690 on secure session with LSID: 41640
D: 16293 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 16379 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 16387 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 16395 [EM]>>> [E:13195r S:41640 M:78121251] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 16406 [IM]Received Read request
I: 16410 [EM]<<< [E:13195r S:41640 M:213702691] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 16421 [IN](S) Sending msg 213702691 on secure session with LSID: 41640
D: 16427 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 16514 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 16522 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 16530 [EM]>>> [E:13196r S:41640 M:78121252] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 16541 [IM]Received Read request
I: 16546 [EM]<<< [E:13196r S:41640 M:213702692] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 16556 [IN](S) Sending msg 213702692 on secure session with LSID: 41640
D: 16563 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 97)
D: 16649 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 16657 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 16665 [EM]>>> [E:13197r S:41640 M:78121253] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 16676 [IM]Received Read request
I: 16680 [EM]<<< [E:13197r S:41640 M:213702693] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 16691 [IN](S) Sending msg 213702693 on secure session with LSID: 41640
D: 16698 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72)
D: 16784 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 16792 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 16800 [EM]>>> [E:13198r S:41640 M:78121254] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 16811 [IM]Received Read request
I: 16815 [EM]<<< [E:13198r S:41640 M:213702694] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 16826 [IN](S) Sending msg 213702694 on secure session with LSID: 41640
D: 16832 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 16919 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 17774 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 17782 [EM]>>> [E:13199r S:41640 M:78121255] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
I: 17794 [EM]<<< [E:13199r S:41640 M:213702695] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
I: 17805 [IN](S) Sending msg 213702695 on secure session with LSID: 41640
D: 17811 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 43)
D: 17909 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 17917 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 17925 [EM]>>> [E:13199r S:41640 M:78121256] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 17937 [FS]GeneralCommissioning: Received ArmFailSafe (120s)
I: 17944 [EM]<<< [E:13199r S:41640 M:213702696] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 17955 [IN](S) Sending msg 213702696 on secure session with LSID: 41640
D: 17962 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 18044 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 18052 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 18060 [EM]>>> [E:13200r S:41640 M:78121257] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 18071 [IM]Received Read request
I: 18075 [EM]<<< [E:13200r S:41640 M:213702697] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 18086 [IN](S) Sending msg 213702697 on secure session with LSID: 41640
D: 18093 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 18224 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 18232 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 18240 [EM]>>> [E:13201r S:41640 M:78121258] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
I: 18251 [EM]<<< [E:13201r S:41640 M:213702698] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
I: 18262 [IN](S) Sending msg 213702698 on secure session with LSID: 41640
D: 18269 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 43)
D: 18359 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 18367 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 18375 [EM]>>> [E:13201r S:41640 M:78121259] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 18390 [EM]<<< [E:13201r S:41640 M:213702699] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 18401 [IN](S) Sending msg 213702699 on secure session with LSID: 41640
D: 18408 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 18539 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 18547 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 18555 [EM]>>> [E:13202r S:41640 M:78121260] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 18567 [ZCL]OpCreds: Certificate Chain request received for DAC
I: 18576 [EM]<<< [E:13202r S:41640 M:213702700] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 18588 [IN](S) Sending msg 213702700 on secure session with LSID: 41640
D: 18594 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 18674 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 18682 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 18764 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 18772 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 18854 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 18862 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 18989 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 18997 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 19004 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 57)
D: 19079 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 19087 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 19095 [EM]>>> [E:13203r S:41640 M:78121261] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 19107 [ZCL]OpCreds: Certificate Chain request received for PAI
I: 19116 [EM]<<< [E:13203r S:41640 M:213702701] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 19128 [IN](S) Sending msg 213702701 on secure session with LSID: 41640
D: 19134 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 19214 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 19222 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 19304 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 19312 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 19394 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 19402 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 19484 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 19492 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 19499 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 28)
D: 19574 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 19582 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 19590 [EM]>>> [E:13204r S:41640 M:78121262] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 19602 [ZCL]OpCreds: Received an AttestationRequest command
I: 19637 [ZCL]OpCreds: AttestationRequest successful.
I: 19646 [EM]<<< [E:13204r S:41640 M:213702702] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 19658 [IN](S) Sending msg 213702702 on secure session with LSID: 41640
D: 19664 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 19754 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 19762 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 19844 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 19852 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 19934 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 19942 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 20024 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 20032 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 20039 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 20114 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 20122 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 92)
D: 20204 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 20212 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 20220 [EM]>>> [E:13205r S:41640 M:78121263] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 20232 [ZCL]OpCreds: Received a CSRRequest command
I: 20377 [ZCL]OpCreds: AllocatePendingOperationalKey succeeded
I: 20412 [ZCL]OpCreds: CSRRequest successful.
I: 20419 [EM]<<< [E:13205r S:41640 M:213702703] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 20430 [IN](S) Sending msg 213702703 on secure session with LSID: 41640
D: 20437 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
E: 20444 [DL]Long dispatch time: 232 ms, for event type 16388
D: 20519 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 20527 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 20609 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 20617 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 20699 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 21510 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 21600 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 21690 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 21699 [EM]>>> [E:13206r S:41640 M:78121264] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 21711 [ZCL]OpCreds: Received an AddTrustedRootCertificate command
I: 21770 [ZCL]OpCreds: AddTrustedRootCertificate successful.
I: 21776 [EM]<<< [E:13206r S:41640 M:213702704] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 21788 [IN](S) Sending msg 213702704 on secure session with LSID: 41640
D: 21795 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 68)
E: 21802 [DL]Long dispatch time: 112 ms, for event type 16388
D: 21869 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 21877 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 21960 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 22050 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 22139 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 22146 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
I: 22156 [EM]>>> [E:13207r S:41640 M:78121265] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 22168 [ZCL]OpCreds: Received an AddNOC command
I: 22175 [FP]Validating NOC chain
I: 22233 [FP]NOC chain validation successful
I: 22237 [FP]Added new fabric at index: 0x1
I: 22241 [FP]Assigned compressed fabric ID: 0x959848D4ABD510E9, node ID: 0x697FA623206985AE
I: 22249 [TS]Last Known Good Time: 2024-01-16T17:23:49
I: 22254 [TS]New proposed Last Known Good Time: 2024-01-09T00:00:00
I: 22260 [TS]Retaining current Last Known Good Time
I: 22272 [ZCL]OpCreds: ACL entry created for Fabric index 0x1 CASE Admin Subject 0xFFFFFFFD00010001
D: 22281 [DL]Using wifi MAC for hostname
I: 22285 [DIS]Advertise operational node 959848D4ABD510E9-697FA623206985AE
D: 22291 [DIS]Responding with _matter._tcp.local
D: 22296 [DIS]Responding with 959848D4ABD510E9-697FA623206985AE._matter._tcp.local
D: 22303 [DIS]Responding with 959848D4ABD510E9-697FA623206985AE._matter._tcp.local
D: 22310 [DIS]Responding with F4CE36001DFE.local
D: 22315 [DIS]Responding with F4CE36001DFE.local
D: 22319 [DIS]Responding with _I959848D4ABD510E9._sub._matter._tcp.local
I: 22326 [DIS]CHIP minimal mDNS configured as 'Operational device'; instance name: 959848D4ABD510E9-697FA623206985AE.
I: 22336 [DIS]mDNS service published: _matter._tcp
I: 22341 [ZCL]OpCreds: successfully created fabric index 0x1 via AddNOC
I: 22348 [EM]<<< [E:13207r S:41640 M:213702705] (S) Msg TX to 1:FFFFFFFB00000000 [10E9] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 22359 [IN](S) Sending msg 213702705 on secure session with LSID: 41640
E: 22366 [DL]Long dispatch time: 227 ms, for event type 16388
D: 22371 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 22379 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 70)
D: 22454 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 22462 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 22470 [EM]>>> [E:13208r S:41640 M:78121266] (S) Msg RX from 1:FFFFFFFB00000000 [10E9] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 22483 [EM]<<< [E:13208r S:41640 M:213702706] (S) Msg TX to 1:FFFFFFFB00000000 [10E9] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 22495 [IN](S) Sending msg 213702706 on secure session with LSID: 41640
D: 22501 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 22634 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 22642 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 22650 [EM]>>> [E:13209r S:41640 M:78121267] (S) Msg RX from 1:FFFFFFFB00000000 [10E9] --- Type 0001:02 (IM:ReadRequest)
D: 22661 [IM]Received Read request
I: 22665 [EM]<<< [E:13209r S:41640 M:213702707] (S) Msg TX to 1:FFFFFFFB00000000 [10E9] --- Type 0001:05 (IM:ReportData)
I: 22676 [IN](S) Sending msg 213702707 on secure session with LSID: 41640
D: 22682 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 22769 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 22777 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 22785 [EM]>>> [E:13210r S:41640 M:78121268] (S) Msg RX from 1:FFFFFFFB00000000 [10E9] --- Type 0001:08 (IM:InvokeCommandRequest)
D: 22797 [DL]Connecting to WiFi network: LAB1
D: 22804 [DL]WiFi scanning started...
D: 25284 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 25379 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
I: 27415 [DL]Wi-Fi scan done (0)
OK
OK
OK
OK
OK
E: 27427 [DL]Connection request failed -1
I: 27432 [EM]<<< [E:13210r S:41640 M:213702708] (S) Msg TX to 1:FFFFFFFB00000000 [10E9] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 27443 [IN](S) Sending msg 213702708 on secure session with LSID: 41640
D: 27450 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 70)
D: 27584 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 27592 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 27600 [EM]>>> [E:13211r S:41640 M:78121269] (S) Msg RX from 1:FFFFFFFB00000000 [10E9] --- Type 0001:0a (IM:TimedRequest)
I: 27611 [EM]<<< [E:13211r S:41640 M:213702709] (S) Msg TX to 1:FFFFFFFB00000000 [10E9] --- Type 0001:01 (IM:StatusResponse)
I: 27622 [IN](S) Sending msg 213702709 on secure session with LSID: 41640
D: 27629 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 43)
D: 27719 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 27727 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 27735 [EM]>>> [E:13211r S:41640 M:78121270] (S) Msg RX from 1:FFFFFFFB00000000 [10E9] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 27747 [FS]GeneralCommissioning: Received ArmFailSafe (1s)
I: 27754 [EM]<<< [E:13211r S:41640 M:213702710] (S) Msg TX to 1:FFFFFFFB00000000 [10E9] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 27765 [IN](S) Sending msg 213702710 on secure session with LSID: 41640
D: 27772 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 27854 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
I: 28752 [FS]Fail-safe timer expired
E: 28755 [SVR]Failsafe timer expired
D: 28758 [IN]SecureSession[0x200041e0]: MarkForEviction Type:1 LSID:41640
I: 28765 [SC]SecureSession[0x200041e0]: Moving from state 'kActive' --> 'kPendingEviction'
D: 28773 [IN]SecureSession[0x200041e0]: Released - Type:1 LSID:41640
E: 28779 [SVR]Commissioning failed (attempt 1): 32
D: 28783 [IN]Clearing BLE pending packets.
I: 28787 [BLE]Releasing end point's BLE connection back to application.
I: 28794 [DL]Closing BLE GATT connection (ConnId 00)
D: 28799 [IN]SecureSession[0x200041e0]: Allocated Type:1 LSID:41642
D: 28805 [DL]CHIPoBLE advertising set to on
I: 28809 [DIS]Updating services using commissioning mode 1
I: 28815 [DIS]CHIP minimal mDNS started advertising.
D: 28820 [DL]Using wifi MAC for hostname
I: 28823 [DIS]Advertise operational node 959848D4ABD510E9-697FA623206985AE
D: 28830 [DIS]Responding with _matter._tcp.local
D: 28834 [DIS]Responding with 959848D4ABD510E9-697FA623206985AE._matter._tcp.local
D: 28842 [DIS]Responding with 959848D4ABD510E9-697FA623206985AE._matter._tcp.local
D: 28849 [DIS]Responding with F4CE36001DFE.local
D: 28854 [DIS]Responding with F4CE36001DFE.local
D: 28858 [DIS]Responding with _I959848D4ABD510E9._sub._matter._tcp.local
I: 28864 [DIS]CHIP minimal mDNS configured as 'Operational device'; instance name: 959848D4ABD510E9-697FA623206985AE.
I: 28875 [DIS]mDNS service published: _matter._tcp
D: 28879 [DL]Using wifi MAC for hostname
I: 28883 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1
D: 28892 [DIS]Responding with _matterc._udp.local
D: 28897 [DIS]Responding with 069A85E02BE0EE81._matterc._udp.local
D: 28903 [DIS]Responding with F4CE36001DFE.local
D: 28907 [DIS]Responding with F4CE36001DFE.local
D: 28912 [DIS]Responding with _V65521._sub._matterc._udp.local
D: 28917 [DIS]Responding with _S15._sub._matterc._udp.local
D: 28922 [DIS]Responding with _L3840._sub._matterc._udp.local
D: 28928 [DIS]Responding with _CM._sub._matterc._udp.local
D: 28933 [DIS]Responding with 069A85E02BE0EE81._matterc._udp.local
I: 28939 [DIS]CHIP minimal mDNS configured as 'Commissionable node device'; instance name: 069A85E02BE0EE81.
I: 28949 [DIS]mDNS service published: _matterc._udp
E: 28953 [ZCL]OpCreds: Got FailSafeTimerExpired
E: 28958 [ZCL]OpCreds: Proceeding to FailSafeCleanup on fail-safe expiry!
D: 28964 [IN]Expiring all sessions for fabric 0x1!!
E: 28969 [FP]Reverting pending fabric data for fabric 0x1
E: 28974 [FP]Warning: metadata not found during delete of fabric 0x1
I: 28984 [FP]Fabric (0x1) deleted.
I: 28987 [ZCL]OpCreds: Fabric index 0x1 was removed
I: 28991 [DIS]Updating services using commissioning mode 1
I: 28997 [DIS]CHIP minimal mDNS started advertising.
D: 29002 [DL]Using wifi MAC for hostname
I: 29006 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1
D: 29015 [DIS]Responding with _matterc._udp.local
D: 29019 [DIS]Responding with 069A85E02BE0EE81._matterc._udp.local
D: 29025 [DIS]Responding with F4CE36001DFE.local
D: 29030 [DIS]Responding with F4CE36001DFE.local
D: 29034 [DIS]Responding with _V65521._sub._matterc._udp.local
D: 29040 [DIS]Responding with _S15._sub._matterc._udp.local
D: 29045 [DIS]Responding with _L3840._sub._matterc._udp.local
D: 29051 [DIS]Responding with _CM._sub._matterc._udp.local
D: 29056 [DIS]Responding with 069A85E02BE0EE81._matterc._udp.local
I: 29062 [DIS]CHIP minimal mDNS configured as 'Commissionable node device'; instance name: 069A85E02BE0EE81.
I: 29071 [DIS]mDNS service published: _matterc._udp
I: 29085 [TS]Pending Last Known Good Time: 2024-01-16T17:23:49
I: 29091 [TS]Previous Last Known Good Time: 2024-01-16T17:23:49
I: 29097 [TS]Reverted Last Known Good Time to previous value
E: 29103 [FP]Warning: metadata not found during delete of fabric 0x1
E: 29110 [ZCL]OpCreds: failed to delete fabric at index 1: d8
E: 29116 [DL]Long dispatch time: 361 ms, for event type 32782
I: 29121 [FS]Fail-safe cleanly disarmed
I: 29125 [DL]BLE GAP connection terminated (reason 0x16)
I: 29130 [DL]Current number of connections: 0/1
I: 29137 [DL]CHIPoBLE advertising started
I: 29141 [DL]NFC Tag emulation started
I: 29987 [TS]Pending Last Known Good Time: 2024-01-16T17:23:49
I: 29993 [TS]Previous Last Known Good Time: 2024-01-16T17:23:49
I: 29999 [TS]Reverted Last Known Good Time to previous value
I: 30004 [DL]Performing factory reset


uart:~$ *** Booting nRF Connect SDK v2.5.1 ***
I: Init CHIP stack
I: 152 [DL]BLE address: C3:4C:E6:59:06:4E
OK
D: 182 [DL]WiFiManager has been initialized
I: 187 [SVR]Subscription persistence not supported
I: 191 [SVR]Server initializing...
I: 194 [TS]Last Known Good Time: [unknown]
I: 198 [TS]Setting Last Known Good Time to firmware build time 2024-01-16T17:23:49
I: 207 [DMG]AccessControl: initializing
I: 210 [DMG]Examples::AccessControlDelegate::Init
I: 215 [DMG]AccessControl: setting
I: 218 [DMG]DefaultAclStorage: initializing
I: 222 [DMG]DefaultAclStorage: 0 entries loaded
D: 226 [IN]UDP::Init bind&listen port=5540
E: 230 [IN]SO_REUSEPORT failed: 109
D: 233 [IN]UDP::Init bound to port=5540
D: 236 [IN]BLEBase::Init - setting/overriding transport
D: 241 [IN]TransportMgr initialized
I: 248 [ZCL]Using ZAP configuration...
I: 253 [DMG]AccessControlCluster: initializing
D: 257 [DL]Boot reason: 6
I: 260 [ZCL]Initiating Admin Commissioning cluster.
I: 265 [ZCL]Endpoint 1 On/off already set to new value
I: 270 [ZCL]Cluster LevelControl: attribute CurrentLevel set to 1
D: 277 [IN]SecureSession[0x200041e0]: Allocated Type:1 LSID:9247
D: 283 [DL]CHIPoBLE advertising set to on
I: 287 [DIS]Updating services using commissioning mode 1
I: 292 [DIS]CHIP minimal mDNS started advertising.
D: 297 [DL]Using wifi MAC for hostname
I: 300 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1
D: 309 [DIS]Responding with _matterc._udp.local
D: 313 [DIS]Responding with BC75E38739EBDE9E._matterc._udp.local
D: 319 [DIS]Responding with F4CE36001DFE.local
D: 323 [DIS]Responding with F4CE36001DFE.local
D: 327 [DIS]Responding with _V65521._sub._matterc._udp.local
D: 333 [DIS]Responding with _S15._sub._matterc._udp.local
D: 338 [DIS]Responding with _L3840._sub._matterc._udp.local
D: 343 [DIS]Responding with _CM._sub._matterc._udp.local
D: 349 [DIS]Responding with BC75E38739EBDE9E._matterc._udp.local
I: 354 [DIS]CHIP minimal mDNS configured as 'Commissionable node device'; instance name: BC75E38739EBDE9E.
I: 364 [DIS]mDNS service published: _matterc._udp
I: 368 [DIS]Updating services using commissioning mode 1
I: 373 [DIS]CHIP minimal mDNS started advertising.
D: 378 [DL]Using wifi MAC for hostname
I: 382 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1
D: 391 [DIS]Responding with _matterc._udp.local
D: 395 [DIS]Responding with BC75E38739EBDE9E._matterc._udp.local
D: 401 [DIS]Responding with F4CE36001DFE.local
D: 405 [DIS]Responding with F4CE36001DFE.local
D: 409 [DIS]Responding with _V65521._sub._matterc._udp.local
D: 415 [DIS]Responding with _S15._sub._matterc._udp.local
D: 420 [DIS]Responding with _L3840._sub._matterc._udp.local
D: 425 [DIS]Responding with _CM._sub._matterc._udp.local
D: 430 [DIS]Responding with BC75E38739EBDE9E._matterc._udp.local
I: 436 [DIS]CHIP minimal mDNS configured as 'Commissionable node device'; instance name: BC75E38739EBDE9E.
I: 445 [DIS]mDNS service published: _matterc._udp
I: 450 [IN]CASE Server enabling CASE session setups
D: 455 [IN]SecureSession[0x20004298]: Allocated Type:2 LSID:9248
I: 460 [SVR]Joining Multicast groups
I: 464 [SVR]Server Listening...
I: 467 [DL]Device Configuration:
I: 470 [DL]  Serial Number: 11223344556677889900
I: 474 [DL]  Vendor Id: 65521 (0xFFF1)
I: 477 [DL]  Product Id: 32773 (0x8005)
I: 481 [DL]  Product Name: not-specified
I: 485 [DL]  Hardware Version: 0
I: 488 [DL]  Setup Pin Code (0 for UNKNOWN/ERROR): 20202021
I: 493 [DL]  Setup Discriminator (0xFFFF for UNKNOWN/ERROR): 3840 (0xF00)
I: 499 [DL]  Manufacturing Date: 2022-01-01
I: 503 [DL]  Device Type: 65535 (0xFFFF)
I: 507 [SVR]SetupQRCode: [MT:6FCJ142C00KA0648G00]
I: 511 [SVR]Copy/paste the below URL in a browser to see the QR Code:
I: 518 [SVR]https://project-chip.github.io/connectedhomeip/qrcode.html?data=MT%3A6FCJ142C00KA0648G00
I: 526 [SVR]Manual pairing code: [34970112332]
I: 531 [DL]CHIP task running
I: 537 [DL]CHIPoBLE advertising started
I: 542 [ZCL]Cluster OnOff: attribute OnOff set to 0
I: 547 [ZCL]Cluster LevelControl: attribute CurrentLevel set to 254
I: 553 [DL]NFC Tag emulation started
I: 30541 [DL]CHIPoBLE advertising mode changed to slow
I: 30549 [DL]CHIPoBLE advertising started

Fullscreen log file commissionning in google home.txt Download

I: 737222 [DL]BLE connection established (ConnId: 0x00)
I: 737227 [DL]Current number of connections: 1/1
I: 737232 [DL]CHIPoBLE advertising stopped
I: 737236 [DL]NFC Tag emulation stopped
D: 738156 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 738164 [BLE]local and remote recv window sizes = 5
I: 738168 [BLE]selected BTP version 4
I: 738172 [BLE]using BTP fragment sizes rx 128 / tx 128.
D: 738179 [DL]ConnId: 0x00, New CCCD value: 0x0002
D: 738183 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6)
D: 738191 [IN]BLE EndPoint 0x2000ae00 Connection Complete
I: 738196 [DL]CHIPoBLE connection established (ConnId: 0x00, GATT MTU: 131)
D: 738308 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 738488 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 738495 [EM]>>> [E:13212r S:0 M:54730547] (U) Msg RX from 0:3EB80429B74FAB13 [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest)
I: 738508 [EM]<<< [E:13212r S:0 M:260577999] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:21 (SecureChannel:PBKDFParamResponse)
I: 738520 [IN](U) Sending msg 260577999 to IP address 'BLE'
D: 738526 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 738623 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 738630 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 14)
D: 738713 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 738721 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 738728 [EM]>>> [E:13212r S:0 M:54730548] (U) Msg RX from 0:3EB80429B74FAB13 [0000] --- Type 0000:22 (SecureChannel:PASE_Pake1)
I: 740093 [EM]<<< [E:13212r S:0 M:260578000] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:23 (SecureChannel:PASE_Pake2)
I: 740105 [IN](U) Sending msg 260578000 to IP address 'BLE'
D: 740110 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
E: 740118 [DL]Long dispatch time: 1397 ms, for event type 16388
D: 740241 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 740249 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6)
D: 740331 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 740340 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 740347 [EM]>>> [E:13212r S:0 M:54730549] (U) Msg RX from 0:3EB80429B74FAB13 [0000] --- Type 0000:24 (SecureChannel:PASE_Pake3)
I: 740359 [EM]<<< [E:13212r S:0 M:260578001] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:40 (SecureChannel:StatusReport)
I: 740371 [IN](U) Sending msg 260578001 to IP address 'BLE'
D: 740376 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 35)
I: 740384 [SC]SecureSession[0x200041e0]: Moving from state 'kEstablishing' --> 'kActive'
D: 740392 [IN]SecureSession[0x200041e0]: Activated - Type:1 LSID:9247
D: 740398 [IN]New secure session activated for device <FFFFFFFB00000000, 0>, LSID:9247 PSID:43698!
I: 740407 [SVR]Commissioning completed session establishment step
I: 740413 [DIS]Updating services using commissioning mode 0
I: 740419 [DIS]CHIP minimal mDNS started advertising.
D: 740424 [DL]CHIPoBLE advertising set to off
I: 740428 [SVR]Device completed Rendezvous process
D: 740466 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 740475 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 740483 [EM]>>> [E:13213r S:9247 M:233238346] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 740493 [IM]Received Read request
I: 740498 [EM]<<< [E:13213r S:9247 M:246239065] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 740509 [IN](S) Sending msg 246239065 on secure session with LSID: 9247
D: 740516 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 97)
D: 740601 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 740610 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 740618 [EM]>>> [E:13214r S:9247 M:233238347] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 740628 [IM]Received Read request
I: 740633 [EM]<<< [E:13214r S:9247 M:246239066] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 740644 [IN](S) Sending msg 246239066 on secure session with LSID: 9247
D: 740650 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72)
D: 740736 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 740745 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 740753 [EM]>>> [E:13215r S:9247 M:233238348] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 740763 [IM]Received Read request
I: 740768 [EM]<<< [E:13215r S:9247 M:246239067] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 740779 [IN](S) Sending msg 246239067 on secure session with LSID: 9247
D: 740785 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72)
D: 740871 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 740880 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 740888 [EM]>>> [E:13216r S:9247 M:233238349] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 740898 [IM]Received Read request
I: 740903 [EM]<<< [E:13216r S:9247 M:246239068] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 740914 [IN](S) Sending msg 246239068 on secure session with LSID: 9247
D: 740920 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72)
D: 741006 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 741015 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 741023 [EM]>>> [E:13217r S:9247 M:233238350] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 741033 [IM]Received Read request
I: 741038 [EM]<<< [E:13217r S:9247 M:246239069] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 741049 [IN](S) Sending msg 246239069 on secure session with LSID: 9247
D: 741055 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 741141 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 741150 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 741158 [EM]>>> [E:13218r S:9247 M:233238351] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 741168 [IM]Received Read request
I: 741173 [EM]<<< [E:13218r S:9247 M:246239070] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 741184 [IN](S) Sending msg 246239070 on secure session with LSID: 9247
D: 741190 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 741276 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 741285 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 741293 [EM]>>> [E:13219r S:9247 M:233238352] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 741303 [IM]Received Read request
I: 741308 [EM]<<< [E:13219r S:9247 M:246239071] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 741319 [IN](S) Sending msg 246239071 on secure session with LSID: 9247
D: 741326 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 97)
D: 741411 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 741420 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 741428 [EM]>>> [E:13220r S:9247 M:233238353] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 741438 [IM]Received Read request
I: 741443 [EM]<<< [E:13220r S:9247 M:246239072] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 741454 [IN](S) Sending msg 246239072 on secure session with LSID: 9247
D: 741460 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72)
D: 741546 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 741555 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 741563 [EM]>>> [E:13221r S:9247 M:233238354] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 741573 [IM]Received Read request
I: 741578 [EM]<<< [E:13221r S:9247 M:246239073] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 741589 [IN](S) Sending msg 246239073 on secure session with LSID: 9247
D: 741595 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 741681 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 742087 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 742095 [EM]>>> [E:13222r S:9247 M:233238355] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
I: 742106 [EM]<<< [E:13222r S:9247 M:246239074] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
I: 742117 [IN](S) Sending msg 246239074 on secure session with LSID: 9247
D: 742124 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 43)
D: 742221 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 742230 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 742238 [EM]>>> [E:13222r S:9247 M:233238356] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 742250 [FS]GeneralCommissioning: Received ArmFailSafe (120s)
I: 742256 [EM]<<< [E:13222r S:9247 M:246239075] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 742268 [IN](S) Sending msg 246239075 on secure session with LSID: 9247
D: 742275 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 742356 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 742365 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 742373 [EM]>>> [E:13223r S:9247 M:233238357] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 742383 [IM]Received Read request
I: 742388 [EM]<<< [E:13223r S:9247 M:246239076] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 742399 [IN](S) Sending msg 246239076 on secure session with LSID: 9247
D: 742405 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 742491 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 742500 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 742507 [EM]>>> [E:13224r S:9247 M:233238358] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
I: 742519 [EM]<<< [E:13224r S:9247 M:246239077] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
I: 742530 [IN](S) Sending msg 246239077 on secure session with LSID: 9247
D: 742537 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 43)
D: 742671 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 742680 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 742688 [EM]>>> [E:13224r S:9247 M:233238359] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 742703 [EM]<<< [E:13224r S:9247 M:246239078] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 742714 [IN](S) Sending msg 246239078 on secure session with LSID: 9247
D: 742721 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 742806 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 742815 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 742823 [EM]>>> [E:13225r S:9247 M:233238360] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 742835 [ZCL]OpCreds: Certificate Chain request received for DAC
I: 742844 [EM]<<< [E:13225r S:9247 M:246239079] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 742856 [IN](S) Sending msg 246239079 on secure session with LSID: 9247
D: 742862 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 742941 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 742949 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 743032 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 743039 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 743122 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 743129 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 743212 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 743220 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 743227 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 57)
D: 743301 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 743310 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 743318 [EM]>>> [E:13226r S:9247 M:233238361] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 743330 [ZCL]OpCreds: Certificate Chain request received for PAI
I: 743339 [EM]<<< [E:13226r S:9247 M:246239080] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 743350 [IN](S) Sending msg 246239080 on secure session with LSID: 9247
D: 743357 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 743436 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 743444 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 743526 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 743534 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 743616 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 743624 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 743707 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 743715 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 743722 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 28)
D: 743886 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 743895 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 743903 [EM]>>> [E:13227r S:9247 M:233238362] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 743915 [ZCL]OpCreds: Received an AttestationRequest command
I: 743950 [ZCL]OpCreds: AttestationRequest successful.
I: 743959 [EM]<<< [E:13227r S:9247 M:246239081] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 743971 [IN](S) Sending msg 246239081 on secure session with LSID: 9247
D: 743977 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 744066 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 744074 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 744156 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 744164 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 744246 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 744254 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 744337 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 744345 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 744352 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 744426 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 744434 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 92)
D: 744516 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 744525 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 744533 [EM]>>> [E:13228r S:9247 M:233238363] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 744545 [ZCL]OpCreds: Received a CSRRequest command
I: 744692 [ZCL]OpCreds: AllocatePendingOperationalKey succeeded
I: 744727 [ZCL]OpCreds: CSRRequest successful.
I: 744733 [EM]<<< [E:13228r S:9247 M:246239082] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 744745 [IN](S) Sending msg 246239082 on secure session with LSID: 9247
D: 744751 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
E: 744759 [DL]Long dispatch time: 235 ms, for event type 16388
D: 744832 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 744839 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 744922 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 744929 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 745011 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 747351 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 749859 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 749961 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 752481 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 754989 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 755091 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 757611 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 760119 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 760221 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 762786 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 765294 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 765396 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 767917 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 770424 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 770526 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 773047 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 774532 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 774540 [EM]>>> [E:13229r S:9247 M:233238364] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:0a (IM:TimedRequest)
I: 774551 [EM]<<< [E:13229r S:9247 M:246239083] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:01 (IM:StatusResponse)
I: 774562 [IN](S) Sending msg 246239083 on secure session with LSID: 9247
D: 774569 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 43)
D: 774667 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 774675 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 774683 [EM]>>> [E:13229r S:9247 M:233238365] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest)
I: 774695 [FS]GeneralCommissioning: Received ArmFailSafe (1s)
I: 774701 [EM]<<< [E:13229r S:9247 M:246239084] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse)
I: 774713 [IN](S) Sending msg 246239084 on secure session with LSID: 9247
D: 774720 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71)
D: 774802 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
I: 775701 [FS]Fail-safe timer expired
E: 775704 [SVR]Failsafe timer expired
D: 775707 [IN]SecureSession[0x200041e0]: MarkForEviction Type:1 LSID:9247
I: 775714 [SC]SecureSession[0x200041e0]: Moving from state 'kActive' --> 'kPendingEviction'
D: 775722 [IN]SecureSession[0x200041e0]: Released - Type:1 LSID:9247
E: 775728 [SVR]Commissioning failed (attempt 1): 32
D: 775733 [IN]Clearing BLE pending packets.
I: 775737 [BLE]Releasing end point's BLE connection back to application.
I: 775743 [DL]Closing BLE GATT connection (ConnId 00)
D: 775749 [IN]SecureSession[0x200041e0]: Allocated Type:1 LSID:9249
D: 775755 [DL]CHIPoBLE advertising set to on
I: 775759 [DIS]Updating services using commissioning mode 1
I: 775764 [DIS]CHIP minimal mDNS started advertising.
D: 775769 [DL]Using wifi MAC for hostname
I: 775773 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1
D: 775782 [DIS]Responding with _matterc._udp.local
D: 775787 [DIS]Responding with BC75E38739EBDE9E._matterc._udp.local
D: 775793 [DIS]Responding with F4CE36001DFE.local
D: 775797 [DIS]Responding with F4CE36001DFE.local
D: 775802 [DIS]Responding with _V65521._sub._matterc._udp.local
D: 775807 [DIS]Responding with _S15._sub._matterc._udp.local
D: 775813 [DIS]Responding with _L3840._sub._matterc._udp.local
D: 775818 [DIS]Responding with _CM._sub._matterc._udp.local
D: 775824 [DIS]Responding with BC75E38739EBDE9E._matterc._udp.local
I: 775830 [DIS]CHIP minimal mDNS configured as 'Commissionable node device'; instance name: BC75E38739EBDE9E.
I: 775840 [DIS]mDNS service published: _matterc._udp
E: 775844 [ZCL]OpCreds: Got FailSafeTimerExpired
E: 775849 [ZCL]OpCreds: Proceeding to FailSafeCleanup on fail-safe expiry!
I: 775856 [TS]Pending Last Known Good Time: 2024-01-16T17:23:49
I: 775861 [TS]Previous Last Known Good Time: 2024-01-16T17:23:49
I: 775867 [TS]Reverted Last Known Good Time to previous value
E: 775873 [DL]Long dispatch time: 169 ms, for event type 32782
I: 775878 [FS]Fail-safe cleanly disarmed
I: 775882 [DL]BLE GAP connection terminated (reason 0x16)
I: 775887 [DL]Current number of connections: 0/1
I: 775895 [DL]CHIPoBLE advertising started
I: 775898 [DL]NFC Tag emulation started
I: 805898 [DL]CHIPoBLE advertising mode changed to slow
I: 805907 [DL]CHIPoBLE advertising started

[Maria Gilje]

I was unclear in my last reply. Sorry about that.

The way you use the Kconfig symbols is to add them to prj.conf of your project. In your case you would add these lines to prj.conf:

CONFIG_WIFI_CREDENTIALS_STATIC=y

CONFIG_WIFI_CREDENTIALS_STATIC_SSID="LAB1"

CONFIG_WIFI_CREDENTIALS_STATIC_PASSWORD="pasword"

Changing Kconfig files outside of project directories is not advised. This can impact other projects, applications and samples and make them unpredictable. If you want to change how the Kconfig symbols is defined for your project you can make a Kconfig.defaults file in your project directory or redefine the Kconfig symbols in a Kconfig in your project directory. For examples on how this is done, you can take a look at the applications in ncs/nrf/applications.

Best regards,

Maria

[vorrias]

OK Maria,
Still not able to commission.
That is what I did:
1 - wifi_credentials/Kconfig in original state.
2 - add lines into prj.conf file:

CONFIG_WIFI_CREDENTIALS_STATIC=y

CONFIG_WIFI_CREDENTIALS_STATIC_SSID="LAB2"

CONFIG_WIFI_CREDENTIALS_STATIC_PASSWORD="password"

LAB2 is a closer hot spot with stronger signal
Smartphone also connected to LAB2
3 - Rebuild the nrf7002dk_nrf5340_cpuapp board
4 - In ACTIONS:
Build
Flash

I am sending bot commissioning GH and HA
The procedure goes well registering the device. Only final sate when connecting to Network fails.
On that stage LED is solid ON. Then after failure drops into commissioning mode
In Google Home message final message is :

"Something went wrong
Make sure you are connected to your network and try again"

In Home Assistant
"Can't connect to your device
Check your device instructions"


I don't know if it matters but in PROBLEMS tab I see a message No such file or directory".....
see image. Is this a problem?

Is that so difficult tro do? Looks a detailed is missing
Is anybody in Nodric did that?
Please advise me. I am stacked
Regards
Vasilis

Fullscreen 0435.log file commissionning in google home.txt Download

I: 30542 [DL]CHIPoBLE advertising mode changed to slow
I: 30550 [DL]CHIPoBLE advertising started
I: 41379 [DL]BLE connection established (ConnId: 0x00)
I: 41384 [DL]Current number of connections: 1/1
I: 41389 [DL]CHIPoBLE advertising stopped
I: 41392 [DL]NFC Tag emulation stopped
D: 42325 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 42332 [BLE]local and remote recv window sizes = 5
I: 42336 [BLE]selected BTP version 4
I: 42340 [BLE]using BTP fragment sizes rx 128 / tx 128.
D: 42347 [DL]ConnId: 0x00, New CCCD value: 0x0002
D: 42352 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6)
D: 42359 [IN]BLE EndPoint 0x2000ae00 Connection Complete
I: 42364 [DL]CHIPoBLE connection established (ConnId: 0x00, GATT MTU: 131)
D: 42491 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 42626 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 42634 [EM]>>> [E:58343r S:0 M:130127054] (U) Msg RX from 0:A830FE246DEFFF81 [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest)
I: 42647 [EM]<<< [E:58343r S:0 M:53953585] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:21 (SecureChannel:PBKDFParamResponse)
I: 42658 [IN](U) Sending msg 53953585 to IP address 'BLE'
D: 42664 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 42761 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 42768 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 14)
D: 42851 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 42859 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 42866 [EM]>>> [E:58343r S:0 M:130127055] (U) Msg RX from 0:A830FE246DEFFF81 [0000] --- Type 0000:22 (SecureChannel:PASE_Pake1)
I: 44235 [EM]<<< [E:58343r S:0 M:53953586] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:23 (SecureChannel:PASE_Pake2)
I: 44246 [IN](U) Sending msg 53953586 to IP address 'BLE'
D: 44251 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
E: 44259 [DL]Long dispatch time: 1400 ms, for event type 16388
D: 44379 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 44387 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6)
D: 44469 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 44478 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 44485 [EM]>>> [E:58343r S:0 M:130127056] (U) Msg RX from 0:A830FE246DEFFF81 [0000] --- Type 0000:24 (SecureChannel:PASE_Pake3)
I: 44497 [EM]<<< [E:58343r S:0 M:53953587] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:40 (SecureChannel:StatusReport)
I: 44508 [IN](U) Sending msg 53953587 to IP address 'BLE'
D: 44513 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 35)
I: 44522 [SC]SecureSession[0x200041e0]: Moving from state 'kEstablishing' --> 'kActive'
D: 44530 [IN]SecureSession[0x200041e0]: Activated - Type:1 LSID:62092
D: 44536 [IN]New secure session activated for device <FFFFFFFB00000000, 0>, LSID:62092 PSID:60093!
I: 44544 [SVR]Commissioning completed session establishment step
I: 44550 [DIS]Updating services using commissioning mode 0
I: 44556 [DIS]CHIP minimal mDNS started advertising.
D: 44561 [DL]CHIPoBLE advertising set to off
I: 44565 [SVR]Device completed Rendezvous process
D: 44604 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 44613 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 44621 [EM]>>> [E:58344r S:62092 M:260939178] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest)
D: 44631 [IM]Received Read request
I: 44636 [EM]<<< [E:58344r S:62092 M:173049266] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData)
I: 44647 [IN](S) Sending msg 173049266 on secure session with LSID: 62092
D: 44653 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 97)
D: 44740 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 47260 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 49767 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 49914 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 52480 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 54987 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 55089 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 57610 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 60117 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 60175 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 62740 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 65247 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 65350 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 67870 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 70377 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 70435 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 73000 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
D: 75507 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3)
D: 75610 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
I: 76600 [DL]BLE GAP connection terminated (reason 0x13)
D: 76605 [IN]Clearing BLE pending packets.
I: 76609 [DL]Current number of connections: 0/1
I: 104565 [FS]Fail-safe timer expired
E: 104569 [SVR]Failsafe timer expired
D: 104572 [IN]SecureSession[0x200041e0]: MarkForEviction Type:1 LSID:62092
I: 104579 [SC]SecureSession[0x200041e0]: Moving from state 'kActive' --> 'kPendingEviction'
D: 104587 [IN]SecureSession[0x200041e0]: Released - Type:1 LSID:62092
E: 104593 [SVR]Commissioning failed (attempt 1): 32
D: 104598 [IN]SecureSession[0x200041e0]: Allocated Type:1 LSID:62094
D: 104604 [DL]CHIPoBLE advertising set to on
I: 104608 [DIS]Updating services using commissioning mode 1
I: 104613 [DIS]CHIP minimal mDNS started advertising.
D: 104618 [DL]Using wifi MAC for hostname
I: 104622 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1
D: 104631 [DIS]Responding with _matterc._udp.local
D: 104636 [DIS]Responding with 10401FF08571A2FC._matterc._udp.local
D: 104642 [DIS]Responding with F4CE36001DFE.local
D: 104646 [DIS]Responding with F4CE36001DFE.local
D: 104651 [DIS]Responding with _V65521._sub._matterc._udp.local
D: 104656 [DIS]Responding with _S15._sub._matterc._udp.local
D: 104662 [DIS]Responding with _L3840._sub._matterc._udp.local
D: 104667 [DIS]Responding with _CM._sub._matterc._udp.local
D: 104673 [DIS]Responding with 10401FF08571A2FC._matterc._udp.local
I: 104679 [DIS]CHIP minimal mDNS configured as 'Commissionable node device'; instance name: 10401FF08571A2FC.
I: 104689 [DIS]mDNS service published: _matterc._udp
E: 104693 [ZCL]OpCreds: Got FailSafeTimerExpired
E: 104697 [ZCL]OpCreds: Proceeding to FailSafeCleanup on fail-safe expiry!
I: 104704 [TS]Pending Last Known Good Time: 2024-01-18T14:54:43
I: 104710 [TS]Previous Last Known Good Time: 2024-01-18T14:54:43
I: 104716 [TS]Reverted Last Known Good Time to previous value
E: 104721 [DL]Long dispatch time: 152 ms, for event type 32782
I: 104727 [FS]Fail-safe cleanly disarmed
I: 104733 [DL]CHIPoBLE advertising started
I: 104737 [DL]NFC Tag emulation started

Fullscreen 5226.log file commissionning in ha.txt Download

I: 224970 [DL]BLE connection established (ConnId: 0x00)
I: 224975 [DL]Current number of connections: 1/1
I: 224980 [DL]CHIPoBLE advertising stopped
I: 224983 [DL]NFC Tag emulation stopped
D: 225926 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 225933 [BLE]local and remote recv window sizes = 5
I: 225938 [BLE]selected BTP version 4
I: 225941 [BLE]using BTP fragment sizes rx 128 / tx 128.
D: 225948 [DL]ConnId: 0x00, New CCCD value: 0x0002
D: 225953 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6)
D: 225960 [IN]BLE EndPoint 0x2000ae00 Connection Complete
I: 225966 [DL]CHIPoBLE connection established (ConnId: 0x00, GATT MTU: 131)
D: 226092 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 226227 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 226235 [EM]>>> [E:58346r S:0 M:130127058] (U) Msg RX from 0:653972D48721474E [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest)
I: 226248 [EM]<<< [E:58346r S:0 M:53953588] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:21 (SecureChannel:PBKDFParamResponse)
I: 226260 [IN](U) Sending msg 53953588 to IP address 'BLE'
D: 226265 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
D: 226362 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 226370 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 14)
D: 226452 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00)
D: 226460 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00)
I: 226468 [EM]>>> [E:58346r S:0 M:130127059] (U) Msg RX from 0:653972D48721474E [0000] --- Type 0000:22 (SecureChannel:PASE_Pake1)
I: 227833 [EM]<<< [E:58346r S:0 M:53953589] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:23 (SecureChannel:PASE_Pake2)
I: 227844 [IN](U) Sending msg 53953589 to IP address 'BLE'
D: 227849 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128)
E: 227857 [DL]Long dispatch time: 1397 ms, for event type 16388
D: 241571 [DL]ConnId: 0x00, New CCCD value: 0x0000
D: 241575 [IN]Clearing BLE pending packets.
I: 241579 [BLE]Releasing end point's BLE connection back to application.
I: 241585 [DL]Closing BLE GATT connection (ConnId 00)
D: 241706 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x0e)
E: 241713 [BLE]no endpoint for BLE sent data ack
I: 241718 [DL]BLE GAP connection terminated (reason 0x16)
I: 241723 [DL]Current number of connections: 0/1
I: 241730 [DL]CHIPoBLE advertising started
I: 241734 [DL]NFC Tag emulation started
I: 271735 [DL]CHIPoBLE advertising mode changed to slow
I: 271743 [DL]CHIPoBLE advertising started
E: 272833 [SC]PASESession timed out while waiting for a response from the peer. Expected message type was 36
D: 272843 [IN]SecureSession[0x200041e0]: Released - Type:1 LSID:62094
E: 272849 [SVR]Commissioning failed (attempt 2): 32
D: 272854 [IN]SecureSession[0x200041e0]: Allocated Type:1 LSID:62095
I: 272860 [DIS]Updating services using commissioning mode 1
I: 272865 [DIS]CHIP minimal mDNS started advertising.
D: 272871 [DL]Using wifi MAC for hostname
I: 272874 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1
D: 272884 [DIS]Responding with _matterc._udp.local
D: 272888 [DIS]Responding with 10401FF08571A2FC._matterc._udp.local
D: 272894 [DIS]Responding with F4CE36001DFE.local
D: 272899 [DIS]Responding with F4CE36001DFE.local
D: 272903 [DIS]Responding with _V65521._sub._matterc._udp.local
D: 272909 [DIS]Responding with _S15._sub._matterc._udp.local
D: 272914 [DIS]Responding with _L3840._sub._matterc._udp.local
D: 272920 [DIS]Responding with _CM._sub._matterc._udp.local
D: 272925 [DIS]Responding with 10401FF08571A2FC._matterc._udp.local
I: 272931 [DIS]CHIP minimal mDNS configured as 'Commissionable node device'; instance name: 10401FF08571A2FC.
I: 272941 [DIS]mDNS service published: _matterc._udp

[Maria Gilje]

Hi Vasilis,

vorrias said:

I am sending bot commissioning GH and HA
The procedure goes well registering the device. Only final sate when connecting to Network fails.
On that stage LED is solid ON.

Which LED is solid ON? This is OK if it is LED2, based on the User Interface overview.

Here are a couple of things you can test if you don't have already:

• Make sure that the light bulb device is factory reset before starting the commissioning process.
• Erase and flash the device to make sure that there are nothing outdated on the device causing issues.
• Follow the Testing and Commissioning instructions for the light bulb sample.
• Connect the DK to a terminal to see its logging output.

Best regards,

Maria