[62.190498] Initializing watchdogs
[62.190543]   /dev/watchdog0
[62.205142] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[62.209888] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.212255] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.214152] [001/133] (960s left) kms_chamelium_hpd (hdmi-hpd-fast)
[62.599733] Subtest hdmi-hpd-fast: SKIP (0.000s)
[63.396192] [002/133] (959s left) kms_properties (plane-properties-legacy)
[63.486542] Starting subtest: plane-properties-legacy
[63.487632] Starting dynamic subtest: pipe-A-eDP-1
[64.060916] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[64.066824] Starting dynamic subtest: pipe-B-eDP-1
[65.300473] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.239s)
[65.307042] Starting dynamic subtest: pipe-C-eDP-1
[66.529412] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.227s)
[66.535624] Starting dynamic subtest: pipe-D-eDP-1
[67.754331] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[67.755333] Subtest plane-properties-legacy: SUCCESS (4.266s)
[68.535694] [003/133] (954s left) gem_mmap (basic)
[68.595846] Subtest basic: SKIP (0.000s)
[68.653479] [004/133] (954s left) gem_exec_schedule (u-fairslice)
[68.710326] Starting subtest: u-fairslice
[68.711376] Starting dynamic subtest: rcs0
[70.736165] Dynamic subtest rcs0: SUCCESS (2.019s)
[70.743510] Starting dynamic subtest: bcs0
[72.753976] Dynamic subtest bcs0: SUCCESS (2.016s)
[72.762466] Starting dynamic subtest: vcs0
[74.775050] Dynamic subtest vcs0: SUCCESS (2.021s)
[74.782803] Starting dynamic subtest: vcs1
[76.795467] Dynamic subtest vcs1: SUCCESS (2.019s)
[76.802344] Starting dynamic subtest: vecs0
[78.811946] Dynamic subtest vecs0: SUCCESS (2.018s)
[78.820174] Starting dynamic subtest: ccs0
[80.833275] Dynamic subtest ccs0: SUCCESS (2.020s)
[80.834296] Subtest u-fairslice: SUCCESS (12.115s)
[81.117766] [005/133] (941s left) gem_workarounds (suspend-resume)
[81.179030] Starting subtest: suspend-resume
[97.572329] Subtest suspend-resume: SUCCESS (1.704s)
[106.716816] [006/133] (925s left) kms_color (gamma)
[106.824886] Starting subtest: gamma
[106.825773] Starting dynamic subtest: pipe-A-eDP-1
[107.536238] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[107.543300] Starting dynamic subtest: pipe-B-eDP-1
[108.977927] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.431s)
[108.985244] Starting dynamic subtest: pipe-C-eDP-1
[110.344227] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.357s)
[110.357047] Starting dynamic subtest: pipe-D-eDP-1
[111.686087] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[111.686971] Subtest gamma: SUCCESS (4.834s)
[112.490656] [007/133] (919s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[112.584893] Starting subtest: yf-tiled-64bpp-rotate-180
[112.586782] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[112.669977] [008/133] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[112.760481] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[112.762171] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[112.850262] [009/133] (919s left) gem_exec_balancer (bonded-sync)
[112.910336] Starting subtest: bonded-sync
[112.912288] Subtest bonded-sync: SKIP (0.000s)
[113.197515] [010/133] (918s left) kms_invalid_mode (bad-hsync-end)
[113.286701] Starting subtest: bad-hsync-end
[113.287766] Starting dynamic subtest: pipe-A-eDP-1
[113.570029] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[113.576270] Starting dynamic subtest: pipe-B-eDP-1
[113.577166] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[113.582945] Starting dynamic subtest: pipe-C-eDP-1
[113.583779] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[113.589675] Starting dynamic subtest: pipe-D-eDP-1
[113.590556] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[113.591446] Subtest bad-hsync-end: SUCCESS (0.287s)
[114.423491] [011/133] (917s left) gem_tiled_pread_basic (basic)
[114.481866] Subtest basic: SKIP (0.000s)
[114.540651] [012/133] (917s left) gem_exec_balancer (parallel-keep-in-fence)
[114.795701] Starting subtest: parallel-keep-in-fence
[116.105481] Subtest parallel-keep-in-fence: SUCCESS (1.305s)
[116.194660] [013/133] (915s left) kms_pm_backlight (brightness-with-dpms)
[116.284402] Starting subtest: brightness-with-dpms
[116.334338] Starting dynamic subtest: eDP-1
[118.724435] Dynamic subtest eDP-1: SUCCESS (2.383s)
[118.725474] Subtest brightness-with-dpms: SUCCESS (2.434s)
[119.593996] [014/133] (912s left) i915_drm_fdinfo (memory-info-active)
[119.632396] Starting subtest: memory-info-active
[119.640707] Starting dynamic subtest: smem0
[122.211543] Dynamic subtest smem0: SUCCESS (2.576s)
[122.212749] Subtest memory-info-active: SUCCESS (2.576s)
[122.284583] [015/133] (909s left) perf (polling-parameterized)
[122.400713] Starting subtest: polling-parameterized
[142.465970] Subtest polling-parameterized: SUCCESS (20.006s)
[142.497664] [016/133] (889s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[142.586503] Starting subtest: psr2-cursor-plane-move-continuous-sf
[142.587421] Starting dynamic subtest: pipe-A-eDP-1
[152.935365] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.348s)
[152.950258] Starting dynamic subtest: pipe-B-eDP-1
[163.980602] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.042s)
[163.981868] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.392s)
[164.783052] [017/133] (867s left) kms_flip_tiling (flip-change-tiling)
[164.874094] Starting subtest: flip-change-tiling
[164.875024] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[165.051478] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.177s)
[165.063541] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[165.205529] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.143s)
[165.214046] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[165.349535] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.143s)
[165.359253] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[165.485259] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.144s)
[165.495337] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[165.629381] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.144s)
[165.640950] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[165.773408] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s)
[165.783326] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[165.907624] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.132s)
[165.917442] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[166.018628] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[166.028372] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[166.152226] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[166.162439] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[166.297081] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.144s)
[166.306401] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[166.440178] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s)
[166.450190] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[166.585004] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.143s)
[166.595193] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[166.718570] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[166.728167] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[166.852385] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[166.863651] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[166.974748] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.121s)
[166.985478] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[167.119891] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.144s)
[167.130716] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[167.262895] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[167.273349] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[167.407201] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[167.416693] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[167.552245] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s)
[167.562712] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[167.697139] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[167.707287] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[167.864203] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.166s)
[167.874576] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[167.985680] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.121s)
[167.996046] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[168.129628] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.143s)
[168.139625] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[168.274155] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.144s)
[168.285390] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[168.418582] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s)
[168.428280] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[168.563182] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s)
[168.572632] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[168.708138] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.143s)
[168.717139] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[168.852095] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.143s)
[168.861069] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[168.985809] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.132s)
[168.996088] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[169.130103] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.143s)
[169.140027] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[169.274571] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[169.283271] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[169.419669] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.144s)
[169.431385] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[169.564221] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[169.579509] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[169.708390] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.143s)
[169.718378] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[169.853276] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.144s)
[169.863177] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[169.975636] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.121s)
[170.027506] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[171.264560] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.243s)
[171.273516] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[171.408819] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.132s)
[171.418219] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[171.551229] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.143s)
[171.560274] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[171.687157] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s)
[171.696458] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[171.831593] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.143s)
[171.844320] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[171.975936] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s)
[171.986247] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[172.109801] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.133s)
[172.120117] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[172.220549] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[172.230330] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[172.355253] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.133s)
[172.364391] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[172.498724] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.143s)
[172.508924] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[172.642669] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s)
[172.653293] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[172.775992] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.132s)
[172.789285] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[172.909832] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[172.920418] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[173.052453] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[173.062315] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[173.154257] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[173.164036] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[173.299623] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.144s)
[173.310574] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[173.445810] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[173.454557] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[173.587514] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[173.600100] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[173.732042] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s)
[173.741727] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[173.876829] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[173.885776] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[174.021360] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.143s)
[174.032182] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[174.143314] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.121s)
[174.153801] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[174.288184] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.143s)
[174.301681] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[174.443401] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.154s)
[174.453321] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[174.587755] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s)
[174.597393] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[174.732561] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s)
[174.742684] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[174.876809] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.143s)
[174.889418] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[175.021694] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.143s)
[175.032283] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[175.144038] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.121s)
[175.153780] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[175.299710] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.155s)
[175.309516] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[175.443789] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s)
[175.453486] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[175.588633] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.144s)
[175.599113] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[175.732894] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[175.743682] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[175.877125] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.143s)
[175.887467] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[176.021883] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.143s)
[176.032045] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[176.144247] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.121s)
[176.198182] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[177.389877] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.200s)
[177.399495] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[177.490601] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[177.500440] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[177.589761] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[177.599001] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[177.701128] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[177.710469] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[177.811923] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[177.820959] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[177.922822] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[177.932443] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[178.023641] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[178.033490] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[178.123511] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[178.133143] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[178.234546] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.110s)
[178.244198] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[178.345695] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[178.354317] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[178.456224] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[178.466458] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[178.567441] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[178.579327] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[178.667670] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[178.677087] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[178.767723] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[178.778305] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[178.867908] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[178.877764] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[178.967689] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.099s)
[178.976473] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[179.067682] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.099s)
[179.076913] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[179.224937] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.156s)
[179.234114] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[179.336774] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[179.347718] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[179.448163] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[179.458522] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[179.559177] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.110s)
[179.569355] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[179.669867] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.110s)
[179.679992] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[179.780629] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.110s)
[179.790185] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[179.891772] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[179.901710] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[180.002878] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[180.012246] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[180.114075] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[180.124264] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[180.225298] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[180.235125] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[180.375142] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.149s)
[180.384642] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[180.486406] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[180.496398] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[180.597939] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.110s)
[180.611116] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[180.708434] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[180.720290] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[180.819911] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[180.829894] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[180.930802] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[180.940094] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[181.041949] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[181.052052] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[181.153666] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[181.163904] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[181.264898] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s)
[181.305456] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[182.529636] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.230s)
[182.544135] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[182.629331] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[182.638513] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[182.729397] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[182.739281] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[182.840787] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[182.850915] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[182.951118] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[182.963708] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[183.062258] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[183.075625] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[183.162880] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[183.172895] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[183.262820] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[183.272106] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[183.363092] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[183.372371] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[183.474142] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[183.488548] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[183.584716] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[183.594398] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[183.695885] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[183.704801] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[183.796184] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[183.805940] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[183.896078] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[183.905332] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[183.996055] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[184.004855] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[184.107203] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[184.116066] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[184.218179] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[184.227033] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[184.329409] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[184.342151] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[184.429557] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[184.439248] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[184.529667] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s)
[184.539807] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[184.629788] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[184.639489] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[184.752119] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.121s)
[184.762547] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[184.862891] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.110s)
[184.872758] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[184.974038] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[184.983376] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[185.073964] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s)
[185.083452] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[185.185252] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[185.194733] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[185.297068] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[185.306930] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[185.407764] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[185.416408] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[185.531005] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.121s)
[185.540694] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[185.642118] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.110s)
[185.652293] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[185.763238] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.121s)
[185.771911] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[185.875390] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[185.885738] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[185.996893] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.121s)
[186.006646] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[186.118987] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.121s)
[186.131218] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[186.230394] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[186.240191] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[186.341599] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.110s)
[186.375170] Subtest flip-change-tiling: SUCCESS (21.494s)
[187.512542] [018/133] (844s left) kms_dsc (dsc-with-bpc)
[187.601076] Starting subtest: dsc-with-bpc
[187.612890] Subtest dsc-with-bpc: SKIP (0.001s)
[187.666785] [019/133] (844s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[187.747315] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[187.749588] Starting dynamic subtest: A-eDP1
[191.356492] Dynamic subtest A-eDP1: SUCCESS (3.605s)
[191.363634] Starting dynamic subtest: B-eDP1
[194.553985] Dynamic subtest B-eDP1: SUCCESS (3.196s)
[194.560721] Starting dynamic subtest: C-eDP1
[197.667942] Dynamic subtest C-eDP1: SUCCESS (3.112s)
[197.675345] Starting dynamic subtest: D-eDP1
[200.861326] Dynamic subtest D-eDP1: SUCCESS (3.191s)
[200.863285] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.111s)
[201.660069] [020/133] (830s left) gem_ctx_persistence (engines-hang)
[201.715329] Starting subtest: engines-hang
[201.716406] Starting dynamic subtest: rcs0
[201.846609] Dynamic subtest rcs0: SUCCESS (0.131s)
[201.857142] Starting dynamic subtest: bcs0
[201.947490] Dynamic subtest bcs0: SUCCESS (0.100s)
[201.956927] Starting dynamic subtest: vcs0
[202.041695] Dynamic subtest vcs0: SUCCESS (0.093s)
[202.051895] Starting dynamic subtest: vcs1
[202.154242] Dynamic subtest vcs1: SUCCESS (0.111s)
[202.166437] Starting dynamic subtest: vecs0
[202.251123] Dynamic subtest vecs0: SUCCESS (0.096s)
[202.262107] Starting dynamic subtest: ccs0
[202.355444] Dynamic subtest ccs0: SUCCESS (0.103s)
[202.356868] Subtest engines-hang: SUCCESS (0.641s)
[202.425990] [021/133] (829s left) kms_cursor_crc (cursor-alpha-transparent)
[202.515226] Starting subtest: cursor-alpha-transparent
[202.516201] Starting dynamic subtest: pipe-A-eDP-1
[203.146804] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s)
[203.154016] Starting dynamic subtest: pipe-D-eDP-1
[204.421195] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.274s)
[204.422040] Subtest cursor-alpha-transparent: SUCCESS (1.908s)
[205.223023] [022/133] (827s left) gem_mmap_offset (bad-extensions)
[205.274385] Starting subtest: bad-extensions
[205.275378] Subtest bad-extensions: SUCCESS (0.000s)
[205.359105] [023/133] (827s left) kms_addfb_basic (invalid-set-prop)
[205.407611] Starting subtest: invalid-set-prop
[205.409169] Subtest invalid-set-prop: SUCCESS (0.000s)
[205.557984] [024/133] (826s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[205.651294] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[205.652197] Starting dynamic subtest: pipe-A
[205.716262] Dynamic subtest pipe-A: SUCCESS (0.065s)
[205.725641] Starting dynamic subtest: pipe-B
[206.855507] Dynamic subtest pipe-B: SUCCESS (1.139s)
[206.864448] Starting dynamic subtest: pipe-C
[207.967712] Dynamic subtest pipe-C: SUCCESS (1.111s)
[207.976946] Starting dynamic subtest: pipe-D
[209.097254] Dynamic subtest pipe-D: SUCCESS (1.128s)
[209.098224] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.448s)
[210.248565] [025/133] (822s left) syncobj_timeline (reset-signaled)
[210.303177] Starting subtest: reset-signaled
[210.304139] Subtest reset-signaled: SUCCESS (0.001s)
[210.404714] [026/133] (822s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[210.491812] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[210.493568] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[210.586656] [027/133] (821s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[210.663953] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[210.664798] Starting dynamic subtest: pipe-A-eDP-1
[210.673269] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.680949] Starting dynamic subtest: pipe-B-eDP-1
[210.689176] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.701597] Starting dynamic subtest: pipe-C-eDP-1
[210.709349] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.716302] Starting dynamic subtest: pipe-D-eDP-1
[210.724250] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.725729] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[212.914064] [028/133] (819s left) kms_hdr (invalid-metadata-sizes)
[213.004037] Starting subtest: invalid-metadata-sizes
[213.006646] Subtest invalid-metadata-sizes: SKIP (0.000s)
[213.067748] [029/133] (819s left) gem_fence_thrash (bo-write-verify-y)
[213.102953] Starting subtest: bo-write-verify-y
[213.131354] Subtest bo-write-verify-y: SKIP (0.027s)
[213.183940] [030/133] (819s left) gem_render_copy (linear-to-vebox-y-tiled)
[213.238462] Starting subtest: linear-to-vebox-y-tiled
[213.240540] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[213.413691] [031/133] (819s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[213.495405] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[213.497301] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[213.563751] [032/133] (819s left) i915_query (query-regions-garbage-items)
[213.622298] Starting subtest: query-regions-garbage-items
[213.623368] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[213.723074] [033/133] (819s left) syncobj_timeline (invalid-wait-illegal-handle)
[213.779715] Starting subtest: invalid-wait-illegal-handle
[213.780781] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[213.878437] [034/133] (818s left) kms_prop_blob (invalid-set-prop)
[213.930138] Starting subtest: invalid-set-prop
[213.931177] Subtest invalid-set-prop: SUCCESS (0.000s)
[214.039819] [035/133] (818s left) gem_gpgpu_fill (offset-16x16)
[214.092893] Starting subtest: offset-16x16
[214.099758] Subtest offset-16x16: SUCCESS (0.007s)
[214.216280] [036/133] (818s left) gem_ctx_shared (q-out-order)
[214.279531] Starting subtest: Q-out-order
[214.280598] Starting dynamic subtest: rcs0
[214.419430] Dynamic subtest rcs0: SUCCESS (0.141s)
[214.434939] Starting dynamic subtest: vcs0
[214.507322] Dynamic subtest vcs0: SUCCESS (0.087s)
[214.523618] Starting dynamic subtest: vcs1
[214.590335] Dynamic subtest vcs1: SUCCESS (0.081s)
[214.605187] Starting dynamic subtest: vecs0
[214.666605] Dynamic subtest vecs0: SUCCESS (0.076s)
[214.683116] Starting dynamic subtest: ccs0
[214.747746] Dynamic subtest ccs0: SUCCESS (0.080s)
[214.749235] Subtest Q-out-order: SUCCESS (0.469s)
[215.699406] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[215.701306] [037/133] (817s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[215.803169] Starting subtest: fbc-rgb565-draw-render
[220.032862] Subtest fbc-rgb565-draw-render: SUCCESS (4.230s)
[221.215756] [038/133] (811s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[221.303623] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[221.305308] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[221.420816] [039/133] (811s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[221.513133] Starting subtest: fbc-rgb101010-draw-pwrite
[226.963387] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.451s)
[228.108957] [040/133] (804s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[228.202289] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[228.203940] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[228.268055] [041/133] (804s left) gem_linear_blits (normal)
[228.656531] Starting subtest: normal
[232.251444] Subtest normal: SUCCESS (3.586s)
[232.405703] [042/133] (800s left) sysfs_heartbeat_interval (precise)
[232.503157] Starting subtest: precise
[232.504185] Starting dynamic subtest: vecs0
[239.605703] Dynamic subtest vecs0: SUCCESS (7.101s)
[239.629117] Starting dynamic subtest: ccs0
[240.796316] Dynamic subtest ccs0: SUCCESS (1.179s)
[240.805656] Starting dynamic subtest: vcs0
[247.613720] Dynamic subtest vcs0: SUCCESS (6.824s)
[247.625115] Starting dynamic subtest: bcs0
[248.657654] Dynamic subtest bcs0: SUCCESS (1.041s)
[248.667864] Starting dynamic subtest: rcs0
[249.755641] Dynamic subtest rcs0: SUCCESS (1.097s)
[249.766493] Starting dynamic subtest: vcs1
[257.601248] Dynamic subtest vcs1: SUCCESS (7.835s)
[257.602330] Subtest precise: SUCCESS (25.087s)
[257.699177] [043/133] (775s left) sw_sync (sync_busy_fork_unixsocket)
[257.736383] Starting subtest: sync_busy_fork_unixsocket
[257.744213] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[257.805265] [044/133] (775s left) prime_mmap (test_reprime)
[257.848243] Starting subtest: test_reprime
[257.849463] Starting dynamic subtest: test_reprime-smem
[257.881563] Dynamic subtest test_reprime-smem: SUCCESS (0.034s)
[257.883013] Subtest test_reprime: SUCCESS (0.035s)
[257.974575] [045/133] (775s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[258.103777] Starting subtest: cursorA-vs-flipA-atomic-transitions
[269.539672] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.434s)
[270.327146] [046/133] (762s left) kms_psr (psr2-dpms)
[270.437345] Starting subtest: psr2-dpms
[270.438248] Starting dynamic subtest: eDP-1
[273.370439] Dynamic subtest eDP-1: SUCCESS (2.931s)
[273.371347] Subtest psr2-dpms: SUCCESS (2.932s)
[274.238826] [047/133] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[274.338227] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[274.339913] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[274.423683] [048/133] (758s left) dmabuf (all-tests)
[274.457002] Starting subtest: all-tests
[274.457955] Starting dynamic subtest: sanitycheck
[274.607770] Dynamic subtest sanitycheck: SUCCESS (0.149s)
[274.619617] Starting dynamic subtest: dma_fence
[274.803905] Dynamic subtest dma_fence: SUCCESS (0.194s)
[274.824349] Starting dynamic subtest: dma_fence_chain
[284.569914] Dynamic subtest dma_fence_chain: SUCCESS (9.751s)
[284.579530] Starting dynamic subtest: dma_fence_unwrap
[284.645692] Dynamic subtest dma_fence_unwrap: SUCCESS (0.082s)
[284.657632] Starting dynamic subtest: dma_resv
[284.727561] Dynamic subtest dma_resv: SUCCESS (0.079s)
[284.730865] Subtest all-tests: SUCCESS (10.269s)
[284.790000] [049/133] (748s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[284.904217] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[285.899026] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.993s)
[286.782942] [050/133] (746s left) kms_force_connector_basic (force-edid)
[286.867051] Starting subtest: force-edid
[287.231042] Subtest force-edid: SUCCESS (0.365s)
[287.362892] [051/133] (746s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[287.462535] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[287.464501] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[287.575596] [052/133] (745s left) i915_pm_rc6_residency (rc6-idle)
[287.634597] Starting subtest: rc6-idle
[287.655811] Starting dynamic subtest: gt0-rcs0
[311.956701] Dynamic subtest gt0-rcs0: SUCCESS (24.294s)
[311.966495] Starting dynamic subtest: gt0-bcs0
[336.246794] Dynamic subtest gt0-bcs0: SUCCESS (24.285s)
[336.257424] Starting dynamic subtest: gt0-ccs0
[360.613712] Dynamic subtest gt0-ccs0: SUCCESS (24.368s)
[360.624008] Starting dynamic subtest: gt1-vcs0
[366.833177] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[366.844260] Starting dynamic subtest: gt1-vecs0
[373.003419] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[373.004527] Subtest rc6-idle: SUCCESS (85.322s)
[373.038122] [053/133] (660s left) kms_async_flips (crc-atomic)
[373.140882] Starting subtest: crc-atomic
[373.530798] Starting dynamic subtest: pipe-A-eDP-1
[376.485228] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.954s)
[376.866817] Starting dynamic subtest: pipe-B-eDP-1
[379.787580] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.928s)
[380.172168] Starting dynamic subtest: pipe-C-eDP-1
[383.063727] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.899s)
[383.439914] Starting dynamic subtest: pipe-D-eDP-1
[386.365412] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.932s)
[386.366305] Subtest crc-atomic: SUCCESS (13.226s)
[387.587821] [054/133] (645s left) api_intel_allocator (reserve-simple)
[387.639884] Starting subtest: reserve-simple
[387.641256] Subtest reserve-simple: SUCCESS (0.003s)
[387.782424] [055/133] (645s left) kms_big_fb (linear-8bpp-rotate-90)
[387.892063] Starting subtest: linear-8bpp-rotate-90
[387.914471] Subtest linear-8bpp-rotate-90: SKIP (0.022s)
[388.011973] [056/133] (645s left) kms_joiner (invalid-modeset-ultra-joiner)
[388.098381] Starting subtest: invalid-modeset-ultra-joiner
[388.100035] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[388.165223] [057/133] (645s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[388.277760] Starting subtest: cursorA-vs-flipB-varying-size
[388.279393] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[388.438607] [058/133] (645s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[388.520791] Starting subtest: fbc-2p-pri-indfb-multidraw
[388.522422] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[388.609569] [059/133] (645s left) kms_flip (plain-flip-ts-check-interruptible)
[388.699741] Starting subtest: plain-flip-ts-check-interruptible
[388.702146] Starting dynamic subtest: A-eDP1
[397.577092] Dynamic subtest A-eDP1: SUCCESS (8.849s)
[397.587940] Starting dynamic subtest: B-eDP1
[406.377098] Dynamic subtest B-eDP1: SUCCESS (8.797s)
[406.386929] Starting dynamic subtest: C-eDP1
[415.173080] Dynamic subtest C-eDP1: SUCCESS (8.781s)
[415.185447] Starting dynamic subtest: D-eDP1
[423.981785] Dynamic subtest D-eDP1: SUCCESS (8.806s)
[423.982925] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.245s)
[425.126151] [060/133] (608s left) syncobj_wait (invalid-signal-illegal-handle)
[425.186548] Starting subtest: invalid-signal-illegal-handle
[425.187500] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[425.277085] [061/133] (608s left) gem_basic (create-close)
[425.328057] Starting subtest: create-close
[425.330124] Subtest create-close: SUCCESS (0.000s)
[425.437759] [062/133] (608s left) gem_exec_schedule (wide)
[425.609047] Starting subtest: wide
[425.610138] Starting dynamic subtest: rcs0
[435.933504] Dynamic subtest rcs0: SUCCESS (10.275s)
[435.952539] Starting dynamic subtest: vcs0
[445.928589] Dynamic subtest vcs0: SUCCESS (10.029s)
[445.939465] Starting dynamic subtest: vcs1
[456.414709] Dynamic subtest vcs1: SUCCESS (10.483s)
[456.425285] Starting dynamic subtest: vecs0
[466.092880] Dynamic subtest vecs0: SUCCESS (9.676s)
[466.103896] Starting dynamic subtest: ccs0
[479.800285] Dynamic subtest ccs0: SUCCESS (13.667s)
[479.801699] Subtest wide: SUCCESS (54.136s)
[481.497579] [063/133] (552s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[481.558102] Starting subtest: y-tiled-ccs-to-yf-tiled
[481.559778] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[481.743449] [064/133] (552s left) gem_exec_reloc (basic-cpu)
[481.804281] Subtest basic-cpu: SKIP (0.000s)
[481.861830] [065/133] (552s left) gem_exec_reloc (basic-gtt-cpu-active)
[481.914881] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[481.971567] [066/133] (551s left) i915_drm_fdinfo (virtual-idle)
[482.015618] Starting subtest: virtual-idle
[485.100752] Subtest virtual-idle: SUCCESS (3.073s)
[485.175028] [067/133] (548s left) kms_psr (fbc-pr-primary-mmap-cpu)
[485.265554] Starting subtest: fbc-pr-primary-mmap-cpu
[485.267589] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[485.333109] [068/133] (548s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[485.415573] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[485.417329] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[485.483133] [069/133] (548s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[485.529408] Starting subtest: etime-single-wait-for-submit-unsubmitted
[485.635866] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[485.730231] [070/133] (548s left) gem_mmap_gtt (basic-write-read)
[485.774652] Subtest basic-write-read: SKIP (0.000s)
[485.825398] [071/133] (548s left) i915_query (query-topology-matches-eu-total)
[485.875936] Starting subtest: query-topology-matches-eu-total
[485.876874] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[485.963730] [072/133] (548s left) kms_psr (pr-cursor-render)
[486.050348] Starting subtest: pr-cursor-render
[486.052130] Subtest pr-cursor-render: SKIP (0.000s)
[486.117912] [073/133] (548s left) kms_frontbuffer_tracking (fbc-tiling-y)
[486.198964] Starting subtest: fbc-tiling-y
[486.200579] Subtest fbc-tiling-y: SKIP (0.000s)
[486.290105] [074/133] (547s left) gem_reg_read (timestamp-monotonic)
[486.333112] Starting subtest: timestamp-monotonic
[490.628649] Subtest timestamp-monotonic: SUCCESS (4.286s)
[490.690318] [075/133] (543s left) gem_tiled_partial_pwrite_pread (reads)
[490.747332] Subtest reads: SKIP (0.000s)
[490.808460] [076/133] (543s left) gem_softpin (evict-snoop-interruptible)
[490.862072] Starting subtest: evict-snoop-interruptible
[490.863763] Subtest evict-snoop-interruptible: SKIP (0.000s)
[490.966600] [077/133] (543s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[491.063133] Starting subtest: fbc-psr2-cursor-plane-onoff
[491.064121] Starting dynamic subtest: eDP-1
[491.066086] Dynamic subtest eDP-1: SKIP (0.000s)
[491.067899] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[491.132762] [078/133] (543s left) syncobj_basic (bad-destroy-pad)
[491.186223] Starting subtest: bad-destroy-pad
[491.187228] Subtest bad-destroy-pad: SUCCESS (0.000s)
[491.278551] [079/133] (543s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[491.376268] Starting subtest: async-flip-with-page-flip-events-tiled
[491.747866] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[494.545317] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[494.556769] Starting dynamic subtest: pipe-A-eDP-1-4
[496.719826] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s)
[496.727806] Starting dynamic subtest: pipe-A-eDP-1-4
[498.730131] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[498.738733] Starting dynamic subtest: pipe-A-eDP-1-x
[500.943262] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.211s)
[501.305137] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[504.050100] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.742s)
[504.060478] Starting dynamic subtest: pipe-B-eDP-1-4
[506.236293] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[506.244432] Starting dynamic subtest: pipe-B-eDP-1-4
[508.246079] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[508.257228] Starting dynamic subtest: pipe-B-eDP-1-x
[510.437174] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[510.793271] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[513.546046] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.750s)
[513.557010] Starting dynamic subtest: pipe-C-eDP-1-4
[515.721100] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[515.731737] Starting dynamic subtest: pipe-C-eDP-1-4
[517.731830] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[517.740593] Starting dynamic subtest: pipe-C-eDP-1-x
[519.911146] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[520.263926] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[523.052003] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.785s)
[523.063743] Starting dynamic subtest: pipe-D-eDP-1-4
[525.215344] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.162s)
[525.223973] Starting dynamic subtest: pipe-D-eDP-1-4
[527.225865] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[527.234322] Starting dynamic subtest: pipe-D-eDP-1-x
[529.394095] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.167s)
[529.395482] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.001s)
[530.590669] [080/133] (503s left) kms_chamelium_edid (vga-edid-read)
[530.978893] Subtest vga-edid-read: SKIP (0.000s)
[531.772497] [081/133] (502s left) kms_psr (fbc-psr-no-drrs)
[531.865299] Starting subtest: fbc-psr-no-drrs
[531.866261] Starting dynamic subtest: eDP-1
[531.868078] Dynamic subtest eDP-1: SKIP (0.000s)
[531.869890] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[531.934818] [082/133] (502s left) kms_pipe_crc_basic (hang-read-crc)
[532.024185] Starting subtest: hang-read-crc
[532.025090] Starting dynamic subtest: pipe-A-eDP-1
[534.157371] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.132s)
[534.165583] Starting dynamic subtest: pipe-B-eDP-1
[536.958596] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.799s)
[536.967403] Starting dynamic subtest: pipe-C-eDP-1
[539.619878] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.660s)
[539.629497] Starting dynamic subtest: pipe-D-eDP-1
[542.311062] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.689s)
[542.311894] Subtest hang-read-crc: SUCCESS (10.284s)
[543.132251] [083/133] (491s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[543.220643] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[543.222525] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[543.313768] [084/133] (491s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[544.848497] Starting subtest: modeset-lpsp-stress-no-wait
[555.437675] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.590s)
[555.527583] [085/133] (479s left) fbdev (nullptr)
[555.578811] Starting subtest: nullptr
[555.579893] Subtest nullptr: SUCCESS (0.000s)
[555.635614] [086/133] (478s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[555.744372] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[555.746184] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[555.829614] [087/133] (478s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[555.882687] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[555.986709] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.104s)
[556.057011] [088/133] (478s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[556.142898] Starting subtest: primary-x-tiled-reflect-x-0
[563.150636] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.007s)
[564.303757] [089/133] (470s left) gem_exec_schedule (pi-userfault)
[564.480502] Starting subtest: pi-userfault
[564.481591] Starting dynamic subtest: rcs0
[564.482535] Dynamic subtest rcs0: SUCCESS (0.009s)
[564.491510] Starting dynamic subtest: bcs0
[564.492288] Dynamic subtest bcs0: SUCCESS (0.008s)
[564.500149] Starting dynamic subtest: vcs0
[564.500907] Dynamic subtest vcs0: SUCCESS (0.007s)
[564.508850] Starting dynamic subtest: vcs1
[564.509591] Dynamic subtest vcs1: SUCCESS (0.007s)
[564.517457] Starting dynamic subtest: vecs0
[564.518236] Dynamic subtest vecs0: SUCCESS (0.008s)
[564.526395] Starting dynamic subtest: ccs0
[564.527193] Dynamic subtest ccs0: SUCCESS (0.011s)
[564.527946] Subtest pi-userfault: SUCCESS (0.054s)
[564.719047] [090/133] (470s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[564.806999] Starting subtest: x-tiled-32bpp-rotate-90
[564.826990] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[564.931757] [091/133] (469s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[565.033798] Starting subtest: y-tiled-64bpp-rotate-270
[565.035572] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[565.128582] [092/133] (469s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[565.220321] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[565.222107] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[565.288727] [093/133] (469s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[565.379746] Starting subtest: yf-tiled-32bpp-rotate-0
[565.381707] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[565.481632] [094/133] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[565.573702] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[565.575408] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[565.669533] [095/133] (469s left) kms_universal_plane (universal-plane-functional)
[565.764367] Starting subtest: universal-plane-functional
[565.765313] Starting dynamic subtest: pipe-A-eDP-1
[569.839418] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.073s)
[569.847585] Starting dynamic subtest: pipe-B-eDP-1
[574.521894] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.680s)
[574.530311] Starting dynamic subtest: pipe-C-eDP-1
[579.055819] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.531s)
[579.064424] Starting dynamic subtest: pipe-D-eDP-1
[583.480393] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.423s)
[583.481277] Subtest universal-plane-functional: SUCCESS (17.713s)
[584.297570] [096/133] (450s left) kms_cursor_legacy (single-move)
[584.405769] Starting subtest: single-move
[584.406656] Starting dynamic subtest: pipe-A
[589.829825] Dynamic subtest pipe-A: SUCCESS (5.378s)
[589.840852] Starting dynamic subtest: pipe-B
[595.208602] Dynamic subtest pipe-B: SUCCESS (5.379s)
[595.219771] Starting dynamic subtest: pipe-C
[600.587776] Dynamic subtest pipe-C: SUCCESS (5.379s)
[600.598920] Starting dynamic subtest: pipe-D
[605.966229] Dynamic subtest pipe-D: SUCCESS (5.379s)
[605.977156] Starting dynamic subtest: all-pipes
[611.317492] Dynamic subtest all-pipes: SUCCESS (5.387s)
[611.318537] Subtest single-move: SUCCESS (26.916s)
[611.448534] [097/133] (423s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[611.575829] Starting subtest: short-flip-after-cursor-atomic-transitions
[612.533876] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.959s)
[613.382085] [098/133] (421s left) gem_exec_params (invalid-ring)
[613.439263] Starting subtest: invalid-ring
[613.440332] Subtest invalid-ring: SUCCESS (0.000s)
[613.533346] [099/133] (421s left) gem_pread (self)
[613.588254] Subtest self: SKIP (0.000s)
[613.639321] [100/133] (421s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[613.723939] Starting subtest: primary-4-tiled-reflect-x-180
[620.760239] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.039s)
[621.985956] [101/133] (413s left) gem_spin_batch (spin-each)
[622.059197] Starting subtest: spin-each
[625.326512] Subtest spin-each: SUCCESS (3.262s)
[625.613642] [102/133] (409s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[625.705029] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[625.705826] Starting dynamic subtest: pipe-A-eDP-1
[625.714199] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[625.723021] Starting dynamic subtest: pipe-B-eDP-1
[625.731294] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[625.739641] Starting dynamic subtest: pipe-C-eDP-1
[625.747864] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[625.755615] Starting dynamic subtest: pipe-D-eDP-1
[625.764047] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[625.765686] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[627.988986] [103/133] (407s left) kms_cursor_edge_walk (128x128-top-edge)
[628.069298] Starting subtest: 128x128-top-edge
[628.070147] Starting dynamic subtest: pipe-A-eDP-1
[631.507050] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s)
[631.517314] Starting dynamic subtest: pipe-D-eDP-1
[634.695133] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.191s)
[634.696144] Subtest 128x128-top-edge: SUCCESS (6.629s)
[635.578563] [104/133] (399s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[635.662642] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[642.748966] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.088s)
[642.864979] [105/133] (392s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[642.951179] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[642.952905] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[643.018520] [106/133] (392s left) kms_cursor_crc (cursor-random-32x10)
[643.179602] Starting subtest: cursor-random-32x10
[643.225792] Subtest cursor-random-32x10: SKIP (0.044s)
[643.493215] [107/133] (391s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[643.590014] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[643.590799] Starting dynamic subtest: pipe-A-eDP-1
[643.597733] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[643.606678] Starting dynamic subtest: pipe-B-eDP-1
[643.614532] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[643.622512] Starting dynamic subtest: pipe-C-eDP-1
[643.630024] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[643.637749] Starting dynamic subtest: pipe-D-eDP-1
[643.644819] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[643.645615] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[645.885054] [108/133] (389s left) perf_pmu (busy)
[645.928096] Starting subtest: busy
[645.929014] Starting dynamic subtest: rcs0
[646.529075] Dynamic subtest rcs0: SUCCESS (0.600s)
[646.541160] Starting dynamic subtest: bcs0
[647.095648] Dynamic subtest bcs0: SUCCESS (0.564s)
[647.108166] Starting dynamic subtest: vcs0
[648.638921] Dynamic subtest vcs0: SUCCESS (1.532s)
[648.647592] Starting dynamic subtest: vcs1
[650.622921] Dynamic subtest vcs1: SUCCESS (1.982s)
[650.633360] Starting dynamic subtest: vecs0
[652.607155] Dynamic subtest vecs0: SUCCESS (1.981s)
[652.618247] Starting dynamic subtest: ccs0
[653.166166] Dynamic subtest ccs0: SUCCESS (0.565s)
[653.167734] Subtest busy: SUCCESS (7.240s)
[653.271814] [109/133] (382s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[653.360985] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[653.361872] Starting dynamic subtest: pipe-A-eDP-1
[654.660407] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.300s)
[654.670845] Starting dynamic subtest: pipe-B-eDP-1
[657.000170] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.339s)
[657.009697] Starting dynamic subtest: pipe-C-eDP-1
[659.412764] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.412s)
[659.422529] Starting dynamic subtest: pipe-D-eDP-1
[661.815208] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.401s)
[661.816195] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.456s)
[662.978967] [110/133] (372s left) kms_content_protection (atomic)
[663.125885] Starting subtest: atomic
[663.127644] Subtest atomic: SKIP (0.000s)
[663.230800] [111/133] (372s left) gem_exec_schedule (deep)
[663.418844] Starting subtest: deep
[663.420004] Starting dynamic subtest: rcs0
[669.154541] Dynamic subtest rcs0: SKIP (5.732s)
[669.170191] Starting dynamic subtest: vcs0
[680.096094] Dynamic subtest vcs0: SUCCESS (10.945s)
[680.108322] Starting dynamic subtest: vcs1
[691.664328] Dynamic subtest vcs1: SUCCESS (11.566s)
[691.680458] Starting dynamic subtest: vecs0
[703.673726] Dynamic subtest vecs0: SUCCESS (12.009s)
[703.690590] Starting dynamic subtest: ccs0
[716.503594] Dynamic subtest ccs0: SUCCESS (12.829s)
[716.505345] Subtest deep: SUCCESS (53.086s)
[718.389171] [112/133] (317s left) syncobj_wait (multi-wait-for-submit-signaled)
[718.432918] Starting subtest: multi-wait-for-submit-signaled
[718.433752] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[718.530027] [113/133] (317s left) gem_exec_fence (submit3)
[718.702493] Starting subtest: submit3
[718.704322] Subtest submit3: SKIP (0.000s)
[720.614610] [114/133] (314s left) gem_mmap_wc (write)
[720.670051] Subtest write: SKIP (0.000s)
[720.732607] [115/133] (314s left) gem_create (create-ext-placement-sanity-check)
[720.908319] Starting subtest: create-ext-placement-sanity-check
[720.909356] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[720.998818] [116/133] (314s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[721.087891] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[721.088792] Starting dynamic subtest: pipe-A-eDP-1
[722.008627] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.918s)
[722.016960] Starting dynamic subtest: pipe-B-eDP-1
[723.693676] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.683s)
[723.702100] Starting dynamic subtest: pipe-C-eDP-1
[725.289933] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.595s)
[725.298366] Starting dynamic subtest: pipe-D-eDP-1
[726.861089] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.570s)
[726.861992] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.771s)
[728.067112] [117/133] (307s left) gem_lmem_swapping (parallel-random-verify-ccs)
[728.109214] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[728.144869] [118/133] (307s left) api_intel_bb (object-reloc-keep-cache)
[728.187109] Starting subtest: object-reloc-keep-cache
[728.190165] Subtest object-reloc-keep-cache: SKIP (0.003s)
[728.297216] [119/133] (307s left) kms_rotation_crc (primary-rotation-90)
[728.379553] Starting subtest: primary-rotation-90
[728.381467] Subtest primary-rotation-90: SKIP (0.001s)
[728.448597] [120/133] (307s left) sw_sync (alloc_merge_fence)
[728.485180] Starting subtest: alloc_merge_fence
[728.486465] Subtest alloc_merge_fence: SUCCESS (0.000s)
[728.549206] [121/133] (307s left) kms_flip (2x-flip-vs-panning)
[728.631034] Starting subtest: 2x-flip-vs-panning
[728.641796] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[728.718345] [122/133] (307s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[728.807887] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[728.809736] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[728.908555] [123/133] (306s left) perf_pmu (busy-no-semaphores)
[728.945069] Starting subtest: busy-no-semaphores
[728.945971] Starting dynamic subtest: rcs0
[729.502427] Dynamic subtest rcs0: SUCCESS (0.547s)
[729.513389] Starting dynamic subtest: bcs0
[730.055386] Dynamic subtest bcs0: SUCCESS (0.549s)
[730.075040] Starting dynamic subtest: vcs0
[730.607921] Dynamic subtest vcs0: SUCCESS (0.549s)
[730.619626] Starting dynamic subtest: vcs1
[732.098521] Dynamic subtest vcs1: SUCCESS (1.487s)
[732.109089] Starting dynamic subtest: vecs0
[734.145876] Dynamic subtest vecs0: SUCCESS (2.045s)
[734.157046] Starting dynamic subtest: ccs0
[736.133857] Dynamic subtest ccs0: SUCCESS (1.985s)
[736.135141] Subtest busy-no-semaphores: SUCCESS (7.180s)
[736.251589] [124/133] (299s left) sw_sync (alloc_fence)
[736.283926] Starting subtest: alloc_fence
[736.284826] Subtest alloc_fence: SUCCESS (0.000s)
[736.337891] [125/133] (299s left) gem_eio (in-flight-contexts-immediate)
[736.535125] Starting subtest: in-flight-contexts-immediate
[750.614236] Subtest in-flight-contexts-immediate: SUCCESS (14.077s)
[750.763017] [126/133] (285s left) syncobj_timeline (wait-all-interrupted)
[750.807507] Starting subtest: wait-all-interrupted
[750.925249] Subtest wait-all-interrupted: SUCCESS (0.106s)
[751.000750] [127/133] (285s left) gem_ctx_shared (create-shared-gtt)
[751.062788] Starting subtest: create-shared-gtt
[753.216728] Subtest create-shared-gtt: SUCCESS (2.153s)
[753.826158] [128/133] (282s left) kms_vrr (flip-basic-fastset)
[753.949104] Starting subtest: flip-basic-fastset
[753.951861] Subtest flip-basic-fastset: SKIP (0.000s)
[754.016716] [129/133] (282s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[754.102173] Starting subtest: psr-rgb565-draw-mmap-gtt
[754.103883] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[754.189102] [130/133] (282s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[754.292262] Starting subtest: 4-tiled-16bpp-rotate-90
[754.313359] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[754.423281] [131/133] (281s left) kms_flip (dpms-off-confusion)
[754.521579] Starting subtest: dpms-off-confusion
[754.522483] Starting dynamic subtest: A-eDP1
[763.253866] Dynamic subtest A-eDP1: SUCCESS (8.703s)
[763.263121] Starting dynamic subtest: B-eDP1
[771.950004] Dynamic subtest B-eDP1: SUCCESS (8.692s)
[771.961164] Starting dynamic subtest: C-eDP1
[780.657623] Dynamic subtest C-eDP1: SUCCESS (8.694s)
[780.668446] Starting dynamic subtest: D-eDP1
[789.360822] Dynamic subtest D-eDP1: SUCCESS (8.700s)
[789.362038] Subtest dpms-off-confusion: SUCCESS (34.800s)
[790.558452] [132/133] (245s left) gen9_exec_parse (basic-rejected-ctx-param)
[790.617124] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[790.687373] [133/133] (245s left) gem_mmap_wc (set-cache-level)
[790.733871] Subtest set-cache-level: SKIP (0.000s)
[790.822116] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_hpd
results: parsing output: 1/ for test: kms_properties
results: parsing output: 2/ for test: gem_mmap
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: gem_workarounds
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: kms_invalid_mode
results: parsing output: 10/ for test: gem_tiled_pread_basic
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: kms_pm_backlight
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_flip_tiling
results: parsing output: 17/ for test: kms_dsc
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_ctx_persistence
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: gem_mmap_offset
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_plane_scaling
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_hdr
results: parsing output: 28/ for test: gem_fence_thrash
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: i915_query
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_prop_blob
results: parsing output: 34/ for test: gem_gpgpu_fill
results: parsing output: 35/ for test: gem_ctx_shared
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: gem_linear_blits
results: parsing output: 41/ for test: sysfs_heartbeat_interval
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: prime_mmap
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: dmabuf
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_force_connector_basic
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: i915_pm_rc6_residency
results: parsing output: 52/ for test: kms_async_flips
results: parsing output: 53/ for test: api_intel_allocator
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_joiner
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: gem_basic
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: i915_query
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_reg_read
results: parsing output: 74/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 75/ for test: gem_softpin
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: syncobj_basic
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: kms_chamelium_edid
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_pipe_crc_basic
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: fbdev
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_rotation_crc
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_universal_plane
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: gem_pread
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: gem_spin_batch
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_cursor_edge_walk
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_content_protection
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: gem_mmap_wc
results: parsing output: 114/ for test: gem_create
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: gem_lmem_swapping
results: parsing output: 117/ for test: api_intel_bb
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: sw_sync
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: sw_sync
results: parsing output: 124/ for test: gem_eio
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: gem_ctx_shared
results: parsing output: 127/ for test: kms_vrr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: gen9_exec_parse
results: parsing output: 132/ for test: gem_mmap_wc
Done.