[62.567872] Initializing watchdogs
[62.567921]   /dev/watchdog0
[62.583084] [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.587645] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.590268] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.593624] [001/133] (960s left) kms_chamelium_hpd (hdmi-hpd-fast)
[63.014095] Subtest hdmi-hpd-fast: SKIP (0.000s)
[63.793178] [002/133] (959s left) kms_properties (plane-properties-legacy)
[63.896186] Starting subtest: plane-properties-legacy
[63.898186] Starting dynamic subtest: pipe-A-eDP-1
[64.483269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[64.490988] Starting dynamic subtest: pipe-B-eDP-1
[65.798724] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.307s)
[65.809086] Starting dynamic subtest: pipe-C-eDP-1
[67.046218] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.242s)
[67.056261] Starting dynamic subtest: pipe-D-eDP-1
[68.282411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[68.284698] Subtest plane-properties-legacy: SUCCESS (4.372s)
[69.076856] [003/133] (954s left) gem_mmap (basic)
[69.137609] Subtest basic: SKIP (0.000s)
[69.195323] [004/133] (954s left) gem_exec_schedule (u-fairslice)
[69.268400] Starting subtest: u-fairslice
[69.270660] Starting dynamic subtest: rcs0
[71.286167] Dynamic subtest rcs0: SUCCESS (2.018s)
[71.292623] Starting dynamic subtest: bcs0
[73.304174] Dynamic subtest bcs0: SUCCESS (2.016s)
[73.311545] Starting dynamic subtest: vcs0
[75.323544] Dynamic subtest vcs0: SUCCESS (2.015s)
[75.332287] Starting dynamic subtest: vcs1
[77.342583] Dynamic subtest vcs1: SUCCESS (2.018s)
[77.351805] Starting dynamic subtest: vecs0
[79.363328] Dynamic subtest vecs0: SUCCESS (2.019s)
[79.372416] Starting dynamic subtest: ccs0
[81.386098] Dynamic subtest ccs0: SUCCESS (2.020s)
[81.388350] Subtest u-fairslice: SUCCESS (12.109s)
[81.684856] [005/133] (941s left) gem_workarounds (suspend-resume)
[81.751860] Starting subtest: suspend-resume
[97.294899] Subtest suspend-resume: SUCCESS (2.008s)
[97.429219] [006/133] (925s left) kms_color (gamma)
[97.543923] Starting subtest: gamma
[97.546541] Starting dynamic subtest: pipe-A-eDP-1
[98.307510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[98.317035] Starting dynamic subtest: pipe-B-eDP-1
[99.745109] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s)
[99.753606] Starting dynamic subtest: pipe-C-eDP-1
[101.172214] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[101.181778] Starting dynamic subtest: pipe-D-eDP-1
[102.511539] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.309s)
[102.513937] Subtest gamma: SUCCESS (4.833s)
[103.335960] [007/133] (919s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[103.437882] Starting subtest: yf-tiled-64bpp-rotate-180
[103.442084] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[103.534022] [008/133] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[103.638968] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[103.643321] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[103.750406] [009/133] (919s left) gem_exec_balancer (bonded-sync)
[103.812181] Starting subtest: bonded-sync
[103.816985] Subtest bonded-sync: SKIP (0.000s)
[104.118068] [010/133] (919s left) kms_invalid_mode (bad-hsync-end)
[104.223416] Starting subtest: bad-hsync-end
[104.225949] Starting dynamic subtest: pipe-A-eDP-1
[104.510562] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[104.521420] Starting dynamic subtest: pipe-B-eDP-1
[104.523411] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[104.531213] Starting dynamic subtest: pipe-C-eDP-1
[104.533597] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[104.541379] Starting dynamic subtest: pipe-D-eDP-1
[104.543759] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[104.546201] Subtest bad-hsync-end: SUCCESS (0.291s)
[105.413727] [011/133] (918s left) gem_tiled_pread_basic (basic)
[105.462370] Subtest basic: SKIP (0.000s)
[105.514368] [012/133] (918s left) gem_exec_balancer (parallel-keep-in-fence)
[105.771212] Starting subtest: parallel-keep-in-fence
[106.911576] Subtest parallel-keep-in-fence: SUCCESS (1.125s)
[107.024556] [013/133] (916s left) kms_pm_backlight (brightness-with-dpms)
[107.118877] Starting subtest: brightness-with-dpms
[107.175996] Starting dynamic subtest: eDP-1
[109.552800] Dynamic subtest eDP-1: SUCCESS (2.353s)
[109.555033] Subtest brightness-with-dpms: SUCCESS (2.411s)
[110.422728] [014/133] (913s left) i915_drm_fdinfo (memory-info-active)
[110.471002] Starting subtest: memory-info-active
[110.472897] Starting dynamic subtest: smem0
[113.160910] Dynamic subtest smem0: SUCCESS (2.675s)
[113.163132] Subtest memory-info-active: SUCCESS (2.675s)
[113.240833] [015/133] (910s left) perf (polling-parameterized)
[113.372321] Starting subtest: polling-parameterized
[133.397588] Subtest polling-parameterized: SUCCESS (19.984s)
[133.442415] [016/133] (890s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[133.544153] Starting subtest: psr2-cursor-plane-move-continuous-sf
[133.546503] Starting dynamic subtest: pipe-A-eDP-1
[143.890380] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.346s)
[143.900359] Starting dynamic subtest: pipe-B-eDP-1
[154.971014] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.075s)
[154.973139] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.423s)
[155.760784] [017/133] (867s left) kms_flip_tiling (flip-change-tiling)
[155.871142] Starting subtest: flip-change-tiling
[155.873405] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[156.076074] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.206s)
[156.087367] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[156.221790] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.143s)
[156.232240] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[156.366856] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[156.377421] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[156.510151] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s)
[156.521245] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[156.653867] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.143s)
[156.664852] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[156.809570] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.155s)
[156.820442] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[156.943733] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.133s)
[156.954676] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[157.054534] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[157.065433] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[157.189094] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[157.200115] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[157.332320] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.143s)
[157.343213] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[157.476455] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s)
[157.487737] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[157.621179] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.144s)
[157.632387] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[157.755387] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.133s)
[157.767265] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[157.911731] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.153s)
[157.924007] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[158.021519] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[158.030728] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[158.179086] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.154s)
[158.191136] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[158.321368] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s)
[158.332369] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[158.466030] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[158.480056] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[158.610855] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s)
[158.622761] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[158.755361] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[158.767195] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[158.900113] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.144s)
[158.911248] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[159.022160] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.121s)
[159.034038] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[159.165971] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.143s)
[159.179128] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[159.322389] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.155s)
[159.333147] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[159.465770] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s)
[159.476608] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[159.610489] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.144s)
[159.624574] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[159.754871] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.143s)
[159.765393] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[159.899097] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.143s)
[159.910024] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[160.021672] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.121s)
[160.032552] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[160.166966] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.144s)
[160.178106] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[160.310822] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.144s)
[160.322016] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[160.455264] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s)
[160.466911] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[160.600351] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[160.611787] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[160.744393] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.144s)
[160.755755] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[160.889361] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.143s)
[160.903074] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[161.011254] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.121s)
[161.065166] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[162.329569] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.272s)
[162.340130] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[162.464268] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.133s)
[162.476126] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[162.608766] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.143s)
[162.619699] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[162.752017] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s)
[162.763198] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[162.901255] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.149s)
[162.912084] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[163.023433] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.121s)
[163.034224] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[163.134925] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.110s)
[163.145647] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[163.235654] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[163.245240] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[163.369534] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[163.380586] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[163.556876] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.186s)
[163.568095] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[163.699313] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s)
[163.709358] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[163.843765] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.143s)
[163.856635] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[163.978475] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.133s)
[163.988833] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[164.123478] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.143s)
[164.134770] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[164.233259] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[164.244412] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[164.378383] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.144s)
[164.390054] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[164.521592] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s)
[164.534432] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[164.666512] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[164.676323] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[164.800084] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.132s)
[164.810094] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[164.944963] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[164.954830] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[165.089719] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.143s)
[165.101778] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[165.211275] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.121s)
[165.227362] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[165.355272] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.143s)
[165.365425] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[165.500110] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.143s)
[165.511290] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[165.644904] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s)
[165.655953] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[165.789251] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.144s)
[165.800211] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[165.933744] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.143s)
[165.944860] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[166.077794] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.143s)
[166.088484] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[166.200643] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.121s)
[166.212401] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[166.345371] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.143s)
[166.356161] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[166.489282] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s)
[166.500117] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[166.633950] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s)
[166.645307] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[166.778270] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[166.789108] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[166.923003] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.143s)
[166.934464] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[167.068228] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.143s)
[167.085747] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[167.189936] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.121s)
[167.241061] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[168.465428] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.229s)
[168.477168] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[168.565227] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[168.575739] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[168.665313] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[168.676237] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[168.776819] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[168.786779] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[168.887013] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[168.897954] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[168.998187] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[169.012383] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[169.098309] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[169.109210] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[169.198885] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[169.212420] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[169.299155] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[169.309555] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[169.399100] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.099s)
[169.410198] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[169.509150] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[169.519567] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[169.620294] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[169.630446] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[169.720521] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[169.730974] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[169.821050] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[169.831380] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[169.920664] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[169.930685] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[170.034814] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[170.046820] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[170.142500] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[170.151658] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[170.253673] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[170.264557] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[170.354314] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[170.365067] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[170.454360] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s)
[170.464975] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[170.565777] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.110s)
[170.575563] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[170.676852] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.110s)
[170.687425] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[170.787220] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.110s)
[170.797817] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[170.898571] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[170.908202] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[171.009822] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.111s)
[171.020576] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[171.120816] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[171.130482] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[171.221364] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[171.232422] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[171.332410] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[171.343192] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[171.455089] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.121s)
[171.465876] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[171.577333] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.121s)
[171.588366] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[171.687688] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[171.697450] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[171.799164] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[171.809576] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[171.910382] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[171.921028] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[172.032682] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.122s)
[172.044324] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[172.143787] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[172.154665] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[172.255574] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s)
[172.297384] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[173.499724] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.208s)
[173.511202] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[173.599670] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[173.610504] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[173.699709] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[173.710651] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[173.810672] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[173.821874] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[173.933045] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.121s)
[173.943843] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[174.043597] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[174.054456] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[174.143690] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[174.153651] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[174.244191] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[174.254088] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[174.344209] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[174.354916] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[174.455015] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[174.464734] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[174.565500] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[174.575593] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[174.676472] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[174.686598] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[174.777026] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[174.788399] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[174.877235] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[174.887960] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[174.977272] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[174.987984] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[175.088376] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[175.103840] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[175.199499] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[175.209663] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[175.310421] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[175.320764] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[175.410835] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[175.421503] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[175.510737] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s)
[175.521468] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[175.610981] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[175.621845] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[175.722140] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.110s)
[175.732642] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[175.832779] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.110s)
[175.843290] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[175.982548] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.149s)
[175.993212] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[176.093792] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[176.104366] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[176.193580] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[176.203999] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[176.293939] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[176.304474] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[176.404993] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[176.416534] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[176.516583] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[176.527676] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[176.627438] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.110s)
[176.637152] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[176.738475] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[176.749910] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[176.838991] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.099s)
[176.850233] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[176.949646] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.111s)
[176.963018] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[177.061060] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[177.071565] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[177.172675] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[177.181607] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[177.283553] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.110s)
[177.316375] Subtest flip-change-tiling: SUCCESS (21.438s)
[178.500916] [018/133] (845s left) kms_dsc (dsc-with-bpc)
[178.611787] Starting subtest: dsc-with-bpc
[178.642777] Subtest dsc-with-bpc: SKIP (0.001s)
[178.697597] [019/133] (845s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[178.796741] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[178.798952] Starting dynamic subtest: A-eDP1
[182.423582] Dynamic subtest A-eDP1: SUCCESS (3.623s)
[182.432149] Starting dynamic subtest: B-eDP1
[185.624248] Dynamic subtest B-eDP1: SUCCESS (3.198s)
[185.634176] Starting dynamic subtest: C-eDP1
[188.817572] Dynamic subtest C-eDP1: SUCCESS (3.191s)
[188.826485] Starting dynamic subtest: D-eDP1
[191.924883] Dynamic subtest D-eDP1: SUCCESS (3.106s)
[191.928042] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.125s)
[192.719717] [020/133] (831s left) gem_ctx_persistence (engines-hang)
[192.782970] Starting subtest: engines-hang
[192.785360] Starting dynamic subtest: rcs0
[192.904196] Dynamic subtest rcs0: SUCCESS (0.121s)
[192.915075] Starting dynamic subtest: bcs0
[193.006601] Dynamic subtest bcs0: SUCCESS (0.101s)
[193.017902] Starting dynamic subtest: vcs0
[193.106087] Dynamic subtest vcs0: SUCCESS (0.099s)
[193.117043] Starting dynamic subtest: vcs1
[193.204811] Dynamic subtest vcs1: SUCCESS (0.098s)
[193.215799] Starting dynamic subtest: vecs0
[193.294929] Dynamic subtest vecs0: SUCCESS (0.089s)
[193.305390] Starting dynamic subtest: ccs0
[193.390976] Dynamic subtest ccs0: SUCCESS (0.095s)
[193.393385] Subtest engines-hang: SUCCESS (0.609s)
[193.479809] [021/133] (830s left) kms_cursor_crc (cursor-alpha-transparent)
[193.576944] Starting subtest: cursor-alpha-transparent
[193.579026] Starting dynamic subtest: pipe-A-eDP-1
[194.204312] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s)
[194.214330] Starting dynamic subtest: pipe-D-eDP-1
[195.512972] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.308s)
[195.515321] Subtest cursor-alpha-transparent: SUCCESS (1.937s)
[196.324080] [022/133] (827s left) gem_mmap_offset (bad-extensions)
[196.376260] Starting subtest: bad-extensions
[196.378469] Subtest bad-extensions: SUCCESS (0.000s)
[196.467121] [023/133] (827s left) kms_addfb_basic (invalid-set-prop)
[196.521350] Starting subtest: invalid-set-prop
[196.523169] Subtest invalid-set-prop: SUCCESS (0.000s)
[196.676748] [024/133] (827s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[196.770225] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[196.772423] Starting dynamic subtest: pipe-A
[196.835029] Dynamic subtest pipe-A: SUCCESS (0.065s)
[196.845382] Starting dynamic subtest: pipe-B
[197.950158] Dynamic subtest pipe-B: SUCCESS (1.115s)
[197.960306] Starting dynamic subtest: pipe-C
[199.055052] Dynamic subtest pipe-C: SUCCESS (1.104s)
[199.063040] Starting dynamic subtest: pipe-D
[200.206564] Dynamic subtest pipe-D: SUCCESS (1.151s)
[200.208839] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.439s)
[201.363669] [025/133] (822s left) syncobj_timeline (reset-signaled)
[201.418672] Starting subtest: reset-signaled
[201.421046] Subtest reset-signaled: SUCCESS (0.001s)
[201.521971] [026/133] (822s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[201.608801] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[201.612993] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[201.688198] [027/133] (822s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[201.773944] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[201.776032] Starting dynamic subtest: pipe-A-eDP-1
[201.798390] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[201.808695] Starting dynamic subtest: pipe-B-eDP-1
[201.829385] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[201.837774] Starting dynamic subtest: pipe-C-eDP-1
[201.858776] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[201.866902] Starting dynamic subtest: pipe-D-eDP-1
[201.888413] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[201.892604] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[204.030471] [028/133] (820s left) kms_hdr (invalid-metadata-sizes)
[204.121071] Starting subtest: invalid-metadata-sizes
[204.127603] Subtest invalid-metadata-sizes: SKIP (0.000s)
[204.193557] [029/133] (820s left) gem_fence_thrash (bo-write-verify-y)
[204.229664] Starting subtest: bo-write-verify-y
[204.250973] Subtest bo-write-verify-y: SKIP (0.019s)
[204.314814] [030/133] (819s left) gem_render_copy (linear-to-vebox-y-tiled)
[204.387932] Starting subtest: linear-to-vebox-y-tiled
[204.392247] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[204.571739] [031/133] (819s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[204.667745] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[204.672422] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[204.739752] [032/133] (819s left) i915_query (query-regions-garbage-items)
[204.795374] Starting subtest: query-regions-garbage-items
[204.797802] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[204.915300] [033/133] (819s left) syncobj_timeline (invalid-wait-illegal-handle)
[204.974742] Starting subtest: invalid-wait-illegal-handle
[204.977058] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[205.087305] [034/133] (819s left) kms_prop_blob (invalid-set-prop)
[205.154776] Starting subtest: invalid-set-prop
[205.157082] Subtest invalid-set-prop: SUCCESS (0.000s)
[205.255540] [035/133] (819s left) gem_gpgpu_fill (offset-16x16)
[205.319791] Starting subtest: offset-16x16
[205.326227] Subtest offset-16x16: SUCCESS (0.009s)
[205.464990] [036/133] (819s left) gem_ctx_shared (q-out-order)
[205.526789] Starting subtest: Q-out-order
[205.528571] Starting dynamic subtest: rcs0
[205.683750] Dynamic subtest rcs0: SUCCESS (0.156s)
[205.699801] Starting dynamic subtest: vcs0
[205.765288] Dynamic subtest vcs0: SUCCESS (0.081s)
[205.781654] Starting dynamic subtest: vcs1
[205.846125] Dynamic subtest vcs1: SUCCESS (0.080s)
[205.861983] Starting dynamic subtest: vecs0
[205.928272] Dynamic subtest vecs0: SUCCESS (0.081s)
[205.944284] Starting dynamic subtest: ccs0
[206.018148] Dynamic subtest ccs0: SUCCESS (0.089s)
[206.020682] Subtest Q-out-order: SUCCESS (0.492s)
[207.523305] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[207.526663] [037/133] (817s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[207.636010] Starting subtest: fbc-rgb565-draw-render
[211.765920] Subtest fbc-rgb565-draw-render: SUCCESS (4.134s)
[212.921739] [038/133] (811s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[213.014204] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[213.019032] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[213.112061] [039/133] (811s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[213.203432] Starting subtest: fbc-rgb101010-draw-pwrite
[218.596909] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.396s)
[219.724113] [040/133] (804s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[219.820854] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[219.825354] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[219.894061] [041/133] (804s left) gem_linear_blits (normal)
[220.232495] Starting subtest: normal
[224.166813] Subtest normal: SUCCESS (3.935s)
[224.329757] [042/133] (800s left) sysfs_heartbeat_interval (precise)
[224.431697] Starting subtest: precise
[224.433710] Starting dynamic subtest: vecs0
[232.363813] Dynamic subtest vecs0: SUCCESS (7.933s)
[232.374815] Starting dynamic subtest: ccs0
[233.481506] Dynamic subtest ccs0: SUCCESS (1.113s)
[233.490267] Starting dynamic subtest: vcs0
[241.450411] Dynamic subtest vcs0: SUCCESS (7.969s)
[241.465582] Starting dynamic subtest: bcs0
[244.386183] Dynamic subtest bcs0: SUCCESS (2.933s)
[244.394904] Starting dynamic subtest: rcs0
[245.488220] Dynamic subtest rcs0: SUCCESS (1.101s)
[245.498894] Starting dynamic subtest: vcs1
[253.427497] Dynamic subtest vcs1: SUCCESS (7.936s)
[253.430008] Subtest precise: SUCCESS (28.995s)
[253.506061] [043/133] (771s left) sw_sync (sync_busy_fork_unixsocket)
[253.560865] Starting subtest: sync_busy_fork_unixsocket
[253.569577] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[253.633421] [044/133] (771s left) prime_mmap (test_reprime)
[253.686466] Starting subtest: test_reprime
[253.688641] Starting dynamic subtest: test_reprime-smem
[253.718556] Dynamic subtest test_reprime-smem: SUCCESS (0.034s)
[253.720947] Subtest test_reprime: SUCCESS (0.035s)
[253.841262] [045/133] (771s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[253.977925] Starting subtest: cursorA-vs-flipA-atomic-transitions
[265.178501] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.196s)
[266.040513] [046/133] (758s left) kms_psr (psr2-dpms)
[266.153128] Starting subtest: psr2-dpms
[266.155463] Starting dynamic subtest: eDP-1
[268.989465] Dynamic subtest eDP-1: SUCCESS (2.836s)
[268.991685] Subtest psr2-dpms: SUCCESS (2.837s)
[269.857965] [047/133] (755s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[269.948484] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[269.952776] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[270.058205] [048/133] (754s left) dmabuf (all-tests)
[270.098924] Starting subtest: all-tests
[270.101178] Starting dynamic subtest: sanitycheck
[270.249830] Dynamic subtest sanitycheck: SUCCESS (0.149s)
[270.262332] Starting dynamic subtest: dma_fence
[270.452366] Dynamic subtest dma_fence: SUCCESS (0.201s)
[270.464455] Starting dynamic subtest: dma_fence_chain
[279.745914] Dynamic subtest dma_fence_chain: SUCCESS (9.287s)
[279.757398] Starting dynamic subtest: dma_fence_unwrap
[279.848723] Dynamic subtest dma_fence_unwrap: SUCCESS (0.101s)
[279.860527] Starting dynamic subtest: dma_resv
[279.930725] Dynamic subtest dma_resv: SUCCESS (0.080s)
[279.933439] Subtest all-tests: SUCCESS (9.830s)
[279.994122] [049/133] (745s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[280.128647] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[281.106091] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.976s)
[281.986161] [050/133] (743s left) kms_force_connector_basic (force-edid)
[282.059103] Starting subtest: force-edid
[282.429086] Subtest force-edid: SUCCESS (0.369s)
[282.562953] [051/133] (742s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[282.667078] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[282.671006] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[282.752665] [052/133] (742s left) i915_pm_rc6_residency (rc6-idle)
[282.813450] Starting subtest: rc6-idle
[282.852092] Starting dynamic subtest: gt0-rcs0
[307.238445] Dynamic subtest gt0-rcs0: SUCCESS (24.378s)
[307.249895] Starting dynamic subtest: gt0-bcs0
[331.524793] Dynamic subtest gt0-bcs0: SUCCESS (24.283s)
[331.533827] Starting dynamic subtest: gt0-ccs0
[355.904548] Dynamic subtest gt0-ccs0: SUCCESS (24.382s)
[355.916606] Starting dynamic subtest: gt1-vcs0
[362.081386] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[362.093800] Starting dynamic subtest: gt1-vecs0
[368.252376] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[368.255391] Subtest rc6-idle: SUCCESS (85.438s)
[368.333776] [053/133] (656s left) kms_async_flips (crc-atomic)
[368.444941] Starting subtest: crc-atomic
[368.819775] Starting dynamic subtest: pipe-A-eDP-1
[371.701566] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.879s)
[372.083875] Starting dynamic subtest: pipe-B-eDP-1
[374.996669] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.921s)
[375.396087] Starting dynamic subtest: pipe-C-eDP-1
[378.266893] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.883s)
[378.630472] Starting dynamic subtest: pipe-D-eDP-1
[381.475174] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.855s)
[381.477401] Subtest crc-atomic: SUCCESS (13.033s)
[382.744120] [054/133] (642s left) api_intel_allocator (reserve-simple)
[382.808842] Starting subtest: reserve-simple
[382.810956] Subtest reserve-simple: SUCCESS (0.003s)
[382.932311] [055/133] (642s left) kms_big_fb (linear-8bpp-rotate-90)
[383.053483] Starting subtest: linear-8bpp-rotate-90
[383.074466] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[383.190045] [056/133] (642s left) kms_joiner (invalid-modeset-ultra-joiner)
[383.285603] Starting subtest: invalid-modeset-ultra-joiner
[383.289638] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[383.354525] [057/133] (642s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[383.485602] Starting subtest: cursorA-vs-flipB-varying-size
[383.489809] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[383.657806] [058/133] (641s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[383.754262] Starting subtest: fbc-2p-pri-indfb-multidraw
[383.757783] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[383.846203] [059/133] (641s left) kms_flip (plain-flip-ts-check-interruptible)
[383.939567] Starting subtest: plain-flip-ts-check-interruptible
[383.943597] Starting dynamic subtest: A-eDP1
[392.767112] Dynamic subtest A-eDP1: SUCCESS (8.824s)
[392.779469] Starting dynamic subtest: B-eDP1
[401.567571] Dynamic subtest B-eDP1: SUCCESS (8.798s)
[401.579730] Starting dynamic subtest: C-eDP1
[410.455128] Dynamic subtest C-eDP1: SUCCESS (8.884s)
[410.471561] Starting dynamic subtest: D-eDP1
[419.251803] Dynamic subtest D-eDP1: SUCCESS (8.793s)
[419.257735] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.312s)
[420.412503] [060/133] (605s left) syncobj_wait (invalid-signal-illegal-handle)
[420.468433] Starting subtest: invalid-signal-illegal-handle
[420.470668] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[420.556448] [061/133] (604s left) gem_basic (create-close)
[420.610675] Starting subtest: create-close
[420.614959] Subtest create-close: SUCCESS (0.000s)
[420.727726] [062/133] (604s left) gem_exec_schedule (wide)
[420.911391] Starting subtest: wide
[420.914114] Starting dynamic subtest: rcs0
[431.005127] Dynamic subtest rcs0: SUCCESS (10.091s)
[431.022369] Starting dynamic subtest: vcs0
[441.703400] Dynamic subtest vcs0: SUCCESS (10.696s)
[441.715741] Starting dynamic subtest: vcs1
[454.432014] Dynamic subtest vcs1: SUCCESS (12.724s)
[454.442321] Starting dynamic subtest: vecs0
[465.608104] Dynamic subtest vecs0: SUCCESS (11.172s)
[465.620320] Starting dynamic subtest: ccs0
[479.932670] Dynamic subtest ccs0: SUCCESS (14.320s)
[479.935354] Subtest wide: SUCCESS (59.010s)
[482.213682] [063/133] (543s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[482.277950] Starting subtest: y-tiled-ccs-to-yf-tiled
[482.282573] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[482.468392] [064/133] (543s left) gem_exec_reloc (basic-cpu)
[482.535112] Subtest basic-cpu: SKIP (0.000s)
[482.604230] [065/133] (543s left) gem_exec_reloc (basic-gtt-cpu-active)
[482.662467] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[482.744983] [066/133] (543s left) i915_drm_fdinfo (virtual-idle)
[482.794164] Starting subtest: virtual-idle
[485.857225] Subtest virtual-idle: SUCCESS (3.060s)
[485.950098] [067/133] (539s left) kms_psr (fbc-pr-primary-mmap-cpu)
[486.052197] Starting subtest: fbc-pr-primary-mmap-cpu
[486.056594] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[486.123798] [068/133] (539s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[486.223327] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[486.227745] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[486.297158] [069/133] (539s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[486.349671] Starting subtest: etime-single-wait-for-submit-unsubmitted
[486.454580] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[486.543876] [070/133] (539s left) gem_mmap_gtt (basic-write-read)
[486.605972] Subtest basic-write-read: SKIP (0.000s)
[486.671185] [071/133] (539s left) i915_query (query-topology-matches-eu-total)
[486.728567] Starting subtest: query-topology-matches-eu-total
[486.730923] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[486.827153] [072/133] (539s left) kms_psr (pr-cursor-render)
[486.921299] Starting subtest: pr-cursor-render
[486.925504] Subtest pr-cursor-render: SKIP (0.000s)
[487.032129] [073/133] (539s left) kms_frontbuffer_tracking (fbc-tiling-y)
[487.130113] Starting subtest: fbc-tiling-y
[487.134197] Subtest fbc-tiling-y: SKIP (0.000s)
[487.227899] [074/133] (538s left) gem_reg_read (timestamp-monotonic)
[487.275418] Starting subtest: timestamp-monotonic
[491.725525] Subtest timestamp-monotonic: SUCCESS (4.449s)
[491.801207] [075/133] (534s left) gem_tiled_partial_pwrite_pread (reads)
[491.866994] Subtest reads: SKIP (0.000s)
[491.951486] [076/133] (534s left) gem_softpin (evict-snoop-interruptible)
[492.019834] Starting subtest: evict-snoop-interruptible
[492.024320] Subtest evict-snoop-interruptible: SKIP (0.000s)
[492.146071] [077/133] (534s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[492.238107] Starting subtest: fbc-psr2-cursor-plane-onoff
[492.240415] Starting dynamic subtest: eDP-1
[492.244380] Dynamic subtest eDP-1: SKIP (0.000s)
[492.248366] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[492.309647] [078/133] (533s left) syncobj_basic (bad-destroy-pad)
[492.366220] Starting subtest: bad-destroy-pad
[492.368155] Subtest bad-destroy-pad: SUCCESS (0.000s)
[492.465762] [079/133] (533s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[492.563902] Starting subtest: async-flip-with-page-flip-events-tiled
[492.935607] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[495.752127] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.814s)
[495.762355] Starting dynamic subtest: pipe-A-eDP-1-4
[497.938782] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[497.950263] Starting dynamic subtest: pipe-A-eDP-1-4
[499.948641] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[499.958167] Starting dynamic subtest: pipe-A-eDP-1-x
[502.128465] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[502.502286] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[505.243115] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.754s)
[505.254304] Starting dynamic subtest: pipe-B-eDP-1-4
[507.429655] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[507.441737] Starting dynamic subtest: pipe-B-eDP-1-4
[509.439678] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[509.457146] Starting dynamic subtest: pipe-B-eDP-1-x
[511.630618] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[512.011039] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[514.757425] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.756s)
[514.767771] Starting dynamic subtest: pipe-C-eDP-1-4
[516.923010] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.162s)
[516.933087] Starting dynamic subtest: pipe-C-eDP-1-4
[518.932074] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[518.944341] Starting dynamic subtest: pipe-C-eDP-1-x
[521.111639] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[521.481941] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[524.253463] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.780s)
[524.264153] Starting dynamic subtest: pipe-D-eDP-1-4
[526.429058] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[526.440366] Starting dynamic subtest: pipe-D-eDP-1-4
[528.438733] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[528.449029] Starting dynamic subtest: pipe-D-eDP-1-x
[530.607378] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.167s)
[530.609767] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.035s)
[531.818271] [080/133] (494s left) kms_chamelium_edid (vga-edid-read)
[532.199773] Subtest vga-edid-read: SKIP (0.000s)
[532.982851] [081/133] (493s left) kms_psr (fbc-psr-no-drrs)
[533.083590] Starting subtest: fbc-psr-no-drrs
[533.086057] Starting dynamic subtest: eDP-1
[533.090794] Dynamic subtest eDP-1: SKIP (0.000s)
[533.095496] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[533.156684] [082/133] (493s left) kms_pipe_crc_basic (hang-read-crc)
[533.250244] Starting subtest: hang-read-crc
[533.252545] Starting dynamic subtest: pipe-A-eDP-1
[535.368145] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.117s)
[535.378481] Starting dynamic subtest: pipe-B-eDP-1
[538.154306] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.785s)
[538.164848] Starting dynamic subtest: pipe-C-eDP-1
[540.827115] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.668s)
[540.837882] Starting dynamic subtest: pipe-D-eDP-1
[543.521589] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.694s)
[543.523850] Subtest hang-read-crc: SUCCESS (10.270s)
[544.317153] [083/133] (482s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[544.413109] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[544.417543] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[544.513439] [084/133] (482s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[546.541568] Starting subtest: modeset-lpsp-stress-no-wait
[556.754079] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.212s)
[556.845241] [085/133] (469s left) fbdev (nullptr)
[556.896176] Starting subtest: nullptr
[556.898422] Subtest nullptr: SUCCESS (0.000s)
[556.956169] [086/133] (469s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[557.053662] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[557.058008] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[557.159188] [087/133] (469s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[557.212379] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[557.318396] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[557.396018] [088/133] (469s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[557.491472] Starting subtest: primary-x-tiled-reflect-x-0
[564.371367] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.880s)
[565.530322] [089/133] (461s left) gem_exec_schedule (pi-userfault)
[565.712483] Starting subtest: pi-userfault
[565.714412] Starting dynamic subtest: rcs0
[565.718969] Dynamic subtest rcs0: SUCCESS (0.011s)
[565.728770] Starting dynamic subtest: bcs0
[565.730624] Dynamic subtest bcs0: SUCCESS (0.007s)
[565.740107] Starting dynamic subtest: vcs0
[565.742266] Dynamic subtest vcs0: SUCCESS (0.008s)
[565.751849] Starting dynamic subtest: vcs1
[565.753859] Dynamic subtest vcs1: SUCCESS (0.010s)
[565.763276] Starting dynamic subtest: vecs0
[565.765507] Dynamic subtest vecs0: SUCCESS (0.010s)
[565.774961] Starting dynamic subtest: ccs0
[565.776962] Dynamic subtest ccs0: SUCCESS (0.010s)
[565.778941] Subtest pi-userfault: SUCCESS (0.060s)
[565.954733] [090/133] (460s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[566.047661] Starting subtest: x-tiled-32bpp-rotate-90
[566.067549] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[566.170794] [091/133] (460s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[566.268026] Starting subtest: y-tiled-64bpp-rotate-270
[566.272484] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[566.352193] [092/133] (460s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[566.450237] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[566.454531] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[566.521500] [093/133] (460s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[566.620709] Starting subtest: yf-tiled-32bpp-rotate-0
[566.624740] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[566.741737] [094/133] (460s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[566.843563] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[566.847178] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[566.957107] [095/133] (460s left) kms_universal_plane (universal-plane-functional)
[567.045421] Starting subtest: universal-plane-functional
[567.047200] Starting dynamic subtest: pipe-A-eDP-1
[571.129770] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.079s)
[571.140190] Starting dynamic subtest: pipe-B-eDP-1
[575.745398] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.614s)
[575.755945] Starting dynamic subtest: pipe-C-eDP-1
[580.169884] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.424s)
[580.180404] Starting dynamic subtest: pipe-D-eDP-1
[584.680973] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.513s)
[584.683146] Subtest universal-plane-functional: SUCCESS (17.636s)
[585.514677] [096/133] (441s left) kms_cursor_legacy (single-move)
[585.656445] Starting subtest: single-move
[585.658879] Starting dynamic subtest: pipe-A
[591.033485] Dynamic subtest pipe-A: SUCCESS (5.378s)
[591.045942] Starting dynamic subtest: pipe-B
[596.412266] Dynamic subtest pipe-B: SUCCESS (5.379s)
[596.423973] Starting dynamic subtest: pipe-C
[601.791867] Dynamic subtest pipe-C: SUCCESS (5.379s)
[601.803651] Starting dynamic subtest: pipe-D
[607.170901] Dynamic subtest pipe-D: SUCCESS (5.379s)
[607.183140] Starting dynamic subtest: all-pipes
[612.557594] Dynamic subtest all-pipes: SUCCESS (5.386s)
[612.560136] Subtest single-move: SUCCESS (26.915s)
[612.702700] [097/133] (414s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[612.813685] Starting subtest: short-flip-after-cursor-atomic-transitions
[613.758709] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.946s)
[614.594995] [098/133] (412s left) gem_exec_params (invalid-ring)
[614.674708] Starting subtest: invalid-ring
[614.677075] Subtest invalid-ring: SUCCESS (0.000s)
[614.776838] [099/133] (412s left) gem_pread (self)
[614.828018] Subtest self: SKIP (0.000s)
[614.900991] [100/133] (412s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[614.996494] Starting subtest: primary-4-tiled-reflect-x-180
[622.120397] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.128s)
[623.295597] [101/133] (404s left) gem_spin_batch (spin-each)
[623.351902] Starting subtest: spin-each
[626.623003] Subtest spin-each: SUCCESS (3.265s)
[627.467949] [102/133] (399s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[627.569390] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[627.571693] Starting dynamic subtest: pipe-A-eDP-1
[627.594243] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[627.605967] Starting dynamic subtest: pipe-B-eDP-1
[627.627235] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[627.636419] Starting dynamic subtest: pipe-C-eDP-1
[627.657567] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[627.666318] Starting dynamic subtest: pipe-D-eDP-1
[627.687716] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[627.692087] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[629.798589] [103/133] (397s left) kms_cursor_edge_walk (128x128-top-edge)
[629.897173] Starting subtest: 128x128-top-edge
[629.899440] Starting dynamic subtest: pipe-A-eDP-1
[633.317807] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.421s)
[633.327686] Starting dynamic subtest: pipe-D-eDP-1
[636.504782] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.185s)
[636.506662] Subtest 128x128-top-edge: SUCCESS (6.609s)
[637.386280] [104/133] (390s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[637.489165] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[644.464092] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.980s)
[644.579254] [105/133] (382s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[644.690939] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[644.695170] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[644.778041] [106/133] (382s left) kms_cursor_crc (cursor-random-32x10)
[644.923501] Starting subtest: cursor-random-32x10
[644.974365] Subtest cursor-random-32x10: SKIP (0.046s)
[645.236891] [107/133] (382s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[645.328095] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[645.330416] Starting dynamic subtest: pipe-A-eDP-1
[645.350043] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[645.361120] Starting dynamic subtest: pipe-B-eDP-1
[645.379513] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[645.388951] Starting dynamic subtest: pipe-C-eDP-1
[645.405038] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[645.414083] Starting dynamic subtest: pipe-D-eDP-1
[645.429843] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[645.431432] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[647.590090] [108/133] (380s left) perf_pmu (busy)
[647.633120] Starting subtest: busy
[647.635471] Starting dynamic subtest: rcs0
[648.222282] Dynamic subtest rcs0: SUCCESS (0.591s)
[648.234996] Starting dynamic subtest: bcs0
[648.787570] Dynamic subtest bcs0: SUCCESS (0.563s)
[648.800499] Starting dynamic subtest: vcs0
[650.417837] Dynamic subtest vcs0: SUCCESS (1.627s)
[650.429529] Starting dynamic subtest: vcs1
[652.466626] Dynamic subtest vcs1: SUCCESS (2.045s)
[652.480444] Starting dynamic subtest: vecs0
[654.449840] Dynamic subtest vecs0: SUCCESS (1.980s)
[654.463009] Starting dynamic subtest: ccs0
[655.014792] Dynamic subtest ccs0: SUCCESS (0.564s)
[655.017394] Subtest busy: SUCCESS (7.386s)
[655.104470] [109/133] (372s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[655.206465] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[655.208401] Starting dynamic subtest: pipe-A-eDP-1
[656.539205] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.335s)
[656.556224] Starting dynamic subtest: pipe-B-eDP-1
[658.904967] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.363s)
[658.915620] Starting dynamic subtest: pipe-C-eDP-1
[661.325392] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.420s)
[661.336046] Starting dynamic subtest: pipe-D-eDP-1
[663.713192] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.386s)
[663.715697] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.511s)
[664.869212] [110/133] (362s left) kms_content_protection (atomic)
[665.013807] Starting subtest: atomic
[665.018160] Subtest atomic: SKIP (0.000s)
[665.150376] [111/133] (362s left) gem_exec_schedule (deep)
[665.328282] Starting subtest: deep
[665.330592] Starting dynamic subtest: rcs0
[670.781058] Dynamic subtest rcs0: SKIP (5.451s)
[670.804412] Starting dynamic subtest: vcs0
[681.729156] Dynamic subtest vcs0: SUCCESS (10.949s)
[681.747370] Starting dynamic subtest: vcs1
[693.616249] Dynamic subtest vcs1: SUCCESS (11.885s)
[693.630221] Starting dynamic subtest: vecs0
[705.477050] Dynamic subtest vecs0: SUCCESS (11.860s)
[705.489942] Starting dynamic subtest: ccs0
[718.932015] Dynamic subtest ccs0: SUCCESS (13.453s)
[718.934808] Subtest deep: SUCCESS (53.604s)
[720.953667] [112/133] (306s left) syncobj_wait (multi-wait-for-submit-signaled)
[721.013667] Starting subtest: multi-wait-for-submit-signaled
[721.015995] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[721.110061] [113/133] (306s left) gem_exec_fence (submit3)
[721.293889] Starting subtest: submit3
[721.298693] Subtest submit3: SKIP (0.000s)
[723.531154] [114/133] (304s left) gem_mmap_wc (write)
[723.596881] Subtest write: SKIP (0.000s)
[723.661581] [115/133] (304s left) gem_create (create-ext-placement-sanity-check)
[723.826119] Starting subtest: create-ext-placement-sanity-check
[723.828626] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[723.925264] [116/133] (304s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[724.017609] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[724.019639] Starting dynamic subtest: pipe-A-eDP-1
[724.942601] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.920s)
[724.952638] Starting dynamic subtest: pipe-B-eDP-1
[726.627131] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.680s)
[726.638070] Starting dynamic subtest: pipe-C-eDP-1
[728.173994] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.547s)
[728.184648] Starting dynamic subtest: pipe-D-eDP-1
[729.756775] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.581s)
[729.758716] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.732s)
[730.965193] [117/133] (297s left) gem_lmem_swapping (parallel-random-verify-ccs)
[731.004215] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[731.055548] [118/133] (296s left) api_intel_bb (object-reloc-keep-cache)
[731.109605] Starting subtest: object-reloc-keep-cache
[731.114384] Subtest object-reloc-keep-cache: SKIP (0.003s)
[731.219499] [119/133] (296s left) kms_rotation_crc (primary-rotation-90)
[731.308746] Starting subtest: primary-rotation-90
[731.312933] Subtest primary-rotation-90: SKIP (0.001s)
[731.381742] [120/133] (296s left) sw_sync (alloc_merge_fence)
[731.429198] Starting subtest: alloc_merge_fence
[731.431506] Subtest alloc_merge_fence: SUCCESS (0.000s)
[731.488179] [121/133] (296s left) kms_flip (2x-flip-vs-panning)
[731.576758] Starting subtest: 2x-flip-vs-panning
[731.585716] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[731.672458] [122/133] (296s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[731.770424] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[731.774834] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[731.887781] [123/133] (296s left) perf_pmu (busy-no-semaphores)
[731.922461] Starting subtest: busy-no-semaphores
[731.924333] Starting dynamic subtest: rcs0
[732.469041] Dynamic subtest rcs0: SUCCESS (0.545s)
[732.481212] Starting dynamic subtest: bcs0
[733.016903] Dynamic subtest bcs0: SUCCESS (0.545s)
[733.028310] Starting dynamic subtest: vcs0
[733.567913] Dynamic subtest vcs0: SUCCESS (0.547s)
[733.579377] Starting dynamic subtest: vcs1
[734.965925] Dynamic subtest vcs1: SUCCESS (1.394s)
[734.979537] Starting dynamic subtest: vecs0
[736.950945] Dynamic subtest vecs0: SUCCESS (1.982s)
[736.964328] Starting dynamic subtest: ccs0
[738.936253] Dynamic subtest ccs0: SUCCESS (1.982s)
[738.939571] Subtest busy-no-semaphores: SUCCESS (7.014s)
[739.055422] [124/133] (289s left) sw_sync (alloc_fence)
[739.088851] Starting subtest: alloc_fence
[739.091273] Subtest alloc_fence: SUCCESS (0.000s)
[739.142151] [125/133] (289s left) gem_eio (in-flight-contexts-immediate)
[739.355376] Starting subtest: in-flight-contexts-immediate
[753.480065] Subtest in-flight-contexts-immediate: SUCCESS (14.122s)
[753.638295] [126/133] (274s left) syncobj_timeline (wait-all-interrupted)
[753.689720] Starting subtest: wait-all-interrupted
[753.790404] Subtest wait-all-interrupted: SUCCESS (0.101s)
[753.868055] [127/133] (274s left) gem_ctx_shared (create-shared-gtt)
[753.935385] Starting subtest: create-shared-gtt
[756.090247] Subtest create-shared-gtt: SUCCESS (2.154s)
[756.412009] [128/133] (272s left) kms_vrr (flip-basic-fastset)
[756.524434] Starting subtest: flip-basic-fastset
[756.531104] Subtest flip-basic-fastset: SKIP (0.000s)
[756.595972] [129/133] (271s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[756.681674] Starting subtest: psr-rgb565-draw-mmap-gtt
[756.686108] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[756.783917] [130/133] (271s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[756.896143] Starting subtest: 4-tiled-16bpp-rotate-90
[756.916466] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[757.055524] [131/133] (271s left) kms_flip (dpms-off-confusion)
[757.145685] Starting subtest: dpms-off-confusion
[757.147642] Starting dynamic subtest: A-eDP1
[765.836389] Dynamic subtest A-eDP1: SUCCESS (8.691s)
[765.848443] Starting dynamic subtest: B-eDP1
[774.531980] Dynamic subtest B-eDP1: SUCCESS (8.693s)
[774.543555] Starting dynamic subtest: C-eDP1
[783.219902] Dynamic subtest C-eDP1: SUCCESS (8.686s)
[783.232631] Starting dynamic subtest: D-eDP1
[791.936032] Dynamic subtest D-eDP1: SUCCESS (8.702s)
[791.940584] Subtest dpms-off-confusion: SUCCESS (34.782s)
[793.182916] [132/133] (235s left) gen9_exec_parse (basic-rejected-ctx-param)
[793.250657] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[793.333788] [133/133] (235s left) gem_mmap_wc (set-cache-level)
[793.387046] Subtest set-cache-level: SKIP (0.000s)
[793.442219] 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.