[58.333225] Initializing watchdogs
[58.333271]   /dev/watchdog0
[58.347545] [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.351845] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.354389] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.357859] [001/131] (960s left) kms_pm_rpm (system-suspend-idle)
[60.049126] Starting subtest: system-suspend-idle
[79.443343] Subtest system-suspend-idle: SUCCESS (8.399s)
[79.821774] [002/131] (939s left) kms_plane_scaling (2x-scaler-multi-pipe)
[79.946759] Starting subtest: 2x-scaler-multi-pipe
[79.952049] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[80.069542] [003/131] (938s left) gem_exec_whisper (basic-queues-priority-all)
[80.131471] Starting subtest: basic-queues-priority-all
[102.192167] Subtest basic-queues-priority-all: SUCCESS (22.104s)
[102.395319] [004/131] (916s left) kms_chamelium_color (ctm-limited-range)
[102.493750] Subtest ctm-limited-range: SKIP (0.000s)
[102.536504] [005/131] (916s left) kms_psr (fbc-psr-sprite-render)
[102.626146] Starting subtest: fbc-psr-sprite-render
[102.628784] Starting dynamic subtest: eDP-1
[102.633735] Dynamic subtest eDP-1: SKIP (0.000s)
[102.638772] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[102.716683] [006/131] (916s left) perf_pmu (semaphore-busy)
[102.755095] Starting subtest: semaphore-busy
[102.757501] Starting dynamic subtest: rcs0
[104.378492] Dynamic subtest rcs0: SUCCESS (1.622s)
[104.389884] Starting dynamic subtest: bcs0
[106.009542] Dynamic subtest bcs0: SUCCESS (1.630s)
[106.020995] Starting dynamic subtest: vcs0
[110.424154] Dynamic subtest vcs0: SUCCESS (4.412s)
[110.435329] Starting dynamic subtest: vcs1
[116.440036] Dynamic subtest vcs1: SUCCESS (6.011s)
[116.451828] Starting dynamic subtest: vecs0
[122.455379] Dynamic subtest vecs0: SUCCESS (6.012s)
[122.467388] Starting dynamic subtest: ccs0
[125.528515] Dynamic subtest ccs0: SUCCESS (3.072s)
[125.531065] Subtest semaphore-busy: SUCCESS (22.766s)
[125.677398] [007/131] (893s left) perf (gen12-invalid-class-instance)
[125.805156] Starting subtest: gen12-invalid-class-instance
[125.818203] Subtest gen12-invalid-class-instance: SUCCESS (0.012s)
[125.854417] [008/131] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[125.956107] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[125.961181] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[126.086747] [009/131] (893s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[126.186197] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[126.197273] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[126.291840] [010/131] (892s left) kms_flip_tiling (flip-change-tiling)
[126.381475] Starting subtest: flip-change-tiling
[126.384014] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[126.581142] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.199s)
[126.596345] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[126.727277] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.144s)
[126.736917] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[126.861258] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.133s)
[126.873346] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[127.003918] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s)
[127.015839] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[127.148628] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.144s)
[127.159048] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[127.293062] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.144s)
[127.304405] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[127.437066] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.143s)
[127.447166] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[127.559045] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.121s)
[127.569966] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[127.694173] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.133s)
[127.703687] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[127.837751] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.143s)
[127.856986] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[127.981525] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s)
[127.993474] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[128.126359] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.143s)
[128.137383] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[128.259115] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[128.270290] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[128.394159] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[128.404135] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[128.504005] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[128.512751] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[128.648669] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.144s)
[128.659347] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[128.793536] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.144s)
[128.805405] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[128.937361] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[128.948385] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[129.081879] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.144s)
[129.093348] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[129.226119] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[129.238759] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[129.370651] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.144s)
[129.382919] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[129.519936] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.149s)
[129.531806] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[129.664177] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.143s)
[129.675188] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[129.808884] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.143s)
[129.819828] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[129.953271] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.144s)
[129.964400] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[130.097863] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.144s)
[130.108633] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[130.242620] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.144s)
[130.253733] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[130.386253] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.143s)
[130.396023] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[130.540227] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.153s)
[130.551568] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[130.695988] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.155s)
[130.707341] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[130.840250] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.144s)
[130.853089] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[130.984552] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s)
[130.994675] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[131.129642] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.144s)
[131.139209] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[131.273740] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.143s)
[131.284327] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[131.417936] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.144s)
[131.428671] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[131.540078] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.121s)
[131.597487] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[132.830370] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.244s)
[132.841367] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[132.965499] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.133s)
[132.976502] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[133.109352] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.143s)
[133.120345] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[133.252990] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s)
[133.264706] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[133.397000] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.143s)
[133.407673] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[133.570023] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.171s)
[133.581404] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[133.724551] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.152s)
[133.741639] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[133.847262] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.121s)
[133.857200] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[133.981759] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[133.992689] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[134.153577] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.171s)
[134.165047] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[134.296946] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s)
[134.307354] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[134.441697] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.143s)
[134.452465] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[134.574606] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[134.585706] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[134.709043] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.132s)
[134.720529] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[134.818920] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[134.828408] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[134.963320] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.144s)
[134.974742] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[135.107779] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.144s)
[135.119597] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[135.252525] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.144s)
[135.264359] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[135.396654] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.144s)
[135.408875] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[135.541338] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.144s)
[135.554965] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[135.685264] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[135.697813] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[135.818647] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.132s)
[135.832124] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[135.993268] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.173s)
[136.005004] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[136.137743] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.144s)
[136.148734] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[136.282023] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.144s)
[136.293772] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[136.426241] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s)
[136.436233] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[136.570662] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.144s)
[136.580981] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[136.726100] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.154s)
[136.736310] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[136.848786] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.121s)
[136.858942] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[136.993195] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.144s)
[137.003281] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[137.137554] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.144s)
[137.148842] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[137.281947] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.144s)
[137.293238] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[137.426366] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[137.437648] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[137.582140] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.155s)
[137.592047] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[137.753889] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.170s)
[137.763359] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[137.876005] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.121s)
[137.928183] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[139.154339] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.233s)
[139.166370] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[139.254333] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[139.265409] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[139.354296] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[139.366086] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[139.465359] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.111s)
[139.479353] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[139.575997] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[139.590619] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[139.726170] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.149s)
[139.741404] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[139.826332] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[139.838074] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[139.926130] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[139.937643] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[140.026264] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[140.037966] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[140.137287] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.111s)
[140.147316] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[140.248195] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[140.257350] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[140.358916] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[140.368879] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[140.458798] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[140.470489] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[140.570246] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.110s)
[140.581791] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[140.681262] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[140.691089] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[140.792031] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[140.801763] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[140.903213] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[140.914240] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[141.014572] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.111s)
[141.025839] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[141.125389] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.111s)
[141.136646] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[141.236704] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[141.248980] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[141.347878] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.110s)
[141.362774] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[141.469850] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.121s)
[141.482163] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[141.580931] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.111s)
[141.589957] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[141.692115] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.111s)
[141.702986] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[141.803148] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[141.814174] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[141.914184] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.111s)
[141.923623] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[142.025136] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.111s)
[142.036386] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[142.136019] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.111s)
[142.152366] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[142.247293] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[142.258172] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[142.358559] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.110s)
[142.370140] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[142.469980] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[142.480640] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[142.581091] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.111s)
[142.592275] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[142.692208] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.111s)
[142.702871] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[142.803227] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.111s)
[142.813675] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[142.913883] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.111s)
[142.925342] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[143.025682] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.111s)
[143.066699] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[144.276603] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.217s)
[144.289214] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[144.387989] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[144.398243] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[144.498841] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.110s)
[144.509733] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[144.609516] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[144.620938] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[144.759068] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.149s)
[144.769280] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[144.870553] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.111s)
[144.880169] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[144.970729] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.100s)
[144.981132] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[145.070493] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[145.081790] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[145.169704] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[145.180024] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[145.281348] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.111s)
[145.291040] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[145.391902] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[145.400742] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[145.503167] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.111s)
[145.512049] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[145.603275] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.100s)
[145.613805] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[145.703279] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[145.713278] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[145.803391] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[145.814750] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[145.914209] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.111s)
[145.924867] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[146.025233] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.111s)
[146.035907] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[146.136660] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[146.147201] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[146.247915] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.111s)
[146.259353] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[146.347884] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s)
[146.358954] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[146.458941] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.111s)
[146.469183] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[146.608290] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.149s)
[146.619019] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[146.719639] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.110s)
[146.730969] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[146.830841] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.111s)
[146.841788] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[146.941847] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.111s)
[146.952749] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[147.052589] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.111s)
[147.062803] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[147.163932] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.111s)
[147.174223] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[147.317716] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.153s)
[147.328382] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[147.428836] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.111s)
[147.440667] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[147.540264] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.111s)
[147.551349] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[147.639737] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.099s)
[147.650498] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[147.751386] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.111s)
[147.762422] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[147.862148] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.111s)
[147.873357] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[147.973540] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[147.983271] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[148.084094] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.111s)
[148.093262] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[148.195254] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.110s)
[148.228803] Subtest flip-change-tiling: SUCCESS (21.851s)
[149.492890] [011/131] (869s left) kms_plane_multiple (tiling-none)
[149.587354] Starting subtest: tiling-none
[149.589811] Starting dynamic subtest: pipe-A-eDP-1
[153.306325] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.721s)
[153.316402] Starting dynamic subtest: pipe-B-eDP-1
[157.781279] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.474s)
[157.791254] Starting dynamic subtest: pipe-C-eDP-1
[162.166867] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.386s)
[162.177327] Starting dynamic subtest: pipe-D-eDP-1
[166.506216] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.341s)
[166.508864] Subtest tiling-none: SUCCESS (16.925s)
[167.336699] [012/131] (851s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[167.510392] Starting subtest: cursor-rapid-movement-32x10
[167.556220] Subtest cursor-rapid-movement-32x10: SKIP (0.041s)
[167.855520] [013/131] (851s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[167.954916] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[167.957484] Starting dynamic subtest: pipe-A-eDP-1
[167.981040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[167.995864] Starting dynamic subtest: pipe-B-eDP-1
[168.019863] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[168.029941] Starting dynamic subtest: pipe-C-eDP-1
[168.053493] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[168.062917] Starting dynamic subtest: pipe-D-eDP-1
[168.086169] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[168.088911] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[170.196563] [014/131] (849s left) gem_busy (busy)
[170.271373] Starting subtest: busy
[170.274365] Starting dynamic subtest: all-engines
[170.337737] Dynamic subtest all-engines: SUCCESS (0.066s)
[170.346425] Starting dynamic subtest: rcs0
[171.875910] Dynamic subtest rcs0: SUCCESS (1.538s)
[171.886925] Starting dynamic subtest: bcs0
[171.938971] Dynamic subtest bcs0: SUCCESS (0.060s)
[171.948745] Starting dynamic subtest: vcs0
[171.976357] Dynamic subtest vcs0: SUCCESS (0.038s)
[171.984886] Starting dynamic subtest: vcs1
[173.922163] Dynamic subtest vcs1: SUCCESS (1.943s)
[173.934350] Starting dynamic subtest: vecs0
[175.908361] Dynamic subtest vecs0: SUCCESS (1.983s)
[175.919079] Starting dynamic subtest: ccs0
[177.954113] Dynamic subtest ccs0: SUCCESS (2.046s)
[177.956357] Subtest busy: SUCCESS (7.680s)
[178.342518] [015/131] (841s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[178.449753] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[178.452211] Starting dynamic subtest: pipe-A
[178.472023] Dynamic subtest pipe-A: SKIP (0.017s)
[178.480875] Starting dynamic subtest: pipe-B
[178.503840] Dynamic subtest pipe-B: SKIP (0.030s)
[178.513336] Starting dynamic subtest: pipe-C
[178.533361] Dynamic subtest pipe-C: SKIP (0.030s)
[178.541913] Starting dynamic subtest: pipe-D
[178.564026] Dynamic subtest pipe-D: SKIP (0.031s)
[178.568248] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.110s)
[178.699595] [016/131] (840s left) kms_pm_rpm (basic-rte)
[178.738332] Starting subtest: basic-rte
[181.694853] Subtest basic-rte: SUCCESS (2.956s)
[183.522957] [017/131] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[183.629999] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[183.635029] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[183.740677] [018/131] (835s left) gem_exec_reloc (basic-gtt-wc)
[183.812369] Subtest basic-gtt-wc: SKIP (0.000s)
[183.903908] [019/131] (835s left) i915_pm_freq_api (freq-reset-multiple)
[183.957246] Starting subtest: freq-reset-multiple
[183.960163] Starting dynamic subtest: gt0
[193.975588] Dynamic subtest gt0: SUCCESS (10.015s)
[193.984407] Starting dynamic subtest: gt1
[202.469654] Dynamic subtest gt1: SUCCESS (8.490s)
[202.472227] Subtest freq-reset-multiple: SUCCESS (18.507s)
[202.567693] [020/131] (817s left) kms_setmode (basic)
[202.639823] Starting subtest: basic
[202.972872] Starting dynamic subtest: pipe-A-eDP-1
[205.012089] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.035s)
[205.351162] Starting dynamic subtest: pipe-B-eDP-1
[207.438135] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.089s)
[207.747097] Subtest basic: SUCCESS (5.105s)
[208.609693] [021/131] (811s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[208.710115] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[208.715352] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[208.819887] [022/131] (810s left) sw_sync (timeline_closed)
[208.860555] Starting subtest: timeline_closed
[208.862966] Subtest timeline_closed: SUCCESS (0.000s)
[208.941526] [023/131] (810s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[209.047596] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[209.052610] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[209.186594] [024/131] (810s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[209.276688] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[209.279174] Starting dynamic subtest: pipe-A-default-mode
[209.570016] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[209.575213] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.290s)
[210.431715] [025/131] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[210.538590] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[210.543171] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[210.675265] [026/131] (809s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[210.780380] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[210.782773] Starting dynamic subtest: pipe-A-eDP-1
[210.806473] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.816897] Starting dynamic subtest: pipe-B-eDP-1
[210.841491] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.850033] Starting dynamic subtest: pipe-C-eDP-1
[210.875461] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.883345] Starting dynamic subtest: pipe-D-eDP-1
[210.905601] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.910103] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[213.078603] [027/131] (806s left) gem_flink_basic (bad-open)
[213.148599] Starting subtest: bad-open
[213.151240] Subtest bad-open: SUCCESS (0.000s)
[213.267814] [028/131] (806s left) gem_exec_reloc (basic-cpu-gtt)
[213.333337] Subtest basic-cpu-gtt: SKIP (0.000s)
[213.419465] [029/131] (806s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[213.515997] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[220.547669] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.035s)
[220.699412] [030/131] (799s left) gem_userptr_blits (stress-mm-invalidate-close)
[220.777276] Starting subtest: stress-mm-invalidate-close
[222.925360] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[223.095600] [031/131] (796s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[223.187629] Starting subtest: async-flip-with-page-flip-events-tiled
[223.574919] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[226.328071] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.752s)
[226.340258] Starting dynamic subtest: pipe-A-eDP-1-4
[228.513136] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[228.522506] Starting dynamic subtest: pipe-A-eDP-1-4
[230.522604] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[230.531584] Starting dynamic subtest: pipe-A-eDP-1-x
[232.724224] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s)
[233.108055] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[235.851307] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.749s)
[235.867261] Starting dynamic subtest: pipe-B-eDP-1-4
[238.056864] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.205s)
[238.066353] Starting dynamic subtest: pipe-B-eDP-1-4
[240.066108] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[240.077334] Starting dynamic subtest: pipe-B-eDP-1-x
[242.255900] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[242.621393] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[245.379131] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.765s)
[245.388740] Starting dynamic subtest: pipe-C-eDP-1-4
[247.554405] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.175s)
[247.564226] Starting dynamic subtest: pipe-C-eDP-1-4
[249.563691] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[249.575346] Starting dynamic subtest: pipe-C-eDP-1-x
[251.752591] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[252.122391] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[254.905055] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[254.914411] Starting dynamic subtest: pipe-D-eDP-1-4
[257.092069] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s)
[257.104223] Starting dynamic subtest: pipe-D-eDP-1-4
[259.100025] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[259.111925] Starting dynamic subtest: pipe-D-eDP-1-x
[261.311693] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.211s)
[261.314467] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.132s)
[262.515138] [032/131] (757s left) kms_flip (flip-vs-suspend-interruptible)
[262.616526] Starting subtest: flip-vs-suspend-interruptible
[262.619065] Starting dynamic subtest: A-eDP1
[311.957754] Dynamic subtest A-eDP1: SUCCESS (4.651s)
[311.967186] Starting dynamic subtest: B-eDP1
[360.944261] Dynamic subtest B-eDP1: SUCCESS (4.519s)
[360.960061] Starting dynamic subtest: C-eDP1
[409.948244] Dynamic subtest C-eDP1: SUCCESS (4.528s)
[409.957745] Starting dynamic subtest: D-eDP1
[458.945550] Dynamic subtest D-eDP1: SUCCESS (4.479s)
[458.951900] Subtest flip-vs-suspend-interruptible: SUCCESS (18.189s)
[460.151011] [033/131] (559s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[460.268189] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[460.273039] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[460.397449] [034/131] (559s left) kms_joiner (basic-force-big-joiner)
[460.513070] Starting subtest: basic-force-big-joiner
[460.515979] Starting dynamic subtest: single
[463.855184] Dynamic subtest single: SUCCESS (3.371s)
[463.858012] Subtest basic-force-big-joiner: SUCCESS (3.372s)
[465.051892] [035/131] (555s left) kms_legacy_colorkey (invalid-plane)
[465.152021] Starting subtest: invalid-plane
[465.154401] Starting dynamic subtest: zero-id
[465.156775] Dynamic subtest zero-id: SUCCESS (0.000s)
[465.166867] Starting dynamic subtest: outrange-id
[465.169952] Dynamic subtest outrange-id: SUCCESS (0.000s)
[465.172999] Subtest invalid-plane: SUCCESS (0.001s)
[465.247193] [036/131] (555s left) syncobj_eventfd (binary-wait-signaled)
[465.291210] Starting subtest: binary-wait-signaled
[465.293639] Subtest binary-wait-signaled: SUCCESS (0.000s)
[465.424452] [037/131] (554s left) gem_spin_batch (spin-all-new)
[465.489943] Starting subtest: spin-all-new
[465.509079] Subtest spin-all-new: SUCCESS (0.017s)
[467.173567] [038/131] (553s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[467.281967] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[472.592204] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.327s)
[473.729708] [039/131] (546s left) gem_exec_reloc (basic-cpu-gtt-active)
[473.804967] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[473.885391] [040/131] (546s left) gem_mmap_gtt (medium-copy-xy)
[473.937199] Subtest medium-copy-XY: SKIP (0.000s)
[474.001497] [041/131] (546s left) gem_create (busy-create)
[474.052935] Starting subtest: busy-create
[474.055490] Starting dynamic subtest: smem0
[508.090022] Dynamic subtest smem0: SUCCESS (34.040s)
[508.093199] Subtest busy-create: SUCCESS (34.042s)
[508.303561] [042/131] (512s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[508.354716] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[508.359957] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[508.564919] [043/131] (511s left) gem_exec_schedule (preempt-contexts)
[508.635907] Starting subtest: preempt-contexts
[508.638766] Starting dynamic subtest: rcs0
[508.728121] Dynamic subtest rcs0: SUCCESS (0.101s)
[508.738254] Starting dynamic subtest: bcs0
[508.820716] Dynamic subtest bcs0: SUCCESS (0.092s)
[508.831014] Starting dynamic subtest: vcs0
[508.875324] Dynamic subtest vcs0: SUCCESS (0.053s)
[508.885202] Starting dynamic subtest: vcs1
[508.933640] Dynamic subtest vcs1: SUCCESS (0.059s)
[508.944192] Starting dynamic subtest: vecs0
[509.014368] Dynamic subtest vecs0: SUCCESS (0.079s)
[509.024245] Starting dynamic subtest: ccs0
[509.088788] Dynamic subtest ccs0: SUCCESS (0.074s)
[509.091594] Subtest preempt-contexts: SUCCESS (0.463s)
[510.236867] [044/131] (510s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[510.344102] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[517.347832] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.007s)
[517.506351] [045/131] (503s left) gem_render_linear_blits (basic)
[517.570478] Starting subtest: basic
[517.593233] Subtest basic: SUCCESS (0.023s)
[517.678850] [046/131] (503s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[517.801640] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[517.807161] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[517.977239] [047/131] (502s left) drm_read (short-buffer-block)
[518.116606] Starting subtest: short-buffer-block
[518.119332] Subtest short-buffer-block: SUCCESS (0.000s)
[518.285682] [048/131] (502s left) gem_exec_endless (dispatch)
[518.364065] Starting subtest: dispatch
[518.367100] Starting dynamic subtest: rcs0
[518.372128] Dynamic subtest rcs0: SUCCESS (0.005s)
[518.383714] Starting dynamic subtest: bcs0
[518.388928] Dynamic subtest bcs0: SUCCESS (0.004s)
[518.399023] Starting dynamic subtest: vcs0
[518.403931] Dynamic subtest vcs0: SUCCESS (0.005s)
[518.412571] Starting dynamic subtest: vcs1
[518.416859] Dynamic subtest vcs1: SUCCESS (0.004s)
[518.425370] Starting dynamic subtest: vecs0
[518.430369] Dynamic subtest vecs0: SUCCESS (0.004s)
[518.438777] Starting dynamic subtest: ccs0
[518.443194] Dynamic subtest ccs0: SUCCESS (0.004s)
[518.445553] Subtest dispatch: SUCCESS (0.030s)
[520.159363] [049/131] (500s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[520.270061] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[520.276247] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[520.404984] [050/131] (500s left) api_intel_bb (destroy-bb)
[520.474348] Starting subtest: destroy-bb
[520.481052] Subtest destroy-bb: SUCCESS (0.008s)
[520.650091] [051/131] (500s left) kms_cursor_crc (cursor-onscreen-max-size)
[520.962575] Starting subtest: cursor-onscreen-max-size
[520.970609] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[521.132628] [052/131] (499s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[521.236789] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[528.252008] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.020s)
[528.401277] [053/131] (492s left) kms_psr (psr2-sprite-plane-move)
[528.506048] Starting subtest: psr2-sprite-plane-move
[528.508646] Starting dynamic subtest: eDP-1
[530.240711] Dynamic subtest eDP-1: SUCCESS (1.733s)
[530.243120] Subtest psr2-sprite-plane-move: SUCCESS (1.734s)
[531.099215] [054/131] (489s left) gem_exec_whisper (basic-fds-priority-all)
[531.165395] Starting subtest: basic-fds-priority-all
[554.252892] Subtest basic-fds-priority-all: SUCCESS (23.091s)
[554.463225] [055/131] (466s left) syncobj_timeline (signal)
[554.529232] Starting subtest: signal
[554.532157] Subtest signal: SUCCESS (0.000s)
[554.652637] [056/131] (466s left) gem_ctx_param (invalid-ctx-set)
[554.705559] Starting subtest: invalid-ctx-set
[554.708245] Subtest invalid-ctx-set: SUCCESS (0.001s)
[554.842646] [057/131] (466s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[554.947919] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[559.438859] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.494s)
[560.596797] [058/131] (460s left) kms_psr (fbc-psr-cursor-render)
[560.685781] Starting subtest: fbc-psr-cursor-render
[560.688049] Starting dynamic subtest: eDP-1
[560.692240] Dynamic subtest eDP-1: SKIP (0.000s)
[560.696521] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[560.784005] [059/131] (460s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[560.837865] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[560.943385] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.106s)
[561.044621] [060/131] (460s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[561.112118] Starting subtest: invalid-single-wait-all-unsubmitted
[561.115112] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[561.243801] [061/131] (460s left) gem_ctx_persistence (engines-hostile)
[561.303992] Starting subtest: engines-hostile
[561.306693] Starting dynamic subtest: rcs0
[561.453199] Dynamic subtest rcs0: SUCCESS (0.152s)
[561.466428] Starting dynamic subtest: bcs0
[561.533324] Dynamic subtest bcs0: SUCCESS (0.079s)
[561.545033] Starting dynamic subtest: vcs0
[561.643086] Dynamic subtest vcs0: SUCCESS (0.109s)
[561.655002] Starting dynamic subtest: vcs1
[561.760575] Dynamic subtest vcs1: SUCCESS (0.115s)
[561.776805] Starting dynamic subtest: vecs0
[561.881390] Dynamic subtest vecs0: SUCCESS (0.117s)
[561.893781] Starting dynamic subtest: ccs0
[561.979130] Dynamic subtest ccs0: SUCCESS (0.095s)
[561.981661] Subtest engines-hostile: SUCCESS (0.679s)
[562.084595] [062/131] (459s left) i915_drm_fdinfo (memory-info-shared)
[562.128004] Starting subtest: memory-info-shared
[562.130715] Starting dynamic subtest: smem0
[562.208909] Dynamic subtest smem0: SUCCESS (0.084s)
[562.211598] Subtest memory-info-shared: SUCCESS (0.084s)
[562.306401] [063/131] (459s left) gem_ctx_param (invalid-param-get)
[562.370973] Starting subtest: invalid-param-get
[562.373100] Subtest invalid-param-get: SUCCESS (0.001s)
[562.505186] [064/131] (458s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[562.612401] Starting subtest: psr-shrfb-scaledprimary
[568.348069] Subtest psr-shrfb-scaledprimary: SUCCESS (5.734s)
[568.515205] [065/131] (452s left) gem_exec_params (invalid-bsd1-flag-on-render)
[568.582958] Starting subtest: invalid-bsd1-flag-on-render
[568.585970] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[568.713138] [066/131] (452s left) gem_tiled_partial_pwrite_pread (writes)
[568.779097] Subtest writes: SKIP (0.000s)
[568.861921] [067/131] (452s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[568.970906] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[578.338990] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.368s)
[578.499208] [068/131] (443s left) gem_render_copy_redux (flink)
[578.555731] Starting subtest: flink
[579.289988] Subtest flink: SUCCESS (0.736s)
[579.440865] [069/131] (442s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[579.542679] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[579.546792] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[579.655388] [070/131] (442s left) gem_wait (write-busy)
[579.724606] Starting subtest: write-busy
[579.727014] Starting dynamic subtest: all-engines
[580.433575] Dynamic subtest all-engines: SUCCESS (0.708s)
[580.450505] Starting dynamic subtest: rcs0
[580.983656] Dynamic subtest rcs0: SUCCESS (0.548s)
[580.999221] Starting dynamic subtest: bcs0
[581.530392] Dynamic subtest bcs0: SUCCESS (0.546s)
[581.546305] Starting dynamic subtest: vcs0
[583.066269] Dynamic subtest vcs0: SUCCESS (1.534s)
[583.083254] Starting dynamic subtest: vcs1
[585.114647] Dynamic subtest vcs1: SUCCESS (2.045s)
[585.131240] Starting dynamic subtest: vecs0
[587.098747] Dynamic subtest vecs0: SUCCESS (1.981s)
[587.116792] Starting dynamic subtest: ccs0
[587.652008] Dynamic subtest ccs0: SUCCESS (0.552s)
[587.654908] Subtest write-busy: SUCCESS (7.926s)
[587.877840] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[587.881546] [071/131] (433s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[588.270273] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[589.099268] [072/131] (432s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[589.200197] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[593.854159] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.657s)
[595.051920] [073/131] (426s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[595.154365] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[595.156598] Starting dynamic subtest: pipe-A-eDP-1
[595.179807] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[595.190244] Starting dynamic subtest: pipe-B-eDP-1
[595.214941] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[595.224265] Starting dynamic subtest: pipe-C-eDP-1
[595.249244] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[595.258679] Starting dynamic subtest: pipe-D-eDP-1
[595.284630] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[595.289232] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[597.328511] [074/131] (424s left) kms_flip (2x-wf_vblank-ts-check)
[597.429697] Starting subtest: 2x-wf_vblank-ts-check
[597.441096] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[597.545316] [075/131] (424s left) i915_pm_rps (min-max-config-loaded)
[597.605742] Starting subtest: min-max-config-loaded
[597.610807] Subtest min-max-config-loaded: SKIP (0.001s)
[597.742581] [076/131] (424s left) gem_fence_thrash (bo-write-verify-threaded-none)
[597.779066] Starting subtest: bo-write-verify-threaded-none
[597.806028] Subtest bo-write-verify-threaded-none: SKIP (0.023s)
[597.874649] [077/131] (424s left) perf (oa-formats)
[597.986397] Starting subtest: oa-formats
[597.989272] Starting dynamic subtest: 0-rcs0
[597.998928] Dynamic subtest 0-rcs0: SUCCESS (0.013s)
[598.009256] Starting dynamic subtest: 1-vcs0
[598.024181] Dynamic subtest 1-vcs0: SUCCESS (0.024s)
[598.027268] Subtest oa-formats: SUCCESS (0.039s)
[598.074195] [078/131] (423s left) gem_exec_balancer (nop)
[598.138942] Starting subtest: nop
[644.813630] Subtest nop: SUCCESS (46.684s)
[645.138519] [079/131] (376s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[645.243054] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[645.248062] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[645.353780] [080/131] (376s left) gem_exec_schedule (u-semaphore-user)
[645.424710] Starting subtest: u-semaphore-user
[645.474966] Subtest u-semaphore-user: SUCCESS (0.059s)
[647.192673] [081/131] (374s left) gem_exec_flush (basic-uc-pro-default)
[647.269161] Starting subtest: basic-uc-pro-default
[652.728097] Subtest basic-uc-pro-default: SUCCESS (5.456s)
[652.937162] [082/131] (369s left) kms_cursor_edge_walk (64x64-left-edge)
[653.046028] Starting subtest: 64x64-left-edge
[653.048809] Starting dynamic subtest: pipe-A-eDP-1
[656.465887] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.422s)
[656.476211] Starting dynamic subtest: pipe-D-eDP-1
[659.588237] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[659.590688] Subtest 64x64-left-edge: SUCCESS (6.543s)
[660.417945] [083/131] (361s left) gem_ctx_persistence (legacy-engines-hang)
[660.481204] Starting subtest: legacy-engines-hang
[660.484192] Starting dynamic subtest: render
[660.605534] Dynamic subtest render: SUCCESS (0.124s)
[660.616249] Starting dynamic subtest: bsd1
[660.713482] Dynamic subtest bsd1: SUCCESS (0.105s)
[660.724594] Starting dynamic subtest: bsd2
[660.818462] Dynamic subtest bsd2: SUCCESS (0.102s)
[660.831713] Starting dynamic subtest: blt
[660.928493] Dynamic subtest blt: SUCCESS (0.107s)
[660.941009] Starting dynamic subtest: vebox
[661.022603] Dynamic subtest vebox: SUCCESS (0.091s)
[661.025379] Subtest legacy-engines-hang: SUCCESS (0.542s)
[661.126580] [084/131] (361s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[661.235717] Starting subtest: x-tiled-8bpp-rotate-180
[662.427323] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.192s)
[662.596145] [085/131] (359s left) api_intel_bb (blit-noreloc-keep-cache)
[662.656717] Starting subtest: blit-noreloc-keep-cache
[662.665154] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s)
[662.831789] [086/131] (359s left) gem_mmap_gtt (ptrace)
[662.890979] Subtest ptrace: SKIP (0.000s)
[662.955515] [087/131] (359s left) gem_close (basic)
[663.019622] Starting subtest: basic
[663.022064] Subtest basic: SUCCESS (0.000s)
[663.170404] [088/131] (359s left) gem_mmap_wc (read-write-distinct)
[663.233208] Subtest read-write-distinct: SKIP (0.000s)
[663.301387] [089/131] (359s left) syncobj_timeline (invalid-signal-zero-handles)
[663.363613] Starting subtest: invalid-signal-zero-handles
[663.365882] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[663.486050] [090/131] (359s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[663.594796] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[664.615884] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.023s)
[664.745134] [091/131] (357s left) gem_exec_reloc (basic-active)
[664.804070] Subtest basic-active: SKIP (0.000s)
[664.879490] [092/131] (357s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[664.978663] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[664.980867] Starting dynamic subtest: pipe-A-eDP-1
[665.035906] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[665.046007] Starting dynamic subtest: pipe-B-eDP-1
[665.104114] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[665.114068] Starting dynamic subtest: pipe-C-eDP-1
[665.173114] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[665.183797] Starting dynamic subtest: pipe-D-eDP-1
[665.241783] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[665.245897] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[667.269660] [093/131] (355s left) template (b)
[667.328117] Starting subtest: B
[667.330799] Subtest B: SUCCESS (0.000s)
[667.456737] [094/131] (355s left) perf_pmu (enable-race)
[667.496910] Starting subtest: enable-race
[667.499191] Starting dynamic subtest: rcs0
[680.270387] Dynamic subtest rcs0: SUCCESS (12.777s)
[680.281209] Starting dynamic subtest: bcs0
[693.011258] Dynamic subtest bcs0: SUCCESS (12.737s)
[693.021872] Starting dynamic subtest: vcs0
[709.082931] Dynamic subtest vcs0: SUCCESS (16.064s)
[709.095819] Starting dynamic subtest: vcs1
[725.082576] Dynamic subtest vcs1: SUCCESS (15.994s)
[725.095514] Starting dynamic subtest: vecs0
[741.083556] Dynamic subtest vecs0: SUCCESS (15.997s)
[741.096847] Starting dynamic subtest: ccs0
[753.842750] Dynamic subtest ccs0: SUCCESS (12.758s)
[753.845503] Subtest enable-race: SUCCESS (86.339s)
[753.979422] [095/131] (268s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[754.073450] Starting subtest: plane-lut1d-ctm3x4-lut1d
[754.089595] Starting dynamic subtest: pipe-A-eDP-1
[754.838063] Dynamic subtest pipe-A-eDP-1: FAIL (0.303s)
[755.430426] Starting dynamic subtest: pipe-B-eDP-1
[756.348976] Dynamic subtest pipe-B-eDP-1: FAIL (0.281s)
[756.761587] Starting dynamic subtest: pipe-C-eDP-1
[757.646867] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[758.096227] Starting dynamic subtest: pipe-D-eDP-1
[759.040618] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[759.042936] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.574s)
[759.507102] [096/131] (263s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[759.619581] Starting subtest: y-tiled-8bpp-rotate-90
[759.624900] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[759.758142] [097/131] (263s left) kms_cursor_crc (cursor-alpha-opaque)
[759.857501] Starting subtest: cursor-alpha-opaque
[759.859642] Starting dynamic subtest: pipe-A-eDP-1
[760.498438] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.641s)
[760.509518] Starting dynamic subtest: pipe-D-eDP-1
[761.793147] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.294s)
[761.796070] Subtest cursor-alpha-opaque: SUCCESS (1.937s)
[762.662571] [098/131] (260s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[767.727978] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[767.730871] Starting dynamic subtest: pipe-A-eDP-1
[779.171471] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.442s)
[779.187253] Starting dynamic subtest: pipe-B-eDP-1
[790.584670] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.412s)
[790.587278] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.859s)
[791.454549] [099/131] (231s left) kms_psr (fbc-pr-suspend)
[791.559764] Starting subtest: fbc-pr-suspend
[791.564836] Subtest fbc-pr-suspend: SKIP (0.000s)
[791.657494] [100/131] (231s left) gem_ctx_shared (q-smoketest)
[791.717801] Starting subtest: Q-smoketest
[791.720472] Starting dynamic subtest: rcs0
[797.299850] Dynamic subtest rcs0: SUCCESS (5.521s)
[797.314210] Starting dynamic subtest: bcs0
[802.803367] Dynamic subtest bcs0: SUCCESS (5.509s)
[802.819594] Starting dynamic subtest: vcs0
[808.296087] Dynamic subtest vcs0: SUCCESS (5.486s)
[808.307195] Starting dynamic subtest: vcs1
[813.769022] Dynamic subtest vcs1: SUCCESS (5.479s)
[813.778761] Starting dynamic subtest: vecs0
[819.261712] Dynamic subtest vecs0: SUCCESS (5.483s)
[819.282157] Starting dynamic subtest: ccs0
[824.785235] Dynamic subtest ccs0: SUCCESS (5.513s)
[824.788251] Subtest Q-smoketest: SUCCESS (33.002s)
[824.934635] [101/131] (198s left) gem_exec_fence (expired-history)
[825.422565] Starting subtest: expired-history
[832.820514] Subtest expired-history: SUCCESS (7.399s)
[833.499468] [102/131] (189s left) gen9_exec_parse (basic-rejected)
[833.555567] Subtest basic-rejected: SKIP (0.000s)
[833.628738] [103/131] (189s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[833.723239] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[833.725635] Starting dynamic subtest: A-eDP1
[842.663931] Dynamic subtest A-eDP1: SUCCESS (8.941s)
[842.681065] Starting dynamic subtest: B-eDP1
[851.596326] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[851.606409] Starting dynamic subtest: C-eDP1
[860.515858] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[860.527251] Starting dynamic subtest: D-eDP1
[869.444106] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[869.450737] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.731s)
[870.700812] [104/131] (152s left) dmabuf_sync_file (import-basic)
[870.743234] Starting subtest: import-basic
[870.745512] Subtest import-basic: SUCCESS (0.002s)
[870.822484] [105/131] (152s left) kms_vblank (query-busy-hang)
[870.922085] Starting subtest: query-busy-hang
[870.924840] Starting dynamic subtest: pipe-A-eDP-1
[897.884006] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.966s)
[897.900203] Starting dynamic subtest: pipe-D-eDP-1
[912.861387] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.976s)
[912.863974] Subtest query-busy-hang: SUCCESS (41.946s)
[913.738830] [106/131] (109s left) syncobj_timeline (single-wait-signaled)
[913.796035] Starting subtest: single-wait-signaled
[913.798986] Subtest single-wait-signaled: SUCCESS (0.000s)
[913.922568] [107/131] (109s left) syncobj_wait (multi-wait-all-submitted)
[913.981119] Starting subtest: multi-wait-all-submitted
[914.087361] Subtest multi-wait-all-submitted: SUCCESS (0.107s)
[914.189816] [108/131] (109s left) gem_mmap (pf-nonblock)
[914.255046] Subtest pf-nonblock: SKIP (0.000s)
[914.315954] [109/131] (109s left) perf_pmu (invalid-init)
[914.357450] Starting subtest: invalid-init
[914.360148] Subtest invalid-init: SUCCESS (0.000s)
[914.519874] [110/131] (108s left) kms_psr (psr-suspend)
[914.619101] Starting subtest: psr-suspend
[914.621937] Starting dynamic subtest: eDP-1
[932.356270] Dynamic subtest eDP-1: SUCCESS (2.934s)
[932.358551] Subtest psr-suspend: SUCCESS (2.935s)
[933.247887] [111/131] ( 90s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[933.376686] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[933.381170] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[933.496319] [112/131] ( 89s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[938.522170] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[938.524380] Starting dynamic subtest: pipe-A-eDP-1
[939.306637] Dynamic subtest pipe-A-eDP-1: SKIP (0.780s)
[939.316642] Starting dynamic subtest: pipe-B-eDP-1
[940.439426] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[940.444032] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.912s)
[941.656990] [113/131] ( 81s left) gem_pxp (hw-rejects-pxp-buffer)
[941.791535] Starting subtest: hw-rejects-pxp-buffer
[941.796174] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[941.924419] [114/131] ( 81s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[942.046230] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[943.508117] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.460s)
[944.334040] [115/131] ( 79s left) sw_sync (sync_expired_merge)
[944.369741] Starting subtest: sync_expired_merge
[945.445939] Subtest sync_expired_merge: SUCCESS (1.074s)
[945.528817] [116/131] ( 78s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[945.934147] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[946.719866] [117/131] ( 76s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[946.791449] Starting subtest: multi-wait-all-available-submitted-signaled
[946.793885] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[946.929699] [118/131] ( 76s left) gem_lmem_swapping (parallel-random-verify-ccs)
[946.967669] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[947.021997] [119/131] ( 76s left) i915_pm_rps (thresholds-idle-park)
[947.075477] Starting subtest: thresholds-idle-park
[947.080214] Subtest thresholds-idle-park: SKIP (0.000s)
[947.211865] [120/131] ( 76s left) kms_plane_alpha_blend (alpha-7efc)
[947.300105] Starting subtest: alpha-7efc
[947.588500] Starting dynamic subtest: pipe-A-eDP-1
[948.203842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[948.231486] Starting dynamic subtest: pipe-D-eDP-1
[949.457639] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[949.460150] Subtest alpha-7efc: SUCCESS (2.158s)
[950.342047] [121/131] ( 73s left) gem_mmap_gtt (basic-small-bo)
[950.409274] Subtest basic-small-bo: SKIP (0.000s)
[950.481286] [122/131] ( 73s left) kms_big_fb (linear-64bpp-rotate-180)
[950.598070] Starting subtest: linear-64bpp-rotate-180
[952.212128] Subtest linear-64bpp-rotate-180: SUCCESS (1.612s)
[952.407847] [123/131] ( 71s left) syncobj_basic (bad-pad-fd-to-handle)
[952.474794] Starting subtest: bad-pad-fd-to-handle
[952.476505] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[952.618330] [124/131] ( 71s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[952.713541] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[952.715559] Starting dynamic subtest: pipe-A
[953.896435] Dynamic subtest pipe-A: SUCCESS (1.184s)
[953.912472] Starting dynamic subtest: pipe-B
[956.097955] Dynamic subtest pipe-B: SUCCESS (2.199s)
[956.107771] Starting dynamic subtest: pipe-C
[957.323765] Dynamic subtest pipe-C: SUCCESS (1.223s)
[957.336096] Starting dynamic subtest: pipe-D
[958.551910] Dynamic subtest pipe-D: SUCCESS (1.227s)
[958.554179] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.837s)
[959.756490] [125/131] ( 64s left) kms_hdr (bpc-switch-dpms)
[959.860987] Starting subtest: bpc-switch-dpms
[960.914020] Starting dynamic subtest: pipe-A-eDP-1
[965.434158] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.518s)
[965.436491] Subtest bpc-switch-dpms: SUCCESS (5.573s)
[965.593405] [126/131] ( 58s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[965.694675] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[965.699066] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[965.825316] [127/131] ( 58s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[965.921572] Starting subtest: 4-tiled-64bpp-rotate-180
[967.405137] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.485s)
[967.638357] [128/131] ( 56s left) kms_flip (2x-flip-vs-panning-vs-hang)
[967.744064] Starting subtest: 2x-flip-vs-panning-vs-hang
[967.755820] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.013s)
[967.857942] [129/131] ( 56s left) kms_addfb_basic (bad-pitch-63)
[967.925956] Starting subtest: bad-pitch-63
[967.928120] Subtest bad-pitch-63: SUCCESS (0.000s)
[968.088531] [130/131] ( 56s left) kms_psr (psr2-primary-page-flip)
[968.187167] Starting subtest: psr2-primary-page-flip
[968.189495] Starting dynamic subtest: eDP-1
[969.863675] Dynamic subtest eDP-1: SUCCESS (1.678s)
[969.866095] Subtest psr2-primary-page-flip: SUCCESS (1.679s)
[970.692594] [131/131] ( 53s left) kms_atomic (plane-invalid-params)
[970.792264] Starting subtest: plane-invalid-params
[970.794614] Starting dynamic subtest: pipe-A-eDP-1
[971.197579] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.404s)
[971.199471] Subtest plane-invalid-params: SUCCESS (0.405s)
[972.033096] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: gem_exec_whisper
results: parsing output: 3/ for test: kms_chamelium_color
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_flip_tiling
results: parsing output: 10/ for test: kms_plane_multiple
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_busy
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: i915_pm_freq_api
results: parsing output: 19/ for test: kms_setmode
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: sw_sync
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_flink_basic
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: kms_async_flips
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_joiner
results: parsing output: 34/ for test: kms_legacy_colorkey
results: parsing output: 35/ for test: syncobj_eventfd
results: parsing output: 36/ for test: gem_spin_batch
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: gem_create
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_render_linear_blits
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: drm_read
results: parsing output: 47/ for test: gem_exec_endless
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: api_intel_bb
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_exec_whisper
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_ctx_param
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_params
results: parsing output: 65/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_render_copy_redux
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: i915_pm_rps
results: parsing output: 75/ for test: gem_fence_thrash
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: gem_exec_flush
results: parsing output: 81/ for test: kms_cursor_edge_walk
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: gem_close
results: parsing output: 87/ for test: gem_mmap_wc
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: template
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: kms_color_pipeline
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_ctx_shared
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: gen9_exec_parse
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: dmabuf_sync_file
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: gem_mmap
results: parsing output: 108/ for test: perf_pmu
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: gem_pxp
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: sw_sync
results: parsing output: 115/ for test: kms_chamelium_edid
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: i915_pm_rps
results: parsing output: 119/ for test: kms_plane_alpha_blend
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: syncobj_basic
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_hdr
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_atomic
Done.