[57.992498] Initializing watchdogs
[57.992544]   /dev/watchdog0
[58.013527] [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]
[58.017730] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.019982] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.023462] [001/133] (960s left) kms_chamelium_hpd (hdmi-hpd-fast)
[58.430876] Subtest hdmi-hpd-fast: SKIP (0.000s)
[59.272020] [002/133] (959s left) kms_properties (plane-properties-legacy)
[59.368248] Starting subtest: plane-properties-legacy
[59.370715] Starting dynamic subtest: pipe-A-eDP-1
[59.945717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[59.958305] Starting dynamic subtest: pipe-B-eDP-1
[61.255140] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.310s)
[61.263182] Starting dynamic subtest: pipe-C-eDP-1
[62.495148] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.241s)
[62.504228] Starting dynamic subtest: pipe-D-eDP-1
[63.733466] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[63.735472] Subtest plane-properties-legacy: SUCCESS (4.367s)
[64.577305] [003/133] (954s left) gem_mmap (basic)
[64.644211] Subtest basic: SKIP (0.000s)
[64.704574] [004/133] (953s left) gem_exec_schedule (u-fairslice)
[64.776347] Starting subtest: u-fairslice
[64.778624] Starting dynamic subtest: rcs0
[66.793481] Dynamic subtest rcs0: SUCCESS (2.017s)
[66.804057] Starting dynamic subtest: bcs0
[68.812710] Dynamic subtest bcs0: SUCCESS (2.020s)
[68.819644] Starting dynamic subtest: vcs0
[70.833692] Dynamic subtest vcs0: SUCCESS (2.021s)
[70.842683] Starting dynamic subtest: vcs1
[72.857896] Dynamic subtest vcs1: SUCCESS (2.024s)
[72.867076] Starting dynamic subtest: vecs0
[74.878463] Dynamic subtest vecs0: SUCCESS (2.020s)
[74.888662] Starting dynamic subtest: ccs0
[76.900696] Dynamic subtest ccs0: SUCCESS (2.023s)
[76.903019] Subtest u-fairslice: SUCCESS (12.126s)
[77.190900] [005/133] (941s left) gem_workarounds (suspend-resume)
[77.273701] Starting subtest: suspend-resume
[93.005832] Subtest suspend-resume: SUCCESS (1.302s)
[93.103691] [006/133] (925s left) kms_color (gamma)
[93.206839] Starting subtest: gamma
[93.209089] Starting dynamic subtest: pipe-A-eDP-1
[93.940353] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s)
[93.949422] Starting dynamic subtest: pipe-B-eDP-1
[95.381156] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.444s)
[95.390685] Starting dynamic subtest: pipe-C-eDP-1
[96.758776] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[96.769313] Starting dynamic subtest: pipe-D-eDP-1
[98.086467] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[98.088859] Subtest gamma: SUCCESS (4.887s)
[98.894934] [007/133] (919s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[98.993914] Starting subtest: yf-tiled-64bpp-rotate-180
[98.997980] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[99.099840] [008/133] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[99.201077] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[99.205186] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[99.282027] [009/133] (919s left) gem_exec_balancer (bonded-sync)
[99.337702] Starting subtest: bonded-sync
[99.342333] Subtest bonded-sync: SKIP (0.000s)
[99.632148] [010/133] (919s left) kms_invalid_mode (bad-hsync-end)
[99.738402] Starting subtest: bad-hsync-end
[99.740756] Starting dynamic subtest: pipe-A-eDP-1
[100.021419] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[100.029350] Starting dynamic subtest: pipe-B-eDP-1
[100.031626] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[100.041643] Starting dynamic subtest: pipe-C-eDP-1
[100.043998] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[100.056463] Starting dynamic subtest: pipe-D-eDP-1
[100.058839] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[100.061197] Subtest bad-hsync-end: SUCCESS (0.291s)
[100.821683] [011/133] (918s left) gem_tiled_pread_basic (basic)
[100.880866] Subtest basic: SKIP (0.000s)
[100.944339] [012/133] (918s left) gem_exec_balancer (parallel-keep-in-fence)
[101.209686] Starting subtest: parallel-keep-in-fence
[102.373235] Subtest parallel-keep-in-fence: SUCCESS (1.164s)
[102.493224] [013/133] (916s left) kms_pm_backlight (brightness-with-dpms)
[102.583380] Starting subtest: brightness-with-dpms
[102.632209] Starting dynamic subtest: eDP-1
[105.057030] Dynamic subtest eDP-1: SUCCESS (2.425s)
[105.059286] Subtest brightness-with-dpms: SUCCESS (2.476s)
[105.913441] [014/133] (913s left) i915_drm_fdinfo (memory-info-active)
[105.951398] Starting subtest: memory-info-active
[105.953817] Starting dynamic subtest: smem0
[108.229694] Dynamic subtest smem0: SUCCESS (2.280s)
[108.232037] Subtest memory-info-active: SUCCESS (2.280s)
[108.300685] [015/133] (910s left) perf (polling-parameterized)
[108.411823] Starting subtest: polling-parameterized
[128.434159] Subtest polling-parameterized: SUCCESS (20.025s)
[128.488576] [016/133] (890s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[128.594079] Starting subtest: psr2-cursor-plane-move-continuous-sf
[128.596420] Starting dynamic subtest: pipe-A-eDP-1
[138.934638] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.345s)
[138.944123] Starting dynamic subtest: pipe-B-eDP-1
[149.973852] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.036s)
[149.975838] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.384s)
[150.770608] [017/133] (868s left) kms_flip_tiling (flip-change-tiling)
[150.867342] Starting subtest: flip-change-tiling
[150.869808] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[151.083750] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.217s)
[151.094774] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[151.229542] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.143s)
[151.241188] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[151.374266] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.141s)
[151.387178] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[151.517152] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s)
[151.527889] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[151.661623] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.143s)
[151.672850] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[151.805436] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s)
[151.816406] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[151.950815] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.144s)
[151.961832] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[152.061995] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[152.073037] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[152.196394] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[152.207602] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[152.340219] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.143s)
[152.351745] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[152.483218] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s)
[152.494074] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[152.627586] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.144s)
[152.638861] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[152.761865] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[152.773013] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[152.896126] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[152.907077] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[153.005848] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[153.017064] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[153.150828] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.144s)
[153.162627] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[153.294627] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s)
[153.305138] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[153.439054] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.144s)
[153.451459] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[153.583886] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s)
[153.594235] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[153.717455] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.132s)
[153.728848] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[153.850309] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.132s)
[153.861826] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[153.972450] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.121s)
[153.982760] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[154.127259] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.155s)
[154.138243] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[154.283005] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.154s)
[154.294026] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[154.427565] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s)
[154.437521] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[154.571515] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s)
[154.582014] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[154.704982] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.132s)
[154.714178] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[154.849574] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.143s)
[154.859084] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[154.982828] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.132s)
[154.993201] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[155.127612] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.144s)
[155.137739] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[155.271522] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s)
[155.281858] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[155.416285] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.144s)
[155.427015] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[155.561211] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[155.571547] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[155.704839] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.143s)
[155.714981] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[155.849559] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.144s)
[155.860411] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[155.971496] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.121s)
[156.024901] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[157.244017] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.225s)
[157.255240] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[157.378747] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.133s)
[157.389110] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[157.523086] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.143s)
[157.534001] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[157.654840] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.132s)
[157.665767] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[157.798941] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.143s)
[157.809571] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[157.943119] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s)
[157.953930] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[158.076612] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.132s)
[158.087450] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[158.188621] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[158.199130] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[158.323266] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[158.334132] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[158.466166] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.143s)
[158.479346] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[158.610022] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.144s)
[158.620966] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[158.743671] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.132s)
[158.754882] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[158.888053] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.142s)
[158.899285] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[159.022700] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[159.032693] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[159.132823] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[159.143767] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[159.277467] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.144s)
[159.288646] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[159.410410] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.132s)
[159.421481] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[159.554351] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[159.565118] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[159.688155] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.132s)
[159.699040] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[159.822182] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.132s)
[159.833093] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[159.955138] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.132s)
[159.966147] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[160.076851] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.121s)
[160.087712] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[160.220565] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.143s)
[160.230852] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[160.365067] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.143s)
[160.375842] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[160.498394] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.132s)
[160.509224] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[160.632217] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.132s)
[160.641484] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[160.776221] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.143s)
[160.784604] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[160.920613] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.143s)
[160.930506] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[161.042642] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.121s)
[161.055931] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[161.187810] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.144s)
[161.198690] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[161.331668] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s)
[161.342871] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[161.475936] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s)
[161.486362] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[161.620776] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[161.631821] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[161.764674] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.143s)
[161.775687] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[161.909833] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.143s)
[161.920013] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[162.032061] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.121s)
[162.082167] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[163.286753] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.209s)
[163.297772] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[163.386807] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[163.397753] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[163.486471] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[163.497692] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[163.597816] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[163.608680] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[163.719136] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.121s)
[163.729497] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[163.819187] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.099s)
[163.829680] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[163.918892] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[163.929674] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[164.019073] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[164.029570] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[164.119266] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[164.130187] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[164.219012] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.099s)
[164.232057] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[164.329883] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[164.340546] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[164.429917] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.099s)
[164.440500] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[164.530105] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[164.541006] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[164.630286] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[164.640910] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[164.730298] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[164.740663] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[164.852394] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.121s)
[164.862737] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[164.963134] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[164.973618] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[165.074107] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[165.085345] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[165.185462] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[165.195846] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[165.296864] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[165.307493] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[165.419353] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.121s)
[165.430620] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[165.530116] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[165.541154] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[165.640862] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.110s)
[165.651681] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[165.751838] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[165.762249] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[165.862753] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[165.873648] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[165.962945] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[165.973404] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[166.085306] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.121s)
[166.096125] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[166.196254] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[166.210482] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[166.346699] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.149s)
[166.357443] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[166.457706] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.110s)
[166.468067] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[166.568231] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[166.579055] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[166.679652] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[166.690390] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[166.790170] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[166.801056] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[166.902011] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[166.911871] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[167.013389] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[167.024668] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[167.124388] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s)
[167.165032] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[168.410166] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.252s)
[168.421273] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[168.510116] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[168.521453] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[168.609864] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[168.619593] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[168.720852] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[168.731639] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[168.831664] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[168.842438] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[168.942505] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[168.954006] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[169.054223] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.110s)
[169.065577] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[169.154136] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[169.165555] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[169.254723] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[169.267453] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[169.365427] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[169.376468] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[169.465142] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.099s)
[169.475757] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[169.564218] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.099s)
[169.575094] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[169.665485] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[169.676392] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[169.765590] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[169.774412] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[169.865201] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[169.875453] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[169.976265] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[169.985409] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[170.075717] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.099s)
[170.084278] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[170.175713] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.099s)
[170.186026] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[170.276407] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[170.287367] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[170.376570] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s)
[170.386835] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[170.476439] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[170.487452] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[170.586950] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.110s)
[170.600396] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[170.697824] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[170.708206] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[170.808916] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[170.818957] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[170.919765] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[170.930677] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[171.019846] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[171.030517] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[171.131131] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[171.141939] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[171.242133] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[171.251521] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[171.353156] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[171.363898] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[171.464483] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.110s)
[171.475731] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[171.575483] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[171.585893] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[171.676055] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.099s)
[171.688239] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[171.786637] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[171.799853] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[171.897704] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[171.908319] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[172.009090] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[172.019713] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[172.119851] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.110s)
[172.152903] Subtest flip-change-tiling: SUCCESS (21.290s)
[173.306611] [018/133] (845s left) kms_dsc (dsc-with-bpc)
[173.419456] Starting subtest: dsc-with-bpc
[173.449724] Subtest dsc-with-bpc: SKIP (0.001s)
[173.498689] [019/133] (845s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[173.600155] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[173.602490] Starting dynamic subtest: A-eDP1
[177.262868] Dynamic subtest A-eDP1: SUCCESS (3.660s)
[177.272828] Starting dynamic subtest: B-eDP1
[180.465168] Dynamic subtest B-eDP1: SUCCESS (3.203s)
[180.476620] Starting dynamic subtest: C-eDP1
[183.559432] Dynamic subtest C-eDP1: SUCCESS (3.093s)
[183.567507] Starting dynamic subtest: D-eDP1
[186.680414] Dynamic subtest D-eDP1: SUCCESS (3.119s)
[186.682610] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.083s)
[187.483162] [020/133] (831s left) gem_ctx_persistence (engines-hang)
[187.540444] Starting subtest: engines-hang
[187.542965] Starting dynamic subtest: rcs0
[187.659068] Dynamic subtest rcs0: SUCCESS (0.117s)
[187.670384] Starting dynamic subtest: bcs0
[187.745966] Dynamic subtest bcs0: SUCCESS (0.087s)
[187.758637] Starting dynamic subtest: vcs0
[187.854371] Dynamic subtest vcs0: SUCCESS (0.106s)
[187.865834] Starting dynamic subtest: vcs1
[187.955402] Dynamic subtest vcs1: SUCCESS (0.100s)
[187.965837] Starting dynamic subtest: vecs0
[188.047400] Dynamic subtest vecs0: SUCCESS (0.091s)
[188.058242] Starting dynamic subtest: ccs0
[188.135715] Dynamic subtest ccs0: SUCCESS (0.087s)
[188.138197] Subtest engines-hang: SUCCESS (0.596s)
[188.211733] [021/133] (831s left) kms_cursor_crc (cursor-alpha-transparent)
[188.291753] Starting subtest: cursor-alpha-transparent
[188.294005] Starting dynamic subtest: pipe-A-eDP-1
[188.909054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[188.918868] Starting dynamic subtest: pipe-D-eDP-1
[190.157259] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s)
[190.159282] Subtest cursor-alpha-transparent: SUCCESS (1.867s)
[190.947851] [022/133] (828s left) gem_mmap_offset (bad-extensions)
[191.003755] Starting subtest: bad-extensions
[191.006006] Subtest bad-extensions: SUCCESS (0.000s)
[191.108330] [023/133] (828s left) kms_addfb_basic (invalid-set-prop)
[191.165583] Starting subtest: invalid-set-prop
[191.167472] Subtest invalid-set-prop: SUCCESS (0.000s)
[191.296823] [024/133] (828s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[191.391384] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[191.393678] Starting dynamic subtest: pipe-A
[191.455636] Dynamic subtest pipe-A: SUCCESS (0.066s)
[191.465736] Starting dynamic subtest: pipe-B
[192.576688] Dynamic subtest pipe-B: SUCCESS (1.119s)
[192.587910] Starting dynamic subtest: pipe-C
[193.681944] Dynamic subtest pipe-C: SUCCESS (1.104s)
[193.691374] Starting dynamic subtest: pipe-D
[194.816848] Dynamic subtest pipe-D: SUCCESS (1.134s)
[194.819069] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.427s)
[195.976112] [025/133] (823s left) syncobj_timeline (reset-signaled)
[196.038033] Starting subtest: reset-signaled
[196.040684] Subtest reset-signaled: SUCCESS (0.001s)
[196.142377] [026/133] (823s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[196.240879] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[196.244902] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[196.327691] [027/133] (823s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[196.428989] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[196.431237] Starting dynamic subtest: pipe-A-eDP-1
[196.452577] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[196.461168] Starting dynamic subtest: pipe-B-eDP-1
[196.481845] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[196.489667] Starting dynamic subtest: pipe-C-eDP-1
[196.510445] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[196.518514] Starting dynamic subtest: pipe-D-eDP-1
[196.540309] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[196.544372] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[198.661032] [028/133] (820s left) kms_hdr (invalid-metadata-sizes)
[198.755867] Starting subtest: invalid-metadata-sizes
[198.762485] Subtest invalid-metadata-sizes: SKIP (0.000s)
[198.827689] [029/133] (820s left) gem_fence_thrash (bo-write-verify-y)
[198.862019] Starting subtest: bo-write-verify-y
[198.875885] Subtest bo-write-verify-y: SKIP (0.013s)
[198.928677] [030/133] (820s left) gem_render_copy (linear-to-vebox-y-tiled)
[198.984855] Starting subtest: linear-to-vebox-y-tiled
[198.988874] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[199.164900] [031/133] (820s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[199.264733] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[199.268780] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[199.347079] [032/133] (820s left) i915_query (query-regions-garbage-items)
[199.402004] Starting subtest: query-regions-garbage-items
[199.403924] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[199.510270] [033/133] (820s left) syncobj_timeline (invalid-wait-illegal-handle)
[199.567699] Starting subtest: invalid-wait-illegal-handle
[199.569898] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[199.659826] [034/133] (820s left) kms_prop_blob (invalid-set-prop)
[199.708587] Starting subtest: invalid-set-prop
[199.710420] Subtest invalid-set-prop: SUCCESS (0.000s)
[199.814511] [035/133] (820s left) gem_gpgpu_fill (offset-16x16)
[199.881095] Starting subtest: offset-16x16
[199.888872] Subtest offset-16x16: SUCCESS (0.009s)
[200.013936] [036/133] (819s left) gem_ctx_shared (q-out-order)
[200.079577] Starting subtest: Q-out-order
[200.082018] Starting dynamic subtest: rcs0
[200.226520] Dynamic subtest rcs0: SUCCESS (0.147s)
[200.243236] Starting dynamic subtest: vcs0
[200.306392] Dynamic subtest vcs0: SUCCESS (0.079s)
[200.321952] Starting dynamic subtest: vcs1
[200.382119] Dynamic subtest vcs1: SUCCESS (0.075s)
[200.397974] Starting dynamic subtest: vecs0
[200.463765] Dynamic subtest vecs0: SUCCESS (0.081s)
[200.480371] Starting dynamic subtest: ccs0
[200.549845] Dynamic subtest ccs0: SUCCESS (0.085s)
[200.552018] Subtest Q-out-order: SUCCESS (0.471s)
[201.444569] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[201.448298] [037/133] (818s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[201.556364] Starting subtest: fbc-rgb565-draw-render
[205.733197] Subtest fbc-rgb565-draw-render: SUCCESS (4.180s)
[206.866275] [038/133] (813s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[206.962775] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[206.967407] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[207.043665] [039/133] (813s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[207.138644] Starting subtest: fbc-rgb101010-draw-pwrite
[212.702022] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.568s)
[213.866530] [040/133] (806s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[213.957062] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[213.961497] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[214.029553] [041/133] (806s left) gem_linear_blits (normal)
[214.356822] Starting subtest: normal
[218.085231] Subtest normal: SUCCESS (3.729s)
[218.234378] [042/133] (801s left) sysfs_heartbeat_interval (precise)
[218.331379] Starting subtest: precise
[218.333774] Starting dynamic subtest: vecs0
[226.347990] Dynamic subtest vecs0: SUCCESS (8.015s)
[226.369442] Starting dynamic subtest: ccs0
[227.494506] Dynamic subtest ccs0: SUCCESS (1.142s)
[227.505753] Starting dynamic subtest: vcs0
[234.342961] Dynamic subtest vcs0: SUCCESS (6.850s)
[234.354523] Starting dynamic subtest: bcs0
[235.387386] Dynamic subtest bcs0: SUCCESS (1.041s)
[235.402137] Starting dynamic subtest: rcs0
[236.504495] Dynamic subtest rcs0: SUCCESS (1.117s)
[236.516496] Starting dynamic subtest: vcs1
[244.329960] Dynamic subtest vcs1: SUCCESS (7.825s)
[244.332463] Subtest precise: SUCCESS (25.999s)
[244.418431] [043/133] (775s left) sw_sync (sync_busy_fork_unixsocket)
[244.463751] Starting subtest: sync_busy_fork_unixsocket
[244.471162] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[244.534433] [044/133] (775s left) prime_mmap (test_reprime)
[244.581855] Starting subtest: test_reprime
[244.584149] Starting dynamic subtest: test_reprime-smem
[244.611687] Dynamic subtest test_reprime-smem: SUCCESS (0.030s)
[244.613985] Subtest test_reprime: SUCCESS (0.031s)
[244.720850] [045/133] (775s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[244.840827] Starting subtest: cursorA-vs-flipA-atomic-transitions
[256.025832] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.185s)
[256.874935] [046/133] (763s left) kms_psr (psr2-dpms)
[256.982619] Starting subtest: psr2-dpms
[256.984920] Starting dynamic subtest: eDP-1
[259.805513] Dynamic subtest eDP-1: SUCCESS (2.822s)
[259.807779] Subtest psr2-dpms: SUCCESS (2.823s)
[260.684505] [047/133] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[260.788059] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[260.792264] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[260.890363] [048/133] (759s left) dmabuf (all-tests)
[260.931899] Starting subtest: all-tests
[260.934121] Starting dynamic subtest: sanitycheck
[261.075467] Dynamic subtest sanitycheck: SUCCESS (0.141s)
[261.087862] Starting dynamic subtest: dma_fence
[261.287443] Dynamic subtest dma_fence: SUCCESS (0.210s)
[261.300678] Starting dynamic subtest: dma_fence_chain
[270.239178] Dynamic subtest dma_fence_chain: SUCCESS (8.949s)
[270.250426] Starting dynamic subtest: dma_fence_unwrap
[270.333382] Dynamic subtest dma_fence_unwrap: SUCCESS (0.093s)
[270.344726] Starting dynamic subtest: dma_resv
[270.421362] Dynamic subtest dma_resv: SUCCESS (0.086s)
[270.424018] Subtest all-tests: SUCCESS (9.491s)
[270.487706] [049/133] (749s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[270.620246] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[271.671357] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.049s)
[272.508266] [050/133] (747s left) kms_force_connector_basic (force-edid)
[272.590890] Starting subtest: force-edid
[272.957404] Subtest force-edid: SUCCESS (0.367s)
[273.092867] [051/133] (747s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[273.186764] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[273.190910] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[273.312380] [052/133] (747s left) i915_pm_rc6_residency (rc6-idle)
[273.371984] Starting subtest: rc6-idle
[273.389070] Starting dynamic subtest: gt0-rcs0
[297.773828] Dynamic subtest gt0-rcs0: SUCCESS (24.386s)
[297.784856] Starting dynamic subtest: gt0-bcs0
[322.051995] Dynamic subtest gt0-bcs0: SUCCESS (24.277s)
[322.061082] Starting dynamic subtest: gt0-ccs0
[346.404998] Dynamic subtest gt0-ccs0: SUCCESS (24.347s)
[346.413896] Starting dynamic subtest: gt1-vcs0
[352.578148] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[352.590399] Starting dynamic subtest: gt1-vecs0
[358.751017] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[358.753883] Subtest rc6-idle: SUCCESS (85.380s)
[358.845482] [053/133] (661s left) kms_async_flips (crc-atomic)
[358.941564] Starting subtest: crc-atomic
[359.327669] Starting dynamic subtest: pipe-A-eDP-1
[362.223573] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.894s)
[362.599434] Starting dynamic subtest: pipe-B-eDP-1
[365.551404] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.960s)
[365.929498] Starting dynamic subtest: pipe-C-eDP-1
[368.858016] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.940s)
[369.228519] Starting dynamic subtest: pipe-D-eDP-1
[372.088849] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.868s)
[372.091150] Subtest crc-atomic: SUCCESS (13.148s)
[373.257842] [054/133] (647s left) api_intel_allocator (reserve-simple)
[373.321371] Starting subtest: reserve-simple
[373.323858] Subtest reserve-simple: SUCCESS (0.003s)
[373.441044] [055/133] (647s left) kms_big_fb (linear-8bpp-rotate-90)
[373.549089] Starting subtest: linear-8bpp-rotate-90
[373.569303] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[373.672688] [056/133] (647s left) kms_joiner (invalid-modeset-ultra-joiner)
[373.774909] Starting subtest: invalid-modeset-ultra-joiner
[373.779092] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[373.845924] [057/133] (646s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[373.958069] Starting subtest: cursorA-vs-flipB-varying-size
[373.962504] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[374.125858] [058/133] (646s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[374.221991] Starting subtest: fbc-2p-pri-indfb-multidraw
[374.225330] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[374.305784] [059/133] (646s left) kms_flip (plain-flip-ts-check-interruptible)
[374.395738] Starting subtest: plain-flip-ts-check-interruptible
[374.397980] Starting dynamic subtest: A-eDP1
[383.255993] Dynamic subtest A-eDP1: SUCCESS (8.859s)
[383.267180] Starting dynamic subtest: B-eDP1
[392.083960] Dynamic subtest B-eDP1: SUCCESS (8.827s)
[392.095971] Starting dynamic subtest: C-eDP1
[400.905683] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[400.916552] Starting dynamic subtest: D-eDP1
[409.735476] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[409.741834] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.346s)
[410.921082] [060/133] (609s left) syncobj_wait (invalid-signal-illegal-handle)
[410.981950] Starting subtest: invalid-signal-illegal-handle
[410.984242] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[411.075606] [061/133] (609s left) gem_basic (create-close)
[411.134299] Starting subtest: create-close
[411.138591] Subtest create-close: SUCCESS (0.000s)
[411.242210] [062/133] (609s left) gem_exec_schedule (wide)
[411.427573] Starting subtest: wide
[411.429846] Starting dynamic subtest: rcs0
[421.223429] Dynamic subtest rcs0: SUCCESS (9.795s)
[421.238516] Starting dynamic subtest: vcs0
[430.869385] Dynamic subtest vcs0: SUCCESS (9.645s)
[430.881119] Starting dynamic subtest: vcs1
[442.903509] Dynamic subtest vcs1: SUCCESS (12.032s)
[442.916029] Starting dynamic subtest: vecs0
[454.222427] Dynamic subtest vecs0: SUCCESS (11.318s)
[454.238714] Starting dynamic subtest: ccs0
[467.277425] Dynamic subtest ccs0: SUCCESS (13.053s)
[467.280274] Subtest wide: SUCCESS (55.851s)
[468.615210] [063/133] (552s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[468.689211] Starting subtest: y-tiled-ccs-to-yf-tiled
[468.694127] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[468.876639] [064/133] (552s left) gem_exec_reloc (basic-cpu)
[468.926389] Subtest basic-cpu: SKIP (0.000s)
[469.000481] [065/133] (552s left) gem_exec_reloc (basic-gtt-cpu-active)
[469.066401] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[469.147934] [066/133] (552s left) i915_drm_fdinfo (virtual-idle)
[469.185832] Starting subtest: virtual-idle
[472.227426] Subtest virtual-idle: SUCCESS (3.036s)
[472.301885] [067/133] (548s left) kms_psr (fbc-pr-primary-mmap-cpu)
[472.407894] Starting subtest: fbc-pr-primary-mmap-cpu
[472.412362] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[472.480238] [068/133] (548s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[472.585120] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[472.589360] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[472.658417] [069/133] (548s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[472.701304] Starting subtest: etime-single-wait-for-submit-unsubmitted
[472.803220] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[472.889207] [070/133] (548s left) gem_mmap_gtt (basic-write-read)
[472.936873] Subtest basic-write-read: SKIP (0.000s)
[472.999370] [071/133] (548s left) i915_query (query-topology-matches-eu-total)
[473.055083] Starting subtest: query-topology-matches-eu-total
[473.056942] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[473.158360] [072/133] (548s left) kms_psr (pr-cursor-render)
[473.256033] Starting subtest: pr-cursor-render
[473.259929] Subtest pr-cursor-render: SKIP (0.000s)
[473.330409] [073/133] (548s left) kms_frontbuffer_tracking (fbc-tiling-y)
[473.418821] Starting subtest: fbc-tiling-y
[473.423007] Subtest fbc-tiling-y: SKIP (0.000s)
[473.508908] [074/133] (547s left) gem_reg_read (timestamp-monotonic)
[473.567992] Starting subtest: timestamp-monotonic
[478.439822] Subtest timestamp-monotonic: SUCCESS (4.874s)
[478.517285] [075/133] (543s left) gem_tiled_partial_pwrite_pread (reads)
[478.575338] Subtest reads: SKIP (0.000s)
[478.647569] [076/133] (542s left) gem_softpin (evict-snoop-interruptible)
[478.700746] Starting subtest: evict-snoop-interruptible
[478.704969] Subtest evict-snoop-interruptible: SKIP (0.000s)
[478.819142] [077/133] (542s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[478.911542] Starting subtest: fbc-psr2-cursor-plane-onoff
[478.913594] Starting dynamic subtest: eDP-1
[478.917422] Dynamic subtest eDP-1: SKIP (0.000s)
[478.921363] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[478.983063] [078/133] (542s left) syncobj_basic (bad-destroy-pad)
[479.038312] Starting subtest: bad-destroy-pad
[479.040412] Subtest bad-destroy-pad: SUCCESS (0.000s)
[479.134671] [079/133] (542s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[479.235469] Starting subtest: async-flip-with-page-flip-events-tiled
[479.612093] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[482.368634] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.755s)
[482.378492] Starting dynamic subtest: pipe-A-eDP-1-4
[484.544152] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[484.555951] Starting dynamic subtest: pipe-A-eDP-1-4
[486.552920] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[486.562164] Starting dynamic subtest: pipe-A-eDP-1-x
[488.744225] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[489.111920] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[491.897378] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.793s)
[491.907151] Starting dynamic subtest: pipe-B-eDP-1-4
[494.071224] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.173s)
[494.080637] Starting dynamic subtest: pipe-B-eDP-1-4
[496.081423] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[496.093371] Starting dynamic subtest: pipe-B-eDP-1-x
[498.260461] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s)
[498.626852] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[501.427293] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.808s)
[501.436675] Starting dynamic subtest: pipe-C-eDP-1-4
[503.590437] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.162s)
[503.599614] Starting dynamic subtest: pipe-C-eDP-1-4
[505.601159] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[505.613183] Starting dynamic subtest: pipe-C-eDP-1-x
[507.768650] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.167s)
[508.133986] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[510.863303] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.736s)
[510.872569] Starting dynamic subtest: pipe-D-eDP-1-4
[513.037195] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[513.046408] Starting dynamic subtest: pipe-D-eDP-1-4
[515.047832] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[515.057121] Starting dynamic subtest: pipe-D-eDP-1-x
[517.214941] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.166s)
[517.217171] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (37.983s)
[518.441486] [080/133] (503s left) kms_chamelium_edid (vga-edid-read)
[518.832523] Subtest vga-edid-read: SKIP (0.000s)
[519.647393] [081/133] (502s left) kms_psr (fbc-psr-no-drrs)
[519.737451] Starting subtest: fbc-psr-no-drrs
[519.739596] Starting dynamic subtest: eDP-1
[519.743547] Dynamic subtest eDP-1: SKIP (0.000s)
[519.747537] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[519.810763] [082/133] (501s left) kms_pipe_crc_basic (hang-read-crc)
[519.899765] Starting subtest: hang-read-crc
[519.902025] Starting dynamic subtest: pipe-A-eDP-1
[521.964970] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.064s)
[521.975254] Starting dynamic subtest: pipe-B-eDP-1
[524.631045] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.667s)
[524.641408] Starting dynamic subtest: pipe-C-eDP-1
[527.260510] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.628s)
[527.270543] Starting dynamic subtest: pipe-D-eDP-1
[529.918188] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.655s)
[529.920552] Subtest hang-read-crc: SUCCESS (10.020s)
[530.744948] [083/133] (491s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[530.857661] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[530.861868] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[530.960746] [084/133] (490s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[532.486991] Starting subtest: modeset-lpsp-stress-no-wait
[542.584468] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.101s)
[542.668260] [085/133] (479s left) fbdev (nullptr)
[542.713294] Starting subtest: nullptr
[542.715507] Subtest nullptr: SUCCESS (0.000s)
[542.786258] [086/133] (479s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[542.890818] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[542.895306] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[542.991930] [087/133] (479s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[543.046442] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[543.154658] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[543.233693] [088/133] (478s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[543.325963] Starting subtest: primary-x-tiled-reflect-x-0
[550.313023] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.988s)
[551.503905] [089/133] (470s left) gem_exec_schedule (pi-userfault)
[551.682167] Starting subtest: pi-userfault
[551.684044] Starting dynamic subtest: rcs0
[551.693077] Dynamic subtest rcs0: SUCCESS (0.013s)
[551.705280] Starting dynamic subtest: bcs0
[551.707490] Dynamic subtest bcs0: SUCCESS (0.009s)
[551.717080] Starting dynamic subtest: vcs0
[551.719330] Dynamic subtest vcs0: SUCCESS (0.008s)
[551.728758] Starting dynamic subtest: vcs1
[551.730701] Dynamic subtest vcs1: SUCCESS (0.007s)
[551.740225] Starting dynamic subtest: vecs0
[551.742383] Dynamic subtest vecs0: SUCCESS (0.007s)
[551.751636] Starting dynamic subtest: ccs0
[551.753878] Dynamic subtest ccs0: SUCCESS (0.013s)
[551.756016] Subtest pi-userfault: SUCCESS (0.060s)
[551.926723] [090/133] (470s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[552.029553] Starting subtest: x-tiled-32bpp-rotate-90
[552.049615] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[552.153479] [091/133] (470s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[552.256852] Starting subtest: y-tiled-64bpp-rotate-270
[552.261145] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[552.365031] [092/133] (469s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[552.457867] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[552.461881] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[552.535399] [093/133] (469s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[552.638613] Starting subtest: yf-tiled-32bpp-rotate-0
[552.642896] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[552.726767] [094/133] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[552.834499] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[552.837892] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[552.938713] [095/133] (469s left) kms_universal_plane (universal-plane-functional)
[553.027900] Starting subtest: universal-plane-functional
[553.029863] Starting dynamic subtest: pipe-A-eDP-1
[556.972243] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.941s)
[556.983294] Starting dynamic subtest: pipe-B-eDP-1
[561.514763] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.542s)
[561.525646] Starting dynamic subtest: pipe-C-eDP-1
[565.841619] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.328s)
[565.852814] Starting dynamic subtest: pipe-D-eDP-1
[570.236070] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.391s)
[570.237924] Subtest universal-plane-functional: SUCCESS (17.208s)
[571.125319] [096/133] (451s left) kms_cursor_legacy (single-move)
[571.250290] Starting subtest: single-move
[571.252185] Starting dynamic subtest: pipe-A
[576.633717] Dynamic subtest pipe-A: SUCCESS (5.380s)
[576.645202] Starting dynamic subtest: pipe-B
[582.017638] Dynamic subtest pipe-B: SUCCESS (5.380s)
[582.028997] Starting dynamic subtest: pipe-C
[587.399758] Dynamic subtest pipe-C: SUCCESS (5.379s)
[587.411520] Starting dynamic subtest: pipe-D
[592.784183] Dynamic subtest pipe-D: SUCCESS (5.380s)
[592.796239] Starting dynamic subtest: all-pipes
[598.174678] Dynamic subtest all-pipes: SUCCESS (5.387s)
[598.177215] Subtest single-move: SUCCESS (26.919s)
[598.319029] [097/133] (424s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[598.456186] Starting subtest: short-flip-after-cursor-atomic-transitions
[599.415374] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.958s)
[600.254603] [098/133] (422s left) gem_exec_params (invalid-ring)
[600.318113] Starting subtest: invalid-ring
[600.320414] Subtest invalid-ring: SUCCESS (0.000s)
[600.429308] [099/133] (422s left) gem_pread (self)
[600.484681] Subtest self: SKIP (0.000s)
[600.557192] [100/133] (422s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[600.652029] Starting subtest: primary-4-tiled-reflect-x-180
[607.759399] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.108s)
[609.011583] [101/133] (413s left) gem_spin_batch (spin-each)
[609.078373] Starting subtest: spin-each
[612.347045] Subtest spin-each: SUCCESS (3.262s)
[614.440035] [102/133] (408s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[614.545694] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[614.548042] Starting dynamic subtest: pipe-A-eDP-1
[614.569524] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[614.579818] Starting dynamic subtest: pipe-B-eDP-1
[614.600431] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[614.610054] Starting dynamic subtest: pipe-C-eDP-1
[614.630979] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[614.640856] Starting dynamic subtest: pipe-D-eDP-1
[614.661427] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[614.665399] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[616.867671] [103/133] (405s left) kms_cursor_edge_walk (128x128-top-edge)
[616.964864] Starting subtest: 128x128-top-edge
[616.967044] Starting dynamic subtest: pipe-A-eDP-1
[620.432179] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.466s)
[620.442637] Starting dynamic subtest: pipe-D-eDP-1
[623.545911] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s)
[623.548240] Subtest 128x128-top-edge: SUCCESS (6.581s)
[624.358268] [104/133] (398s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[624.463074] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[631.453256] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.994s)
[631.556498] [105/133] (391s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[631.653032] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[631.657072] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[631.726981] [106/133] (391s left) kms_cursor_crc (cursor-random-32x10)
[631.903668] Starting subtest: cursor-random-32x10
[631.947914] Subtest cursor-random-32x10: SKIP (0.041s)
[632.212093] [107/133] (390s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[632.307051] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[632.309335] Starting dynamic subtest: pipe-A-eDP-1
[632.329849] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[632.346112] Starting dynamic subtest: pipe-B-eDP-1
[632.365122] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[632.374313] Starting dynamic subtest: pipe-C-eDP-1
[632.392178] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[632.400776] Starting dynamic subtest: pipe-D-eDP-1
[632.416765] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[632.418557] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[634.554219] [108/133] (388s left) perf_pmu (busy)
[634.597026] Starting subtest: busy
[634.599305] Starting dynamic subtest: rcs0
[635.185713] Dynamic subtest rcs0: SUCCESS (0.590s)
[635.196962] Starting dynamic subtest: bcs0
[635.749511] Dynamic subtest bcs0: SUCCESS (0.562s)
[635.760444] Starting dynamic subtest: vcs0
[637.359168] Dynamic subtest vcs0: SUCCESS (1.605s)
[637.370597] Starting dynamic subtest: vcs1
[639.342695] Dynamic subtest vcs1: SUCCESS (1.980s)
[639.353718] Starting dynamic subtest: vecs0
[641.327620] Dynamic subtest vecs0: SUCCESS (1.981s)
[641.349197] Starting dynamic subtest: ccs0
[641.899906] Dynamic subtest ccs0: SUCCESS (0.571s)
[641.902311] Subtest busy: SUCCESS (7.305s)
[642.007553] [109/133] (381s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[642.104084] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[642.106280] Starting dynamic subtest: pipe-A-eDP-1
[643.313740] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.209s)
[643.323646] Starting dynamic subtest: pipe-B-eDP-1
[645.567446] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.252s)
[645.578827] Starting dynamic subtest: pipe-C-eDP-1
[647.806008] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.238s)
[647.819427] Starting dynamic subtest: pipe-D-eDP-1
[650.093000] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.283s)
[650.095165] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (7.988s)
[651.221868] [110/133] (371s left) kms_content_protection (atomic)
[651.363448] Starting subtest: atomic
[651.367994] Subtest atomic: SKIP (0.000s)
[651.477180] [111/133] (371s left) gem_exec_schedule (deep)
[651.649576] Starting subtest: deep
[651.651818] Starting dynamic subtest: rcs0
[657.102538] Dynamic subtest rcs0: SKIP (5.451s)
[657.114472] Starting dynamic subtest: vcs0
[668.031438] Dynamic subtest vcs0: SUCCESS (10.928s)
[668.045138] Starting dynamic subtest: vcs1
[679.647224] Dynamic subtest vcs1: SUCCESS (11.615s)
[679.659025] Starting dynamic subtest: vecs0
[691.578667] Dynamic subtest vecs0: SUCCESS (11.928s)
[691.591560] Starting dynamic subtest: ccs0
[704.271006] Dynamic subtest ccs0: SUCCESS (12.690s)
[704.274436] Subtest deep: SUCCESS (52.619s)
[705.838111] [112/133] (317s left) syncobj_wait (multi-wait-for-submit-signaled)
[705.883739] Starting subtest: multi-wait-for-submit-signaled
[705.886014] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[705.982152] [113/133] (317s left) gem_exec_fence (submit3)
[706.151846] Starting subtest: submit3
[706.156844] Subtest submit3: SKIP (0.000s)
[708.512846] [114/133] (314s left) gem_mmap_wc (write)
[708.597026] Subtest write: SKIP (0.000s)
[708.732425] [115/133] (314s left) gem_create (create-ext-placement-sanity-check)
[708.933025] Starting subtest: create-ext-placement-sanity-check
[708.935526] Subtest create-ext-placement-sanity-check: SUCCESS (0.003s)
[709.047098] [116/133] (314s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[709.166849] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[709.169180] Starting dynamic subtest: pipe-A-eDP-1
[710.086049] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.914s)
[710.097668] Starting dynamic subtest: pipe-B-eDP-1
[711.707607] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.618s)
[711.718270] Starting dynamic subtest: pipe-C-eDP-1
[713.233540] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.523s)
[713.246592] Starting dynamic subtest: pipe-D-eDP-1
[714.840748] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.607s)
[714.843010] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.667s)
[716.061477] [117/133] (307s left) gem_lmem_swapping (parallel-random-verify-ccs)
[716.108720] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[716.157347] [118/133] (307s left) api_intel_bb (object-reloc-keep-cache)
[716.216081] Starting subtest: object-reloc-keep-cache
[716.220599] Subtest object-reloc-keep-cache: SKIP (0.003s)
[716.344251] [119/133] (307s left) kms_rotation_crc (primary-rotation-90)
[716.434097] Starting subtest: primary-rotation-90
[716.438747] Subtest primary-rotation-90: SKIP (0.001s)
[716.516044] [120/133] (306s left) sw_sync (alloc_merge_fence)
[716.568175] Starting subtest: alloc_merge_fence
[716.570268] Subtest alloc_merge_fence: SUCCESS (0.000s)
[716.624074] [121/133] (306s left) kms_flip (2x-flip-vs-panning)
[716.715062] Starting subtest: 2x-flip-vs-panning
[716.723439] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[716.802521] [122/133] (306s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[716.907941] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[716.912309] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[717.022135] [123/133] (306s left) perf_pmu (busy-no-semaphores)
[717.066481] Starting subtest: busy-no-semaphores
[717.068295] Starting dynamic subtest: rcs0
[717.595617] Dynamic subtest rcs0: SUCCESS (0.528s)
[717.608589] Starting dynamic subtest: bcs0
[718.146138] Dynamic subtest bcs0: SUCCESS (0.548s)
[718.158912] Starting dynamic subtest: vcs0
[718.697368] Dynamic subtest vcs0: SUCCESS (0.548s)
[718.710121] Starting dynamic subtest: vcs1
[719.856099] Dynamic subtest vcs1: SUCCESS (1.155s)
[719.868134] Starting dynamic subtest: vecs0
[721.841363] Dynamic subtest vecs0: SUCCESS (1.983s)
[721.853767] Starting dynamic subtest: ccs0
[723.827343] Dynamic subtest ccs0: SUCCESS (1.982s)
[723.830210] Subtest busy-no-semaphores: SUCCESS (6.762s)
[723.958409] [124/133] (299s left) sw_sync (alloc_fence)
[723.997477] Starting subtest: alloc_fence
[723.999955] Subtest alloc_fence: SUCCESS (0.000s)
[724.057032] [125/133] (299s left) gem_eio (in-flight-contexts-immediate)
[724.278083] Starting subtest: in-flight-contexts-immediate
[738.389088] Subtest in-flight-contexts-immediate: SUCCESS (14.110s)
[738.535571] [126/133] (285s left) syncobj_timeline (wait-all-interrupted)
[738.595321] Starting subtest: wait-all-interrupted
[738.696136] Subtest wait-all-interrupted: SUCCESS (0.101s)
[738.774019] [127/133] (285s left) gem_ctx_shared (create-shared-gtt)
[738.829542] Starting subtest: create-shared-gtt
[740.983443] Subtest create-shared-gtt: SUCCESS (2.153s)
[741.329098] [128/133] (282s left) kms_vrr (flip-basic-fastset)
[741.428376] Starting subtest: flip-basic-fastset
[741.434841] Subtest flip-basic-fastset: SKIP (0.000s)
[741.530917] [129/133] (282s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[741.618028] Starting subtest: psr-rgb565-draw-mmap-gtt
[741.621998] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[741.724764] [130/133] (282s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[741.835393] Starting subtest: 4-tiled-16bpp-rotate-90
[741.854620] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[741.980867] [131/133] (281s left) kms_flip (dpms-off-confusion)
[742.070027] Starting subtest: dpms-off-confusion
[742.071867] Starting dynamic subtest: A-eDP1
[750.746255] Dynamic subtest A-eDP1: SUCCESS (8.677s)
[750.756619] Starting dynamic subtest: B-eDP1
[759.368338] Dynamic subtest B-eDP1: SUCCESS (8.620s)
[759.379712] Starting dynamic subtest: C-eDP1
[767.997741] Dynamic subtest C-eDP1: SUCCESS (8.628s)
[768.012282] Starting dynamic subtest: D-eDP1
[776.642462] Dynamic subtest D-eDP1: SUCCESS (8.643s)
[776.647296] Subtest dpms-off-confusion: SUCCESS (34.580s)
[777.811477] [132/133] (246s left) gen9_exec_parse (basic-rejected-ctx-param)
[777.875719] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[777.947515] [133/133] (246s left) gem_mmap_wc (set-cache-level)
[778.004419] Subtest set-cache-level: SKIP (0.000s)
[778.063636] 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.