connectedhomeip icon indicating copy to clipboard operation
connectedhomeip copied to clipboard

Published 20 hours ago • verified publisher icon project-chip

[Platform] [tv-app][TC-APBSC-9.1] Tested failed

Open nicelyjust opened this issue 1 year ago • 1 comments

Reproduction steps

  1. Build the TV app using command: scripts/build/build_examples.py --target android-arm64-tv-server build
  2. Build the tv-casting-app using command: $ cd ~/connectedhomeip/examples/tv-casting-app/linux $ gn gen out/debug $ ninja -C out/debug
  3. install and run the platform-app-debug.apk&content-app-debug.apk in the phone
  4. Commissioning the tv-casting-app
  5. test the case [TC-APBSC-9.1] , occured a failure at step 6 (UNSUPPORTED_ATTRIBUTE)

`

cast cluster applicationbasic read application 0 4 [1729240534.531] [37163:743182] [TOO] Run command failure: examples/chip-tool/commands/common/CHIPCommand.h:253: CHIP Error 0x000000AC: Internal error Done [1729240534.532] [37163:743182] [TOO] nodeId set to 0, using default for fabric 1 [1729240534.532] [37163:743182] [-] Binding type=1 fab=1 nodeId=0xFFFFFFEFFFFFFFFF groupId=65535 local endpoint=0 remote endpoint=1 cluster=0x0000_0000 [1729240534.532] [37163:743182] [-] GetVideoPlayerNodeForFabricIndex nodeId=0xFFFFFFEFFFFFFFFF [1729240534.532] [37163:743182] [TOO] Sending command to node 0xffffffefffffffff [1729240534.532] [37163:743182] [CSM] FindOrEstablishSession: PeerId = [1:FFFFFFEFFFFFFFFF] [1729240534.532] [37163:743182] [CSM] FindOrEstablishSession: No existing OperationalSessionSetup instance found [1729240534.532] [37163:743182] [DIS] Found an existing secure session to [1:FFFFFFEFFFFFFFFF]! [1729240534.532] [37163:743182] [DIS] OperationalSessionSetup[1:FFFFFFEFFFFFFFFF]: State change 1 --> 5 [1729240534.532] [37163:743182] [TOO] ModelCommand::OnDeviceConnectedFn [1729240534.532] [37163:743182] [TOO] Sending ReadAttribute to: [1729240534.532] [37163:743182] [TOO] cluster 0x0000_050D, attribute: 0x0000_0004, endpoint 4 [1729240534.532] [37163:743182] [DMG] SendReadRequest ReadClient[0x138f04080]: Sending Read Request [1729240534.532] [37163:743182] [DMG] 0 data version filters provided, 0 not relevant, 0 encoded, 0 skipped due to lack of space [1729240534.533] [37163:743182] [EM] <<< [E:41276i S:17665 M:258475850] (S) Msg TX from C5AA883353531361 to 1:FFFFFFEFFFFFFFFF [D49F] [UDP:[fe80::8b:40d6:8fab:70f%en0]:5552] --- Type 0001:02 (IM:ReadRequest) (B:52) [1729240534.533] [37163:743182] [EM] ??1 [E:41276i S:17665 M:258475850] (S) Msg Retransmission to 1:FFFFFFEFFFFFFFFF in 626ms [State:Idle II:500 AI:300 AT:4000] [1729240534.533] [37163:743182] [DMG] MoveToState ReadClient[0x138f04080]: Moving to [AwaitingIn] [1729240534.535] [37163:743182] [EM] >>> [E:41276i S:17665 M:146351207 (Ack:258475850)] (S) Msg RX from 1:FFFFFFEFFFFFFFFF [D49F] to C5AA883353531361 --- Type 0001:05 (IM:ReportData) (B:68) [1729240534.535] [37163:743182] [EM] Found matching exchange: 41276i, Delegate: 0x138f04090 [1729240534.535] [37163:743182] [EM] Rxd Ack; Removing MessageCounter:258475850 from Retrans Table on exchange 41276i [1729240534.535] [37163:743182] [DMG] ReportDataMessage = [1729240534.535] [37163:743182] [DMG] { [1729240534.535] [37163:743182] [DMG] AttributeReportIBs = [1729240534.535] [37163:743182] [DMG] [ [1729240534.535] [37163:743182] [DMG] AttributeReportIB = [1729240534.535] [37163:743182] [DMG] { [1729240534.535] [37163:743182] [DMG] AttributeStatusIB = [1729240534.535] [37163:743182] [DMG] { [1729240534.535] [37163:743182] [DMG] AttributePathIB = [1729240534.535] [37163:743182] [DMG] { [1729240534.535] [37163:743182] [DMG] Endpoint = 0x4, [1729240534.535] [37163:743182] [DMG] Cluster = 0x50d, [1729240534.535] [37163:743182] [DMG] Attribute = 0x0000_0004, [1729240534.535] [37163:743182] [DMG] } [1729240534.535] [37163:743182] [DMG] [1729240534.535] [37163:743182] [DMG] StatusIB = [1729240534.535] [37163:743182] [DMG] { [1729240534.535] [37163:743182] [DMG] status = 0x86 (UNSUPPORTED_ATTRIBUTE), [1729240534.535] [37163:743182] [DMG] }, [1729240534.535] [37163:743182] [DMG] [1729240534.535] [37163:743182] [DMG] }, [1729240534.535] [37163:743182] [DMG] [1729240534.535] [37163:743182] [DMG] }, [1729240534.535] [37163:743182] [DMG] [1729240534.535] [37163:743182] [DMG] ], [1729240534.535] [37163:743182] [DMG] [1729240534.535] [37163:743182] [DMG] SuppressResponse = true, [1729240534.535] [37163:743182] [DMG] InteractionModelRevision = 11 [1729240534.535] [37163:743182] [DMG] } [1729240534.535] [37163:743182] [TOO] Response Failure: IM Error 0x00000586: General error: 0x86 (UNSUPPORTED_ATTRIBUTE) `

