[59.425427] Initializing watchdogs
[59.425511]   /dev/watchdog0
[59.440197] [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]
[59.444801] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.447051] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.450340] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[59.572641] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[59.575022] Starting dynamic subtest: pipe-A
[59.659334] Dynamic subtest pipe-A: SUCCESS (0.088s)
[59.668849] Starting dynamic subtest: pipe-B
[60.782471] Dynamic subtest pipe-B: SUCCESS (1.119s)
[60.791811] Starting dynamic subtest: pipe-C
[61.893900] Dynamic subtest pipe-C: SUCCESS (1.108s)
[61.901451] Starting dynamic subtest: pipe-D
[63.026756] Dynamic subtest pipe-D: SUCCESS (1.129s)
[63.029085] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.448s)
[64.208757] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[64.269184] Starting subtest: forbidden-operations
[64.273326] Subtest forbidden-operations: SKIP (0.000s)
[64.445597] [003/134] (955s left) gem_mmap_gtt (big-bo)
[64.510078] Subtest big-bo: SKIP (0.000s)
[64.579550] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[64.677065] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[72.489902] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.810s)
[72.683362] [005/134] (947s left) kms_fence_pin_leak
[72.860893] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[72.955965] Starting subtest: x-tiled-16bpp-rotate-180
[74.245027] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.290s)
[74.386304] [007/134] (945s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[74.439546] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[74.510502] [008/134] (945s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[74.612070] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[74.626528] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.013s)
[74.745381] [009/134] (945s left) perf_pmu (busy-check-all)
[74.781279] Starting subtest: busy-check-all
[74.783180] Starting dynamic subtest: rcs0
[75.354469] Dynamic subtest rcs0: SUCCESS (0.572s)
[75.365030] Starting dynamic subtest: bcs0
[75.902336] Dynamic subtest bcs0: SUCCESS (0.548s)
[75.913237] Starting dynamic subtest: vcs0
[77.909545] Dynamic subtest vcs0: SUCCESS (2.004s)
[77.919688] Starting dynamic subtest: vcs1
[79.893226] Dynamic subtest vcs1: SUCCESS (1.983s)
[79.903964] Starting dynamic subtest: vecs0
[81.877767] Dynamic subtest vecs0: SUCCESS (1.983s)
[81.888517] Starting dynamic subtest: ccs0
[82.431189] Dynamic subtest ccs0: SUCCESS (0.554s)
[82.433720] Subtest busy-check-all: SUCCESS (7.648s)
[82.581296] [010/134] (937s left) gem_mmap_wc (coherency)
[82.631604] Subtest coherency: SKIP (0.000s)
[82.704680] [011/134] (937s left) kms_big_fb (yf-tiled-addfb)
[82.813121] Starting subtest: yf-tiled-addfb
[82.817358] Subtest yf-tiled-addfb: SKIP (0.000s)
[82.953082] [012/134] (937s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[83.070445] Starting subtest: extended-modeset-hang-oldfb-with-reset
[83.072681] Starting dynamic subtest: pipe-A
[94.947501] Dynamic subtest pipe-A: SUCCESS (11.872s)
[94.958804] Starting dynamic subtest: pipe-D
[107.436548] Dynamic subtest pipe-D: SUCCESS (12.487s)
[107.439047] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.363s)
[108.262658] [013/134] (912s left) kms_plane_alpha_blend (constant-alpha-min)
[108.384289] Starting subtest: constant-alpha-min
[108.678430] Starting dynamic subtest: pipe-A-eDP-1
[109.381410] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s)
[109.391282] Starting dynamic subtest: pipe-D-eDP-1
[110.812344] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.431s)
[110.814709] Subtest constant-alpha-min: SUCCESS (2.428s)
[111.629250] [014/134] (908s left) sysfs_timeslice_duration (duration)
[111.706884] Starting subtest: duration
[111.709331] Starting dynamic subtest: vecs0
[125.875879] Dynamic subtest vecs0: SUCCESS (14.165s)
[125.887120] Starting dynamic subtest: ccs0
[139.043379] Dynamic subtest ccs0: SUCCESS (13.167s)
[139.054425] Starting dynamic subtest: vcs0
[153.845030] Dynamic subtest vcs0: SUCCESS (14.800s)
[153.856789] Starting dynamic subtest: bcs0
[167.024302] Dynamic subtest bcs0: SUCCESS (13.180s)
[167.036042] Starting dynamic subtest: rcs0
[180.193052] Dynamic subtest rcs0: SUCCESS (13.168s)
[180.204872] Starting dynamic subtest: vcs1
[193.844526] Dynamic subtest vcs1: SUCCESS (13.648s)
[193.847161] Subtest duration: SUCCESS (82.138s)
[193.946099] [015/134] (826s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[194.047572] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[197.600448] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.556s)
[198.830993] [016/134] (821s left) kms_cursor_crc (cursor-onscreen-64x64)
[199.008587] Starting subtest: cursor-onscreen-64x64
[199.013219] Starting dynamic subtest: pipe-A-eDP-1
[201.131642] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s)
[201.160967] Starting dynamic subtest: pipe-D-eDP-1
[203.860662] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.706s)
[203.862538] Subtest cursor-onscreen-64x64: SUCCESS (4.850s)
[204.683874] [017/134] (815s left) kms_color (ctm-red-to-blue)
[204.768769] Starting subtest: ctm-red-to-blue
[204.771056] Starting dynamic subtest: pipe-A-eDP-1
[205.488056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[205.496806] Starting dynamic subtest: pipe-B-eDP-1
[206.867832] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s)
[206.876538] Starting dynamic subtest: pipe-C-eDP-1
[208.237708] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.367s)
[208.247332] Starting dynamic subtest: pipe-D-eDP-1
[209.564120] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[209.566280] Subtest ctm-red-to-blue: SUCCESS (4.794s)
[210.395105] [018/134] (810s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[210.455075] Subtest writes-after-reads-uncached: SKIP (0.000s)
[210.536012] [019/134] (810s left) dumb_buffer (invalid-bpp)
[210.594274] Starting subtest: invalid-bpp
[210.596220] Subtest invalid-bpp: SUCCESS (0.000s)
[210.718247] [020/134] (809s left) gem_mmap_gtt (ptrace)
[210.775631] Subtest ptrace: SKIP (0.000s)
[210.841330] [021/134] (809s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[210.965273] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[210.969803] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[211.133408] [022/134] (809s left) gem_lmem_swapping (verify)
[211.181637] Subtest verify: SKIP (0.000s)
[211.228421] [023/134] (809s left) gem_spin_batch (resubmit-new)
[211.286327] Starting subtest: resubmit-new
[211.288723] Starting dynamic subtest: rcs0
[211.294438] Dynamic subtest rcs0: SUCCESS (0.007s)
[211.305950] Starting dynamic subtest: bcs0
[211.307885] Dynamic subtest bcs0: SUCCESS (0.004s)
[211.319916] Starting dynamic subtest: vcs0
[211.321681] Dynamic subtest vcs0: SUCCESS (0.004s)
[211.329649] Starting dynamic subtest: vcs1
[211.331435] Dynamic subtest vcs1: SUCCESS (0.005s)
[211.339481] Starting dynamic subtest: vecs0
[211.341294] Dynamic subtest vecs0: SUCCESS (0.004s)
[211.353360] Starting dynamic subtest: ccs0
[211.355246] Dynamic subtest ccs0: SUCCESS (0.005s)
[211.357120] Subtest resubmit-new: SUCCESS (0.032s)
[212.949794] [024/134] (807s left) kms_cursor_crc (cursor-random-512x512)
[213.219781] Starting subtest: cursor-random-512x512
[213.224429] Subtest cursor-random-512x512: SKIP (0.001s)
[213.412602] [025/134] (807s left) kms_properties (plane-properties-legacy)
[213.518067] Starting subtest: plane-properties-legacy
[213.520334] Starting dynamic subtest: pipe-A-eDP-1
[214.074458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[214.083898] Starting dynamic subtest: pipe-B-eDP-1
[215.346752] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.271s)
[215.356659] Starting dynamic subtest: pipe-C-eDP-1
[216.580190] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.233s)
[216.588526] Starting dynamic subtest: pipe-D-eDP-1
[217.811694] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[217.813963] Subtest plane-properties-legacy: SUCCESS (4.295s)
[218.640083] [026/134] (802s left) kms_vrr (flipline)
[218.733995] Starting subtest: flipline
[218.740278] Subtest flipline: SKIP (0.000s)
[218.829882] [027/134] (802s left) gem_exec_params (secure-non-master)
[218.888050] Starting subtest: secure-non-master
[218.892669] Subtest secure-non-master: SKIP (0.000s)
[219.017178] [028/134] (801s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[219.281237] Starting subtest: parallel-dmabuf-import-out-fence
[220.412195] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.134s)
[220.529943] [029/134] (800s left) kms_pm_dc (dc5-dpms-negative)
[221.629068] Starting subtest: dc5-dpms-negative
[221.633648] Subtest dc5-dpms-negative: SKIP (0.000s)
[221.726306] [030/134] (799s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[221.828587] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[221.832690] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[221.935044] [031/134] (799s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[222.028137] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[229.112036] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.089s)
[229.273179] [032/134] (791s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[229.385364] Starting subtest: psr-argb161616f-draw-mmap-cpu
[229.389594] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[229.505282] [033/134] (791s left) gem_exec_whisper (basic-fds-all)
[229.574650] Starting subtest: basic-fds-all
[240.899991] Subtest basic-fds-all: SUCCESS (11.326s)
[241.102407] [034/134] (780s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[241.201424] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[241.205438] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[241.335398] [035/134] (779s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[241.451668] Starting subtest: psr-rgb565-draw-render
[248.507883] Subtest psr-rgb565-draw-render: SUCCESS (7.060s)
[248.678770] [036/134] (772s left) gem_render_copy_redux (flink)
[248.749295] Starting subtest: flink
[249.503331] Subtest flink: SUCCESS (0.755s)
[249.663334] [037/134] (771s left) gem_mmap_wc (bad-offset)
[249.727433] Subtest bad-offset: SKIP (0.000s)
[249.797783] [038/134] (771s left) gem_pxp (reject-modify-context-protection-off-2)
[249.927194] Starting subtest: reject-modify-context-protection-off-2
[249.929306] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[250.074553] [039/134] (771s left) kms_3d (basic)
[250.129234] Starting subtest: basic
[252.090712] Subtest basic: SUCCESS (1.962s)
[252.612683] [040/134] (768s left) gem_ctx_persistence (smoketest)
[252.675585] Starting subtest: smoketest
[292.853247] Subtest smoketest: SUCCESS (40.173s)
[292.954966] [041/134] (728s left) kms_psr (fbc-pr-suspend)
[293.063112] Starting subtest: fbc-pr-suspend
[293.067252] Subtest fbc-pr-suspend: SKIP (0.000s)
[293.162926] [042/134] (728s left) syncobj_timeline (multi-wait-for-submit-signaled)
[293.221080] Starting subtest: multi-wait-for-submit-signaled
[293.223293] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[293.343933] [043/134] (728s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[293.436657] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[293.439015] Starting dynamic subtest: pipe-A-default-mode
[296.153500] Dynamic subtest pipe-A-default-mode: SUCCESS (2.718s)
[296.155924] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.720s)
[297.011502] [044/134] (724s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[297.124330] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[297.126676] Starting dynamic subtest: pipe-A-default-mode
[299.882155] Dynamic subtest pipe-A-default-mode: SUCCESS (2.759s)
[299.884683] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.760s)
[300.712111] [045/134] (720s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[300.825057] Starting subtest: psr-rgb565-draw-mmap-cpu
[307.549494] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.725s)
[307.687063] [046/134] (714s left) vgem_basic (mmap)
[307.793256] Starting subtest: mmap
[307.806434] Subtest mmap: SUCCESS (0.014s)
[307.887340] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[307.890466] [047/134] (713s left) gem_userptr_blits (sync-unmap-after-close)
[307.963553] Starting subtest: sync-unmap-after-close
[307.973536] Subtest sync-unmap-after-close: SUCCESS (0.012s)
[308.134201] [048/134] (713s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[308.535507] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[309.364256] [049/134] (712s left) kms_frontbuffer_tracking (basic)
[309.466819] Starting subtest: basic
[312.697750] Subtest basic: SUCCESS (3.235s)
[312.803031] [050/134] (709s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[312.905605] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[319.843718] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.939s)
[320.011827] [051/134] (701s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[320.118345] Starting subtest: fbc-rgb101010-draw-blt
[324.743773] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.630s)
[325.934926] [052/134] (696s left) kms_lease (lease-unleased-connector)
[326.037264] Starting subtest: lease-unleased-connector
[326.039567] Starting dynamic subtest: pipe-A-eDP-1
[326.049689] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.010s)
[326.058867] Starting dynamic subtest: pipe-B-eDP-1
[326.061008] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[326.070216] Starting dynamic subtest: pipe-C-eDP-1
[326.072378] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[326.081244] Starting dynamic subtest: pipe-D-eDP-1
[326.083361] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[326.085428] Subtest lease-unleased-connector: SUCCESS (0.039s)
[326.214410] [053/134] (695s left) gem_tiled_partial_pwrite_pread (reads)
[326.291399] Subtest reads: SKIP (0.000s)
[326.370976] [054/134] (695s left) kms_dp_link_training (uhbr-sst)
[326.474140] Starting subtest: uhbr-sst
[326.482447] Subtest uhbr-sst: SKIP (0.000s)
[326.572453] [055/134] (695s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[326.627551] Starting subtest: etime-multi-wait-all-submitted-signaled
[326.730259] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[326.834107] [056/134] (695s left) kms_invalid_mode (overflow-vrefresh)
[326.947522] Starting subtest: overflow-vrefresh
[326.949796] Starting dynamic subtest: pipe-A-eDP-1
[327.228571] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[327.237809] Starting dynamic subtest: pipe-B-eDP-1
[327.240098] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[327.248890] Starting dynamic subtest: pipe-C-eDP-1
[327.251163] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[327.259921] Starting dynamic subtest: pipe-D-eDP-1
[327.262059] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[327.263979] Subtest overflow-vrefresh: SUCCESS (0.290s)
[328.107773] [057/134] (694s left) kms_pm_rpm (i2c)
[330.048774] Starting subtest: i2c
[335.391544] Subtest i2c: SUCCESS (5.344s)
[335.501324] [058/134] (686s left) gem_exec_balancer (busy)
[335.568869] Starting subtest: busy
[336.899904] Subtest busy: SUCCESS (1.330s)
[337.258321] [059/134] (685s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[342.242641] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[342.247217] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.003s)
[343.115082] [060/134] (679s left) gen9_exec_parse (batch-without-end)
[343.168978] Subtest batch-without-end: SKIP (0.000s)
[343.249920] [061/134] (679s left) gem_ctx_shared (exec-shared-gtt)
[343.318166] Starting subtest: exec-shared-gtt
[343.320470] Starting dynamic subtest: rcs0
[343.327379] Dynamic subtest rcs0: SUCCESS (0.009s)
[343.336659] Starting dynamic subtest: bcs0
[343.338584] Dynamic subtest bcs0: SUCCESS (0.005s)
[343.347612] Starting dynamic subtest: vcs0
[343.349943] Dynamic subtest vcs0: SUCCESS (0.006s)
[343.362949] Starting dynamic subtest: vcs1
[343.365080] Dynamic subtest vcs1: SUCCESS (0.007s)
[343.373800] Starting dynamic subtest: vecs0
[343.375986] Dynamic subtest vecs0: SUCCESS (0.007s)
[343.384646] Starting dynamic subtest: ccs0
[343.386817] Dynamic subtest ccs0: SUCCESS (0.005s)
[343.388980] Subtest exec-shared-gtt: SUCCESS (0.043s)
[343.569984] [062/134] (678s left) perf (invalid-oa-metric-set-id)
[343.723325] Starting subtest: invalid-oa-metric-set-id
[343.733912] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[343.777053] [063/134] (678s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[343.823942] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[343.826154] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[343.959580] [064/134] (678s left) gem_tiled_pread_pwrite
[344.084282] [065/134] (678s left) i915_pm_rps (thresholds-park)
[344.151408] Starting subtest: thresholds-park
[344.155027] Subtest thresholds-park: SKIP (0.001s)
[344.287935] [066/134] (678s left) gem_ctx_engines (invalid-engines)
[344.359434] Starting subtest: invalid-engines
[344.367512] Subtest invalid-engines: SUCCESS (0.008s)
[344.628995] [067/134] (678s left) vgem_basic (create)
[344.678805] Starting subtest: create
[344.680888] Subtest create: SUCCESS (0.000s)
[344.759866] [068/134] (677s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[344.854851] Starting subtest: fbc-psr2-sprite-mmap-cpu
[344.857117] Starting dynamic subtest: eDP-1
[344.861226] Dynamic subtest eDP-1: SKIP (0.000s)
[344.865463] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[344.954018] [069/134] (677s left) gem_mmap_gtt (big-copy-odd)
[345.013592] Subtest big-copy-odd: SKIP (0.000s)
[345.072301] [070/134] (677s left) gem_exec_reloc (basic-gtt-cpu-active)
[345.142574] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[345.222747] [071/134] (677s left) prime_busy (before-wait)
[345.289312] Starting subtest: before-wait
[345.291669] Starting dynamic subtest: rcs0
[345.335949] Dynamic subtest rcs0: SUCCESS (0.046s)
[345.346422] Starting dynamic subtest: bcs0
[345.401781] Dynamic subtest bcs0: SUCCESS (0.065s)
[345.411921] Starting dynamic subtest: vcs0
[345.443299] Dynamic subtest vcs0: SUCCESS (0.041s)
[345.453770] Starting dynamic subtest: vcs1
[345.483227] Dynamic subtest vcs1: SUCCESS (0.039s)
[345.492663] Starting dynamic subtest: vecs0
[345.522392] Dynamic subtest vecs0: SUCCESS (0.039s)
[345.531029] Starting dynamic subtest: ccs0
[345.562343] Dynamic subtest ccs0: SUCCESS (0.039s)
[345.671511] Subtest before-wait: SUCCESS (0.384s)
[345.770613] [072/134] (677s left) gem_exec_fence (keep-in-fence)
[345.947897] Starting subtest: keep-in-fence
[345.950047] Starting dynamic subtest: rcs0
[346.019564] Dynamic subtest rcs0: SUCCESS (0.074s)
[346.031462] Starting dynamic subtest: bcs0
[346.072839] Dynamic subtest bcs0: SUCCESS (0.051s)
[346.084334] Starting dynamic subtest: vcs0
[347.926397] Dynamic subtest vcs0: SUCCESS (1.849s)
[347.938901] Starting dynamic subtest: vcs1
[349.910494] Dynamic subtest vcs1: SUCCESS (1.981s)
[349.922679] Starting dynamic subtest: vecs0
[351.894102] Dynamic subtest vecs0: SUCCESS (1.981s)
[351.906617] Starting dynamic subtest: ccs0
[352.133201] Dynamic subtest ccs0: SUCCESS (0.237s)
[352.136043] Subtest keep-in-fence: SUCCESS (6.188s)
[353.998274] [073/134] (668s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[354.112097] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[357.832425] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.724s)
[359.016657] [074/134] (663s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[359.126412] Starting subtest: 4-tiled-8bpp-rotate-270
[359.148741] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.022s)
[359.308839] [075/134] (663s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[364.384545] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[364.386483] Starting dynamic subtest: pipe-A-eDP-1
[365.175137] Dynamic subtest pipe-A-eDP-1: SKIP (0.787s)
[365.184893] Starting dynamic subtest: pipe-B-eDP-1
[366.301408] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[366.306093] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.915s)
[367.525764] [076/134] (655s left) gem_ccs (block-multicopy-inplace)
[367.596394] Starting subtest: block-multicopy-inplace
[367.601052] Subtest block-multicopy-inplace: SKIP (0.000s)
[367.745398] [077/134] (655s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[367.862484] Starting subtest: x-tiled-addfb-size-offset-overflow
[367.864753] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[368.001548] [078/134] (655s left) kms_atomic (crtc-invalid-params)
[368.103074] Starting subtest: crtc-invalid-params
[368.105317] Starting dynamic subtest: pipe-A-eDP-1
[368.479462] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.371s)
[368.481423] Subtest crtc-invalid-params: SUCCESS (0.375s)
[369.338928] [079/134] (653s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[369.440663] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[369.442553] Starting dynamic subtest: pipe-A-eDP-1
[369.462769] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[369.473448] Starting dynamic subtest: pipe-B-eDP-1
[369.492863] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[369.502525] Starting dynamic subtest: pipe-C-eDP-1
[369.522465] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[369.533781] Starting dynamic subtest: pipe-D-eDP-1
[369.554559] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[369.556917] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s)
[371.731446] [080/134] (651s left) gem_lmem_swapping (heavy-verify-multi)
[371.777236] Subtest heavy-verify-multi: SKIP (0.000s)
[371.826229] [081/134] (651s left) kms_chamelium_frames (hdmi-crc-fast)
[372.218611] Subtest hdmi-crc-fast: SKIP (0.000s)
[373.019544] [082/134] (650s left) kms_vblank (query-forked-busy-hang)
[373.110307] Starting subtest: query-forked-busy-hang
[373.112234] Starting dynamic subtest: pipe-A-eDP-1
[399.702173] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.589s)
[399.720622] Starting dynamic subtest: pipe-D-eDP-1
[425.695395] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.991s)
[425.697773] Subtest query-forked-busy-hang: SUCCESS (52.585s)
[426.512975] [083/134] (596s left) kms_big_fb (linear-16bpp-rotate-90)
[426.623771] Starting subtest: linear-16bpp-rotate-90
[426.644316] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[426.806172] [084/134] (596s left) gem_flink_race (flink_close)
[426.850510] Starting subtest: flink_close
[431.961768] Subtest flink_close: SUCCESS (5.113s)
[432.067246] [085/134] (591s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[432.195534] Starting subtest: fbcpsr-modesetfrombusy
[438.458031] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.265s)
[438.640434] [086/134] (584s left) gem_exec_schedule (thriceslice)
[438.706488] Starting subtest: thriceslice
[438.708227] Starting dynamic subtest: rcs0
[438.728800] Dynamic subtest rcs0: SUCCESS (0.030s)
[438.741271] Starting dynamic subtest: bcs0
[438.757306] Dynamic subtest bcs0: SUCCESS (0.028s)
[438.766097] Starting dynamic subtest: vcs0
[438.807945] Dynamic subtest vcs0: SUCCESS (0.050s)
[438.819367] Starting dynamic subtest: vcs1
[438.859561] Dynamic subtest vcs1: SUCCESS (0.050s)
[438.872592] Starting dynamic subtest: vecs0
[438.889442] Dynamic subtest vecs0: SUCCESS (0.028s)
[438.902188] Starting dynamic subtest: ccs0
[438.918713] Dynamic subtest ccs0: SUCCESS (0.029s)
[438.920675] Subtest thriceslice: SUCCESS (0.221s)
[439.955877] [087/134] (583s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[440.059214] Starting subtest: flip-vs-dpms-off-vs-modeset
[440.061494] Starting dynamic subtest: A-eDP1
[443.666990] Dynamic subtest A-eDP1: SUCCESS (3.606s)
[443.678944] Starting dynamic subtest: B-eDP1
[446.878503] Dynamic subtest B-eDP1: SUCCESS (3.207s)
[446.887979] Starting dynamic subtest: C-eDP1
[449.979403] Dynamic subtest C-eDP1: SUCCESS (3.101s)
[449.988708] Starting dynamic subtest: D-eDP1
[453.108864] Dynamic subtest D-eDP1: SUCCESS (3.128s)
[453.111255] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.050s)
[453.936638] [088/134] (569s left) i915_pm_rps (min-max-config-idle)
[454.001479] Starting subtest: min-max-config-idle
[454.006061] Subtest min-max-config-idle: SKIP (0.000s)
[454.139163] [089/134] (569s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[454.243179] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[460.806857] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.566s)
[460.979858] [090/134] (562s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[466.007150] Starting subtest: psr2-overlay-plane-move-continuous-sf
[466.009693] Starting dynamic subtest: pipe-A-eDP-1
[472.709819] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.700s)
[472.719559] Starting dynamic subtest: pipe-B-eDP-1
[479.364755] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.654s)
[479.367259] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.358s)
[480.263635] [091/134] (543s left) kms_concurrent (multi-plane-atomic-lowres)
[480.360157] Starting subtest: multi-plane-atomic-lowres
[480.361942] Starting dynamic subtest: pipe-A-eDP-1
[480.878739] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.517s)
[480.881081] Subtest multi-plane-atomic-lowres: SUCCESS (0.518s)
[481.697389] [092/134] (541s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[481.797137] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[481.801082] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[481.918411] [093/134] (541s left) api_intel_allocator (reopen)
[481.976525] Starting subtest: reopen
[481.978800] Subtest reopen: SUCCESS (0.004s)
[482.134751] [094/134] (541s left) kms_flip (dpms-vs-vblank-race)
[482.222032] Starting subtest: dpms-vs-vblank-race
[482.224265] Starting dynamic subtest: A-eDP1
[487.161250] Dynamic subtest A-eDP1: SUCCESS (4.938s)
[487.170458] Starting dynamic subtest: B-eDP1
[491.807393] Dynamic subtest B-eDP1: SUCCESS (4.645s)
[491.817439] Starting dynamic subtest: C-eDP1
[496.420598] Dynamic subtest C-eDP1: SUCCESS (4.614s)
[496.432230] Starting dynamic subtest: D-eDP1
[501.061607] Dynamic subtest D-eDP1: SUCCESS (4.637s)
[501.063842] Subtest dpms-vs-vblank-race: SUCCESS (18.842s)
[501.959829] [095/134] (521s left) syncobj_timeline (single-wait-all-available-signaled)
[502.015058] Starting subtest: single-wait-all-available-signaled
[502.017325] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[502.156539] [096/134] (521s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[502.252753] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[502.254603] Starting dynamic subtest: pipe-A-eDP-1
[503.577078] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.323s)
[503.861611] Starting dynamic subtest: pipe-B-eDP-1
[504.908255] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[505.182269] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.931s)
[506.045560] [097/134] (517s left) gem_exec_params (rs-invalid)
[506.115152] Starting subtest: rs-invalid
[506.119852] Subtest rs-invalid: SUCCESS (0.003s)
[506.281439] [098/134] (517s left) kms_scaling_modes (scaling-mode-full-aspect)
[506.375432] Starting subtest: scaling-mode-full-aspect
[506.377328] Starting dynamic subtest: pipe-A-eDP-1
[506.468376] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[506.482355] Starting dynamic subtest: pipe-B-eDP-1
[507.644664] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.175s)
[507.654901] Starting dynamic subtest: pipe-C-eDP-1
[508.754955] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[508.767192] Starting dynamic subtest: pipe-D-eDP-1
[509.885144] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[509.887380] Subtest scaling-mode-full-aspect: SUCCESS (3.513s)
[511.079335] [099/134] (512s left) kms_plane (plane-panning-top-left)
[511.187174] Starting subtest: plane-panning-top-left
[511.189505] Starting dynamic subtest: pipe-A
[512.911630] Dynamic subtest pipe-A: SUCCESS (1.723s)
[512.925300] Starting dynamic subtest: pipe-B
[515.294284] Dynamic subtest pipe-B: SUCCESS (2.383s)
[515.296579] Subtest plane-panning-top-left: SUCCESS (4.109s)
[516.191261] [100/134] (507s left) kms_psr (psr2-sprite-mmap-cpu)
[516.297172] Starting subtest: psr2-sprite-mmap-cpu
[516.299395] Starting dynamic subtest: eDP-1
[518.064174] Dynamic subtest eDP-1: SUCCESS (1.765s)
[518.066498] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.766s)
[518.958724] [101/134] (505s left) gem_exec_params (rel-constants-invalid-ring)
[519.023609] Starting subtest: rel-constants-invalid-ring
[519.025978] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[519.155204] [102/134] (504s left) i915_query (query-garbage)
[519.217811] Starting subtest: query-garbage
[519.220064] Subtest query-garbage: SUCCESS (0.000s)
[519.347023] [103/134] (504s left) kms_psr (psr-cursor-mmap-cpu)
[519.447812] Starting subtest: psr-cursor-mmap-cpu
[519.450136] Starting dynamic subtest: eDP-1
[521.126420] Dynamic subtest eDP-1: SUCCESS (1.677s)
[521.128651] Subtest psr-cursor-mmap-cpu: SUCCESS (1.678s)
[522.027042] [104/134] (502s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[522.137774] Starting subtest: y-tiled-16bpp-rotate-90
[522.142115] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[522.283660] [105/134] (501s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[522.388141] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[522.392718] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[523.552236] [106/134] (500s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[523.683815] Starting subtest: flip-vs-cursor-legacy
[530.735645] Subtest flip-vs-cursor-legacy: SUCCESS (7.049s)
[531.591449] [107/134] (492s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[531.687426] Starting subtest: fbcpsr-argb161616f-draw-blt
[531.691607] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[531.808213] [108/134] (492s left) kms_flip (flip-vs-fences)
[531.899048] Starting subtest: flip-vs-fences
[531.903103] Subtest flip-vs-fences: SKIP (0.000s)
[532.033384] [109/134] (492s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[532.089842] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[532.183544] [110/134] (492s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[532.278064] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[532.280219] Starting dynamic subtest: pipe-A-eDP-1
[533.238084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.955s)
[533.246989] Starting dynamic subtest: pipe-B-eDP-1
[534.960777] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.717s)
[534.970950] Starting dynamic subtest: pipe-C-eDP-1
[536.479378] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.517s)
[536.489181] Starting dynamic subtest: pipe-D-eDP-1
[538.030725] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.550s)
[538.032605] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.745s)
[539.238554] [111/134] (485s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[539.343899] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[539.348312] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[539.485387] [112/134] (485s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[539.576903] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[539.578849] Starting dynamic subtest: pipe-A-eDP-1
[540.324848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[540.335067] Starting dynamic subtest: pipe-B-eDP-1
[542.138718] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.812s)
[542.149679] Starting dynamic subtest: pipe-C-eDP-1
[543.971914] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.833s)
[543.980828] Starting dynamic subtest: pipe-D-eDP-1
[545.806967] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.834s)
[545.809060] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.223s)
[546.958918] [113/134] (477s left) i915_drm_fdinfo (memory-info-shared)
[547.004580] Starting subtest: memory-info-shared
[547.006939] Starting dynamic subtest: smem0
[547.082412] Dynamic subtest smem0: SUCCESS (0.079s)
[547.085252] Subtest memory-info-shared: SUCCESS (0.079s)
[547.179728] [114/134] (477s left) gem_exec_flush (basic-wb-set-default)
[547.254871] Starting subtest: basic-wb-set-default
[552.704967] Subtest basic-wb-set-default: SUCCESS (5.452s)
[552.919795] [115/134] (471s left) sysfs_timeslice_duration (timeout)
[552.982718] Starting subtest: timeout
[552.985215] Starting dynamic subtest: vecs0
[562.918231] Dynamic subtest vecs0: SUCCESS (9.932s)
[562.930031] Starting dynamic subtest: ccs0
[564.333845] Dynamic subtest ccs0: SUCCESS (1.415s)
[564.349263] Starting dynamic subtest: vcs0
[573.917863] Dynamic subtest vcs0: SUCCESS (9.579s)
[573.929630] Starting dynamic subtest: bcs0
[574.658243] Dynamic subtest bcs0: SUCCESS (0.739s)
[574.670214] Starting dynamic subtest: rcs0
[576.050688] Dynamic subtest rcs0: SUCCESS (1.390s)
[576.060539] Starting dynamic subtest: vcs1
[585.965812] Dynamic subtest vcs1: SUCCESS (9.910s)
[585.968912] Subtest timeout: SUCCESS (32.978s)
[586.062124] [116/134] (438s left) sriov_basic (enable-vfs-bind-unbind-each)
[586.122651] Starting subtest: enable-vfs-bind-unbind-each
[586.124874] Starting dynamic subtest: numvfs-1
[586.203191] Dynamic subtest numvfs-1: FAIL (0.029s)
[586.214360] Starting dynamic subtest: numvfs-2
[586.286829] Dynamic subtest numvfs-2: FAIL (0.004s)
[586.297816] Starting dynamic subtest: numvfs-3
[586.369709] Dynamic subtest numvfs-3: FAIL (0.003s)
[586.379979] Starting dynamic subtest: numvfs-4
[586.451743] Dynamic subtest numvfs-4: FAIL (0.003s)
[586.462037] Starting dynamic subtest: numvfs-5
[586.533793] Dynamic subtest numvfs-5: FAIL (0.004s)
[586.544274] Starting dynamic subtest: numvfs-6
[586.616678] Dynamic subtest numvfs-6: FAIL (0.003s)
[586.627397] Starting dynamic subtest: numvfs-7
[586.699649] Dynamic subtest numvfs-7: FAIL (0.004s)
[586.710208] Starting dynamic subtest: numvfs-random
[586.782866] Dynamic subtest numvfs-random: FAIL (0.004s)
[586.785281] Subtest enable-vfs-bind-unbind-each: FAIL (0.060s)
[586.825358] [117/134] (437s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[586.925991] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[586.930617] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[588.082581] [118/134] (436s left) kms_getfb (getfb-handle-not-fb)
[588.189650] Starting subtest: getfb-handle-not-fb
[588.191928] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[588.325624] [119/134] (436s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[588.379808] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[588.383729] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[588.591992] [120/134] (436s left) gem_workarounds (reset-context)
[588.657086] Starting subtest: reset-context
[588.823020] Subtest reset-context: SUCCESS (0.165s)
[588.986078] [121/134] (435s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[589.085062] Starting subtest: psr-farfromfence-mmap-gtt
[589.089414] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[589.219418] [122/134] (435s left) gem_wait (write-busy)
[589.278146] Starting subtest: write-busy
[589.280442] Starting dynamic subtest: all-engines
[589.901073] Dynamic subtest all-engines: SUCCESS (0.622s)
[589.910972] Starting dynamic subtest: rcs0
[590.459481] Dynamic subtest rcs0: SUCCESS (0.556s)
[590.478065] Starting dynamic subtest: bcs0
[591.009692] Dynamic subtest bcs0: SUCCESS (0.549s)
[591.025712] Starting dynamic subtest: vcs0
[592.917194] Dynamic subtest vcs0: SUCCESS (1.905s)
[592.934045] Starting dynamic subtest: vcs1
[594.901650] Dynamic subtest vcs1: SUCCESS (1.981s)
[594.917749] Starting dynamic subtest: vecs0
[596.885059] Dynamic subtest vecs0: SUCCESS (1.981s)
[596.901855] Starting dynamic subtest: ccs0
[597.435025] Dynamic subtest ccs0: SUCCESS (0.549s)
[597.437421] Subtest write-busy: SUCCESS (8.157s)
[597.657419] [123/134] (427s left) i915_hangman (detector)
[597.735883] Starting subtest: detector
[597.738287] Starting dynamic subtest: rcs0
[608.819999] Dynamic subtest rcs0: SUCCESS (11.084s)
[608.831422] Starting dynamic subtest: bcs0
[619.828171] Dynamic subtest bcs0: SUCCESS (11.004s)
[619.841204] Starting dynamic subtest: vcs0
[631.796086] Dynamic subtest vcs0: SUCCESS (11.964s)
[631.808115] Starting dynamic subtest: vcs1
[641.842976] Dynamic subtest vcs1: SUCCESS (10.044s)
[641.854702] Starting dynamic subtest: vecs0
[653.875909] Dynamic subtest vecs0: SUCCESS (12.030s)
[653.887915] Starting dynamic subtest: ccs0
[665.908105] Dynamic subtest ccs0: SUCCESS (12.029s)
[665.911116] Subtest detector: SUCCESS (68.171s)
[666.072321] [124/134] (358s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[666.182395] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[666.186437] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[666.315446] [125/134] (358s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[666.433254] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[666.437495] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[666.603266] [126/134] (358s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[666.664766] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[666.736246] [127/134] (358s left) gem_exec_schedule (noreorder-corked)
[666.923964] Starting subtest: noreorder-corked
[666.926727] Starting dynamic subtest: rcs0
[668.089810] Dynamic subtest rcs0: SUCCESS (1.166s)
[668.102488] Starting dynamic subtest: vcs0
[669.892420] Dynamic subtest vcs0: SUCCESS (1.799s)
[669.908559] Starting dynamic subtest: vcs1
[671.907313] Dynamic subtest vcs1: SUCCESS (2.012s)
[671.920894] Starting dynamic subtest: vecs0
[673.915785] Dynamic subtest vecs0: SUCCESS (2.006s)
[673.928262] Starting dynamic subtest: ccs0
[675.058643] Dynamic subtest ccs0: SUCCESS (1.142s)
[675.061242] Subtest noreorder-corked: SUCCESS (8.137s)
[675.272217] [128/134] (349s left) kms_psr (pr-cursor-mmap-cpu)
[675.371087] Starting subtest: pr-cursor-mmap-cpu
[675.375660] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[675.489837] [129/134] (349s left) perf (invalid-oa-format-id)
[675.599640] Starting subtest: invalid-oa-format-id
[675.608307] Subtest invalid-oa-format-id: SUCCESS (0.009s)
[675.653189] [130/134] (349s left) gem_eio (in-flight-internal-immediate)
[675.847866] Starting subtest: in-flight-internal-immediate
[676.961447] Subtest in-flight-internal-immediate: SUCCESS (1.113s)
[677.135460] [131/134] (348s left) kms_cursor_edge_walk (256x256-top-edge)
[677.239079] Starting subtest: 256x256-top-edge
[677.241309] Starting dynamic subtest: pipe-A-eDP-1
[680.718238] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[680.728209] Starting dynamic subtest: pipe-D-eDP-1
[683.845353] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[683.847309] Subtest 256x256-top-edge: SUCCESS (6.607s)
[684.662608] [132/134] (340s left) gem_ctx_persistence (engines-persistence)
[684.734412] Starting subtest: engines-persistence
[684.736835] Starting dynamic subtest: rcs0
[685.543568] Dynamic subtest rcs0: SUCCESS (0.807s)
[685.556318] Starting dynamic subtest: bcs0
[686.319770] Dynamic subtest bcs0: SUCCESS (0.774s)
[686.332849] Starting dynamic subtest: vcs0
[687.150487] Dynamic subtest vcs0: SUCCESS (0.828s)
[687.162898] Starting dynamic subtest: vcs1
[687.933227] Dynamic subtest vcs1: SUCCESS (0.781s)
[687.944669] Starting dynamic subtest: vecs0
[688.731482] Dynamic subtest vecs0: SUCCESS (0.796s)
[688.743893] Starting dynamic subtest: ccs0
[689.519665] Dynamic subtest ccs0: SUCCESS (0.786s)
[689.522829] Subtest engines-persistence: SUCCESS (4.785s)
[689.626381] [133/134] (335s left) api_intel_bb (render-ccs)
[689.677335] Starting subtest: render-ccs
[690.062962] Subtest render-ccs: SUCCESS (0.385s)
[690.188291] [134/134] (335s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[690.304048] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[690.308540] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[690.410236] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_fence_pin_leak
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_mmap_wc
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_busy
results: parsing output: 12/ for test: kms_plane_alpha_blend
results: parsing output: 13/ for test: sysfs_timeslice_duration
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: gem_partial_pwrite_pread
results: parsing output: 18/ for test: dumb_buffer
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: gem_lmem_swapping
results: parsing output: 22/ for test: gem_spin_batch
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_properties
results: parsing output: 25/ for test: kms_vrr
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: kms_pm_dc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_render_copy_redux
results: parsing output: 36/ for test: gem_mmap_wc
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: kms_3d
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: vgem_basic
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 53/ for test: kms_dp_link_training
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_tiled_pread_pwrite
results: parsing output: 64/ for test: i915_pm_rps
results: parsing output: 65/ for test: gem_ctx_engines
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: gem_ccs
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gem_lmem_swapping
results: parsing output: 80/ for test: kms_chamelium_frames
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_flink_race
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: i915_pm_rps
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_concurrent
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: api_intel_allocator
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_scaling_modes
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: i915_query
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: sysfs_timeslice_duration
results: parsing output: 115/ for test: sriov_basic
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_getfb
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: gem_workarounds
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_wait
results: parsing output: 122/ for test: i915_hangman
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: kms_cursor_edge_walk
results: parsing output: 131/ for test: gem_ctx_persistence
results: parsing output: 132/ for test: api_intel_bb
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.