I: nRF5 802154 radio initialized
I: 8 Sectors of 4096 bytes
I: alloc wra: 0, c88
I: data wra: 0, 8e4
*** Booting Zephyr OS build v2.7.99-ncs1-1  ***
I: Init CHIP stack


uaI: 233 [DL]BLE address: E1:1A:F3:88:76:8B
I: SoftDevice Controller build revision:
I: 0e e7 c5 66 67 18 3c ac |...fg.<.
I: b3 d2 cc 81 a3 dc f1 c0 |........
I: c0 36 02 22             |.6."
rt:~$ I: Starting CHIP task
I: Init Thread stack
I: 265 [DL]OpenThread started: OK
I: 269 [DL]Setting OpenThread device type to MINIMAL END DEVICE
I: 275 [ZCL]Using ZAP configuration...
D: 281 [DMG]Failed to read stored attribute (0, 0x0000_002B, 0x0000_0001: a0
D: 291 [DMG]Failed to read stored attribute (0, 0x0000_002C, 0x0000_0000: a0
I: 300 [SVR]Retrieved from server storage: a/0/2c/1
I: 309 [ZCL]Initiating Admin Commissioning cluster.
I: 314 [ZCL]OpCreds: Initiating OpCreds cluster by writing fabrics list from fabric table.
D: 322 [DIS]Set the fabric pairing table delegate
E: 336 [ZCL]Trying to write invalid Calendar Type
D: 352 [DIS]Init fabric pairing table with server storage
D: 370 [IN]UDP::Init bind&listen port=5540
D: 374 [IN]UDP::Init bound to port=5540
D: 377 [IN]TransportMgr initialized
D: 419 [SC]Assigned local session key ID 1
D: 422 [SC]Waiting for PBKDF param request
D: 426 [DL]CHIPoBLE advertising set to on
D: 430 [DIS]DNS-SD StartServer modeHasValue=1 modeValue=1
D: 435 [DL]Using Thread extended MAC for hostname.
I: 440 [DIS]Failed to find a valid admin pairing. Node ID unknown
I: 446 [DIS]Start dns-sd server - no current nodeId
D: 451 [DL]Using Thread extended MAC for hostname.
I: 457 [DIS]Advertise commission parameter vendorID=9050 productID=20052 discriminator=3840/15
E: 466 [DIS]Failed to advertise unprovisioned commissionable node: Error CHIP:0x00000003
D: 474 [DIS]Scheduling Discovery timeout in secs=900
E: 479 [DIS]Failed to finalize service update: Error CHIP:0x0000001C
D: 485 [DIS]DNS-SD StartServer modeHasValue=0 modeValue=0
D: 490 [DL]Using Thread extended MAC for hostname.
I: 495 [DIS]Failed to find a valid admin pairing. Node ID unknown
I: 501 [DIS]Start dns-sd server - no current nodeId
D: 505 [DL]Using Thread extended MAC for hostname.
I: 512 [DIS]Advertise commission parameter vendorID=9050 productID=20052 discriminator=3840/15
E: 521 [DIS]Failed to advertise unprovisioned commissionable node: Error CHIP:0x00000003
D: 529 [DIS]Scheduling Discovery timeout in secs=900
E: 533 [DIS]Failed to finalize service update: Error CHIP:0x0000001C
I: 539 [IN]CASE Server enabling CASE session setups
D: 544 [DL]Using Thread extended MAC for hostname.
I: 549 [SVR]Server Listening...
I: 552 [DL]Device Configuration:
I: 557 [DL]  Serial Number: TEST_SN
I: 560 [DL]  Vendor Id: 9050 (0x235A)
I: 564 [DL]  Product Id: 20052 (0x4E54)
I: 569 [DL]  Hardware Version: 0
I: 575 [DL]  Setup Pin Code: 20202021
I: 580 [DL]  Setup Discriminator: 3840 (0xF00)
I: 587 [DL]  Manufacturing Date: (not set)
I: 591 [DL]  Device Type: 65535 (0xFFFF)
I: 599 [SVR]SetupQRCode: [MT:CSF25OTB00KA0648G00]
I: 603 [SVR]Copy/paste the below URL in a browser to see the QR Code:
    https://dhrishi.github.io/connectedhomeip/qrcode.html?data=MT%3ACSF25OTB00KA0648G00
I: 622 [SVR]Manual pairing code: [34970112332]
I: 631 [SVR]Long manual pairing code: [749701123309050200520]
D: 636 [DL]CHIP task running
I: 645 [DL]CHIPoBLE advertising started
I: 649 [ZCL]GeneralDiagnosticsDelegate: OnDeviceRebooted
I: 14154 [DL]BLE connection established (ConnId: 0x00)
I: 14159 [DL]Current number of connections: 1/1
I: 14164 [DL]CHIPoBLE advertising stopped
D: 15183 [DL]Write request received for CHIPoBLE RX (ConnId 0x00)
I: 15189 [BLE]local and remote recv window sizes = 5
I: 15194 [BLE]selected BTP version 4
I: 15197 [BLE]using BTP fragment sizes rx 244 / tx 244.
D: 15274 [DL]ConnId: 0x00, New CCCD value: 0x0001
D: 15278 [DL]Sending notification for CHIPoBLE TX (ConnId 00, len 6)
D: 15284 [IN]BLE EndPoint 0x20007588 Connection Complete
I: 15290 [DL]CHIPoBLE connection established (ConnId: 0x00, GATT MTU: 247)
D: 15454 [DL]Notification for CHIPoBLE TX done (ConnId 0x00)
D: 15459 [DL]Write request received for CHIPoBLE RX (ConnId 0x00)
I: 15465 [EM]Received message of type 0x20 with protocolId (0, 0) and MessageCounter:3702871344 on exchange 36516r
D: 15476 [EM]Handling via exchange: 36516r, Delegate: 0x20004f30
D: 15481 [SC]Received PBKDF param request
D: 15485 [SC]Peer assigned session ID 699
D: 15489 [SC]Found MRP parameters in the message
D: 15493 [SC]Including MRP parameters in PBKDF param response
I: 15722 [IN]Prepared unauthenticated message 0x20027950 to 0x0000000000000000 (0)  of type 0x21 and protocolId (0, 0) on exchange 36516r with MessageCounter:3298953600.
I: 15737 [IN]Sending unauthenticated msg 0x20027950 with MessageCounter:3298953600 to 0x0000000000000000 at monotonic time: 15737 msec
D: 15749 [DL]Sending notification for CHIPoBLE TX (ConnId 00, len 130)
D: 15755 [SC]Sent PBKDF param response
E: 15759 [DL]Long dispatch time: 300 ms, for event type 16388
D: 15813 [DL]Notification for CHIPoBLE TX done (ConnId 0x00)
D: 18333 [DL]Write request received for CHIPoBLE RX (ConnId 0x00)
D: 20840 [DL]Sending notification for CHIPoBLE TX (ConnId 00, len 3)
D: 20868 [DL]Notification for CHIPoBLE TX done (ConnId 0x00)
D: 23418 [DL]Write request received for CHIPoBLE RX (ConnId 0x00)
D: 25925 [DL]Sending notification for CHIPoBLE TX (ConnId 00, len 3)
D: 25953 [DL]Notification for CHIPoBLE TX done (ConnId 0x00)
D: 28503 [DL]Write request received for CHIPoBLE RX (ConnId 0x00)
D: 31010 [DL]Sending notification for CHIPoBLE TX (ConnId 00, len 3)
D: 31038 [DL]Notification for CHIPoBLE TX done (ConnId 0x00)
D: 33573 [DL]Write request received for CHIPoBLE RX (ConnId 0x00)
D: 36079 [DL]Sending notification for CHIPoBLE TX (ConnId 00, len 3)
D: 36108 [DL]Notification for CHIPoBLE TX done (ConnId 0x00)
D: 38643 [DL]Write request received for CHIPoBLE RX (ConnId 0x00)
D: 41149 [DL]Sending notification for CHIPoBLE TX (ConnId 00, len 3)
D: 41178 [DL]Notification for CHIPoBLE TX done (ConnId 0x00)
D: 43713 [DL]Write request received for CHIPoBLE RX (ConnId 0x00)
D: 45198 [DL]ConnId: 0x00, New CCCD value: 0x0000
D: 45202 [IN]Clearing BLE pending packets.
I: 45206 [BLE]Releasing end point's BLE connection back to application.
I: 45213 [DL]Closing BLE GATT connection (ConnId 00)
I: 45243 [DL]BLE GAP connection terminated (reason 0x16)
I: 45248 [DL]Current number of connections: 0/1
I: 45256 [DL]CHIPoBLE advertising started
E: 45721 [SC]PASESession timed out while waiting for a response from the peer. Expected message type was 34
E: 45731 [SVR]Commissioning failed (attempt 1): Error CHIP:0x00000032
D: 45740 [SC]Assigned local session key ID 2
D: 45744 [SC]Waiting for PBKDF param request
D: 45748 [DIS]DNS-SD StartServer modeHasValue=1 modeValue=1
D: 45753 [DL]Using Thread extended MAC for hostname.
I: 45758 [DIS]Failed to find a valid admin pairing. Node ID unknown
I: 45764 [DIS]Start dns-sd server - no current nodeId
D: 45769 [DL]Using Thread extended MAC for hostname.
I: 45776 [DIS]Advertise commission parameter vendorID=9050 productID=20052 discriminator=3840/15
E: 45785 [DIS]Failed to advertise unprovisioned commissionable node: Error CHIP:0x00000003
D: 45793 [DIS]Scheduling Discovery timeout in secs=900
E: 45798 [DIS]Failed to finalize service update: Error CHIP:0x0000001C