Platform

android

Platform Version(s)

1.3

Type

Manually tested with SDK

(Optional) If manually tested please explain why this is only manually tested

No response

Anything else?

No response

nicelyjust avatar Oct 18 '24 08:10 nicelyjust

the linux tv-casting-app against the linux tv-app had the same issue

cast cluster applicationbasic read application 0 4 [1729242277.649] [37163:746802] [TOO] Run command failure: examples/tv-casting-app/tv-casting-common/commands/common/CHIPCommand.cpp:74: CHIP Error 0x00000032: Timeout Done [1729242277.649] [37163:746802] [TOO] nodeId set to 0, using default for fabric 1 [1729242277.649] [37163:746802] [-] Binding type=1 fab=1 nodeId=0xFFFFFFEFFFFFFFFF groupId=65535 local endpoint=0 remote endpoint=1 cluster=0x0000_0000 [1729242277.649] [37163:746802] [-] GetVideoPlayerNodeForFabricIndex nodeId=0xFFFFFFEFFFFFFFFF [1729242277.649] [37163:746802] [TOO] Sending command to node 0xffffffefffffffff [1729242277.649] [37163:746802] [CSM] FindOrEstablishSession: PeerId = [1:FFFFFFEFFFFFFFFF] [1729242277.649] [37163:746802] [CSM] FindOrEstablishSession: No existing OperationalSessionSetup instance found [1729242277.649] [37163:746802] [DIS] Found an existing secure session to [1:FFFFFFEFFFFFFFFF]! [1729242277.649] [37163:746802] [DIS] OperationalSessionSetup[1:FFFFFFEFFFFFFFFF]: State change 1 --> 5 [1729242277.649] [37163:746802] [TOO] ModelCommand::OnDeviceConnectedFn [1729242277.649] [37163:746802] [TOO] Sending ReadAttribute to: [1729242277.649] [37163:746802] [TOO] cluster 0x0000_050D, attribute: 0x0000_0004, endpoint 4 [1729242277.649] [37163:746802] [DMG] SendReadRequest ReadClient[0x138f04080]: Sending Read Request [1729242277.649] [37163:746802] [DMG] 0 data version filters provided, 0 not relevant, 0 encoded, 0 skipped due to lack of space [1729242277.649] [37163:746802] [EM] <<< [E:41278i S:17665 M:258475854] (S) Msg TX from C5AA883353531361 to 1:FFFFFFEFFFFFFFFF [D49F] [UDP:[fe80::8b:40d6:8fab:70f%en0]:5552] --- Type 0001:02 (IM:ReadRequest) (B:52) [1729242277.650] [37163:746802] [EM] ??1 [E:41278i S:17665 M:258475854] (S) Msg Retransmission to 1:FFFFFFEFFFFFFFFF in 679ms [State:Idle II:500 AI:300 AT:4000] [1729242277.650] [37163:746802] [DMG] MoveToState ReadClient[0x138f04080]: Moving to [AwaitingIn] [1729242277.652] [37163:764298] [EM] >>> [E:41278i S:17665 M:146351209 (Ack:258475854)] (S) Msg RX from 1:FFFFFFEFFFFFFFFF [D49F] to C5AA883353531361 --- Type 0001:05 (IM:ReportData) (B:68) [1729242277.652] [37163:764298] [EM] Found matching exchange: 41278i, Delegate: 0x138f04090 [1729242277.652] [37163:764298] [EM] Rxd Ack; Removing MessageCounter:258475854 from Retrans Table on exchange 41278i [1729242277.652] [37163:764298] [DMG] ReportDataMessage = [1729242277.652] [37163:764298] [DMG] { [1729242277.652] [37163:764298] [DMG] AttributeReportIBs = [1729242277.652] [37163:764298] [DMG] [ [1729242277.652] [37163:764298] [DMG] AttributeReportIB = [1729242277.652] [37163:764298] [DMG] { [1729242277.652] [37163:764298] [DMG] AttributeStatusIB = [1729242277.652] [37163:764298] [DMG] { [1729242277.652] [37163:764298] [DMG] AttributePathIB = [1729242277.652] [37163:764298] [DMG] { [1729242277.652] [37163:764298] [DMG] Endpoint = 0x4, [1729242277.652] [37163:764298] [DMG] Cluster = 0x50d, [1729242277.652] [37163:764298] [DMG] Attribute = 0x0000_0004, [1729242277.652] [37163:764298] [DMG] } [1729242277.652] [37163:764298] [DMG] [1729242277.652] [37163:764298] [DMG] StatusIB = [1729242277.652] [37163:764298] [DMG] { [1729242277.652] [37163:764298] [DMG] status = 0x86 (UNSUPPORTED_ATTRIBUTE), [1729242277.652] [37163:764298] [DMG] }, [1729242277.652] [37163:764298] [DMG] [1729242277.652] [37163:764298] [DMG] }, [1729242277.652] [37163:764298] [DMG] [1729242277.652] [37163:764298] [DMG] }, [1729242277.652] [37163:764298] [DMG] [1729242277.652] [37163:764298] [DMG] ], [1729242277.652] [37163:764298] [DMG] [1729242277.652] [37163:764298] [DMG] SuppressResponse = true, [1729242277.652] [37163:764298] [DMG] InteractionModelRevision = 11 [1729242277.652] [37163:764298] [DMG] } [1729242277.652] [37163:764298] [TOO] Response Failure: IM Error 0x00000586: General error: 0x86 (UNSUPPORTED_ATTRIBUTE) [1729242277.652] [37163:764298] [EM] <<< [E:41278i S:17665 M:258475855 (Ack:146351209)] (S) Msg TX from C5AA883353531361 to 1:FFFFFFEFFFFFFFFF [D49F] [UDP:[fe80::8b:40d6:8fab:70f%en0]:5552] --- Type 0000:10 (SecureChannel:StandaloneAck) (B:34) [1729242277.652] [37163:764298] [EM] Flushed pending ack for MessageCounter:146351209 on exchange 41278i

