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 , 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