| # 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: |
| 114.3.3. [TC-DRLK-3.3] Verification for the Door Lock Events [DUT - Client] |
| |
| config: |
| nodeId: 0x12344321 |
| cluster: "Basic" |
| endpoint: 0 |
| |
| tests: |
| - label: "TH will initiate DoorLockAlarm Event (LockJammed scenario)" |
| PICS: DRLK.C.E00 |
| verification: | |
| ./chip-tool doorlock read-event door-lock-alarm 1 1 |
| |
| Verify DUT receives the DoorLockAlarm event on TH / lock app log: |
| |
| [1658143092.410930][3017:3023] CHIP:DMG: ReportDataMessage = |
| [1658143092.410964][3017:3023] CHIP:DMG: { |
| [1658143092.410994][3017:3023] CHIP:DMG: SuppressResponse = true, |
| [1658143092.411026][3017:3023] CHIP:DMG: InteractionModelRevision = 1 |
| [1658143092.411056][3017:3023] CHIP:DMG: } |
| |
| DUT/ChipTool log: |
| |
| [1658399559.467861][2474:2474] CHIP:IM: Received Read request |
| [1658399559.467960][2474:2474] CHIP:DMG: ReadRequestMessage = |
| [1658399559.467994][2474:2474] CHIP:DMG: { |
| [1658399559.468022][2474:2474] CHIP:DMG: EventPathIBs = |
| [1658399559.468054][2474:2474] CHIP:DMG: [ |
| [1658399559.468084][2474:2474] CHIP:DMG: EventPath = |
| [1658399559.468118][2474:2474] CHIP:DMG: { |
| [1658399559.468154][2474:2474] CHIP:DMG: Endpoint = 0x1, |
| [1658399559.468200][2474:2474] CHIP:DMG: Cluster = 0x101, |
| [1658399559.468238][2474:2474] CHIP:DMG: Event = 0x0, |
| [1658399559.468274][2474:2474] CHIP:DMG: }, |
| [1658399559.468308][2474:2474] CHIP:DMG: |
| [1658399559.468337][2474:2474] CHIP:DMG: ], |
| [1658399559.468371][2474:2474] CHIP:DMG: |
| [1658399559.468403][2474:2474] CHIP:DMG: isFabricFiltered = true, |
| [1658399559.468434][2474:2474] CHIP:DMG: InteractionModelRevision = 1 |
| [1658399559.468463][2474:2474] CHIP:DMG: }, |
| [1658399559.468543][2474:2474] CHIP:DMG: IM RH moving to [GeneratingReports] |
| disabled: true |
| |
| - label: "DUT sends the Unlock Door command to the TH with valid PINCode" |
| PICS: DRLK.C.C01.Tx |
| verification: | |
| ./chip-tool doorlock set-user 0 1 xxx 6452 1 0 0 1 1 --timedInteractionTimeoutMs 1000 |
| |
| Verify Test Harness receives the Set User Door command from the DUT on TH / lock app log: |
| |
| [1658143230.937379][3029:3034] CHIP:DMG: StatusIB = |
| [1658143230.937412][3029:3034] CHIP:DMG: { |
| [1658143230.937446][3029:3034] CHIP:DMG: status = 0x00 (SUCCESS), |
| [1658143230.937478][3029:3034] CHIP:DMG: }, |
| |
| DUT/ChipTool log: |
| |
| [1658399917.774631][2474:2474] CHIP:DMG: CommandFields = |
| [1658399917.774662][2474:2474] CHIP:DMG: { |
| [1658399917.774694][2474:2474] CHIP:DMG: 0x0 = 0, |
| [1658399917.774727][2474:2474] CHIP:DMG: 0x1 = 1, |
| [1658399917.774763][2474:2474] CHIP:DMG: 0x2 = "xxx", |
| [1658399917.774799][2474:2474] CHIP:DMG: 0x3 = 6452, |
| [1658399917.774835][2474:2474] CHIP:DMG: 0x4 = 1, |
| [1658399917.774872][2474:2474] CHIP:DMG: 0x5 = 0, |
| [1658399917.774907][2474:2474] CHIP:DMG: 0x6 = 0, |
| [1658399917.774940][2474:2474] CHIP:DMG: }, |
| [1658399917.774968][2474:2474] CHIP:DMG: }, |
| [1658399917.775002][2474:2474] CHIP:DMG: |
| [1658399917.775025][2474:2474] CHIP:DMG: ], |
| [1658399917.775058][2474:2474] CHIP:DMG: |
| [1658399917.775082][2474:2474] CHIP:DMG: InteractionModelRevision = 1 |
| [1658399917.775107][2474:2474] CHIP:DMG: }, |
| [1658399917.775179][2474:2474] CHIP:DMG: AccessControl: checking f=1 a=c s=0x000000000001B669 t= c=0x0000_0101 e=1 p=a |
| [1658399917.775241][2474:2474] CHIP:DMG: AccessControl: allowed |
| [1658399917.775273][2474:2474] CHIP:DMG: Received command for Endpoint=1 Cluster=0x0000_0101 Command=0x0000_001A |
| [1658399917.775327][2474:2474] CHIP:ZCL: [SetUser] Incoming command [endpointId=1,userIndex=1] |
| |
| ./chip-tool doorlock set-credential 0 '{ "credentialType" : 1 , "credentialIndex" : 1 }' 123456 1 0 0 1 1 --timedInteractionTimeoutMs 1000 |
| |
| Verify Test Harness receives the Set Credential command from the DUT on TH / lock app log: |
| |
| [1658143318.915533][3039:3044] CHIP:DMG: }, |
| [1658143318.915609][3039:3044] CHIP:DMG: Received Command Response Data, Endpoint=1 Cluster=0x0000_0101 Command=0x0000_0023 |
| [1658143318.915705][3039:3044] CHIP:TOO: Endpoint: 1 Cluster: 0x0000_0101 Command 0x0000_0023 |
| [1658143318.915778][3039:3044] CHIP:TOO: SetCredentialResponse: { |
| [1658143318.915821][3039:3044] CHIP:TOO: status: 0 |
| [1658143318.915851][3039:3044] CHIP:TOO: userIndex: null |
| [1658143318.915880][3039:3044] CHIP:TOO: nextCredentialIndex: 2 |
| [1658143318.915909][3039:3044] CHIP:TOO: } |
| |
| DUT/ChipTool log: |
| |
| [1658400025.688730][2474:2474] CHIP:DMG: CommandFields = |
| [1658400025.688777][2474:2474] CHIP:DMG: { |
| [1658400025.688822][2474:2474] CHIP:DMG: 0x0 = 0, |
| [1658400025.688873][2474:2474] CHIP:DMG: 0x1 = |
| [1658400025.688922][2474:2474] CHIP:DMG: { |
| [1658400025.688964][2474:2474] CHIP:DMG: 0x0 = 1, |
| [1658400025.689016][2474:2474] CHIP:DMG: 0x1 = 1, |
| [1658400025.689058][2474:2474] CHIP:DMG: }, |
| [1658400025.689110][2474:2474] CHIP:DMG: 0x2 = [ |
| [1658400025.689161][2474:2474] CHIP:DMG: 0x31, 0x32, 0x33, 0x34, 0x35, 0x36, |
| [1658400025.689209][2474:2474] CHIP:DMG: ] |
| [1658400025.689261][2474:2474] CHIP:DMG: 0x3 = 1, |
| [1658400025.689312][2474:2474] CHIP:DMG: 0x4 = 0, |
| [1658400025.689353][2474:2474] CHIP:DMG: 0x5 = 0, |
| [1658400025.689403][2474:2474] CHIP:DMG: }, |
| [1658400025.689436][2474:2474] CHIP:DMG: }, |
| [1658400025.689477][2474:2474] CHIP:DMG: |
| [1658400025.689529][2474:2474] CHIP:DMG: ], |
| [1658400025.689575][2474:2474] CHIP:DMG: |
| [1658400025.689619][2474:2474] CHIP:DMG: InteractionModelRevision = 1 |
| [1658400025.689648][2474:2474] CHIP:DMG: }, |
| [1658400025.689747][2474:2474] CHIP:DMG: AccessControl: checking f=1 a=c s=0x000000000001B669 t= c=0x0000_0101 e=1 p=a |
| [1658400025.689802][2474:2474] CHIP:DMG: AccessControl: allowed |
| [1658400025.689836][2474:2474] CHIP:DMG: Received command for Endpoint=1 Cluster=0x0000_0101 Command=0x0000_0022 |
| [1658400025.689909][2474:2474] CHIP:ZCL: [SetCredential] Incoming command [endpointId=1] |
| |
| |
| ./chip-tool doorlock unlock-door 1 1 --timedInteractionTimeoutMs 1000 --PinCode 123456 |
| |
| Verify Test Harness receives the Unlock Door command from the DUT on TH / lock app log: |
| |
| [1658143429.670361][3057:3062] CHIP:DMG: }, |
| [1658143429.670411][3057:3062] CHIP:DMG: |
| [1658143429.670451][3057:3062] CHIP:DMG: StatusIB = |
| [1658143429.670498][3057:3062] CHIP:DMG: { |
| [1658143429.670548][3057:3062] CHIP:DMG: status = 0x00 (SUCCESS), |
| [1658143429.670593][3057:3062] CHIP:DMG: }, |
| [1658143429.670637][3057:3062] CHIP:DMG: |
| [1658143429.670681][3057:3062] CHIP:DMG: }, |
| [1658143429.670725][3057:3062] CHIP:DMG: |
| [1658143429.670759][3057:3062] CHIP:DMG: }, |
| [1658143429.670799][3057:3062] CHIP:DMG: |
| [1658143429.670829][3057:3062] CHIP:DMG: ], |
| [1658143429.670867][3057:3062] CHIP:DMG: |
| [1658143429.670896][3057:3062] CHIP:DMG: InteractionModelRevision = 1 |
| [1658143429.670926][3057:3062] CHIP:DMG: }, |
| |
| DUT/ChipTool log: |
| |
| [1658400115.693300][2474:2474] CHIP:DMG: CommandDataIB = |
| [1658400115.693328][2474:2474] CHIP:DMG: { |
| [1658400115.693353][2474:2474] CHIP:DMG: CommandPathIB = |
| [1658400115.693387][2474:2474] CHIP:DMG: { |
| [1658400115.693421][2474:2474] CHIP:DMG: EndpointId = 0x1, |
| [1658400115.693456][2474:2474] CHIP:DMG: ClusterId = 0x101, |
| [1658400115.693489][2474:2474] CHIP:DMG: CommandId = 0x1, |
| [1658400115.693519][2474:2474] CHIP:DMG: }, |
| [1658400115.693552][2474:2474] CHIP:DMG: |
| [1658400115.693579][2474:2474] CHIP:DMG: CommandFields = |
| [1658400115.693609][2474:2474] CHIP:DMG: { |
| [1658400115.693641][2474:2474] CHIP:DMG: 0x0 = [ |
| [1658400115.693675][2474:2474] CHIP:DMG: 0x31, 0x32, 0x33, 0x34, 0x35, 0x36, |
| [1658400115.693709][2474:2474] CHIP:DMG: ] |
| [1658400115.693742][2474:2474] CHIP:DMG: }, |
| [1658400115.693771][2474:2474] CHIP:DMG: }, |
| [1658400115.693801][2474:2474] CHIP:DMG: |
| [1658400115.693825][2474:2474] CHIP:DMG: ], |
| [1658400115.693855][2474:2474] CHIP:DMG: |
| [1658400115.693879][2474:2474] CHIP:DMG: InteractionModelRevision = 1 |
| [1658400115.693902][2474:2474] CHIP:DMG: }, |
| [1658400115.693971][2474:2474] CHIP:DMG: AccessControl: checking f=1 a=c s=0x000000000001B669 t= c=0x0000_0101 e=1 p=o |
| [1658400115.694008][2474:2474] CHIP:DMG: AccessControl: allowed |
| [1658400115.694035][2474:2474] CHIP:DMG: Received command for Endpoint=1 Cluster=0x0000_0101 Command=0x0000_0001 |
| [1658400115.694070][2474:2474] CHIP:ZCL: Received command: UnlockDoor |
| [1658400115.694114][2474:2474] CHIP:ZCL: Lock App: LockEndpoint::GetUser [endpoint=1,userIndex=1] |
| [1658400115.694139][2474:2474] CHIP:ZCL: Found occupied user [endpoint=1,adjustedIndex=0,name="xxx",credentialsCount=1,uniqueId=1934,type=0,credentialRule=0,createdBy=1,lastModifiedBy=1] |
| [1658400115.694212][2474:2474] CHIP:ZCL: Lock App: LockEndpoint::GetCredential [endpoint=1,credentialIndex=1,credentialType=1] |
| [1658400115.694240][2474:2474] CHIP:ZCL: Found occupied credential [endpoint=1,index=1,type=1,dataSize=6,createdBy=1,modifiedBy=1] |
| [1658400115.694266][2474:2474] CHIP:ZCL: Lock App: specified PIN code was found in the database, setting door lock state to "Unlocked" [endpointId=1] |
| disabled: true |
| |
| - label: "TH initiates DoorStateChange event with Doorstate set to DoorOpen" |
| PICS: DRLK.C.F05 && DRLK.C.E01 |
| verification: | |
| ./chip-tool doorlock read-event door-state-change 1 1 |
| |
| Verify DUT receives the DoorStateChange event on TH / lock app log: |
| |
| [1658143492.705309][3065:3070] CHIP:DMG: ReportDataMessage = |
| [1658143492.705348][3065:3070] CHIP:DMG: { |
| [1658143492.705374][3065:3070] CHIP:DMG: SuppressResponse = true, |
| [1658143492.705402][3065:3070] CHIP:DMG: InteractionModelRevision = 1 |
| [1658143492.705427][3065:3070] CHIP:DMG: } |
| |
| DUT/ChipTool log: |
| |
| [1658400265.159396][2474:2474] CHIP:IM: Received Read request |
| [1658400265.159485][2474:2474] CHIP:DMG: ReadRequestMessage = |
| [1658400265.159518][2474:2474] CHIP:DMG: { |
| [1658400265.159544][2474:2474] CHIP:DMG: EventPathIBs = |
| [1658400265.159574][2474:2474] CHIP:DMG: [ |
| [1658400265.159602][2474:2474] CHIP:DMG: EventPath = |
| [1658400265.159633][2474:2474] CHIP:DMG: { |
| [1658400265.159665][2474:2474] CHIP:DMG: Endpoint = 0x1, |
| [1658400265.159703][2474:2474] CHIP:DMG: Cluster = 0x101, |
| [1658400265.159738][2474:2474] CHIP:DMG: Event = 0x1, |
| [1658400265.159770][2474:2474] CHIP:DMG: }, |
| [1658400265.159803][2474:2474] CHIP:DMG: |
| [1658400265.159830][2474:2474] CHIP:DMG: ], |
| [1658400265.159862][2474:2474] CHIP:DMG: |
| [1658400265.159891][2474:2474] CHIP:DMG: isFabricFiltered = true, |
| [1658400265.159920][2474:2474] CHIP:DMG: InteractionModelRevision = 1 |
| [1658400265.159947][2474:2474] CHIP:DMG: }, |
| [1658400265.160024][2474:2474] CHIP:DMG: IM RH moving to [GeneratingReports] |
| disabled: true |
| |
| - label: "DUT sends the Lock Door command to the TH with valid PINCode" |
| PICS: DRLK.C.C00.Tx |
| verification: | |
| ./chip-tool doorlock lock-door 1 1 --timedInteractionTimeoutMs 1000 --PinCode 123456 |
| |
| Verify Test Harness receives the lock Door command from the DUT on TH / lock app log: |
| |
| [1658143612.854142][3083:3088] CHIP:DMG: |
| [1658143612.854178][3083:3088] CHIP:DMG: StatusIB = |
| [1658143612.854229][3083:3088] CHIP:DMG: { |
| [1658143612.854268][3083:3088] CHIP:DMG: status = 0x00 (SUCCESS), |
| [1658143612.854317][3083:3088] CHIP:DMG: }, |
| [1658143612.854365][3083:3088] CHIP:DMG: |
| [1658143612.854400][3083:3088] CHIP:DMG: }, |
| [1658143612.854448][3083:3088] CHIP:DMG: |
| [1658143612.854481][3083:3088] CHIP:DMG: }, |
| [1658143612.854528][3083:3088] CHIP:DMG: |
| [1658143612.854559][3083:3088] CHIP:DMG: ], |
| [1658143612.854604][3083:3088] CHIP:DMG: |
| [1658143612.854634][3083:3088] CHIP:DMG: InteractionModelRevision = 1 |
| [1658143612.854673][3083:3088] CHIP:DMG: }, |
| [1658143612.854756][3083:3088] CHIP:DMG: Received Command Response Status for Endpoint=1 Cluster=0x0000_0101 Command=0x0000_0000 Status=0x0 |
| |
| DUT/ChipTool log: |
| |
| [1658400315.379482][2474:2474] CHIP:DMG: CommandPathIB = |
| [1658400315.379524][2474:2474] CHIP:DMG: { |
| [1658400315.379559][2474:2474] CHIP:DMG: EndpointId = 0x1, |
| [1658400315.379608][2474:2474] CHIP:DMG: ClusterId = 0x101, |
| [1658400315.379650][2474:2474] CHIP:DMG: CommandId = 0x0, |
| [1658400315.379694][2474:2474] CHIP:DMG: }, |
| [1658400315.379734][2474:2474] CHIP:DMG: |
| [1658400315.379769][2474:2474] CHIP:DMG: CommandFields = |
| [1658400315.379807][2474:2474] CHIP:DMG: { |
| [1658400315.379845][2474:2474] CHIP:DMG: 0x0 = [ |
| [1658400315.379886][2474:2474] CHIP:DMG: 0x31, 0x32, 0x33, 0x34, 0x35, 0x36, |
| [1658400315.379931][2474:2474] CHIP:DMG: ] |
| [1658400315.379976][2474:2474] CHIP:DMG: }, |
| [1658400315.380010][2474:2474] CHIP:DMG: }, |
| [1658400315.380049][2474:2474] CHIP:DMG: |
| [1658400315.380079][2474:2474] CHIP:DMG: ], |
| [1658400315.380116][2474:2474] CHIP:DMG: |
| [1658400315.380145][2474:2474] CHIP:DMG: InteractionModelRevision = 1 |
| [1658400315.380174][2474:2474] CHIP:DMG: }, |
| [1658400315.380251][2474:2474] CHIP:DMG: AccessControl: checking f=1 a=c s=0x000000000001B669 t= c=0x0000_0101 e=1 p=o |
| [1658400315.380293][2474:2474] CHIP:DMG: AccessControl: allowed |
| [1658400315.380327][2474:2474] CHIP:DMG: Received command for Endpoint=1 Cluster=0x0000_0101 Command=0x0000_0000 |
| [1658400315.380369][2474:2474] CHIP:ZCL: Received command: LockDoor |
| [1658400315.380419][2474:2474] CHIP:ZCL: Lock App: LockEndpoint::GetUser [endpoint=1,userIndex=1] |
| [1658400315.380449][2474:2474] CHIP:ZCL: Found occupied user [endpoint=1,adjustedIndex=0,name="xxx",credentialsCount=1,uniqueId=1934,type=0,credentialRule=0,createdBy=1,lastModifiedBy=1] |
| [1658400315.380479][2474:2474] CHIP:ZCL: Lock App: LockEndpoint::GetCredential [endpoint=1,credentialIndex=1,credentialType=1] |
| [1658400315.380506][2474:2474] CHIP:ZCL: Found occupied credential [endpoint=1,index=1,type=1,dataSize=6,createdBy=1,modifiedBy=1] |
| [1658400315.380537][2474:2474] CHIP:ZCL: Lock App: specified PIN code was found in the database, setting door lock state to "Locked" [endpointId=1] |
| disabled: true |
| |
| - label: |
| "TH will initiate LockOperation event with LockOperationType to Lock" |
| PICS: DRLK.C.E02 |
| verification: | |
| ./chip-tool doorlock read-event lock-operation 1 1 |
| |
| Verify DUT receives the LockOperation event on TH / lock app log: |
| |
| [1658220863.460617][4105:4110] CHIP:DMG: } |
| [1658220863.460814][4105:4110] CHIP:TOO: Endpoint: 1 Cluster: 0x0000_0101 Event 0x0000_0002 |
| [1658220863.460844][4105:4110] CHIP:TOO: Event number: 5 |
| [1658220863.460869][4105:4110] CHIP:TOO: Priority: Critical |
| [1658220863.460894][4105:4110] CHIP:TOO: Timestamp: 12367237 |
| [1658220863.461015][4105:4110] CHIP:TOO: LockOperation: { |
| [1658220863.461057][4105:4110] CHIP:TOO: LockOperationType: 0 |
| [1658220863.461085][4105:4110] CHIP:TOO: OperationSource: 7 |
| [1658220863.461112][4105:4110] CHIP:TOO: UserIndex: 1 |
| [1658220863.461139][4105:4110] CHIP:TOO: FabricIndex: 1 |
| [1658220863.461169][4105:4110] CHIP:TOO: SourceNode: 112233 |
| [1658220863.461202][4105:4110] CHIP:TOO: Credentials: 1 entries |
| [1658220863.461242][4105:4110] CHIP:TOO: [1]: { |
| [1658220863.461269][4105:4110] CHIP:TOO: CredentialType: 1 |
| [1658220863.461296][4105:4110] CHIP:TOO: CredentialIndex: 1 |
| [1658220863.461321][4105:4110] CHIP:TOO: } |
| [1658220863.461348][4105:4110] CHIP:TOO: } |
| |
| DUT/ChipTool log: |
| |
| [1658400639.617399][3227:3227] CHIP:IM: Received Read request |
| [1658400639.617491][3227:3227] CHIP:DMG: ReadRequestMessage = |
| [1658400639.617535][3227:3227] CHIP:DMG: { |
| [1658400639.617561][3227:3227] CHIP:DMG: EventPathIBs = |
| [1658400639.617592][3227:3227] CHIP:DMG: [ |
| [1658400639.617632][3227:3227] CHIP:DMG: EventPath = |
| [1658400639.617669][3227:3227] CHIP:DMG: { |
| [1658400639.617716][3227:3227] CHIP:DMG: Endpoint = 0x1, |
| [1658400639.617765][3227:3227] CHIP:DMG: Cluster = 0x101, |
| [1658400639.617801][3227:3227] CHIP:DMG: Event = 0x2, |
| [1658400639.617843][3227:3227] CHIP:DMG: }, |
| [1658400639.617878][3227:3227] CHIP:DMG: |
| [1658400639.617916][3227:3227] CHIP:DMG: ], |
| [1658400639.617949][3227:3227] CHIP:DMG: |
| [1658400639.617988][3227:3227] CHIP:DMG: isFabricFiltered = true, |
| [1658400639.618016][3227:3227] CHIP:DMG: InteractionModelRevision = 1 |
| [1658400639.618055][3227:3227] CHIP:DMG: }, |
| [1658400639.618145][3227:3227] CHIP:DMG: IM RH moving to [GeneratingReports] |
| [1658400639.618271][3227:3227] CHIP:DMG: Building Reports for ReadHandler with LastReportGeneration = 0 DirtyGeneration = 0 |
| [1658400639.618520][3227:3227] CHIP:DMG: AccessControl: checking f=1 a=c s=0x000000000001B669 t= c=0x0000_0101 e=1 p=v |
| [1658400639.618573][3227:3227] CHIP:DMG: AccessControl: allowed |
| [1658400639.618651][3227:3227] CHIP:DMG: Fetched 1 events |
| disabled: true |
| |
| - label: "DUT sends the Unlock Door command to the TH with Invalid PINCode" |
| PICS: DRLK.C.C01.Tx |
| verification: | |
| ./chip-tool doorlock unlock-door 1 1 --timedInteractionTimeoutMs 1000 --PinCode 12345678 |
| |
| Verify Test Harness receives the Unlock Door command from the DUT on TH / lock app log: |
| |
| [1658143767.123426][3101:3106] CHIP:DMG: }, |
| [1658143767.123464][3101:3106] CHIP:DMG: |
| [1658143767.123493][3101:3106] CHIP:DMG: StatusIB = |
| [1658143767.123527][3101:3106] CHIP:DMG: { |
| [1658143767.123559][3101:3106] CHIP:DMG: status = 0x01 (FAILURE), |
| [1658143767.123592][3101:3106] CHIP:DMG: }, |
| [1658143767.123626][3101:3106] CHIP:DMG: |
| [1658143767.123684][3101:3106] CHIP:DMG: }, |
| [1658143767.123720][3101:3106] CHIP:DMG: |
| [1658143767.123748][3101:3106] CHIP:DMG: }, |
| [1658143767.123780][3101:3106] CHIP:DMG: |
| [1658143767.123804][3101:3106] CHIP:DMG: ], |
| [1658143767.123834][3101:3106] CHIP:DMG: |
| [1658143767.123859][3101:3106] CHIP:DMG: InteractionModelRevision = 1 |
| [1658143767.123883][3101:3106] CHIP:DMG: }, |
| [1658143767.123943][3101:3106] CHIP:DMG: Received Command Response Status for Endpoint=1 Cluster=0x0000_0101 Command=0x0000_0001 Status=0x1 |
| [1658143767.123978][3101:3106] CHIP:TOO: Error: IM Error 0x00000501: General error: 0x01 (FAILURE) |
| |
| |
| DUT/ChipTool log: |
| |
| [1658400708.187116][3227:3227] CHIP:DMG: CommandPathIB = |
| [1658400708.187205][3227:3227] CHIP:DMG: { |
| [1658400708.187337][3227:3227] CHIP:DMG: EndpointId = 0x1, |
| [1658400708.187439][3227:3227] CHIP:DMG: ClusterId = 0x101, |
| [1658400708.187540][3227:3227] CHIP:DMG: CommandId = 0x1, |
| [1658400708.187637][3227:3227] CHIP:DMG: }, |
| [1658400708.187729][3227:3227] CHIP:DMG: |
| [1658400708.187806][3227:3227] CHIP:DMG: CommandFields = |
| [1658400708.187894][3227:3227] CHIP:DMG: { |
| [1658400708.187983][3227:3227] CHIP:DMG: 0x0 = [ |
| [1658400708.188083][3227:3227] CHIP:DMG: 0x31, 0x32, 0x33, 0x34, 0x35, 0x36, 0x37, 0x38, |
| [1658400708.188205][3227:3227] CHIP:DMG: ] |
| [1658400708.188311][3227:3227] CHIP:DMG: }, |
| [1658400708.188400][3227:3227] CHIP:DMG: }, |
| [1658400708.188481][3227:3227] CHIP:DMG: |
| [1658400708.188544][3227:3227] CHIP:DMG: ], |
| [1658400708.188615][3227:3227] CHIP:DMG: |
| [1658400708.188672][3227:3227] CHIP:DMG: InteractionModelRevision = 1 |
| [1658400708.188743][3227:3227] CHIP:DMG: }, |
| [1658400708.188836][3227:3227] CHIP:DMG: AccessControl: checking f=1 a=c s=0x000000000001B669 t= c=0x0000_0101 e=1 p=o |
| [1658400708.188891][3227:3227] CHIP:DMG: AccessControl: allowed |
| disabled: true |
| |
| - label: |
| "TH will initiate LockOperationError event by causing Lock error using |
| invalid PIN" |
| PICS: DRLK.C.E03 |
| verification: | |
| ./chip-tool doorlock read-event lock-operation-error 1 1 |
| |
| Verify DUT receives the LockOperationError event on TH / lock app log: |
| |
| [1658221172.148732][4132:4137] CHIP:TOO: Endpoint: 1 Cluster: 0x0000_0101 Event 0x0000_0003 |
| [1658221172.148764][4132:4137] CHIP:TOO: Event number: 6 |
| [1658221172.148790][4132:4137] CHIP:TOO: Priority: Critical |
| [1658221172.148815][4132:4137] CHIP:TOO: Timestamp: 12682848 |
| [1658221172.148936][4132:4137] CHIP:TOO: LockOperationError: { |
| [1658221172.149056][4132:4137] CHIP:TOO: LockOperationType: 1 |
| [1658221172.149085][4132:4137] CHIP:TOO: OperationSource: 7 |
| [1658221172.149112][4132:4137] CHIP:TOO: OperationError: 1 |
| [1658221172.149139][4132:4137] CHIP:TOO: UserIndex: 0 |
| [1658221172.149166][4132:4137] CHIP:TOO: FabricIndex: 1 |
| [1658221172.149197][4132:4137] CHIP:TOO: SourceNode: 112233 |
| [1658221172.149233][4132:4137] CHIP:TOO: Credentials: 1 entries |
| [1658221172.149272][4132:4137] CHIP:TOO: [1]: { |
| [1658221172.149300][4132:4137] CHIP:TOO: CredentialType: 1 |
| [1658221172.149327][4132:4137] CHIP:TOO: CredentialIndex: 0 |
| [1658221172.149353][4132:4137] CHIP:TOO: } |
| [1658221172.149380][4132:4137] CHIP:TOO: } |
| |
| DUT/ChipTool log: |
| |
| [1658400788.866836][3227:3227] CHIP:IM: Received Read request |
| [1658400788.866927][3227:3227] CHIP:DMG: ReadRequestMessage = |
| [1658400788.866961][3227:3227] CHIP:DMG: { |
| [1658400788.867001][3227:3227] CHIP:DMG: EventPathIBs = |
| [1658400788.867033][3227:3227] CHIP:DMG: [ |
| [1658400788.867059][3227:3227] CHIP:DMG: EventPath = |
| [1658400788.867099][3227:3227] CHIP:DMG: { |
| [1658400788.867130][3227:3227] CHIP:DMG: Endpoint = 0x1, |
| [1658400788.867171][3227:3227] CHIP:DMG: Cluster = 0x101, |
| [1658400788.867205][3227:3227] CHIP:DMG: Event = 0x3, |
| [1658400788.867271][3227:3227] CHIP:DMG: }, |
| [1658400788.867304][3227:3227] CHIP:DMG: |
| [1658400788.867330][3227:3227] CHIP:DMG: ], |
| [1658400788.867359][3227:3227] CHIP:DMG: |
| [1658400788.867385][3227:3227] CHIP:DMG: isFabricFiltered = true, |
| [1658400788.867414][3227:3227] CHIP:DMG: InteractionModelRevision = 1 |
| [1658400788.867439][3227:3227] CHIP:DMG: }, |
| [1658400788.867515][3227:3227] CHIP:DMG: IM RH moving to [GeneratingReports] |
| [1658400788.867623][3227:3227] CHIP:DMG: Building Reports for ReadHandler with LastReportGeneration = 0 DirtyGeneration = 0 |
| [1658400788.867883][3227:3227] CHIP:DMG: AccessControl: checking f=1 a=c s=0x000000000001B669 t= c=0x0000_0101 e=1 p=v |
| [1658400788.867931][3227:3227] CHIP:DMG: AccessControl: allowed |
| [1658400788.868004][3227:3227] CHIP:DMG: Fetched 1 events |
| disabled: true |
| |
| - label: "DUT sends Set User command to TH" |
| PICS: DRLK.C.F08 && DRLK.C.C1a.Tx |
| verification: | |
| ./chip-tool doorlock set-user 0 3 xxx 6452 1 0 0 1 1 --timedInteractionTimeoutMs 1000 |
| |
| Verify Test Harness receives the Set User Door command from the DUT on TH / lock app log: |
| |
| [1658143964.643101][3139:3144] CHIP:DMG: |
| [1658143964.643137][3139:3144] CHIP:DMG: StatusIB = |
| [1658143964.643179][3139:3144] CHIP:DMG: { |
| [1658143964.643220][3139:3144] CHIP:DMG: status = 0x00 (SUCCESS), |
| [1658143964.643263][3139:3144] CHIP:DMG: }, |
| [1658143964.643303][3139:3144] CHIP:DMG: |
| [1658143964.643343][3139:3144] CHIP:DMG: }, |
| [1658143964.643388][3139:3144] CHIP:DMG: |
| [1658143964.643421][3139:3144] CHIP:DMG: }, |
| [1658143964.643457][3139:3144] CHIP:DMG: |
| [1658143964.643486][3139:3144] CHIP:DMG: ], |
| [1658143964.643522][3139:3144] CHIP:DMG: |
| [1658143964.643551][3139:3144] CHIP:DMG: InteractionModelRevision = 1 |
| [1658143964.643580][3139:3144] CHIP:DMG: }, |
| [1658143964.643721][3139:3144] CHIP:DMG: Received Command Response Status for Endpoint=1 Cluster=0x0000_0101 Command=0x0000_001A Status=0x0 |
| |
| DUT/ChipTool log: |
| |
| [1658400855.689218][3227:3227] CHIP:DMG: CommandPathIB = |
| [1658400855.689259][3227:3227] CHIP:DMG: { |
| [1658400855.689302][3227:3227] CHIP:DMG: EndpointId = 0x1, |
| [1658400855.689347][3227:3227] CHIP:DMG: ClusterId = 0x101, |
| [1658400855.689390][3227:3227] CHIP:DMG: CommandId = 0x1a, |
| [1658400855.689435][3227:3227] CHIP:DMG: }, |
| [1658400855.689479][3227:3227] CHIP:DMG: |
| [1658400855.689514][3227:3227] CHIP:DMG: CommandFields = |
| [1658400855.689554][3227:3227] CHIP:DMG: { |
| [1658400855.689597][3227:3227] CHIP:DMG: 0x0 = 0, |
| [1658400855.689640][3227:3227] CHIP:DMG: 0x1 = 3, |
| [1658400855.689686][3227:3227] CHIP:DMG: 0x2 = "xxx", |
| [1658400855.689734][3227:3227] CHIP:DMG: 0x3 = 6452, |
| [1658400855.689781][3227:3227] CHIP:DMG: 0x4 = 1, |
| [1658400855.689829][3227:3227] CHIP:DMG: 0x5 = 0, |
| [1658400855.689872][3227:3227] CHIP:DMG: 0x6 = 0, |
| [1658400855.689915][3227:3227] CHIP:DMG: }, |
| [1658400855.689954][3227:3227] CHIP:DMG: }, |
| [1658400855.689996][3227:3227] CHIP:DMG: |
| [1658400855.690027][3227:3227] CHIP:DMG: ], |
| [1658400855.690071][3227:3227] CHIP:DMG: |
| [1658400855.690102][3227:3227] CHIP:DMG: InteractionModelRevision = 1 |
| [1658400855.690133][3227:3227] CHIP:DMG: }, |
| [1658400855.690221][3227:3227] CHIP:DMG: AccessControl: checking f=1 a=c s=0x000000000001B669 t= c=0x0000_0101 e=1 p=a |
| [1658400855.690267][3227:3227] CHIP:DMG: AccessControl: allowed |
| [1658400855.690302][3227:3227] CHIP:DMG: Received command for Endpoint=1 Cluster=0x0000_0101 Command=0x0000_001A |
| [1658400855.690367][3227:3227] CHIP:ZCL: [SetUser] Incoming command [endpointId=1,userIndex=3] |
| [1658400855.690424][3227:3227] CHIP:ZCL: Lock App: LockEndpoint::GetUser [endpoint=1,userIndex=3] |
| [1658400855.690455][3227:3227] CHIP:ZCL: Found unoccupied user [endpoint=1,adjustedIndex=2] |
| [1658400855.690485][3227:3227] CHIP:ZCL: Lock App: LockEndpoint::SetUser [endpoint=1,userIndex=3,creator=1,modifier=1,userName="xxx",uniqueId=1934,userStatus=1,userType=0,credentialRule=0,credentials=(nil),totalCredentials=0] |
| [1658400855.690519][3227:3227] CHIP:ZCL: Successfully set the user [mEndpointId=1,index=3,adjustedIndex=2] |
| [1658400855.690547][3227:3227] CHIP:ZCL: [createUser] User created [endpointId=1,creatorFabricId=1,userIndex=3,userName="xxx",userUniqueId=0x1934,userStatus=1,userType=0,credentialRule=0,totalCredentials=0] |
| disabled: true |
| |
| - label: |
| "TH initiates LockUserChange event by adding the UserIndex using Set |
| User command" |
| PICS: DRLK.C.E04 |
| verification: | |
| ./chip-tool doorlock read-event lock-user-change 1 1 |
| |
| verify DUT receives LockUserChange from TH on TH / lock app log: |
| |
| [1658400921.180741][3300:3305] CHIP:DMG: } |
| [1658400921.181012][3300:3305] CHIP:TOO: Endpoint: 1 Cluster: 0x0000_0101 Event 0x0000_0004 |
| [1658400921.181047][3300:3305] CHIP:TOO: Event number: 3 |
| [1658400921.181075][3300:3305] CHIP:TOO: Priority: Info |
| [1658400921.181104][3300:3305] CHIP:TOO: Timestamp: 4919184 |
| [1658400921.181240][3300:3305] CHIP:TOO: LockUserChange: { |
| [1658400921.181288][3300:3305] CHIP:TOO: LockDataType: 2 |
| [1658400921.181322][3300:3305] CHIP:TOO: DataOperationType: 0 |
| [1658400921.181354][3300:3305] CHIP:TOO: OperationSource: 7 |
| [1658400921.181386][3300:3305] CHIP:TOO: UserIndex: 1 |
| [1658400921.181418][3300:3305] CHIP:TOO: FabricIndex: 1 |
| [1658400921.181452][3300:3305] CHIP:TOO: SourceNode: 112233 |
| [1658400921.181483][3300:3305] CHIP:TOO: DataIndex: 1 |
| [1658400921.181513][3300:3305] CHIP:TOO: } |
| [1658400921.181654][3300:3305] CHIP:TOO: Endpoint: 1 Cluster: 0x0000_0101 Event 0x0000_0004 |
| [1658400921.181686][3300:3305] CHIP:TOO: Event number: 4 |
| [1658400921.181716][3300:3305] CHIP:TOO: Priority: Info |
| [1658400921.181745][3300:3305] CHIP:TOO: Timestamp: 4928528 |
| [1658400921.181791][3300:3305] CHIP:TOO: LockUserChange: { |
| [1658400921.181825][3300:3305] CHIP:TOO: LockDataType: 6 |
| [1658400921.181856][3300:3305] CHIP:TOO: DataOperationType: 0 |
| [1658400921.181886][3300:3305] CHIP:TOO: OperationSource: 7 |
| [1658400921.181916][3300:3305] CHIP:TOO: UserIndex: 1 |
| [1658400921.181945][3300:3305] CHIP:TOO: FabricIndex: 1 |
| [1658400921.181975][3300:3305] CHIP:TOO: SourceNode: 112233 |
| [1658400921.182006][3300:3305] CHIP:TOO: DataIndex: 1 |
| [1658400921.182035][3300:3305] CHIP:TOO: } |
| [1658400921.182174][3300:3305] CHIP:TOO: Endpoint: 1 Cluster: 0x0000_0101 Event 0x0000_0004 |
| [1658400921.182206][3300:3305] CHIP:TOO: Event number: 7 |
| [1658400921.182235][3300:3305] CHIP:TOO: Priority: Info |
| [1658400921.182263][3300:3305] CHIP:TOO: Timestamp: 5193731 |
| [1658400921.182400][3300:3305] CHIP:TOO: LockUserChange: { |
| [1658400921.182435][3300:3305] CHIP:TOO: LockDataType: 2 |
| [1658400921.182467][3300:3305] CHIP:TOO: DataOperationType: 0 |
| [1658400921.182497][3300:3305] CHIP:TOO: OperationSource: 7 |
| [1658400921.182527][3300:3305] CHIP:TOO: UserIndex: 3 |
| [1658400921.182557][3300:3305] CHIP:TOO: FabricIndex: 1 |
| [1658400921.182587][3300:3305] CHIP:TOO: SourceNode: 112233 |
| [1658400921.182617][3300:3305] CHIP:TOO: DataIndex: 3 |
| [1658400921.182645][3300:3305] CHIP:TOO: } |
| |
| DUT/ChipTool log: |
| |
| [1658400921.173789][3227:3227] CHIP:IM: Received Read request |
| [1658400921.173921][3227:3227] CHIP:DMG: ReadRequestMessage = |
| [1658400921.173978][3227:3227] CHIP:DMG: { |
| [1658400921.174015][3227:3227] CHIP:DMG: EventPathIBs = |
| [1658400921.174078][3227:3227] CHIP:DMG: [ |
| [1658400921.174110][3227:3227] CHIP:DMG: EventPath = |
| [1658400921.174164][3227:3227] CHIP:DMG: { |
| [1658400921.174214][3227:3227] CHIP:DMG: Endpoint = 0x1, |
| [1658400921.174257][3227:3227] CHIP:DMG: Cluster = 0x101, |
| [1658400921.174308][3227:3227] CHIP:DMG: Event = 0x4, |
| [1658400921.174351][3227:3227] CHIP:DMG: }, |
| [1658400921.174402][3227:3227] CHIP:DMG: |
| [1658400921.174436][3227:3227] CHIP:DMG: ], |
| [1658400921.174486][3227:3227] CHIP:DMG: |
| [1658400921.174519][3227:3227] CHIP:DMG: isFabricFiltered = true, |
| [1658400921.174565][3227:3227] CHIP:DMG: InteractionModelRevision = 1 |
| [1658400921.174596][3227:3227] CHIP:DMG: }, |
| [1658400921.174712][3227:3227] CHIP:DMG: IM RH moving to [GeneratingReports] |
| [1658400921.174844][3227:3227] CHIP:DMG: Building Reports for ReadHandler with LastReportGeneration = 0 DirtyGeneration = 0 |
| [1658400921.175067][3227:3227] CHIP:DMG: AccessControl: checking f=1 a=c s=0x000000000001B669 t= c=0x0000_0101 e=1 p=v |
| [1658400921.175116][3227:3227] CHIP:DMG: AccessControl: allowed |
| [1658400921.175254][3227:3227] CHIP:DMG: AccessControl: checking f=1 a=c s=0x000000000001B669 t= c=0x0000_0101 e=1 p=v |
| [1658400921.175305][3227:3227] CHIP:DMG: AccessControl: allowed |
| [1658400921.175494][3227:3227] CHIP:DMG: AccessControl: checking f=1 a=c s=0x000000000001B669 t= c=0x0000_0101 e=1 p=v |
| [1658400921.175531][3227:3227] CHIP:DMG: AccessControl: allowed |
| [1658400921.175603][3227:3227] CHIP:DMG: Fetched 3 events |
| disabled: true |