[1729242277.650] [37157:745624] [EM] Handling via exchange: 41278r, Delegate: 0x104f75758 [1729242277.650] [37157:745624] [IM] Received Read request [1729242277.650] [37157:745624] [DMG] ReadRequestMessage = [1729242277.650] [37157:745624] [DMG] { [1729242277.650] [37157:745624] [DMG] AttributePathIBs = [1729242277.650] [37157:745624] [DMG] [ [1729242277.651] [37157:745624] [DMG] AttributePathIB = [1729242277.651] [37157:745624] [DMG] { [1729242277.651] [37157:745624] [DMG] Endpoint = 0x4, [1729242277.651] [37157:745624] [DMG] Cluster = 0x50d, [1729242277.651] [37157:745624] [DMG] Attribute = 0x0000_0004, [1729242277.651] [37157:745624] [DMG] } [1729242277.651] [37157:745624] [DMG] [1729242277.651] [37157:745624] [DMG] ], [1729242277.651] [37157:745624] [DMG] [1729242277.651] [37157:745624] [DMG] isFabricFiltered = true, [1729242277.651] [37157:745624] [DMG] InteractionModelRevision = 11 [1729242277.651] [37157:745624] [DMG] }, [1729242277.651] [37157:745624] [DMG] IM RH moving to [CanStartReporting] [1729242277.651] [37157:745624] [DMG] Building Reports for ReadHandler with LastReportGeneration = 0x0000000000000000 DirtyGeneration = 0x0000000000000000 [1729242277.651] [37157:745624] [DMG] <RE:Run> Cluster 50d, Attribute 4 is dirty [1729242277.651] [37157:745624] [DMG] Reading attribute: Cluster=0x0000_050D Endpoint=4 AttributeId=0x0000_0004 (expanded=0) [1729242277.651] [37157:745624] [DMG] Fail to retrieve data, roll back and encode status on clusterId: 0x0000_050D, attributeId: 0x0000_0004err = src/app/util/ember-compatibility-functions.cpp:290: IM Error 0x00000586: General error: 0x86 (UNSUPPORTED_ATTRIBUTE) [1729242277.651] [37157:745624] [DMG] <RE> Sending report (payload has 34 bytes)... [1729242277.651] [37157:745624] [EM] <<< [E:41278r S:35390 M:146351209 (Ack:258475854)] (S) Msg TX from FFFFFFEFFFFFFFFF to 1:C5AA883353531361 [D49F] [UDP:[fe80::8b:40d6:8fab:70f%en0]:5540] --- Type 0001:05 (IM:ReportData) (B:68) [1729242277.651] [37157:745624] [EM] ??1 [E:41278r S:35390 M:146351209] (S) Msg Retransmission to 1:C5AA883353531361 in 373ms [State:Active II:500 AI:300 AT:4000]

