| # Copyright (c) 2021 Project CHIP Authors |
| # |
| # Licensed under the Apache License, Version 2.0 (the "License"); |
| # you may not use this file except in compliance with the License. |
| # You may obtain a copy of the License at |
| # |
| # http://www.apache.org/licenses/LICENSE-2.0 |
| # |
| # Unless required by applicable law or agreed to in writing, software |
| # distributed under the License is distributed on an "AS IS" BASIS, |
| # WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied. |
| # See the License for the specific language governing permissions and |
| # limitations under the License. |
| # Auto-generated scripts for harness use only, please review before automation. The endpoints and cluster names are currently set to default |
| |
| name: |
| 3.3.6. [TC-DD-3.6] Commissioning Flow - Non-concurrent [DUT - Commissioner] |
| |
| PICS: |
| - MCORE.ROLE.COMMISSIONER |
| |
| config: |
| nodeId: 0x12344321 |
| cluster: "Basic Information" |
| endpoint: 0 |
| |
| tests: |
| - label: "Note" |
| verification: | |
| Chip-tool command used below are an example to verify the DUT as commissioner test cases. For certification test, we expect DUT should have a capability or way to run the equivalent command. |
| Test Harness is a Commissionee device that is not connected to an operational network (i.e. Wi-Fi, or Ethernet) and is configured as a Non-concurrent device. |
| disabled: true |
| |
| - label: "Preconditions" |
| verification: | |
| 1 - 5.5 - Commissioner is on a network. - The network can either be WiFi or Thread. |
| |
| 2 - 5.5 - Commissionee is not connected to an operational network |
| disabled: true |
| |
| - label: |
| "Step 1: Commissioner has regulatory and fabric information available |
| and has accurate date, time and timezone" |
| verification: | |
| 1. Manually verify that the time, date and timezone is accurate for the DUT Commissioner |
| disabled: true |
| |
| - label: |
| "Step 2: Commissioner and Commissionee discover each other and connect |
| via the discovery mode applicable for the DUT." |
| verification: | |
| Verify in TH (ALL-CLUSTER-APP) start BLE Advertising by specific DUT implementation |
| |
| Verify in DUT(CHIP-TOOL) start commissioning process (either Thread or WiFi) |
| |
| ./chip-tool pairing ble-thread 1 hex:0e080000000000010000000300000f35060004001fffe0020811111111222222220708fd27e57b1b1e22d9051000112233445566778899aabbccddeeff030e4f70656e54687265616444656d6f01021234041061e1206d2c2b46e079eb775f41fc72190c0402a0fff8 20202021 3840 |
| ./chip-tool pairing ble-wifi <Node ID> <SSID> <password> 20202021 3840 |
| |
| disabled: true |
| |
| - label: |
| "Step 3: Establish encryption keys with Password Authenticated Session |
| Establishment on the commissioning channel" |
| verification: | |
| Verify in DUT as commissioner side |
| |
| CHIP:SC: Received PBKDF param response |
| disabled: true |
| |
| - label: |
| "Step 3a: Commissioner reads commissioning information, including |
| SupportsConcurrentConnection attribute from General Commissioining |
| Cluster" |
| verification: | |
| Verify in TH that SupportsConcurrentConnection is false |
| |
| CHIP:IM: Received Read request |
| CHIP:DMG: ReadRequestMessage = |
| CHIP:DMG: { |
| CHIP:DMG: AttributePathIBs = |
| CHIP:DMG: [ |
| CHIP:DMG: AttributePathIB = |
| CHIP:DMG: { |
| CHIP:DMG: Endpoint = 0x0, |
| CHIP:DMG: Cluster = 0x30, |
| CHIP:DMG: Attribute = 0x0000_0004, |
| CHIP:DMG: } |
| CHIP:DMG: |
| CHIP:DMG: isFabricFiltered = false, |
| CHIP:DMG: InteractionModelRevision = 11 |
| CHIP:DMG: }, |
| disabled: true |
| |
| - label: |
| "Step 4: Commissioner SHALL re-arm Fail-safe timer on Commissionee |
| within 60s (the autonomously Fail-safe timer length set by |
| Commissionee)" |
| verification: | |
| Verify in DUT as commissioner side |
| |
| CHIP:CTL: Arming failsafe (60 seconds) |
| disabled: true |
| |
| - label: |
| "Step 5: Commissioner SHALL configure regulatory information in the |
| Commissionee." |
| PICS: MCORE.COM.WIRELESS |
| verification: | |
| Verify in DUT as commissioner side |
| |
| Performing next commissioning step 'ConfigRegulatory' |
| [1653471968.202645][30157:30162] CHIP:CTL: Setting Regulatory Config |
| [1653471968.202666][30157:30162] CHIP:CTL: No regulatory config supplied by controller, leaving as device default (0) |
| |
| Verify in TH as commissionee side |
| NVS set: chip-config/regulatory-location = 0 (0x0) |
| disabled: true |
| |
| - label: |
| "Step 6: Commissioner requests operational CSR from Commissionee with |
| OperationalCSRRequest command" |
| verification: | |
| Verify in DUT as commissioner side |
| |
| CHIP:CTL: Sending CSR request to 0xffffa4001730 device |
| CHIP:DMG: ICR moving to [AddingComm] |
| CHIP:DMG: ICR moving to [AddedComma] |
| CHIP:IN: Prepared secure message 0xffffb9ba6db8 to 0x0000000000000001 (1) of type 0x8 and protocolId (0, 1) on exchange 45042i with MessageCounter:12011388. |
| CHIP:IN: Sending encrypted msg 0xffffb9ba6db8 with MessageCounter:12011388 to 0x0000000000000001 (1) at monotonic time: 304120 msec |
| CHIP:DMG: ICR moving to [CommandSen] |
| CHIP:CTL: Sent CSR request, waiting for the CSR |
| CHIP:DMG: ICR moving to [AwaitingDe] |
| CHIP:DL: HandlePlatformSpecificBLEEvent 16387 |
| CHIP:DL: Indication received, conn = 0xffffb0044210 |
| CHIP:DL: HandlePlatformSpecificBLEEvent 16389 |
| CHIP:DL: Indication received, conn = 0xffffb0044210 |
| CHIP:DL: HandlePlatformSpecificBLEEvent 16389 |
| CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:8508040 on exchange 45042i |
| CHIP:EM: Found matching exchange: 45042i, Delegate: 0xffffb0040000 |
| CHIP:DMG: ICR moving to [ResponseRe] |
| CHIP:DMG: InvokeResponseMessage = |
| CHIP:DMG: { |
| CHIP:DMG: suppressResponse = false, |
| CHIP:DMG: InvokeResponseIBs = |
| CHIP:DMG: [ |
| CHIP:DMG: InvokeResponseIB = |
| CHIP:DMG: { |
| CHIP:DMG: CommandDataIB = |
| CHIP:DMG: { |
| CHIP:DMG: CommandPathIB = |
| CHIP:DMG: { |
| CHIP:DMG: EndpointId = 0x0, |
| CHIP:DMG: ClusterId = 0x3e, |
| CHIP:DMG: CommandId = 0x5, |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: CommandData = |
| CHIP:DMG: { |
| CHIP:DMG: 0x0 = [ |
| CHIP:DMG: 0x15, 0x30, 0x1, 0xcd, 0x30, 0x81, 0xca, 0x30, 0x70, 0x2, 0x1, 0x0, 0x30, 0xe, 0x31, 0xc, 0x30, 0xa, 0x6, 0x3, 0x55, 0x4, 0xa, 0xc, 0x3, 0x43, 0x53, 0x52, 0x30, 0x59, 0x30, 0x13, 0x6, 0x7, 0x2a, 0x86, 0x48, 0xce, 0x3d, 0x2, 0x1, 0x6, 0x8, 0x2a, 0x86 |
| CHIP:DMG: ] |
| CHIP:DMG: 0x1 = [ |
| CHIP:DMG: 0xea, 0xd6, 0x96, 0x53, 0x4d, 0x46, 0x1d, 0xd6, 0xcc, 0x7f, 0x25, 0x50, 0x80, 0x4c, 0x2a, 0xe9, 0xc8, 0xb8, 0x1b, 0x34, 0xca, 0x98, 0x38, 0x42, 0x74, 0xc2, 0x13, 0xf4, 0x10, 0x4d, 0xa2, 0x44, 0x38, 0x98, 0x28, 0xb6, 0xb1, 0x94, 0x6b, 0xd, 0x29, 0x1b |
| CHIP:DMG: ] |
| CHIP:DMG: }, |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: ], |
| CHIP:DMG: |
| CHIP:DMG: InteractionModelRevision = 1 |
| CHIP:DMG: }, |
| CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0005 |
| CHIP:CTL: Received certificate signing request from the device |
| CHIP:CTL: Getting certificate chain for the device from the issuer |
| CHIP:CTL: Verifying Certificate Signing Request |
| CHIP:CTL: Generating NOC |
| CHIP:CTL: Providing certificate chain to the commissioner |
| CHIP:CTL: Received callback from the CA for NOC Chain generation. Status ../../src/controller/ExampleOperationalCredentialsIssuer.cpp:225: Success |
| disabled: true |
| |
| - label: |
| "Step 7: Commissioner configures operational credentials on DUT if not |
| previously installed" |
| verification: | |
| Verify in DUT as commissioner side |
| |
| [1651218829.220063][3273:3278] CHIP:CTL: Sending root certificate to the device |
| [1651218829.220201][3273:3278] CHIP:DMG: ICR moving to [AddingComm] |
| [1651218829.222415][3273:3278] CHIP:DMG: ICR moving to [AddedComma] |
| [1651218829.222549][3273:3278] CHIP:IN: Prepared secure message 0xffffb9ba6b98 to 0x0000000000000001 (1) of type 0x8 and protocolId (0, 1) on exchange 45043i with MessageCounter:12011389. |
| [1651218829.222616][3273:3278] CHIP:IN: Sending encrypted msg 0xffffb9ba6b98 with MessageCounter:12011389 to 0x0000000000000001 (1) at monotonic time: 305872 msec |
| [1651218829.222746][3273:3278] CHIP:DMG: ICR moving to [CommandSen] |
| [1651218829.222789][3273:3278] CHIP:CTL: Sent root certificate to the device |
| [1651218829.223121][3273:3278] CHIP:DMG: ICR moving to [AwaitingDe] |
| [1651218829.306861][3273:3278] CHIP:DL: HandlePlatformSpecificBLEEvent 16387 |
| [1651218829.404144][3273:3278] CHIP:DL: HandlePlatformSpecificBLEEvent 16387 |
| [1651218829.454121][3273:3276] CHIP:DL: Indication received, conn = 0xffffb0044210 |
| [1651218829.454352][3273:3278] CHIP:DL: HandlePlatformSpecificBLEEvent 16389 |
| CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:8508041 on exchange 45043i |
| CHIP:EM: Found matching exchange: 45043i, Delegate: 0xffffa400def0 |
| CHIP:DMG: ICR moving to [ResponseRe] |
| CHIP:DMG: InvokeResponseMessage = |
| CHIP:DMG: { |
| CHIP:DMG: suppressResponse = false, |
| CHIP:DMG: InvokeResponseIBs = |
| CHIP:DMG: [ |
| CHIP:DMG: InvokeResponseIB = |
| CHIP:DMG: { |
| CHIP:DMG: CommandStatusIB = |
| CHIP:DMG: { |
| CHIP:DMG: CommandPathIB = |
| CHIP:DMG: { |
| CHIP:DMG: EndpointId = 0x0, |
| CHIP:DMG: ClusterId = 0x3e, |
| CHIP:DMG: CommandId = 0xb, |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: StatusIB = |
| CHIP:DMG: { |
| CHIP:DMG: status = 0x0, |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: ], |
| CHIP:DMG: |
| CHIP:DMG: InteractionModelRevision = 1 |
| CHIP:DMG: }, |
| CHIP:DMG: Received Command Response Status for Endpoint=0 Cluster=0x0000_003E Command=0x0000_000B Status=0x0 |
| CHIP:CTL: Device confirmed that it has received the root certificate |
| disabled: true |
| |
| - label: |
| "Step 8: Commissioner configures itself as administrator in ACL on TH |
| if needed" |
| verification: | |
| Verify in DUT as commissioner side |
| |
| [1651218829.457248][3273:3278] CHIP:CTL: Sending operational certificate chain to the device |
| [1651218829.457372][3273:3278] CHIP:DMG: ICR moving to [AddingComm] |
| [1651218829.460013][3273:3278] CHIP:DMG: ICR moving to [AddedComma] |
| [1651218829.460273][3273:3278] CHIP:IN: Prepared secure message 0xffffb9ba7828 to 0x0000000000000001 (1) of type 0x8 and protocolId (0, 1) on exchange 45044i with MessageCounter:12011390. |
| [1651218829.460374][3273:3278] CHIP:IN: Sending encrypted msg 0xffffb9ba7828 with MessageCounter:12011390 to 0x0000000000000001 (1) at monotonic time: 306110 msec |
| [1651218829.460602][3273:3278] CHIP:DMG: ICR moving to [CommandSen] |
| [1651218829.460684][3273:3278] CHIP:CTL: Sent operational certificate to the device |
| [1651218829.460778][3273:3278] CHIP:DMG: ICR moving to [AwaitingDe] |
| [1651218829.550574][3273:3278] CHIP:DL: HandlePlatformSpecificBLEEvent 16387 |
| [1651218829.648065][3273:3278] CHIP:DL: HandlePlatformSpecificBLEEvent 16387 |
| [1651218829.745594][3273:3278] CHIP:DL: HandlePlatformSpecificBLEEvent 16387 |
| [1651218833.988087][3273:3276] CHIP:DL: Indication received, conn = 0xffffb0044210 |
| [1651218833.988336][3273:3278] CHIP:DL: HandlePlatformSpecificBLEEvent 16389 |
| [1651218833.988598][3273:3278] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:8508042 on exchange 45044i |
| CHIP:EM: Found matching exchange: 45044i, Delegate: 0xffffb0040000 |
| CHIP:DMG: ICR moving to [ResponseRe] |
| CHIP:DMG: InvokeResponseMessage = |
| CHIP:DMG: { |
| CHIP:DMG: suppressResponse = false, |
| CHIP:DMG: InvokeResponseIBs = |
| CHIP:DMG: [ |
| CHIP:DMG: InvokeResponseIB = |
| CHIP:DMG: { |
| CHIP:DMG: CommandDataIB = |
| CHIP:DMG: { |
| CHIP:DMG: CommandPathIB = |
| CHIP:DMG: { |
| CHIP:DMG: EndpointId = 0x0, |
| CHIP:DMG: ClusterId = 0x3e, |
| CHIP:DMG: CommandId = 0x8, |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: CommandData = |
| CHIP:DMG: { |
| CHIP:DMG: 0x0 = 0, |
| CHIP:DMG: 0x1 = 1, |
| CHIP:DMG: }, |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: ], |
| CHIP:DMG: |
| CHIP:DMG: InteractionModelRevision = 1 |
| CHIP:DMG: }, |
| CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_003E Command=0x0000_0008 |
| CHIP:CTL: Device returned status 0 on receiving the NOC |
| CHIP:CTL: Operational credentials provisioned on device 0xffffa4001730 |
| disabled: true |
| |
| - label: |
| "Step 9: Commissioner configures operational network on TH if TH both |
| supports and requires" |
| verification: | |
| Verify in DUT as commissioner side |
| |
| [1651218833.995054][3273:3278] CHIP:CTL: Adding thread network |
| [1651218833.995176][3273:3278] CHIP:DMG: ICR moving to [AddingComm] |
| [1651218833.995253][3273:3278] CHIP:DMG: ICR moving to [AddedComma] |
| [1651218833.995431][3273:3278] CHIP:IN: Prepared secure message 0xffffb9ba7848 to 0x0000000000000001 (1) of type 0x8 and protocolId (0, 1) on exchange 45045i with MessageCounter:12011391. |
| [1651218833.995523][3273:3278] CHIP:IN: Sending encrypted msg 0xffffb9ba7848 with MessageCounter:12011391 to 0x0000000000000001 (1) at monotonic time: 310645 msec |
| [1651218833.995723][3273:3278] CHIP:DMG: ICR moving to [CommandSen] |
| [1651218833.995823][3273:3278] CHIP:DMG: ICR moving to [AwaitingDe] |
| [1651218834.084548][3273:3278] CHIP:DL: HandlePlatformSpecificBLEEvent 16387 |
| [1651218834.134690][3273:3276] CHIP:DL: Indication received, conn = 0xffffb0044210 |
| [1651218834.134918][3273:3278] CHIP:DL: HandlePlatformSpecificBLEEvent 16389 |
| CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:8508043 on exchange 45045i |
| CHIP:EM: Found matching exchange: 45045i, Delegate: 0xffffa400def0 |
| CHIP:DMG: ICR moving to [ResponseRe] |
| CHIP:DMG: InvokeResponseMessage = |
| CHIP:DMG: { |
| CHIP:DMG: suppressResponse = false, |
| CHIP:DMG: InvokeResponseIBs = |
| CHIP:DMG: [ |
| CHIP:DMG: InvokeResponseIB = |
| CHIP:DMG: { |
| CHIP:DMG: CommandDataIB = |
| CHIP:DMG: { |
| CHIP:DMG: CommandPathIB = |
| CHIP:DMG: { |
| CHIP:DMG: EndpointId = 0x0, |
| CHIP:DMG: ClusterId = 0x31, |
| CHIP:DMG: CommandId = 0x5, |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: CommandData = |
| CHIP:DMG: { |
| CHIP:DMG: 0x0 = 0, |
| CHIP:DMG: 0x1 = "", |
| CHIP:DMG: }, |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: ], |
| CHIP:DMG: |
| CHIP:DMG: InteractionModelRevision = 1 |
| CHIP:DMG: }, |
| CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_0031 Command=0x0000_0005 |
| CHIP:CTL: Received NetworkConfig response |
| disabled: true |
| |
| - label: |
| "Step 10: Commissioner instructs Commissionee to connect to |
| operational network if not already connected" |
| verification: | |
| Verify in DUT as commissioner side |
| |
| [1651218834.137891][3273:3278] CHIP:CTL: Enabling thread network |
| [1651218834.138014][3273:3278] CHIP:DMG: ICR moving to [AddingComm] |
| [1651218834.138086][3273:3278] CHIP:DMG: ICR moving to [AddedComma] |
| [1651218834.138236][3273:3278] CHIP:IN: Prepared secure message 0xffffb9ba7938 to 0x0000000000000001 (1) of type 0x8 and protocolId (0, 1) on exchange 45046i with MessageCounter:12011392. |
| [1651218834.138325][3273:3278] CHIP:IN: Sending encrypted msg 0xffffb9ba7938 with MessageCounter:12011392 to 0x0000000000000001 (1) at monotonic time: 310788 msec |
| [1651218834.138522][3273:3278] CHIP:DMG: ICR moving to [CommandSen] |
| [1651218834.138628][3273:3278] CHIP:DMG: ICR moving to [AwaitingDe] |
| [1651218834.231701][3273:3278] CHIP:DL: HandlePlatformSpecificBLEEvent 16387 |
| [1651218834.426948][3273:3276] CHIP:DL: Indication received, conn = 0xffffb0044210 |
| [1651218834.427186][3273:3278] CHIP:DL: HandlePlatformSpecificBLEEvent 16389 |
| [1651218834.427443][3273:3278] CHIP:EM: Received message of type 0x9 with protocolId (0, 1) and MessageCounter:8508044 on exchange 45046i |
| CHIP:EM: Found matching exchange: 45046i, Delegate: 0xffffb0040000 |
| CHIP:DMG: ICR moving to [ResponseRe] |
| CHIP:DMG: InvokeResponseMessage = |
| CHIP:DMG: { |
| CHIP:DMG: suppressResponse = false, |
| CHIP:DMG: InvokeResponseIBs = |
| CHIP:DMG: [ |
| CHIP:DMG: InvokeResponseIB = |
| CHIP:DMG: { |
| CHIP:DMG: CommandDataIB = |
| CHIP:DMG: { |
| CHIP:DMG: CommandPathIB = |
| CHIP:DMG: { |
| CHIP:DMG: EndpointId = 0x0, |
| CHIP:DMG: ClusterId = 0x31, |
| CHIP:DMG: CommandId = 0x7, |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: CommandData = |
| CHIP:DMG: { |
| CHIP:DMG: 0x0 = 0, |
| CHIP:DMG: 0x1 = "", |
| CHIP:DMG: 0x2 = 0, |
| CHIP:DMG: }, |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: }, |
| CHIP:DMG: |
| CHIP:DMG: ], |
| CHIP:DMG: |
| CHIP:DMG: InteractionModelRevision = 1 |
| CHIP:DMG: }, |
| CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_0031 Command=0x0000_0007 |
| CHIP:CTL: Received ConnectNetwork response |
| disabled: true |
| |
| - label: |
| "Step 11: Commissioning channel between the Commissioner and |
| Commissionee is closed, operational channel started." |
| verification: | |
| Inferred by successful completion of Step 12 |
| disabled: true |
| |
| - label: |
| "Step 12: Commissioner starts discovery of TH using Operational |
| Discovery" |
| verification: | |
| Verify in DUT as commissioner side |
| |
| CHIP:CTL: Performing next commissioning step 'FindOperational' |
| CHIP:IN: Expiring all sessions for node <00000000000007CE, 1>!! |
| CHIP:CSM: FindOrEstablishSession: PeerId = [1:00000000000007CE] |
| CHIP:CSM: FindOrEstablishSession: No existing OperationalSessionSetup instance found |
| CHIP:DIS: OperationalSessionSetup[1:00000000000007CE]: State change 1 --> 2 |
| CHIP:DMG: ICR moving to [AwaitingDe] |
| CHIP:DIS: Checking node lookup status after 200 ms |
| CHIP:DL: HandlePlatformSpecificBLEEvent 16387 |
| CHIP:DIS: UDP:[fe80::e65f:1ff:fec2:47af%eth0]:5540: new best score: 7 |
| CHIP:DIS: Lookup clearing interface for non LL address |
| CHIP:DIS: UDP:172.16.62.113%eth0:5540: new best score: 2 |
| CHIP:DIS: Checking node lookup status after 7151 ms |
| CHIP:DIS: OperationalSessionSetup[1:00000000000007CE]: Updating device address to UDP:[fe80::e65f:1ff:fec2:47af%eth0]:5540 while in state 2 |
| CHIP:DIS: OperationalSessionSetup[1:00000000000007CE]: State change 2 --> 3 |
| CHIP:IN: SecureSession[0xffff7902f2c0]: Allocated Type:2 LSID:28474 |
| disabled: true |
| |
| - label: |
| "Step 13: Commissioner opens a CASE session with TH over operational |
| network" |
| verification: | |
| Verify in DUT as commissioner side |
| |
| CHIP:SC: Sent Sigma1 msg |
| CHIP:DIS: OperationalSessionSetup[1:00000000000007CE]: State change 3 --> 4 |
| CHIP:EM: Retransmitting MessageCounter:226454874 on exchange 11063i Send Cnt 1 |
| CHIP:EM: Retransmitting MessageCounter:226454874 on exchange 11063i Send Cnt 2 |
| CHIP:EM: Retransmitting MessageCounter:226454874 on exchange 11063i Send Cnt 3 |
| CHIP:EM: >>> [E:11063i S:0 M:192590746 (Ack:226454874)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:31 (SecureChannel:CASE_Sigma2) |
| CHIP:EM: Found matching exchange: 11063i, Delegate: 0xffff78207b08 |
| CHIP:EM: Rxd Ack; Removing MessageCounter:226454874 from Retrans Table on exchange 11063i |
| CHIP:SC: Received Sigma2 msg |
| CHIP:SC: Peer assigned session session ID 24240 |
| CHIP:SC: Found MRP parameters in the message |
| CHIP:SC: Sending Sigma3 |
| CHIP:EM: <<< [E:11063i S:0 M:226454875 (Ack:192590746)] (U) Msg TX to 0:0000000000000000 [0000] [UDP:[fe80::e65f:1ff:fec2:47af%eth0]:5540] --- Type 0000:32 (SecureChannel:CASE_Sigma3) |
| CHIP:SC: Sent Sigma3 msg |
| CHIP:EM: >>> [E:11063i S:0 M:192590747 (Ack:226454875)] (U) Msg RX from 0:0000000000000000 [0000] --- Type 0000:40 (SecureChannel:StatusReport) |
| CHIP:EM: Found matching exchange: 11063i, Delegate: 0xffff78207b08 |
| CHIP:EM: Rxd Ack; Removing MessageCounter:226454875 from Retrans Table on exchange 11063i |
| CHIP:SC: Success status report received. Session was established |
| CHIP:SC: SecureSession[0xffff7902f2c0, LSID:28474]: State change 'kEstablishing' --> 'kActive' |
| CHIP:IN: SecureSession[0xffff7902f2c0]: Activated - Type:2 LSID:28474 |
| CHIP:IN: New secure session activated for device <00000000000007CE, 1>, LSID:28474 PSID:24240! |
| CHIP:DIS: OperationalSessionSetup[1:00000000000007CE]: State change 4 --> 5 |
| CHIP:CTL: Successfully finished commissioning step 'FindOperational' disabled: true |
| disabled: true |
| |
| - label: "Step 14: Commissioner sends CommissioningComplete command" |
| verification: | |
| Verify in DUT as commissioner side |
| |
| CHIP:DMG: Received Command Response Data, Endpoint=0 Cluster=0x0000_0030 Command=0x0000_0005 |
| CHIP:CTL: Received CommissioningComplete response, errorCode=0 |
| CHIP:CTL: Successfully finished commissioning step 'SendComplete' |
| disabled: true |
