Hi everyone,
I'm working on the nrf54l15 with the nrf sdk v9.0.0 wihch I assume integrate matter version 1.4. I'm using the google nest max as a thread border router.
Can someone tell me if that border router is compatible with matter 1.4 since i'm not able to add my device ( commissioning) through that border router.
Thanks
I'm working on the nrf54l15 with the nrf sdk v9.0.0 wihch I assume integrate matter version 1.4.
Correct, nRF Connect SDK v2.9.0 supports Matter 1.4.0.0. See this documentation for a mapping of nRF Connect SDK version to Matter version.
Can someone tell me if that border router is compatible with matter 1.4 since i'm not able to add my device ( commissioning) through that border router.
We don't have an overview of all the commencially available Matter hubs, so you'll have to contact the manufacturer to find out which Matter specification version they are following.
Which device type are you trying to commission? I don't know if the list found here is applicable to your hub, but if your device type is not on the list it can be an indication that it is not supported.
Best regards,
Maria
Thanks for tour answer. It's a simple contact sensor.
In that case it doesn't look like a Matter specification compatibility issue.
What are you seeing when the commissioning fails? Have you successfully commissioned your device with the CHIP tool?
BR,
Maria
In that case it doesn't look like a Matter specification compatibility issue.
What are you seeing when the commissioning fails? Have you successfully commissioned your device with the CHIP tool?
BR,
Maria
This is the output log when commissioning
I: 1612 [DL]CHIPoBLE advertising started I: 7730 [DL]Current number of connections: 1/1 I: 7734 [DL]BLE connection established (ConnId: 0x00) I: 7739 [DL]CHIPoBLE advertising stopped D: 9766 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 9773 [BLE]local and remote recv window sizes = 5 I: 9778 [BLE]selected BTP version 4 I: 9781 [BLE]using BTP fragment sizes rx 244 / tx 244. D: 9856 [DL]ConnId: 0x00, New CCCD value: 0x0002 D: 9861 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 6) D: 9868 [IN]BLE EndPoint 0x2000f2b0 Connection Complete I: 9873 [DL]CHIPoBLE connection established (ConnId: 0x00, GATT MTU: 247) D: 9946 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 9955 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 9962 [EM]>>> [E:98r S:0 M:54145265] (U) Msg RX from 0:A603AA601FFE4BE0 [0000] to 0000000000000000 --- Type 0000:20 (SecureChannel:PBKDFParamRequest) (B:98) I: 9977 [EM]<<< [E:98r S:0 M:141235376] (U) Msg TX from 0000000000000000 to 0:A603AA601FFE4BE0 [0000] [BLE] --- Type 0000:21 (SecureChannel:PBKDFParamResponse) (B:154) D: 9992 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 159) I: 9999 [SVR]Commissioning session establishment step started D: 10081 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 10129 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 10136 [EM]>>> [E:98r S:0 M:54145266] (U) Msg RX from 0:A603AA601FFE4BE0 [0000] to 0000000000000000 --- Type 0000:22 (SecureChannel:PASE_Pake1) (B:92) I: 10175 [EM]<<< [E:98r S:0 M:141235377] (U) Msg TX from 0000000000000000 to 0:A603AA601FFE4BE0 [0000] [BLE] --- Type 0000:23 (SecureChannel:PASE_Pake2) (B:127) D: 10189 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 132) D: 10261 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 10270 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 10277 [EM]>>> [E:98r S:0 M:54145267] (U) Msg RX from 0:A603AA601FFE4BE0 [0000] to 0000000000000000 --- Type 0000:24 (SecureChannel:PASE_Pake3) (B:59) I: 10291 [EM]<<< [E:98r S:0 M:141235378] (U) Msg TX from 0000000000000000 to 0:A603AA601FFE4BE0 [0000] [BLE] --- Type 0000:40 (SecureChannel:StatusReport) (B:30) D: 10305 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 35) I: 10314 [SC]SecureSession[0x20004428, LSID:46427]: State change 'kEstablishing' --> 'kActive' D: 10322 [IN]SecureSession[0x20004428]: Activated - Type:1 LSID:46427 D: 10328 [IN]New secure session activated for device <FFFFFFFB00000000, 0>, LSID:46427 PSID:48490! I: 10337 [SVR]Commissioning completed session establishment step I: 10343 [DIS]Updating services using commissioning mode 0 E: 10348 [DIS]Failed to remove advertised services: 3 E: 10353 [DIS]Failed to finalize service update: 3 D: 10358 [DL]CHIPoBLE advertising set to off I: 10362 [SVR]Device completed Rendezvous process D: 10396 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 10406 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 10413 [EM]>>> [E:99r S:46427 M:189458403] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:02 (IM:ReadRequest) (B:131) D: 10426 [IM]Received Read request I: 10442 [EM]<<< [E:99r S:46427 M:17197082] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:05 (IM:ReportData) (B:258) D: 10456 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 244) D: 10531 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 10539 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 21) D: 10621 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 10630 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 10638 [EM]>>> [E:100r S:46427 M:189458404] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:02 (IM:ReadRequest) (B:51) D: 10651 [IM]Received Read request I: 10655 [EM]<<< [E:100r S:46427 M:17197083] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:05 (IM:ReportData) (B:65) D: 10668 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 70) D: 10756 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 10802 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 10810 [EM]>>> [E:101r S:46427 M:189458405] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:66) I: 10824 [FS]GeneralCommissioning: Received ArmFailSafe (600s) I: 10830 [EM]<<< [E:101r S:46427 M:17197084] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:66) D: 10844 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71) D: 10936 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 10945 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 10953 [EM]>>> [E:102r S:46427 M:189458406] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:70) I: 10969 [EM]<<< [E:102r S:46427 M:17197085] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:66) D: 10984 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71) D: 11071 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 11080 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 11088 [EM]>>> [E:103r S:46427 M:189458407] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:62) I: 11102 [ZCL]OpCreds: Certificate Chain request received for PAI I: 11108 [EM]<<< [E:103r S:46427 M:17197086] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:527) D: 11123 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 244) D: 11206 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 11214 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 244) D: 11296 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 11304 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 48) D: 11386 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 11395 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 11403 [EM]>>> [E:104r S:46427 M:189458408] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:62) I: 11417 [ZCL]OpCreds: Certificate Chain request received for DAC I: 11423 [EM]<<< [E:104r S:46427 M:17197087] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:557) D: 11438 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 244) D: 11521 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 11529 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 244) D: 11611 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 11619 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 78) D: 11701 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 11710 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 11718 [EM]>>> [E:105r S:46427 M:189458409] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:94) I: 11732 [ZCL]OpCreds: Received an AttestationRequest command I: 11739 [ZCL]OpCreds: AttestationRequest successful. I: 11745 [EM]<<< [E:105r S:46427 M:17197088] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:716) D: 11759 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 244) D: 11836 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 11844 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 244) D: 11926 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 11934 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 237) D: 12016 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 14179 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 14186 [EM]>>> [E:106r S:46427 M:189458410] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:94) I: 14201 [ZCL]OpCreds: Received a CSRRequest command I: 14212 [ZCL]OpCreds: AllocatePendingOperationalKey succeeded I: 14218 [ZCL]OpCreds: CSRRequest successful. I: 14223 [EM]<<< [E:106r S:46427 M:17197089] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:392) D: 14238 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 244) D: 14311 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 14319 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 155) D: 14491 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 14543 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) D: 14628 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 14636 [EM]>>> [E:107r S:46427 M:189458411] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:293) I: 14650 [ZCL]OpCreds: Received an AddTrustedRootCertificate command I: 14658 [ZCL]OpCreds: AddTrustedRootCertificate successful. I: 14664 [EM]<<< [E:107r S:46427 M:17197090] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:63) D: 14678 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 68) D: 14761 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 14807 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) D: 14854 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 14862 [EM]>>> [E:108r S:46427 M:189458412] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:335) I: 14876 [ZCL]OpCreds: Received an AddNOC command I: 14881 [FP]Validating NOC chain I: 14887 [FP]NOC chain validation successful I: 14891 [FP]Added new fabric at index: 0x1 I: 14895 [FP]Assigned compressed fabric ID: 0x224D0785BA8358D0, node ID: 0x00000000000000B7 I: 14903 [TS]Last Known Good Time: 2023-10-14T01:16:48 I: 14908 [TS]New proposed Last Known Good Time: 2021-06-10T00:00:00 I: 14914 [TS]Retaining current Last Known Good Time I: 14929 [ZCL]OpCreds: ACL entry created for Fabric index 0x1 CASE Admin Subject 0x000000000001B669 D: 14938 [DL]Using Thread extended MAC for hostname. I: 14943 [DIS]Advertise operational node 224D0785BA8358D0-00000000000000B7 E: 14949 [SVR]Operational advertising failed: 3 I: 14954 [ZCL]OpCreds: successfully created fabric index 0x1 via AddNOC I: 14961 [EM]<<< [E:108r S:46427 M:17197091] (S) Msg TX from 0000000000000000 to 1:FFFFFFFB00000000 [58D0] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:66) D: 14975 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71) E: 14982 [DL]Long dispatch time: 128 ms, for event type 16388 D: 15031 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 15041 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 15049 [EM]>>> [E:109r S:46427 M:189458413] (S) Msg RX from 1:FFFFFFFB00000000 [58D0] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:171) I: 15065 [EM]<<< [E:109r S:46427 M:17197092] (S) Msg TX from 0000000000000000 to 1:FFFFFFFB00000000 [58D0] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:66) D: 15080 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71) D: 15166 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 15175 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 15183 [EM]>>> [E:110r S:46427 M:189458414] (S) Msg RX from 1:FFFFFFFB00000000 [58D0] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:66) I: 15197 [FS]GeneralCommissioning: Received ArmFailSafe (644s) I: 15203 [EM]<<< [E:110r S:46427 M:17197093] (S) Msg TX from 0000000000000000 to 1:FFFFFFFB00000000 [58D0] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:66) D: 15218 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 71) D: 15301 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 15310 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 15318 [EM]>>> [E:111r S:46427 M:189458415] (S) Msg RX from 1:FFFFFFFB00000000 [58D0] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:73) D: 15361 [DL]OpenThread State Changed (Flags: 0x1017c110) D: 15366 [DL] Network Name: OpenThread-785e D: 15370 [DL] PAN Id: 0x785E D: 15372 [DL] Extended PAN Id: 0x36B2005A72A9719E D: 15377 [DL] Channel: 24 D: 15379 [DL] Mesh Prefix: fd17:2:1301:91ab::/64 D: 15385 [DL]OpenThread State Changed (Flags: 0x1100100d) D: 15390 [DL] Device Role: DETACHED D: 15393 [DL] Thread Unicast Addresses: D: 15397 [DL] fd17:2:1301:91ab:7265:125b:33d9:86b7/64 valid preferred D: 15404 [DL] fe80::e452:5336:ce94:a795/64 valid preferred I: 16535 [DL]SRP Client was started, detected server: fd17:0002:1301:91ab:215e:9c2f:34e1:835e D: 16543 [DL]OpenThread State Changed (Flags: 0x200002a4) D: 16548 [DL] Device Role: CHILD D: 16552 [DL] Partition Id: 0x71D5F545 D: 16556 [DL]OpenThread State Changed (Flags: 0x00000001) D: 16561 [DL] Thread Unicast Addresses: D: 16565 [DL] fd41:d894:feb0:1:9119:71ff:ec13:13c2/64 valid preferred D: 16571 [DL] fd17:2:1301:91ab:0:ff:fe00:8402/64 valid preferred rloc D: 16578 [DL] fd17:2:1301:91ab:7265:125b:33d9:86b7/64 valid preferred D: 16585 [DL] fe80::e452:5336:ce94:a795/64 valid preferred I: 16592 [EM]<<< [E:111r S:46427 M:17197094] (S) Msg TX from 0000000000000000 to 1:FFFFFFFB00000000 [58D0] [BLE] --- Type 0001:09 (IM:InvokeCommandResponse) (B:65) D: 16613 [DL]Sending indication for CHIPoBLE TX characteristic (ConnId 00, len 70) D: 16621 [DL]Using Thread extended MAC for hostname. I: 16627 [DIS]Advertise operational node 224D0785BA8358D0-00000000000000B7 E: 16633 [SVR]Operational advertising failed: 3 D: 16697 [DL]Indication for CHIPoBLE TX characteristic done (ConnId 0x00, result 0x00) D: 16813 [DL]SRP update succeeded I: 16816 [SVR]Server initialization complete I: 16820 [DIS]Updating services using commissioning mode 0 D: 16825 [DL]Using Thread extended MAC for hostname. I: 16830 [DIS]Advertise operational node 224D0785BA8358D0-00000000000000B7 I: 16837 [DL]advertising srp service: 224D0785BA8358D0-00000000000000B7._matter._tcp I: 16847 [SWU]Stopping the watchdog timer I: 16850 [SWU]Starting the periodic query timer, timeout: 86400 seconds D: 18442 [DL]SRP update succeeded D: 19217 [DL]Write request received for CHIPoBLE RX characteristic (ConnId 0x00) I: 19615 [EM]>>> [E:112r S:0 M:54145268] (U) Msg RX from 0:5A8A86C8EC1FE954 [0000] to 0000000000000000 --- Type 0000:30 (SecureChannel:CASE_Sigma1) (B:196) I: 19629 [IN]CASE Server received Sigma1 message . Starting handshake. EC 0x20006590 I: 19637 [EM]<<< [E:112r S:0 M:141235379 (Ack:54145268)] (U) Msg TX from 0000000000000000 to 0:5A8A86C8EC1FE954 [0000] [UDP:[2a01:cb06:b850:c7c9:8c52:ccd1:33bc:eecf]:45616] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26) I: 19657 [SC]Received Sigma1 msg I: 19664 [SC]CASE matched destination ID: fabricIndex 1, NodeID 0x00000000000000B7 I: 19687 [EM]<<< [E:112r S:0 M:141235380 (Ack:54145268)] (U) Msg TX from 0000000000000000 to 0:5A8A86C8EC1FE954 [0000] [UDP:[2a01:cb06:b850:c7c9:8c52:ccd1:33bc:eecf]:45616] --- Type 0000:31 (SecureChannel:CASE_Sigma2) (B:517) I: 19707 [EM]??1 [E:112r S:0 M:141235380] (U) Msg Retransmission to 0:0000000000000000 in 2103ms [State:Active II:300 AI:300 AT:4000] I: 19720 [SC]Sent Sigma2 msg I: 20018 [EM]>>> [E:112r S:0 M:54145269 (Ack:141235380)] (U) Msg RX from 0:5A8A86C8EC1FE954 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26) I: 20283 [EM]>>> [E:112r S:0 M:54145270 (Ack:141235380)] (U) Msg RX from 0:5A8A86C8EC1FE954 [0000] to 0000000000000000 --- Type 0000:32 (SecureChannel:CASE_Sigma3) (B:364) I: 20298 [EM]<<< [E:112r S:0 M:141235381 (Ack:54145270)] (U) Msg TX from 0000000000000000 to 0:5A8A86C8EC1FE954 [0000] [UDP:[2a01:cb06:b850:c7c9:8c52:ccd1:33bc:eecf]:45616] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26) I: 20318 [SC]Received Sigma3 msg E: 20324 [SC]The device does not support GetClock_RealTimeMS() API: 3. Falling back to Last Known Good UTC Time I: 20347 [EM]<<< [E:112r S:0 M:141235382 (Ack:54145270)] (U) Msg TX from 0000000000000000 to 0:5A8A86C8EC1FE954 [0000] [UDP:[2a01:cb06:b850:c7c9:8c52:ccd1:33bc:eecf]:45616] --- Type 0000:40 (SecureChannel:StatusReport) (B:34) I: 20367 [EM]??1 [E:112r S:0 M:141235382] (U) Msg Retransmission to 0:0000000000000000 in 2090ms [State:Active II:300 AI:300 AT:4000] I: 20381 [SC]SecureSession[0x20004500, LSID:46428]: State change 'kEstablishing' --> 'kActive' D: 20389 [IN]SecureSession[0x20004500]: Activated - Type:2 LSID:46428 D: 20395 [IN]New secure session activated for device <000000000001B669, 1>, LSID:46428 PSID:48491! I: 20404 [IN]CASE Session established to peer: <000000000001B669, 1> D: 20410 [IN]SecureSession[0x200045d8]: Allocated Type:2 LSID:46429 I: 20492 [EM]>>> [E:113r S:46428 M:107449382] (S) Msg RX from 1:000000000001B669 [58D0] to 00000000000000B7 --- Type 0001:08 (IM:InvokeCommandRequest) (B:59) I: 20507 [FS]GeneralCommissioning: Received CommissioningComplete I: 20524 [FP]Metadata for Fabric 0x1 persisted to storage. I: 20535 [TS]Committing Last Known Good Time to storage: 2023-10-14T01:16:48 I: 20544 [ZCL]OpCreds: Fabric index 0x1 was committed to storage. Compressed Fabric Id 0x224D0785BA8358D0, FabricId 0000000000000001, NodeId 00000000000000B7, VendorId 0x1467 I: 20567 [FS]GeneralCommissioning: Successfully commited pending fabric data I: 20574 [FS]Fail-safe cleanly disarmed I: 20578 [EM]<<< [E:113r S:46428 M:125087340 (Ack:107449382)] (S) Msg TX from 00000000000000B7 to 1:000000000001B669 [58D0] [UDP:[2a01:cb06:b850:c7c9:8c52:ccd1:33bc:eecf]:45616] --- Type 0001:09 (IM:InvokeCommandResponse) (B:70) I: 20599 [EM]??1 [E:113r S:46428 M:125087340] (S) Msg Retransmission to 1:000000000001B669 in 2099ms [State:Active II:300 AI:300 AT:4000] I: 20612 [SWU]Device commissioned, schedule a default provider query I: 20618 [SVR]Commissioning completed successfully I: 20622 [DIS]Updating services using commissioning mode 0 D: 20628 [DL]Using Thread extended MAC for hostname. I: 20632 [DIS]Advertise operational node 224D0785BA8358D0-00000000000000B7 D: 20639 [DL]CHIPoBLE advertising set to off D: 20643 [IN]Expiring all PASE sessions D: 20646 [IN]SecureSession[0x20004428]: MarkForEviction Type:1 LSID:46427 I: 20653 [SC]SecureSession[0x20004428, LSID:46427]: State change 'kActive' --> 'kPendingEviction' D: 20662 [IN]SecureSession[0x20004428]: Released - Type:1 LSID:46427 D: 20668 [IN]Clearing BLE pending packets. I: 20672 [BLE]Releasing end point's BLE connection back to application. I: 20678 [DL]Closing BLE GATT connection (ConnId 00) D: 20684 [DL]ConnId: 0x00, New CCCD value: 0x0000 I: 20689 [EM]>>> [E:112r S:0 M:54145271 (Ack:141235382)] (U) Msg RX from 0:5A8A86C8EC1FE954 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26) I: 20721 [EM]>>> [E:113r S:46428 M:107449383 (Ack:125087340)] (S) Msg RX from 1:000000000001B669 [58D0] to 00000000000000B7 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 20755 [EM]>>> [E:114r S:46428 M:107449384] (S) Msg RX from 1:000000000001B669 [58D0] to 00000000000000B7 --- Type 0001:0A (IM:TimedRequest) (B:39) I: 20768 [EM]<<< [E:114r S:46428 M:125087341 (Ack:107449384)] (S) Msg TX from 00000000000000B7 to 1:000000000001B669 [58D0] [UDP:[2a01:cb06:b850:c7c9:8c52:ccd1:33bc:eecf]:45616] --- Type 0001:01 (IM:StatusResponse) (B:42) I: 20789 [EM]??1 [E:114r S:46428 M:125087341] (S) Msg Retransmission to 1:000000000001B669 in 2052ms [State:Active II:300 AI:300 AT:4000] I: 20802 [DL]Current number of connections: 0/1 I: 20806 [DL]BLE GAP connection terminated (reason 0x16) I: 21019 [EM]>>> [E:114r S:46428 M:107449385 (Ack:125087341)] (S) Msg RX from 1:000000000001B669 [58D0] to 00000000000000B7 --- Type 0001:08 (IM:InvokeCommandRequest) (B:210) I: 21034 [ZCL]Received command to open commissioning window D: 21040 [IN]SecureSession[0x20004428]: Allocated Type:1 LSID:46430 I: 21046 [DIS]Updating services using commissioning mode 2 D: 21051 [DL]Using Thread extended MAC for hostname. I: 21056 [DIS]Advertise operational node 224D0785BA8358D0-00000000000000B7 D: 21063 [DL]Using Thread extended MAC for hostname. I: 21067 [DIS]Advertise commission parameter vendorID=65521 productID=32768 discriminator=3843/15 cm=2 cp=0 I: 21077 [DL]advertising srp service: 8C5D2EECB63C407D._matterc._udp I: 21083 [ZCL]Commissioning window is now open I: 21088 [EM]<<< [E:114r S:46428 M:125087342 (Ack:107449385)] (S) Msg TX from 00000000000000B7 to 1:000000000001B669 [58D0] [UDP:[2a01:cb06:b850:c7c9:8c52:ccd1:33bc:eecf]:45616] --- Type 0001:09 (IM:InvokeCommandResponse) (B:67) I: 21111 [EM]??1 [E:114r S:46428 M:125087342] (S) Msg Retransmission to 1:000000000001B669 in 2108ms [State:Active II:300 AI:300 AT:4000] I: 21394 [EM]>>> [E:114r S:46428 M:107449386 (Ack:125087342)] (S) Msg RX from 1:000000000001B669 [58D0] to 00000000000000B7 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) D: 22337 [DL]SRP update succeeded I: 22375 [EM]>>> [E:15347r S:0 M:178539175] (U) Msg RX from 0:3D7DF150DCAAA1F3 [0000] to 0000000000000000 --- Type 0000:20 (SecureChannel:PBKDFParamRequest) (B:68) I: 22389 [EM]<<< [E:15347r S:0 M:141235383 (Ack:178539175)] (U) Msg TX from 0000000000000000 to 0:3D7DF150DCAAA1F3 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26) I: 22410 [EM]<<< [E:15347r S:0 M:141235384 (Ack:178539175)] (U) Msg TX from 0000000000000000 to 0:3D7DF150DCAAA1F3 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:21 (SecureChannel:PBKDFParamResponse) (B:174) I: 22432 [EM]??1 [E:15347r S:0 M:141235384] (U) Msg Retransmission to 0:0000000000000000 in 2106ms [State:Active II:500 AI:300 AT:4000] I: 22445 [SVR]Commissioning session establishment step started I: 22598 [EM]>>> [E:15347r S:0 M:178539176 (Ack:141235384)] (U) Msg RX from 0:3D7DF150DCAAA1F3 [0000] to 0000000000000000 --- Type 0000:22 (SecureChannel:PASE_Pake1) (B:96) I: 22613 [EM]<<< [E:15347r S:0 M:141235385 (Ack:178539176)] (U) Msg TX from 0000000000000000 to 0:3D7DF150DCAAA1F3 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26) I: 22659 [EM]<<< [E:15347r S:0 M:141235386 (Ack:178539176)] (U) Msg TX from 0000000000000000 to 0:3D7DF150DCAAA1F3 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:23 (SecureChannel:PASE_Pake2) (B:131) I: 22680 [EM]??1 [E:15347r S:0 M:141235386] (U) Msg Retransmission to 0:0000000000000000 in 2042ms [State:Active II:500 AI:300 AT:4000] I: 22801 [EM]>>> [E:15347r S:0 M:178539177 (Ack:141235386)] (U) Msg RX from 0:3D7DF150DCAAA1F3 [0000] to 0000000000000000 --- Type 0000:24 (SecureChannel:PASE_Pake3) (B:63) I: 22817 [EM]<<< [E:15347r S:0 M:141235387 (Ack:178539177)] (U) Msg TX from 0000000000000000 to 0:3D7DF150DCAAA1F3 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26) I: 22838 [EM]<<< [E:15347r S:0 M:141235388 (Ack:178539177)] (U) Msg TX from 0000000000000000 to 0:3D7DF150DCAAA1F3 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:40 (SecureChannel:StatusReport) (B:34) I: 22859 [EM]??1 [E:15347r S:0 M:141235388] (U) Msg Retransmission to 0:0000000000000000 in 2067ms [State:Active II:500 AI:300 AT:4000] I: 22872 [SC]SecureSession[0x20004428, LSID:46430]: State change 'kEstablishing' --> 'kActive' D: 22880 [IN]SecureSession[0x20004428]: Activated - Type:1 LSID:46430 D: 22887 [IN]New secure session activated for device <FFFFFFFB00000000, 0>, LSID:46430 PSID:29169! I: 22895 [SVR]Commissioning completed session establishment step I: 22901 [DIS]Updating services using commissioning mode 0 D: 22906 [DL]Using Thread extended MAC for hostname. I: 22911 [DIS]Advertise operational node 224D0785BA8358D0-00000000000000B7 I: 22917 [DL]removing srp service: 8C5D2EECB63C407D._matterc._udp I: 22923 [SVR]Device completed Rendezvous process I: 23034 [EM]>>> [E:15348r S:46430 M:245957179] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:02 (IM:ReadRequest) (B:131) D: 23048 [IM]Received Read request I: 23054 [EM]<<< [E:15348r S:46430 M:149948099 (Ack:245957179)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:05 (IM:ReportData) (B:262) I: 23077 [EM]??1 [E:15348r S:46430 M:149948099] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2051ms [State:Active II:300 AI:300 AT:4000] I: 23091 [EM]>>> [E:15347r S:0 M:178539178 (Ack:141235388)] (U) Msg RX from 0:3D7DF150DCAAA1F3 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26) D: 23250 [DL]SRP update succeeded I: 23288 [EM]>>> [E:15349r S:46430 M:245957180] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:65) I: 23303 [FS]GeneralCommissioning: Received ArmFailSafe (60s) I: 23309 [EM]<<< [E:15349r S:46430 M:149948100 (Ack:245957180)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:09 (IM:InvokeCommandResponse) (B:70) I: 23332 [EM]??1 [E:15349r S:46430 M:149948100] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2053ms [State:Active II:300 AI:300 AT:4000] I: 23345 [EM]>>> [E:15348r S:46430 M:245957181 (Ack:149948099)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 23521 [EM]>>> [E:15350r S:46430 M:245957182] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:70) I: 23538 [EM]<<< [E:15350r S:46430 M:149948101 (Ack:245957182)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:09 (IM:InvokeCommandResponse) (B:70) I: 23561 [EM]??1 [E:15350r S:46430 M:149948101] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2087ms [State:Active II:300 AI:300 AT:4000] I: 23574 [EM]>>> [E:15349r S:46430 M:245957183 (Ack:149948100)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 23755 [EM]>>> [E:15351r S:46430 M:245957184] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:62) I: 23770 [ZCL]OpCreds: Certificate Chain request received for PAI I: 23777 [EM]<<< [E:15351r S:46430 M:149948102 (Ack:245957184)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:09 (IM:InvokeCommandResponse) (B:531) I: 23800 [EM]??1 [E:15351r S:46430 M:149948102] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2042ms [State:Active II:300 AI:300 AT:4000] I: 23814 [EM]>>> [E:15350r S:46430 M:245957185 (Ack:149948101)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 23988 [EM]>>> [E:15352r S:46430 M:245957186] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:62) I: 24003 [ZCL]OpCreds: Certificate Chain request received for DAC I: 24010 [EM]<<< [E:15352r S:46430 M:149948103 (Ack:245957186)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:09 (IM:InvokeCommandResponse) (B:561) I: 24032 [EM]??1 [E:15352r S:46430 M:149948103] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2112ms [State:Active II:300 AI:300 AT:4000] I: 24047 [EM]>>> [E:15351r S:46430 M:245957187 (Ack:149948102)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 24245 [EM]>>> [E:15353r S:46430 M:245957188] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:94) I: 24259 [ZCL]OpCreds: Received an AttestationRequest command I: 24265 [EM]<<< [E:15353r S:46430 M:149948104 (Ack:245957188)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 24290 [ZCL]OpCreds: AttestationRequest successful. I: 24296 [EM]<<< [E:15353r S:46430 M:149948105 (Ack:245957188)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:09 (IM:InvokeCommandResponse) (B:720) I: 24317 [EM]??1 [E:15353r S:46430 M:149948105] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2059ms [State:Active II:300 AI:300 AT:4000] I: 24331 [EM]>>> [E:15352r S:46430 M:245957189 (Ack:149948103)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 24702 [EM]>>> [E:15354r S:46430 M:245957190] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:94) I: 24717 [ZCL]OpCreds: Received a CSRRequest command I: 24722 [EM]<<< [E:15354r S:46430 M:149948106 (Ack:245957190)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 24754 [ZCL]OpCreds: AllocatePendingOperationalKey succeeded I: 24760 [ZCL]OpCreds: CSRRequest successful. I: 24766 [EM]<<< [E:15354r S:46430 M:149948107 (Ack:245957190)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:09 (IM:InvokeCommandResponse) (B:396) I: 24786 [EM]??1 [E:15354r S:46430 M:149948107] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2093ms [State:Active II:300 AI:300 AT:4000] I: 24801 [EM]>>> [E:15353r S:46430 M:245957191 (Ack:149948105)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 25030 [EM]>>> [E:15355r S:46430 M:245957192] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:293) I: 25045 [ZCL]OpCreds: Received an AddTrustedRootCertificate command I: 25052 [EM]<<< [E:15355r S:46430 M:149948108 (Ack:245957192)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 25077 [ZCL]OpCreds: AddTrustedRootCertificate successful. I: 25083 [EM]<<< [E:15355r S:46430 M:149948109 (Ack:245957192)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:09 (IM:InvokeCommandResponse) (B:67) I: 25104 [EM]??1 [E:15355r S:46430 M:149948109] (S) Msg Retransmission to 0:FFFFFFFB00000000 in 2106ms [State:Active II:300 AI:300 AT:4000] I: 25117 [EM]>>> [E:15354r S:46430 M:245957193 (Ack:149948107)] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 25464 [EM]>>> [E:15356r S:46430 M:245957194] (S) Msg RX from 0:FFFFFFFB00000000 [0000] to 0000000000000000 --- Type 0001:08 (IM:InvokeCommandRequest) (B:563) I: 25479 [ZCL]OpCreds: Received an AddNOC command I: 25484 [EM]<<< [E:15356r S:46430 M:149948110 (Ack:245957194)] (S) Msg TX from 0000000000000000 to 0:FFFFFFFB00000000 [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 25509 [FP]Validating NOC chain I: 25517 [FP]NOC chain validation successful I: 25521 [FP]Added new fabric at index: 0x2 I: 25525 [FP]Assigned compressed fabric ID: 0xB2B80C805C60FB9A, node ID: 0x00000000000000AD I: 25533 [TS]Last Known Good Time: 2023-10-14T01:16:48 I: 25538 [TS]New proposed Last Known Good Time: 2021-01-01T00:00:00 I: 25544 [TS]Retaining current Last Known Good Time I: 25561 [ZCL]OpCreds: ACL entry created for Fabric index 0x2 CASE Admin Subject 0x0000000000000001 D: 25570 [DL]Using Thread extended MAC for hostname. I: 25574 [DIS]Advertise operational node 224D0785BA8358D0-00000000000000B7 D: 25581 [DL]Using Thread extended MAC for hostname. I: 25586 [DIS]Advertise operational node B2B80C805C60FB9A-00000000000000AD I: 25592 [DL]advertising srp service: B2B80C805C60FB9A-00000000000000AD._matter._tcp I: 25600 [ZCL]OpCreds: successfully created fabric index 0x2 via AddNOC I: 25607 [EM]<<< [E:15356r S:46430 M:149948111 (Ack:245957194)] (S) Msg TX from 0000000000000000 to 2:FFFFFFFB00000000 [FB9A] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:09 (IM:InvokeCommandResponse) (B:70) I: 25628 [EM]??1 [E:15356r S:46430 M:149948111] (S) Msg Retransmission to 2:FFFFFFFB00000000 in 2044ms [State:Active II:300 AI:300 AT:4000] I: 25641 [EM]>>> [E:15355r S:46430 M:245957195 (Ack:149948109)] (S) Msg RX from 2:FFFFFFFB00000000 [FB9A] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 25815 [EM]>>> [E:15356r S:46430 M:245957196 (Ack:149948111)] (S) Msg RX from 2:FFFFFFFB00000000 [FB9A] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) D: 26978 [DL]SRP update succeeded I: 27069 [EM]>>> [E:15357r S:0 M:178539179] (U) Msg RX from 0:3496C287F29A540E [0000] to 0000000000000000 --- Type 0000:30 (SecureChannel:CASE_Sigma1) (B:166) I: 27083 [IN]CASE Server received Sigma1 message . Starting handshake. EC 0x20006590 I: 27090 [EM]<<< [E:15357r S:0 M:141235389 (Ack:178539179)] (U) Msg TX from 0000000000000000 to 0:3496C287F29A540E [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26) I: 27111 [SC]Received Sigma1 msg I: 27122 [SC]CASE matched destination ID: fabricIndex 2, NodeID 0x00000000000000AD I: 27144 [EM]<<< [E:15357r S:0 M:141235390 (Ack:178539179)] (U) Msg TX from 0000000000000000 to 0:3496C287F29A540E [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:31 (SecureChannel:CASE_Sigma2) (B:751) I: 27165 [EM]??1 [E:15357r S:0 M:141235390] (U) Msg Retransmission to 0:0000000000000000 in 2083ms [State:Active II:500 AI:300 AT:4000] I: 27178 [SC]Sent Sigma2 msg I: 27650 [EM]>>> [E:15357r S:0 M:178539180 (Ack:141235390)] (U) Msg RX from 0:3496C287F29A540E [0000] to 0000000000000000 --- Type 0000:32 (SecureChannel:CASE_Sigma3) (B:595) I: 27666 [EM]<<< [E:15357r S:0 M:141235391 (Ack:178539180)] (U) Msg TX from 0000000000000000 to 0:3496C287F29A540E [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26) I: 27686 [SC]Received Sigma3 msg E: 27691 [SC]The device does not support GetClock_RealTimeMS() API: 3. Falling back to Last Known Good UTC Time I: 27714 [EM]<<< [E:15357r S:0 M:141235392 (Ack:178539180)] (U) Msg TX from 0000000000000000 to 0:3496C287F29A540E [0000] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:40 (SecureChannel:StatusReport) (B:34) I: 27734 [EM]??1 [E:15357r S:0 M:141235392] (U) Msg Retransmission to 0:0000000000000000 in 2088ms [State:Active II:500 AI:300 AT:4000] I: 27748 [SC]SecureSession[0x200045d8, LSID:46429]: State change 'kEstablishing' --> 'kActive' D: 27756 [IN]SecureSession[0x200045d8]: Activated - Type:2 LSID:46429 D: 27762 [IN]New secure session activated for device <0000000000000001, 2>, LSID:46429 PSID:29170! I: 27771 [IN]CASE Session established to peer: <0000000000000001, 2> D: 27777 [IN]SecureSession[0x200046b0]: Allocated Type:2 LSID:46431 I: 27855 [EM]>>> [E:15358r S:46429 M:255360142] (S) Msg RX from 2:0000000000000001 [FB9A] to 00000000000000AD --- Type 0001:08 (IM:InvokeCommandRequest) (B:59) I: 27870 [FS]GeneralCommissioning: Received CommissioningComplete I: 27886 [FP]Metadata for Fabric 0x2 persisted to storage. I: 27898 [TS]Committing Last Known Good Time to storage: 2023-10-14T01:16:48 I: 27906 [ZCL]OpCreds: Fabric index 0x2 was committed to storage. Compressed Fabric Id 0xB2B80C805C60FB9A, FabricId 0000000000000001, NodeId 00000000000000AD, VendorId 0x1467 I: 27922 [FS]GeneralCommissioning: Successfully commited pending fabric data I: 27929 [FS]Fail-safe cleanly disarmed I: 27933 [EM]<<< [E:15358r S:46429 M:173679028 (Ack:255360142)] (S) Msg TX from 00000000000000AD to 2:0000000000000001 [FB9A] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:09 (IM:InvokeCommandResponse) (B:70) I: 27954 [EM]??1 [E:15358r S:46429 M:173679028] (S) Msg Retransmission to 2:0000000000000001 in 2107ms [State:Active II:300 AI:300 AT:4000] I: 27966 [SVR]Commissioning completed successfully I: 27971 [DIS]Updating services using commissioning mode 0 D: 27976 [DL]Using Thread extended MAC for hostname. I: 27981 [DIS]Advertise operational node 224D0785BA8358D0-00000000000000B7 D: 27987 [DL]Using Thread extended MAC for hostname. I: 27992 [DIS]Advertise operational node B2B80C805C60FB9A-00000000000000AD D: 27999 [IN]Expiring all PASE sessions D: 28002 [IN]SecureSession[0x20004428]: MarkForEviction Type:1 LSID:46430 I: 28009 [SC]SecureSession[0x20004428, LSID:46430]: State change 'kActive' --> 'kPendingEviction' D: 28017 [IN]SecureSession[0x20004428]: Released - Type:1 LSID:46430 I: 28023 [SWU]Device commissioned, schedule a default provider query I: 28031 [EM]>>> [E:15357r S:0 M:178539181 (Ack:141235392)] (U) Msg RX from 0:3496C287F29A540E [0000] to 0000000000000000 --- Type 0000:10 (SecureChannel:StandaloneAck) (B:26) I: 28086 [EM]>>> [E:15358r S:46429 M:255360143 (Ack:173679028)] (S) Msg RX from 2:0000000000000001 [FB9A] to 00000000000000AD --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 29313 [EM]>>> [E:15359r S:46429 M:255360144] (S) Msg RX from 2:0000000000000001 [FB9A] to 00000000000000AD --- Type 0001:02 (IM:ReadRequest) (B:84) D: 29326 [IM]Received Read request I: 29331 [EM]<<< [E:15359r S:46429 M:173679029 (Ack:255360144)] (S) Msg TX from 00000000000000AD to 2:0000000000000001 [FB9A] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:05 (IM:ReportData) (B:178) I: 29351 [EM]??1 [E:15359r S:46429 M:173679029] (S) Msg Retransmission to 2:0000000000000001 in 2071ms [State:Active II:300 AI:300 AT:4000] I: 29518 [EM]>>> [E:15359r S:46429 M:255360145 (Ack:173679029)] (S) Msg RX from 2:0000000000000001 [FB9A] to 00000000000000AD --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) I: 29552 [EM]>>> [E:15360r S:46429 M:255360146] (S) Msg RX from 2:0000000000000001 [FB9A] to 00000000000000AD --- Type 0001:03 (IM:SubscribeRequest) (B:53) D: 29565 [IM]Received Subscribe request I: 29569 [DMG]Final negotiated min/max parameters: Min = 1s, Max = 120s I: 29582 [EM]<<< [E:15360r S:46429 M:173679030 (Ack:255360146)] (S) Msg TX from 00000000000000AD to 2:0000000000000001 [FB9A] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:05 (IM:ReportData) (B:1206) I: 29602 [EM]??1 [E:15360r S:46429 M:173679030] (S) Msg Retransmission to 2:0000000000000001 in 2112ms [State:Active II:300 AI:300 AT:4000] I: 29947 [EM]>>> [E:15360r S:46429 M:255360147 (Ack:173679030)] (S) Msg RX from 2:0000000000000001 [FB9A] to 00000000000000AD --- Type 0001:01 (IM:StatusResponse) (B:42) I: 29962 [IM]Received status response, status is 0x00 I: 29973 [EM]<<< [E:15360r S:46429 M:173679031 (Ack:255360147)] (S) Msg TX from 00000000000000AD to 2:0000000000000001 [FB9A] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:05 (IM:ReportData) (B:1200) I: 29993 [EM]??1 [E:15360r S:46429 M:173679031] (S) Msg Retransmission to 2:0000000000000001 in 2065ms [State:Active II:300 AI:300 AT:4000] I: 30347 [EM]>>> [E:15360r S:46429 M:255360148 (Ack:173679031)] (S) Msg RX from 2:0000000000000001 [FB9A] to 00000000000000AD --- Type 0001:01 (IM:StatusResponse) (B:42) I: 30362 [IM]Received status response, status is 0x00 I: 30371 [EM]<<< [E:15360r S:46429 M:173679032 (Ack:255360148)] (S) Msg TX from 00000000000000AD to 2:0000000000000001 [FB9A] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:05 (IM:ReportData) (B:753) I: 30391 [EM]??1 [E:15360r S:46429 M:173679032] (S) Msg Retransmission to 2:0000000000000001 in 2054ms [State:Active II:300 AI:300 AT:4000] I: 30747 [EM]>>> [E:15360r S:46429 M:255360149 (Ack:173679032)] (S) Msg RX from 2:0000000000000001 [FB9A] to 00000000000000AD --- Type 0001:01 (IM:StatusResponse) (B:42) I: 30762 [IM]Received status response, status is 0x00 I: 30769 [EM]<<< [E:15360r S:46429 M:173679033 (Ack:255360149)] (S) Msg TX from 00000000000000AD to 2:0000000000000001 [FB9A] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:05 (IM:ReportData) (B:982) I: 30789 [EM]??1 [E:15360r S:46429 M:173679033] (S) Msg Retransmission to 2:0000000000000001 in 2057ms [State:Active II:300 AI:300 AT:4000] I: 31147 [EM]>>> [E:15360r S:46429 M:255360150 (Ack:173679033)] (S) Msg RX from 2:0000000000000001 [FB9A] to 00000000000000AD --- Type 0001:01 (IM:StatusResponse) (B:42) I: 31162 [IM]Received status response, status is 0x00 I: 31171 [EM]<<< [E:15360r S:46429 M:173679034 (Ack:255360150)] (S) Msg TX from 00000000000000AD to 2:0000000000000001 [FB9A] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:05 (IM:ReportData) (B:793) I: 31191 [EM]??1 [E:15360r S:46429 M:173679034] (S) Msg Retransmission to 2:0000000000000001 in 2078ms [State:Active II:300 AI:300 AT:4000] I: 31549 [EM]>>> [E:15360r S:46429 M:255360151 (Ack:173679034)] (S) Msg RX from 2:0000000000000001 [FB9A] to 00000000000000AD --- Type 0001:01 (IM:StatusResponse) (B:42) I: 31564 [IM]Received status response, status is 0x00 I: 31569 [EM]<<< [E:15360r S:46429 M:173679035 (Ack:255360151)] (S) Msg TX from 00000000000000AD to 2:0000000000000001 [FB9A] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:04 (IM:SubscribeResponse) (B:48) I: 31589 [EM]??1 [E:15360r S:46429 M:173679035] (S) Msg Retransmission to 2:0000000000000001 in 2090ms [State:Active II:300 AI:300 AT:4000] I: 31602 [DMG]Registered a ReadHandler that will schedule a report between system Timestamp: 0x0000000000007F5A and system Timestamp 0x0000000000025032. I: 31747 [EM]>>> [E:15360r S:46429 M:255360152 (Ack:173679035)] (S) Msg RX from 2:0000000000000001 [FB9A] to 00000000000000AD --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) E: 58029 [SWU]No suitable OTA Provider candidate found I: 58034 [SWU]No provider available I: 151604 [EM]<<< [E:41824i S:46429 M:173679036] (S) Msg TX from 00000000000000AD to 2:0000000000000001 [FB9A] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0001:05 (IM:ReportData) (B:41) I: 151623 [EM]??1 [E:41824i S:46429 M:173679036] (S) Msg Retransmission to 2:0000000000000001 in 2058ms [State:Idle II:300 AI:300 AT:4000] I: 151841 [EM]>>> [E:41824i S:46429 M:255360153 (Ack:173679036)] (S) Msg RX from 2:0000000000000001 [FB9A] to 00000000000000AD --- Type 0001:01 (IM:StatusResponse) (B:42) I: 151856 [IM]Received status response, status is 0x00 I: 151861 [EM]<<< [E:41824i S:46429 M:173679037 (Ack:255360153)] (S) Msg TX from 00000000000000AD to 2:0000000000000001 [FB9A] [UDP:[fd41:d894:feb0:1:670b:b1a2:d8fa:2a52]:33263] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34)
I'm not specially use the CHIP tool in CLI for commissioning.
Just to know how do you do the commissioning when integrating the version 1.4 in your new devices. I mean, do you use a hub or you have a custom border router ?
Hi,
S MOUNZEO said:Just to know how do you do the commissioning when integrating the version 1.4 in your new devices. I mean, do you use a hub or you have a custom border router ?
The Google Nest Hub Max supports Thread and can act as the border router, so you do not need a separate border router.
Have you added the Vendor ID and Product ID used in the application in the Google Home Developer Console? Since the samples use test IDs, the Google Home ecosystem requires that they are added in the Developer Console of the same Google account as you are using in the Google Home application and on the hub.
This blog post explains how to test with commercial ecosystems, such as Google: Matter: Testing the nRF Connect platform with Apple, Google and Samsung ecosystems
Best regards,
Marte
HI,
the problem, is now solved. The matter objet was not correctly generated and that's the main reason my device was not commissioned correctly.
Thanks.