nicelyjust avatar Oct 18 '24 09:10 nicelyjust

It looks like something changed in the main SDK code which encodes attributes of type struct, and this broke the reading of the struct attributes in the ApplicationBasic cluster. I suspect that other media clusters with struct attributes would also be impacted.

The code which likely needs to be updated to whatever the new convention is can be found here:

src/app/clusters/application-basic-server/application-basic-server.cpp:

CHIP_ERROR Delegate::HandleGetApplication(app::AttributeValueEncoder & aEncoder)
{
    ApplicationBasicApplicationType application;
    application.catalogVendorID = mCatalogVendorApp.catalogVendorId;
    application.applicationID   = CharSpan(mCatalogVendorApp.applicationId, strlen(mCatalogVendorApp.applicationId));
    return aEncoder.Encode(application);
}

We should verify that this is getting called, and then double check that the values being assigned to application.catalogVendorID and application.applicationID are valid.

chrisdecenzo avatar Oct 24 '24 20:10 chrisdecenzo

the HandleGetApplication is not getting called @chrisdecenzo

nicelyjust avatar Nov 14 '24 02:11 nicelyjust

There is another issue where the feature-map attribute cannot be retrieved, and a generic error code is returned.

nicelyjust avatar Nov 14 '24 02:11 nicelyjust