uart:~$ *** Booting nRF Connect SDK v2.5.2 *** I: Init CHIP stack I: 166 [DL]BLE address: F6:00:73:A7:7F:6A I: 190 [DL]OpenThread started: OK I: 193 [DL]Setting OpenThread device type to ROUTER I: 198 [SVR]Subscription persistence not supported I: 203 [SVR]Server initializing... I: 207 [TS]Last Known Good Time: 2024-04-13T13:13:07 I: 212 [DMG]AccessControl: initializing I: 216 [DMG]Examples::AccessControlDelegate::Init I: 220 [DMG]AccessControl: setting I: 223 [DMG]DefaultAclStorage: initializing I: 227 [DMG]DefaultAclStorage: 0 entries loaded D: 231 [IN]UDP::Init bind&listen port=5540 E: 235 [IN]SO_REUSEPORT failed: 109 D: 239 [IN]UDP::Init bound to port=5540 D: 242 [IN]BLEBase::Init - setting/overriding transport D: 247 [IN]TransportMgr initialized D: 253 [DL]Using Thread extended MAC for hostname. I: 259 [ZCL]Using ZAP configuration... I: 267 [DMG]AccessControlCluster: initializing D: 271 [DL]Boot reason: 1 I: 274 [ZCL]Initiating Admin Commissioning cluster. I: 278 [ZCL]Endpoint 1 On/off already set to new value I: 284 [ZCL]Cluster LevelControl: attribute CurrentLevel set to 254 D: 290 [IN]SecureSession[0x200041f0]: Allocated Type:1 LSID:29577 D: 296 [DL]CHIPoBLE advertising set to on I: 300 [DIS]Updating services using commissioning mode 1 E: 305 [DIS]Failed to remove advertised services: 3 D: 310 [DL]Using Thread extended MAC for hostname. I: 314 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1 E: 323 [DIS]Failed to advertise commissionable node: 3 E: 328 [DIS]Failed to finalize service update: 3 I: 332 [DIS]Updating services using commissioning mode 1 E: 337 [DIS]Failed to remove advertised services: 3 D: 342 [DL]Using Thread extended MAC for hostname. I: 347 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1 E: 355 [DIS]Failed to advertise commissionable node: 3 E: 360 [DIS]Failed to finalize service update: 3 I: 365 [DIS]Delaying proxy of operational discovery: missing delegate I: 371 [IN]CASE Server enabling CASE session setups D: 376 [IN]SecureSession[0x200042a8]: Allocated Type:2 LSID:29578 I: 381 [SVR]Joining Multicast groups I: 385 [SVR]Server Listening... I: 388 [DL]Device Configuration: I: 391 [DL] Serial Number: 11223344556677889900 I: 395 [DL] Vendor Id: 65521 (0xFFF1) I: 398 [DL] Product Id: 32773 (0x8005) I: 402 [DL] Product Name: not-specified I: 406 [DL] Hardware Version: 0 I: 409 [DL] Setup Pin Code (0 for UNKNOWN/ERROR): 20202021 I: 414 [DL] Setup Discriminator (0xFFFF for UNKNOWN/ERROR): 3840 (0xF00) I: 420 [DL] Manufacturing Date: 2022-01-01 I: 424 [DL] Device Type: 65535 (0xFFFF) I: 428 [SVR]SetupQRCode: [MT:6FCJ142C00KA0648G00] I: 432 [SVR]Copy/paste the below URL in a browser to see the QR Code: I: 439 [SVR]https://project-chip.github.io/connectedhomeip/qrcode.html?data=MT%3A6FCJ142C00KA0648G00 I: 448 [SVR]Manual pairing code: [34970112332] I: 452 [DL]CHIP task running I: 458 [DL]CHIPoBLE advertising started I: 462 [ZCL]Cluster OnOff: attribute OnOff set to 0 I: 467 [ZCL]Cluster LevelControl: attribute CurrentLevel set to 254 I: 473 [DL]NFC Tag emulation started I: Factory Reset Triggered. Release button within 3000ms to cancel. I: 30462 [DL]CHIPoBLE advertising mode changed to slow I: 30471 [DL]CHIPoBLE advertising started I: 31426 [TS]Pending Last Known Good Time: 2024-04-13T13:13:07 I: 31432 [TS]Previous Last Known Good Time: 2024-04-13T13:13:07 I: 31438 [TS]Reverted Last Known Good Time to previous value I: 31444 [DL]Performing factory reset uart:~$ *** Booting nRF Connect SDK v2.5.2 *** I: Init CHIP stack I: 159 [DL]BLE address: C4:C2:03:03:1B:E7 I: 180 [DL]OpenThread started: OK I: 183 [DL]Setting OpenThread device type to ROUTER I: 189 [SVR]Subscription persistence not supported I: 193 [SVR]Server initializing... I: 196 [TS]Last Known Good Time: [unknown] I: 200 [TS]Setting Last Known Good Time to firmware build time 2024-04-13T13:13:07 I: 208 [DMG]AccessControl: initializing I: 212 [DMG]Examples::AccessControlDelegate::Init I: 216 [DMG]AccessControl: setting I: 220 [DMG]DefaultAclStorage: initializing I: 223 [DMG]DefaultAclStorage: 0 entries loaded D: 228 [IN]UDP::Init bind&listen port=5540 E: 232 [IN]SO_REUSEPORT failed: 109 D: 235 [IN]UDP::Init bound to port=5540 D: 238 [IN]BLEBase::Init - setting/overriding transport D: 243 [IN]TransportMgr initialized D: 249 [DL]Using Thread extended MAC for hostname. I: 255 [ZCL]Using ZAP configuration... I: 260 [DMG]AccessControlCluster: initializing D: 264 [DL]Boot reason: 6 I: 267 [ZCL]Initiating Admin Commissioning cluster. I: 272 [ZCL]Endpoint 1 On/off already set to new value I: 277 [ZCL]Cluster LevelControl: attribute CurrentLevel set to 1 D: 284 [IN]SecureSession[0x200041f0]: Allocated Type:1 LSID:28010 D: 290 [DL]CHIPoBLE advertising set to on I: 293 [DIS]Updating services using commissioning mode 1 E: 299 [DIS]Failed to remove advertised services: 3 D: 303 [DL]Using Thread extended MAC for hostname. I: 308 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1 E: 317 [DIS]Failed to advertise commissionable node: 3 E: 321 [DIS]Failed to finalize service update: 3 I: 326 [DIS]Updating services using commissioning mode 1 E: 331 [DIS]Failed to remove advertised services: 3 D: 335 [DL]Using Thread extended MAC for hostname. I: 340 [DIS]Advertise commission parameter vendorID=65521 productID=32773 discriminator=3840/15 cm=1 E: 349 [DIS]Failed to advertise commissionable node: 3 E: 354 [DIS]Failed to finalize service update: 3 I: 358 [DIS]Delaying proxy of operational discovery: missing delegate I: 364 [IN]CASE Server enabling CASE session setups D: 369 [IN]SecureSession[0x200042a8]: Allocated Type:2 LSID:28011 I: 375 [SVR]Joining Multicast groups I: 378 [SVR]Server Listening... I: 381 [DL]Device Configuration: I: 384 [DL] Serial Number: 11223344556677889900 I: 388 [DL] Vendor Id: 65521 (0xFFF1) I: 392 [DL] Product Id: 32773 (0x8005) I: 395 [DL] Product Name: not-specified I: 399 [DL] Hardware Version: 0 I: 402 [DL] Setup Pin Code (0 for UNKNOWN/ERROR): 20202021 I: 407 [DL] Setup Discriminator (0xFFFF for UNKNOWN/ERROR): 3840 (0xF00) I: 414 [DL] Manufacturing Date: 2022-01-01 I: 418 [DL] Device Type: 65535 (0xFFFF) I: 421 [SVR]SetupQRCode: [MT:6FCJ142C00KA0648G00] I: 426 [SVR]Copy/paste the below URL in a browser to see the QR Code: I: 432 [SVR]https://project-chip.github.io/connectedhomeip/qrcode.html?data=MT%3A6FCJ142C00KA0648G00 I: 441 [SVR]Manual pairing code: [34970112332] I: 446 [DL]CHIP task running I: 452 [DL]CHIPoBLE advertising started I: 456 [ZCL]Cluster OnOff: attribute OnOff set to 0 I: 461 [ZCL]Cluster LevelControl: attribute CurrentLevel set to 254 I: 467 [DL]NFC Tag emulation started I: 30455 [DL]CHIPoBLE advertising mode changed to slow I: 30463 [DL]CHIPoBLE advertising started I: 111102 [DL]BLE connection established (ConnId: 0x00) I: 111108 [DL]Current number of connections: 1/1 I: 111112 [DL]CHIPoBLE advertising stopped I: 111116 [DL]NFC Tag emulation stopped D: 111991 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 111998 [BLE]local and remote recv window sizes = 5 I: 112003 [BLE]selected BTP version 4 I: 112007 [BLE]using BTP fragment sizes rx 128 / tx 128. D: 112141 [DL]ConnId: 0x00, New CCCD value: 0x0002 D: 112145 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6) D: 112153 [IN]BLE EndPoint 0x20012208 Connection Complete I: 112158 [DL]CHIPoBLE connection established (ConnId: 0x00, GATT MTU: 131) D: 112321 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 112367 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 112374 [EM]>>> [E:29187r S:0 M:61905166] (U) Msg RX from 0:C5B06DACB80BC6FA [0000] --- Type 0000:20 (SecureChannel:PBKDFParamRequest) I: 112387 [EM]<<< [E:29187r S:0 M:244028423] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:21 (SecureChannel:PBKDFParamResponse) I: 112399 [IN](U) Sending msg 244028423 to IP address 'BLE' D: 112405 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128) D: 112501 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 112509 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 14) D: 112591 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 112637 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 112644 [EM]>>> [E:29187r S:0 M:61905167] (U) Msg RX from 0:C5B06DACB80BC6FA [0000] --- Type 0000:22 (SecureChannel:PASE_Pake1) I: 114019 [EM]<<< [E:29187r S:0 M:244028424] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:23 (SecureChannel:PASE_Pake2) I: 114030 [IN](U) Sending msg 244028424 to IP address 'BLE' D: 114035 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128) E: 114043 [DL]Long dispatch time: 1406 ms, for event type 16388 D: 114211 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 114219 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6) D: 114301 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 114309 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 114317 [EM]>>> [E:29187r S:0 M:61905168] (U) Msg RX from 0:C5B06DACB80BC6FA [0000] --- Type 0000:24 (SecureChannel:PASE_Pake3) I: 114329 [EM]<<< [E:29187r S:0 M:244028425] (U) Msg TX to 0:0000000000000000 [0000] --- Type 0000:40 (SecureChannel:StatusReport) I: 114340 [IN](U) Sending msg 244028425 to IP address 'BLE' D: 114346 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 35) I: 114354 [SC]SecureSession[0x200041f0]: Moving from state 'kEstablishing' --> 'kActive' D: 114362 [IN]SecureSession[0x200041f0]: Activated - Type:1 LSID:28010 D: 114368 [IN]New secure session activated for device , LSID:28010 PSID:39400! I: 114377 [SVR]Commissioning completed session establishment step I: 114383 [DIS]Updating services using commissioning mode 0 E: 114388 [DIS]Failed to remove advertised services: 3 E: 114393 [DIS]Failed to finalize service update: 3 D: 114398 [DL]CHIPoBLE advertising set to off I: 114402 [SVR]Device completed Rendezvous process D: 114436 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 114444 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 114452 [EM]>>> [E:29188r S:28010 M:118782625] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest) D: 114463 [IM]Received Read request I: 114468 [EM]<<< [E:29188r S:28010 M:30549887] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData) I: 114479 [IN](S) Sending msg 30549887 on secure session with LSID: 28010 D: 114485 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 97) D: 114571 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 114616 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 114625 [EM]>>> [E:29189r S:28010 M:118782626] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest) D: 114635 [IM]Received Read request I: 114640 [EM]<<< [E:29189r S:28010 M:30549888] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData) I: 114651 [IN](S) Sending msg 30549888 on secure session with LSID: 28010 D: 114657 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72) D: 114751 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 114796 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 114804 [EM]>>> [E:29190r S:28010 M:118782627] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest) D: 114815 [IM]Received Read request I: 114820 [EM]<<< [E:29190r S:28010 M:30549889] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData) I: 114831 [IN](S) Sending msg 30549889 on secure session with LSID: 28010 D: 114837 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72) D: 114931 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 114939 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 114947 [EM]>>> [E:29191r S:28010 M:118782628] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest) D: 114958 [IM]Received Read request I: 114963 [EM]<<< [E:29191r S:28010 M:30549890] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData) I: 114974 [IN](S) Sending msg 30549890 on secure session with LSID: 28010 D: 114980 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72) D: 115066 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 115074 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 115082 [EM]>>> [E:29192r S:28010 M:118782629] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest) D: 115093 [IM]Received Read request I: 115098 [EM]<<< [E:29192r S:28010 M:30549891] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData) I: 115109 [IN](S) Sending msg 30549891 on secure session with LSID: 28010 D: 115115 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71) D: 115201 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 115209 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 115217 [EM]>>> [E:29193r S:28010 M:118782630] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest) D: 115228 [IM]Received Read request I: 115233 [EM]<<< [E:29193r S:28010 M:30549892] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData) I: 115244 [IN](S) Sending msg 30549892 on secure session with LSID: 28010 D: 115250 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71) D: 115336 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 115344 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 115352 [EM]>>> [E:29194r S:28010 M:118782631] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:08 (IM:InvokeCommandRequest) I: 115364 [ZCL]OpCreds: Certificate Chain request received for DAC I: 115374 [EM]<<< [E:29194r S:28010 M:30549893] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:09 (IM:InvokeCommandResponse) I: 115385 [IN](S) Sending msg 30549893 on secure session with LSID: 28010 D: 115392 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128) D: 115471 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 115479 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128) D: 115561 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 115569 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128) D: 115651 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 115659 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 128) D: 115741 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 115749 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) D: 115756 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 57) D: 115831 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 115839 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 115847 [EM]>>> [E:29195r S:28010 M:118782632] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest) D: 115858 [IM]Received Read request I: 115863 [EM]<<< [E:29195r S:28010 M:30549894] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData) I: 115874 [IN](S) Sending msg 30549894 on secure session with LSID: 28010 D: 115880 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 97) D: 115966 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 115974 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 115982 [EM]>>> [E:29196r S:28010 M:118782633] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest) D: 115993 [IM]Received Read request I: 115998 [EM]<<< [E:29196r S:28010 M:30549895] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData) I: 116009 [IN](S) Sending msg 30549895 on secure session with LSID: 28010 D: 116015 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 72) D: 116101 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 116109 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 116117 [EM]>>> [E:29197r S:28010 M:118782634] (S) Msg RX from 0:FFFFFFFB00000000 [0000] --- Type 0001:02 (IM:ReadRequest) D: 116128 [IM]Received Read request I: 116133 [EM]<<< [E:29197r S:28010 M:30549896] (S) Msg TX to 0:FFFFFFFB00000000 [0000] --- Type 0001:05 (IM:ReportData) I: 116144 [IN](S) Sending msg 30549896 on secure session with LSID: 28010 D: 116150 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71) D: 116236 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 118711 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) D: 121219 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3) D: 121366 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 123886 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) D: 126394 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 3) D: 126451 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) I: 127441 [DL]BLE GAP connection terminated (reason 0x13) D: 127447 [IN]Clearing BLE pending packets. I: 127450 [DL]Current number of connections: 0/1