sc7180-trogdor-kingoftown: kms_plane@plane-position-hole-dpms, FLAKE
Below test was reported as flake in drm-ci testing,
# Board Name: sc7180-trogdor-kingoftown
# Failure Rate: 20
# IGT Version: 1.29-g33adea9eb
# Linux Version: 6.13.0-rc2
kms_plane@plane-position-hole-dpms2024-12-16 11:46:08.620737: Slowest tests:
2024-12-16 11:46:08.620758: drm_read@short-buffer-wakeup (34.97s)
2024-12-16 11:46:08.620767: kms_cursor_legacy@torture-bo (20.69s)
2024-12-16 11:46:08.620776: kms_rotation_crc@primary-rotation-180 (17.92s)
2024-12-16 11:46:08.620785: kms_flip@dpms-vs-vblank-race (16.65s)
2024-12-16 11:46:08.620794: kms_plane@plane-position-hole-dpms (15.63s)
2024-12-16 11:46:08.620802: Some new flakes found:
2024-12-16 11:46:08.620811: kms_plane@plane-position-hole-dpmsPipeline: https://gitlab.freedesktop.org/vigneshraman/linux/-/jobs/68249793
2024-12-16 11:43:36.163094: DEBUG - Begin test kms_plane@plane-position-hole-dpms
2024-12-16 11:43:46.303072: [ 572.798995] usb 1-1.4: new high-speed USB device number 10 using xhci-hcd
2024-12-16 11:43:46.303128: [ 572.899730] Console: switching to colour dummy device 80x25
2024-12-16 11:43:46.303144: [ 572.905858] [IGT] kms_frontbuffer_tracking: executing
2024-12-16 11:43:46.303157: [ 572.940584] [IGT] kms_frontbuffer_tracking: exiting, ret=77
2024-12-16 11:43:46.303169: [ 572.975677] Console: switching to colour frame buffer device 170x48
2024-12-16 11:43:46.303180: [ 573.085941] Console: switching to colour dummy device 80x25
2024-12-16 11:43:46.303191: [ 573.091928] [IGT] kms_pm_dc: executing
2024-12-16 11:43:46.303203: [ 573.123062] [IGT] kms_pm_dc: exiting, ret=77
2024-12-16 11:43:46.303215: [ 573.158399] Console: switching to colour frame buffer device 170x48
2024-12-16 11:43:46.303226: [ 573.266503] Console: switching to colour dummy device 80x25
2024-12-16 11:43:46.303237: [ 573.272487] [IGT] kms_ccs: executing
2024-12-16 11:43:46.303248: [ 573.306517] [IGT] kms_ccs: exiting, ret=77
2024-12-16 11:43:46.303260: [ 573.341810] Console: switching to colour frame buffer device 170x48
2024-12-16 11:43:46.303271: [ 573.447773] Console: switching to colour dummy device 80x25
2024-12-16 11:43:46.303282: [ 573.453727] [IGT] kms_frontbuffer_tracking: executing
2024-12-16 11:43:46.303293: [ 573.490699] [IGT] kms_frontbuffer_tracking: exiting, ret=77
2024-12-16 11:43:46.303304: [ 573.525339] Console: switching to colour frame buffer device 170x48
2024-12-16 11:43:46.303319: [ 573.631873] Console: switching to colour dummy device 80x25
2024-12-16 11:43:46.303337: [ 573.637956] [IGT] kms_big_fb: executing
2024-12-16 11:43:46.303355: [ 573.673149] [IGT] kms_big_fb: exiting, ret=77
2024-12-16 11:43:46.303442: [ 573.708893] Console: switching to colour frame buffer device 170x48
2024-12-16 11:43:46.303462: [ 573.836420] Console: switching to colour dummy device 80x25
2024-12-16 11:43:46.303475: [ 573.842351] [IGT] kms_plane: executing
2024-12-16 11:43:46.303486: [ 574.118805] usb 1-1.4: USB disconnect, device number 10
2024-12-16 11:43:46.303497: [ 574.846476] usb 1-1.4: new high-speed USB device number 11 using xhci-hcd
2024-12-16 11:43:46.303509: [ 575.036136] [IGT] kms_plane: starting subtest plane-position-hole-dpms
2024-12-16 11:43:46.303520: [ 575.142797] usb 1-1.4: USB disconnect, device number 11
2024-12-16 11:43:46.303531: [ 576.126179] usb 1-1.4: new high-speed USB device number 12 using xhci-hcd
2024-12-16 11:43:46.303543: [ 576.306350] [IGT] kms_plane: starting dynamic subtest pipe-A-plane-1
2024-12-16 11:43:46.303554: [ 576.325050] usb 1-1.4: can't set config #1, error -71
2024-12-16 11:43:46.303578: [ 576.423413] usb 1-1.4: USB disconnect, device number 12
2024-12-16 11:43:46.303590: [ 577.150223] usb 1-1.4: new high-speed USB device number 13 using xhci-hcd
2024-12-16 11:43:46.303602: [ 577.703174] usb 1-1.4: USB disconnect, device number 13
2024-12-16 11:43:46.303614: [ 578.414228] usb 1-1.4: new high-speed USB device number 14 using xhci-hcd
2024-12-16 11:43:46.303625: [ 578.664838] [IGT] kms_plane: finished subtest pipe-A-plane-1, SUCCESS
2024-12-16 11:43:46.303636: [ 578.672091] [IGT] kms_plane: starting dynamic subtest pipe-A-plane-2
2024-12-16 11:43:46.303647: [ 578.726665] usb 1-1.4: USB disconnect, device number 14
2024-12-16 11:43:46.303659: [ 579.710344] usb 1-1.4: new high-speed USB device number 15 using xhci-hcd
2024-12-16 11:43:46.303670: [ 579.808097] usb 1-1.4: device descriptor read/all, error -71
2024-12-16 11:43:46.303681: [ 580.734286] usb 1-1.4: new high-speed USB device number 16 using xhci-hcd
2024-12-16 11:43:46.303691: [ 580.975482] [IGT] kms_plane: finished subtest pipe-A-plane-2, SUCCESS
2024-12-16 11:43:46.303702: [ 580.982639] [IGT] kms_plane: starting dynamic subtest pipe-A-plane-3
2024-12-16 11:43:46.303713: [ 581.030031] usb 1-1.4: USB disconnect, device number 16
2024-12-16 11:43:46.303724: [ 582.014196] usb 1-1.4: new high-speed USB device number 17 using xhci-hcd
2024-12-16 11:43:46.303736: [ 582.034912] arm-smmu 15000000.iommu: Unhandled context fault: fsr=0x402, iova=0x00812000, fsynr=0x510023, cbfrsynra=0x800, cb=4
2024-12-16 11:43:46.303747: [ 582.034940] arm-smmu 15000000.iommu: FSR = 00000402 [Format=2 TF], SID=0x800
2024-12-16 11:43:46.303758: [ 582.034948] arm-smmu 15000000.iommu: FSYNR0 = 00510023 [S1CBNDX=81 PNU PLVL=3]
2024-12-16 11:43:46.303770: [ 582.046901] arm-smmu 15000000.iommu: Unhandled context fault: fsr=0x402, iova=0x00812000, fsynr=0x510023, cbfrsynra=0x800, cb=4
2024-12-16 11:43:46.303781: [ 582.046912] arm-smmu 15000000.iommu: FSR = 00000402 [Format=2 TF], SID=0x800
2024-12-16 11:43:46.303792: [ 582.046920] arm-smmu 15000000.iommu: FSYNR0 = 00510023 [S1CBNDX=81 PNU PLVL=3]
2024-12-16 11:43:46.303802: [ 582.063621] arm-smmu 15000000.iommu: Unhandled context fault: fsr=0x402, iova=0x00812000, fsynr=0x510023, cbfrsynra=0x800, cb=4
2024-12-16 11:43:46.303814: [ 582.063632] arm-smmu 15000000.iommu: FSR = 00000402 [Format=2 TF], SID=0x800
2024-12-16 11:43:46.303824: [ 582.063639] arm-smmu 15000000.iommu: FSYNR0 = 00510023 [S1CBNDX=81 PNU PLVL=3]
2024-12-16 11:43:46.303835: [ 582.078541] arm-smmu 15000000.iommu: Unhandled context fault: fsr=0x402, iova=0x00812000, fsynr=0x510023, cbfrsynra=0x800, cb=4
2024-12-16 11:43:46.303847: [ 582.078557] arm-smmu 15000000.iommu: FSR = 00000402 [Format=2 TF], SID=0x800
2024-12-16 11:43:46.303857: [ 582.078565] arm-smmu 15000000.iommu: FSYNR0 = 00510023 [S1CBNDX=81 PNU PLVL=3]
2024-12-16 11:43:51.368402: [ 582.099771] arm-smmu 15000000.iommu: Unhandled context fault: fsr=0x402, iova=0x00812000, fsynr=0x510023, cbfrsynra=0x800, cb=4
2024-12-16 11:43:51.368448: [ 582.099782] arm-smmu 15000000.iommu: FSR = 00000402 [Format=2 TF], SID=0x800
2024-12-16 11:43:51.368456: [ 582.099830] arm-smmu 15000000.iommu: FSYNR0 = 00510023 [S1CBNDX=81 PNU PLVL=3]
2024-12-16 11:43:51.368463: [ 582.113143] arm-smmu 15000000.iommu: Unhandled context fault: fsr=0x402, iova=0x00812000, fsynr=0x510023, cbfrsynra=0x800, cb=4
2024-12-16 11:43:51.368469: [ 582.113809] arm-smmu 15000000.iommu: FSR = 00000402 [Format=2 TF], SID=0x800
2024-12-16 11:43:51.368476: [ 582.114512] arm-smmu 15000000.iommu: FSYNR0 = 00510023 [S1CBNDX=81 PNU PLVL=3]
2024-12-16 11:43:51.368493: [ 582.122779] arm-smmu 15000000.iommu: Unhandled context fault: fsr=0x402, iova=0x00812000, fsynr=0x510023, cbfrsynra=0x800, cb=4
2024-12-16 11:43:51.368706: ERROR - Igt error: (kms_plane:890) igt_pipe_crc-CRITICAL: Test assertion failure function igt_assert_crc_equal, file ../lib/igt_pipe_crc.c:112:
2024-12-16 11:43:51.368711: ERROR - Igt error: (kms_plane:890) igt_pipe_crc-CRITICAL: Failed assertion: !mismatch || igt_skip_crc_compare
2024-12-16 11:43:51.368716: ERROR - Igt error: Dynamic subtest pipe-A-plane-3 failed.
2024-12-16 11:43:51.368720: ERROR - Igt error: **** DEBUG ****
2024-12-16 11:43:51.368724: ERROR - Igt error: (kms_plane:890) DEBUG: Testing connector eDP-1 using pipe A plane 3
2024-12-16 11:43:51.368728: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: eDP-1: set_pipe(A)
2024-12-16 11:43:51.368732: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: eDP-1: Selecting pipe A
2024-12-16 11:43:51.368735: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes
2024-12-16 11:43:51.368739: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes
2024-12-16 11:43:51.368743: ERROR - Igt error: (kms_plane:890) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=1366, height=768, format=XR24(0x34325258), modifier=0x0, size=0)
2024-12-16 11:43:51.368747: ERROR - Igt error: (kms_plane:890) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=1, pitch=5504)
2024-12-16 11:43:51.368751: ERROR - Igt error: (kms_plane:890) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
2024-12-16 11:43:51.368755: ERROR - Igt error: (kms_plane:890) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
2024-12-16 11:43:51.368758: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: A.0: plane_set_fb(72)
2024-12-16 11:43:51.368762: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: A.0: plane_set_size (1366x768)
2024-12-16 11:43:51.368766: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: A.0: fb_set_position(0,0)
2024-12-16 11:43:51.368770: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: A.0: fb_set_size(1366x768)
2024-12-16 11:43:51.368774: ERROR - Igt error: (kms_plane:890) igt_fb-DEBUG: igt_create_fb_with_bo_size(width=64, height=64, format=XR24(0x34325258), modifier=0x0, size=0)
2024-12-16 11:43:51.368778: ERROR - Igt error: (kms_plane:890) igt_fb-DEBUG: igt_create_fb_with_bo_size(handle=2, pitch=256)
2024-12-16 11:43:51.368781: ERROR - Igt error: (kms_plane:890) ioctl_wrappers-DEBUG: Test requirement passed: igt_has_fb_modifiers(fd)
2024-12-16 11:43:51.368785: ERROR - Igt error: (kms_plane:890) igt_fb-DEBUG: Test requirement passed: cairo_surface_status(fb->cairo_surface) == CAIRO_STATUS_SUCCESS
2024-12-16 11:43:51.368789: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: A.3: plane_set_fb(73)
2024-12-16 11:43:51.368793: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: A.3: plane_set_size (64x64)
2024-12-16 11:43:51.368797: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: A.3: fb_set_position(0,0)
2024-12-16 11:43:51.368801: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: A.3: fb_set_size(64x64)
2024-12-16 11:43:51.368804: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: A.3: plane_set_position(132,132)
2024-12-16 11:43:51.368808: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: commit {
2024-12-16 11:43:51.368812: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes
2024-12-16 11:43:51.368819: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: eDP-1: SetCrtc pipe A, fb 72, src (0, 0), mode 1366x768
2024-12-16 11:43:51.368823: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes
2024-12-16 11:43:51.368827: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes
2024-12-16 11:43:51.368830: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: Test requirement passed: plane_idx >= 0 && plane_idx < pipe->n_planes
2024-12-16 11:43:51.368834: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: SetCursor pipe A, fb 2 64x64
2024-12-16 11:43:51.368838: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: MoveCursor pipe A, (132, 132)
2024-12-16 11:43:51.368842: ERROR - Igt error: (kms_plane:890) igt_kms-DEBUG: display: }
2024-12-16 11:43:51.368846: ERROR - Igt error: (kms_plane:890) igt_pipe_crc-DEBUG: CRC mismatch at index 0: 0xbe84f596 != 0xcbe27bc7
2024-12-16 11:43:51.368850: ERROR - Igt error: (kms_plane:890) igt_pipe_crc-CRITICAL: Test assertion failure function igt_assert_crc_equal, file ../lib/igt_pipe_crc.c:112:
2024-12-16 11:43:51.368853: ERROR - Igt error: (kms_plane:890) igt_pipe_crc-CRITICAL: Failed assertion: !mismatch || igt_skip_crc_compare
2024-12-16 11:43:51.368857: ERROR - Igt error: (kms_plane:890) igt_core-INFO: Stack trace:
2024-12-16 11:43:51.368861: ERROR - Igt error: (kms_plane:890) igt_core-INFO: #0 ../lib/igt_core.c:2051 __igt_fail_assert()
2024-12-16 11:43:51.368865: ERROR - Igt error: (kms_plane:890) igt_core-INFO: #1 ../lib/igt_pipe_crc.c:125 igt_check_crc_equal()
2024-12-16 11:43:51.368869: ERROR - Igt error: (kms_plane:890) igt_core-INFO: #2 ../tests/kms_plane.c:320 test_plane_position()
2024-12-16 11:43:51.368872: ERROR - Igt error: (kms_plane:890) igt_core-INFO: #3 ../tests/kms_plane.c:1327 run_test.constprop.0()
2024-12-16 11:43:51.368876: ERROR - Igt error: (kms_plane:890) igt_core-INFO: #4 ../tests/kms_plane.c:1387 run_tests_for_pipe_plane.constprop.0()
2024-12-16 11:43:51.368880: ERROR - Igt error: (kms_plane:890) igt_core-INFO: #5 ../tests/kms_plane.c:1457 __igt_unique____real_main1444()
2024-12-16 11:43:51.368884: ERROR - Igt error: (kms_plane:890) igt_core-INFO: #6 ../tests/kms_plane.c:1444 main()
2024-12-16 11:43:51.368888: ERROR - Igt error: (kms_plane:890) igt_core-INFO: #7 [__libc_init_first+0x80]
2024-12-16 11:43:51.368891: ERROR - Igt error: (kms_plane:890) igt_core-INFO: #8 [__libc_start_main+0x98]
2024-12-16 11:43:51.368895: ERROR - Igt error: (kms_plane:890) igt_core-INFO: #9 [_start+0x30]
2024-12-16 11:43:51.368899: ERROR - Igt error: **** END ****
2024-12-16 11:43:51.368903: ERROR - Test kms_plane@plane-position-hole-dpms: Fail: See "/results/igt.kms_plane@plane-position-hole-dpms.log"
2024-12-16 11:43:51.368907: DEBUG - End test kms_plane@plane-position-hole-dpms
2024-12-16 11:43:51.368911: DEBUG - Begin test kms_plane@plane-position-hole-dpms
2024-12-16 11:43:56.433956: [ 582.122790] arm-smmu 15000000.iommu: FSR = 00000402 [Format=2 TF], SID=0x800
2024-12-16 11:43:56.434085: [ 582.122798] arm-smmu 15000000.iommu: FSYNR0 = 00510023 [S1CBNDX=81 PNU PLVL=3]
2024-12-16 11:43:56.434181: [ 582.142457] arm-smmu 15000000.iommu: Unhandled context fault: fsr=0x402, iova=0x00812000, fsynr=0x510023, cbfrsynra=0x800, cb=4
2024-12-16 11:43:56.434202: [ 582.142472] arm-smmu 15000000.iommu: FSR = 00000402 [Format=2 TF], SID=0x800
2024-12-16 11:43:56.434229: [ 582.142479] arm-smmu 15000000.iommu: FSYNR0 = 00510023 [S1CBNDX=81 PNU PLVL=3]
2024-12-16 11:43:56.434240: [ 582.161982] arm-smmu 15000000.iommu: Unhandled context fault: fsr=0x402, iova=0x00812000, fsynr=0x510023, cbfrsynra=0x800, cb=4
2024-12-16 11:43:56.434252: [ 582.161993] arm-smmu 15000000.iommu: FSR = 00000402 [Format=2 TF], SID=0x800
2024-12-16 11:43:56.434263: [ 582.162001] arm-smmu 15000000.iommu: FSYNR0 = 00510023 [S1CBNDX=81 PNU PLVL=3]
2024-12-16 11:43:56.434274: [ 582.170049] arm-smmu 15000000.iommu: Unhandled context fault: fsr=0x402, iova=0x00812000, fsynr=0x510023, cbfrsynra=0x800, cb=4
2024-12-16 11:43:56.434284: [ 582.170060] arm-smmu 15000000.iommu: FSR = 00000402 [Format=2 TF], SID=0x800
2024-12-16 11:43:56.434295: [ 582.170068] arm-smmu 15000000.iommu: FSYNR0 = 00510023 [S1CBNDX=81 PNU PLVL=3]
2024-12-16 11:43:56.434306: [ 582.367879] [IGT] kms_plane: finished subtest pipe-A-plane-3, FAIL
2024-12-16 11:43:56.434317: [ 582.533029] usb 1-1.4: can't set config #1, error -71
2024-12-16 11:43:56.434329: [ 582.566507] usb 1-1.4: USB disconnect, device number 17
2024-12-16 11:43:56.434340: [ 583.538386] usb 1-1.4: new high-speed USB device number 18 using xhci-hcd
2024-12-16 11:43:56.434351: [ 583.640814] usb 1-1.4: unable to read config index 0 descriptor/start: -71
2024-12-16 11:43:56.434386: [ 583.648046] usb 1-1.4: can't read configurations, error -71
2024-12-16 11:43:56.434398: [ 583.674963] [IGT] kms_plane: starting dynamic subtest pipe-B-plane-1
2024-12-16 11:43:56.434409: [ 583.683348] [IGT] kms_plane: finished subtest pipe-B-plane-1, SUCCESS
2024-12-16 11:43:56.434419: [ 583.690761] [IGT] kms_plane: starting dynamic subtest pipe-B-plane-2
2024-12-16 11:43:56.434430: [ 584.578331] usb 1-1.4: new high-speed USB device number 19 using xhci-hcd
2024-12-16 11:43:56.434440: [ 584.871353] usb 1-1.4: USB disconnect, device number 19
2024-12-16 11:43:56.434451: [ 585.842469] usb 1-1.4: new high-speed USB device number 20 using xhci-hcd
2024-12-16 11:43:56.434461: [ 585.966688] [IGT] kms_plane: finished subtest pipe-B-plane-2, SUCCESS
2024-12-16 11:43:56.434472: [ 585.973819] [IGT] kms_plane: starting dynamic subtest pipe-B-plane-3
2024-12-16 11:43:56.434483: [ 586.020977] usb 1-1.4: can't set config #1, error -71
2024-12-16 11:43:56.434505: [ 586.150859] usb 1-1.4: USB disconnect, device number 20
2024-12-16 11:43:56.434516: [ 586.862240] usb 1-1.4: new high-speed USB device number 21 using xhci-hcd
2024-12-16 11:43:56.434527: [ 587.174422] usb 1-1.4: USB disconnect, device number 21
2024-12-16 11:43:56.434538: [ 588.158003] usb 1-1.4: new high-speed USB device number 22 using xhci-hcd
2024-12-16 11:43:56.434548: [ 588.255455] usb 1-1.4: device descriptor read/all, error -71
2024-12-16 11:43:56.434559: [ 588.270958] [IGT] kms_plane: finished subtest pipe-B-plane-3, SUCCESS
2024-12-16 11:43:56.434569: [ 588.278281] [IGT] kms_plane: finished subtest plane-position-hole-dpms, FAIL
2024-12-16 11:43:56.434580: [ 589.190990] usb 1-1.4: new high-speed USB device number 23 using xhci-hcd
2024-12-16 11:43:56.434591: [ 589.314801] [IGT] kms_plane: exiting, ret=98
2024-12-16 11:43:56.434601: [ 589.357115] Console: switching to colour frame buffer device 170x48
2024-12-16 11:43:56.434612: [ 589.530187] Console: switching to colour dummy device 80x25
2024-12-16 11:43:56.434623: [ 589.537089] [IGT] kms_plane: executing
2024-12-16 11:43:56.434634: [ 589.735170] usb 1-1.4: USB disconnect, device number 23
2024-12-16 11:43:56.434644: [ 590.463101] usb 1-1.4: new high-speed USB device number 24 using xhci-hcd
2024-12-16 11:43:56.434661: [ 590.713521] [IGT] kms_plane: starting subtest plane-position-hole-dpms
2024-12-16 11:43:56.434671: [ 591.016382] usb 1-1.4: USB disconnect, device number 24
2024-12-16 11:43:56.434682: [ 591.742284] usb 1-1.4: new high-speed USB device number 25 using xhci-hcd
2024-12-16 11:43:56.434693: [ 591.985684] [IGT] kms_plane: starting dynamic subtest pipe-A-plane-1
2024-12-16 11:43:56.434703: [ 592.037967] usb 1-1.4: USB disconnect, device number 25
2024-12-16 11:44:01.578302: [ 593.026325] usb 1-1.4: new high-speed USB device number 26 using xhci-hcd
2024-12-16 11:44:01.579712: [ 593.221074] usb 1-1.4: can't set config #1, error -71
2024-12-16 11:44:01.579741: [ 593.318394] usb 1-1.4: USB disconnect, device number 26
2024-12-16 11:44:01.579758: [ 594.030283] usb 1-1.4: new high-speed USB device number 27 using xhci-hcd
2024-12-16 11:44:01.579774: [ 594.335028] [IGT] kms_plane: finished subtest pipe-A-plane-1, SUCCESS
2024-12-16 11:44:01.579788: [ 594.342441] usb 1-1.4: USB disconnect, device number 27
2024-12-16 11:44:01.579803: [ 594.342490] [IGT] kms_plane: starting dynamic subtest pipe-A-plane-2
2024-12-16 11:44:01.579817: [ 595.327043] usb 1-1.4: new high-speed USB device number 28 using xhci-hcd
2024-12-16 11:44:01.579831: [ 595.524995] usb 1-1.4: can't set config #1, error -71
2024-12-16 11:44:01.579845: [ 595.623550] usb 1-1.4: USB disconnect, device number 28
2024-12-16 11:44:01.579860: [ 596.350365] usb 1-1.4: new high-speed USB device number 29 using xhci-hcd
2024-12-16 11:44:01.579874: [ 596.635142] [IGT] kms_plane: finished subtest pipe-A-plane-2, SUCCESS
2024-12-16 11:44:01.579888: [ 596.642329] [IGT] kms_plane: starting dynamic subtest pipe-A-plane-3
2024-12-16 11:44:01.579902: [ 596.646539] usb 1-1.4: USB disconnect, device number 29
2024-12-16 11:44:01.579916: [ 597.631045] usb 1-1.4: new high-speed USB device number 30 using xhci-hcd
2024-12-16 11:44:01.579930: [ 597.743432] usb 1-1.4: device descriptor read/all, error -71
2024-12-16 11:44:01.579944: [ 598.670994] usb 1-1.4: new high-speed USB device number 31 using xhci-hcd
2024-12-16 11:44:01.579958: [ 598.883277] [IGT] kms_plane: finished subtest pipe-A-plane-3, SUCCESS
2024-12-16 11:44:01.579972: [ 598.950664] usb 1-1.4: USB disconnect, device number 31
2024-12-16 11:44:01.579986: [ 599.934106] usb 1-1.4: new high-speed USB device number 32 using xhci-hcd
2024-12-16 11:44:01.580000: [ 600.031655] usb 1-1.4: device descriptor read/all, error -71
2024-12-16 11:44:01.580014: [ 600.047199] [IGT] kms_plane: starting dynamic subtest pipe-B-plane-1
2024-12-16 11:44:01.580028: [ 600.055421] [IGT] kms_plane: finished subtest pipe-B-plane-1, SUCCESS
2024-12-16 11:44:01.580043: [ 600.062569] [IGT] kms_plane: starting dynamic subtest pipe-B-plane-2
2024-12-16 11:44:01.580057: [ 600.958314] usb 1-1.4: new high-speed USB device number 33 using xhci-hcd
2024-12-16 11:44:01.580071: [ 601.256192] usb 1-1.4: USB disconnect, device number 33
2024-12-16 11:44:01.580085: [ 602.238255] usb 1-1.4: new high-speed USB device number 34 using xhci-hcd
2024-12-16 11:44:01.580099: [ 602.318585] usb 1-1.4: Device not responding to setup address.
2024-12-16 11:44:01.580113: [ 602.339598] [IGT] kms_plane: finished subtest pipe-B-plane-2, SUCCESS
2024-12-16 11:44:01.580127: [ 602.346739] [IGT] kms_plane: starting dynamic subtest pipe-B-plane-3
2024-12-16 11:44:01.580141: [ 602.531698] usb 1-1.4: Device not responding to setup address.
2024-12-16 11:44:01.580155: [ 602.742279] usb 1-1.4: device not accepting address 34, error -71
2024-12-16 11:44:01.580169: [ 603.262151] usb 1-1.4: new high-speed USB device number 35 using xhci-hcd
2024-12-16 11:44:01.580515: DEBUG - End test kms_plane@plane-position-hole-dpmsdmesg: lava.zip