[60.833769] Initializing watchdogs
[60.833812]   /dev/watchdog0
[60.847563] [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]
[60.851747] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.854387] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.857672] [001/133] (960s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[60.996514] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[61.819425] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.825s)
[62.005600] [002/133] (959s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[62.055117] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[62.059651] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[62.234831] [003/133] (959s left) i915_pm_rps (thresholds-park)
[62.300699] Starting subtest: thresholds-park
[62.305448] Subtest thresholds-park: SKIP (0.001s)
[62.399514] [004/133] (959s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[62.462956] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[62.569075] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[62.642769] [005/133] (958s left) gem_pxp (reject-modify-context-protection-off-2)
[62.768070] Starting subtest: reject-modify-context-protection-off-2
[62.770975] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[62.886558] [006/133] (958s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[62.998377] Starting subtest: fbcpsr-modesetfrombusy
[69.348173] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.355s)
[69.469207] [007/133] (952s left) prime_vgem (basic-write)
[69.602851] Starting subtest: basic-write
[69.610590] Subtest basic-write: SKIP (0.006s)
[69.690025] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true
[69.692664] [008/133] (951s left) gem_pxp (create-protected-buffer)
[69.752123] Starting subtest: create-protected-buffer
[69.754121] Subtest create-protected-buffer: SUCCESS (0.000s)
[69.847366] [009/133] (951s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[69.903054] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[69.905000] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[70.001754] [010/133] (951s left) kms_psr (fbc-pr-sprite-plane-onoff)
[70.090582] Starting subtest: fbc-pr-sprite-plane-onoff
[70.094047] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[70.173571] [011/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[70.269523] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[76.840976] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.574s)
[76.985251] [012/133] (944s left) gem_mmap_gtt (fault-concurrent)
[77.045324] Subtest fault-concurrent: SKIP (0.000s)
[77.105735] [013/133] (944s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[77.218482] Starting subtest: x-tiled-64bpp-rotate-0
[78.807813] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.590s)
[78.959157] [014/133] (942s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[79.044312] Starting subtest: bad-rotation-90-yf-tiled-ccs
[79.046673] Starting dynamic subtest: pipe-A-eDP-1
[79.069656] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[79.077967] Starting dynamic subtest: pipe-B-eDP-1
[79.095991] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[79.103070] Starting dynamic subtest: pipe-C-eDP-1
[79.121925] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[79.130638] Starting dynamic subtest: pipe-D-eDP-1
[79.148819] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[79.152184] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[81.242788] [015/133] (940s left) kms_plane_lowres (tiling-yf)
[81.330809] Starting subtest: tiling-yf
[81.334822] Subtest tiling-yf: SKIP (0.000s)
[81.400508] [016/133] (940s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[81.503647] Starting subtest: yf-tiled-32bpp-rotate-90
[81.507867] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[81.606107] [017/133] (940s left) kms_cursor_legacy (torture-move)
[81.717758] Starting subtest: torture-move
[81.719827] Starting dynamic subtest: pipe-A
[87.523316] Dynamic subtest pipe-A: SUCCESS (5.803s)
[87.533033] Starting dynamic subtest: pipe-B
[94.951688] Dynamic subtest pipe-B: SUCCESS (7.427s)
[94.962068] Starting dynamic subtest: pipe-C
[102.217542] Dynamic subtest pipe-C: SUCCESS (7.266s)
[102.228332] Starting dynamic subtest: pipe-D
[108.326894] Dynamic subtest pipe-D: SUCCESS (6.108s)
[108.339603] Starting dynamic subtest: all-pipes
[114.895951] Dynamic subtest all-pipes: SUCCESS (6.569s)
[114.898528] Subtest torture-move: SUCCESS (33.177s)
[115.062032] [018/133] (906s left) kms_lease (simple-lease)
[115.164122] Starting subtest: simple-lease
[115.166380] Starting dynamic subtest: pipe-A-eDP-1
[115.671584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.508s)
[115.680145] Starting dynamic subtest: pipe-B-eDP-1
[117.081723] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s)
[117.091312] Starting dynamic subtest: pipe-C-eDP-1
[118.480480] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.398s)
[118.489176] Starting dynamic subtest: pipe-D-eDP-1
[119.886358] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.405s)
[119.888377] Subtest simple-lease: SUCCESS (4.723s)
[120.695911] [019/133] (901s left) i915_module_load (reload)
[120.737559] Starting subtest: reload
[125.332767] Subtest reload: SUCCESS (4.597s)
[125.372905] [020/133] (896s left) syncobj_basic (bad-fd-to-handle)
[126.903908] Starting subtest: bad-fd-to-handle
[126.906248] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[127.009374] [021/133] (895s left) gem_exec_fence (syncobj-unused-fence)
[127.432244] Starting subtest: syncobj-unused-fence
[127.437138] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[128.993805] [022/133] (893s left) syncobj_timeline (invalid-signal-illegal-handle)
[129.052226] Starting subtest: invalid-signal-illegal-handle
[129.054469] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[129.147092] [023/133] (893s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[129.206903] Starting subtest: invalid-bsd1-flag-on-vebox
[129.209439] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[129.304948] [024/133] (892s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[129.408620] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[129.410977] Starting dynamic subtest: pipe-A-eDP-1
[129.434058] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[129.443071] Starting dynamic subtest: pipe-B-eDP-1
[129.463128] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[129.469904] Starting dynamic subtest: pipe-C-eDP-1
[129.490172] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[129.496948] Starting dynamic subtest: pipe-D-eDP-1
[129.518497] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[129.522851] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[131.588334] [025/133] (890s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[131.683850] Starting subtest: random-ccs-data-y-tiled-ccs
[131.686044] Starting dynamic subtest: pipe-A-eDP-1
[131.710132] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[131.719224] Starting dynamic subtest: pipe-B-eDP-1
[131.741804] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[131.748729] Starting dynamic subtest: pipe-C-eDP-1
[131.771278] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[131.779135] Starting dynamic subtest: pipe-D-eDP-1
[131.803418] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[131.807707] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[133.946898] [026/133] (888s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[134.044707] Starting subtest: 4-tiled-addfb-size-offset-overflow
[134.046685] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[134.140988] [027/133] (888s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[134.246334] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[134.250580] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[134.339985] [028/133] (888s left) gem_softpin (evict-snoop)
[134.399353] Starting subtest: evict-snoop
[134.403988] Subtest evict-snoop: SKIP (0.000s)
[134.518839] [029/133] (887s left) gen9_exec_parse (unaligned-jump)
[134.591477] Subtest unaligned-jump: SKIP (0.000s)
[134.651248] [030/133] (887s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[134.763036] Starting subtest: cursorA-vs-flipA-atomic-transitions
[145.927319] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.164s)
[146.789400] [031/133] (875s left) kms_vrr (flip-suspend)
[146.892058] Starting subtest: flip-suspend
[146.898268] Subtest flip-suspend: SKIP (0.000s)
[146.967749] [032/133] (875s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[147.058882] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[147.061134] Starting dynamic subtest: pipe-A
[148.114851] Dynamic subtest pipe-A: SUCCESS (1.055s)
[148.122910] Starting dynamic subtest: pipe-B
[150.201093] Dynamic subtest pipe-B: SUCCESS (2.085s)
[150.208317] Starting dynamic subtest: pipe-C
[151.404786] Dynamic subtest pipe-C: SUCCESS (1.203s)
[151.412755] Starting dynamic subtest: pipe-D
[152.554480] Dynamic subtest pipe-D: SUCCESS (1.148s)
[152.556695] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.496s)
[153.742673] [033/133] (868s left) kms_rotation_crc (primary-rotation-90)
[153.834146] Starting subtest: primary-rotation-90
[153.841319] Subtest primary-rotation-90: SKIP (0.001s)
[153.909387] [034/133] (868s left) gem_exec_schedule (smoketest-all)
[153.977914] Starting subtest: smoketest-all
[186.336253] Subtest smoketest-all: SUCCESS (32.316s)
[187.984135] [035/133] (834s left) perf (oa-exponents)
[188.098293] Starting subtest: oa-exponents
[188.100503] Starting dynamic subtest: 0-rcs0
[189.895593] Dynamic subtest 0-rcs0: SUCCESS (1.796s)
[189.904116] Starting dynamic subtest: 1-vcs1
[191.725443] Dynamic subtest 1-vcs1: SUCCESS (1.829s)
[191.728045] Subtest oa-exponents: SUCCESS (3.626s)
[191.775486] [036/133] (830s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[191.873043] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[191.875332] Starting dynamic subtest: pipe-A
[193.066108] Dynamic subtest pipe-A: SUCCESS (1.195s)
[193.074107] Starting dynamic subtest: pipe-B
[195.187782] Dynamic subtest pipe-B: SUCCESS (2.120s)
[195.195923] Starting dynamic subtest: pipe-C
[196.340361] Dynamic subtest pipe-C: SUCCESS (1.152s)
[196.348848] Starting dynamic subtest: pipe-D
[197.474241] Dynamic subtest pipe-D: SUCCESS (1.133s)
[197.476503] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.604s)
[198.670692] [037/133] (824s left) gem_tiled_fence_blits (basic)
[198.729056] Subtest basic: SKIP (0.000s)
[198.793701] [038/133] (824s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[198.891548] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[198.895860] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[198.987510] [039/133] (823s left) api_intel_bb (blit-noreloc-purge-cache)
[199.042677] Starting subtest: blit-noreloc-purge-cache
[199.052100] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[199.180428] [040/133] (823s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[199.274922] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[203.416852] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.148s)
[204.568173] [041/133] (818s left) syncobj_wait (multi-wait-all-signaled)
[204.619544] Starting subtest: multi-wait-all-signaled
[204.622061] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[204.705483] [042/133] (818s left) gem_exec_whisper (basic-forked-all)
[204.767845] Starting subtest: basic-forked-all
[217.879851] Subtest basic-forked-all: SUCCESS (13.107s)
[218.080384] [043/133] (804s left) sysfs_timeslice_duration (idempotent)
[218.144683] Starting subtest: idempotent
[218.147141] Starting dynamic subtest: vecs0
[218.149494] Dynamic subtest vecs0: SUCCESS (0.000s)
[218.159082] Starting dynamic subtest: ccs0
[218.161272] Dynamic subtest ccs0: SUCCESS (0.000s)
[218.169367] Starting dynamic subtest: vcs0
[218.171282] Dynamic subtest vcs0: SUCCESS (0.000s)
[218.179171] Starting dynamic subtest: bcs0
[218.181323] Dynamic subtest bcs0: SUCCESS (0.000s)
[218.189053] Starting dynamic subtest: rcs0
[218.191321] Dynamic subtest rcs0: SUCCESS (0.000s)
[218.199039] Starting dynamic subtest: vcs1
[218.201232] Dynamic subtest vcs1: SUCCESS (0.000s)
[218.203382] Subtest idempotent: SUCCESS (0.006s)
[218.239094] [044/133] (804s left) sriov_basic (bind-unbind-vf)
[218.295783] Starting subtest: bind-unbind-vf
[218.298143] Starting dynamic subtest: vf-1
[218.371759] Dynamic subtest vf-1: FAIL (0.013s)
[218.381883] Starting dynamic subtest: vf-2
[218.456720] Dynamic subtest vf-2: FAIL (0.004s)
[218.466575] Starting dynamic subtest: vf-3
[218.540340] Dynamic subtest vf-3: FAIL (0.003s)
[218.549501] Starting dynamic subtest: vf-4
[218.622702] Dynamic subtest vf-4: FAIL (0.004s)
[218.632811] Starting dynamic subtest: vf-5
[218.705341] Dynamic subtest vf-5: FAIL (0.004s)
[218.714878] Starting dynamic subtest: vf-6
[218.787516] Dynamic subtest vf-6: FAIL (0.003s)
[218.796628] Starting dynamic subtest: vf-7
[218.870376] Dynamic subtest vf-7: FAIL (0.003s)
[218.879917] Starting dynamic subtest: vf-random
[218.952073] Dynamic subtest vf-random: FAIL (0.003s)
[218.961328] Starting dynamic subtest: vf-last
[219.029252] Dynamic subtest vf-last: FAIL (0.510s)
[219.030945] Subtest bind-unbind-vf: FAIL (0.555s)
[219.066326] [045/133] (804s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[219.165310] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[225.904995] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.743s)
[226.059802] [046/133] (797s left) kms_invalid_mode (bad-vsync-end)
[226.150274] Starting subtest: bad-vsync-end
[226.152596] Starting dynamic subtest: pipe-A-eDP-1
[226.446331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[226.455279] Starting dynamic subtest: pipe-B-eDP-1
[226.457150] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[226.464951] Starting dynamic subtest: pipe-C-eDP-1
[226.466924] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[226.475065] Starting dynamic subtest: pipe-D-eDP-1
[226.477335] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[226.479790] Subtest bad-vsync-end: SUCCESS (0.303s)
[227.329895] [047/133] (795s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[227.715235] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[228.528574] [048/133] (794s left) gem_create (create-ext-placement-each)
[228.706512] Starting subtest: create-ext-placement-each
[228.708837] Subtest create-ext-placement-each: SUCCESS (0.000s)
[228.803627] [049/133] (794s left) kms_psr (fbc-psr-sprite-render)
[228.887974] Starting subtest: fbc-psr-sprite-render
[228.890255] Starting dynamic subtest: eDP-1
[228.894473] Dynamic subtest eDP-1: SKIP (0.000s)
[228.898692] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[228.974675] [050/133] (794s left) perf_pmu (init-busy)
[229.008481] Starting subtest: init-busy
[229.010778] Starting dynamic subtest: rcs0
[229.013199] Dynamic subtest rcs0: SUCCESS (0.001s)
[229.023087] Starting dynamic subtest: bcs0
[229.025037] Dynamic subtest bcs0: SUCCESS (0.000s)
[229.032628] Starting dynamic subtest: vcs0
[229.034594] Dynamic subtest vcs0: SUCCESS (0.001s)
[229.042070] Starting dynamic subtest: vcs1
[229.043956] Dynamic subtest vcs1: SUCCESS (0.001s)
[229.051515] Starting dynamic subtest: vecs0
[229.053550] Dynamic subtest vecs0: SUCCESS (0.001s)
[229.063598] Starting dynamic subtest: ccs0
[229.065849] Dynamic subtest ccs0: SUCCESS (0.000s)
[229.068056] Subtest init-busy: SUCCESS (0.007s)
[229.122457] [051/133] (794s left) i915_query (query-topology-coherent-slice-mask)
[229.177679] Starting subtest: query-topology-coherent-slice-mask
[229.181746] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[229.290431] [052/133] (794s left) kms_chamelium_edid (dp-edid-resolution-list)
[229.670974] Subtest dp-edid-resolution-list: SKIP (0.000s)
[230.456668] [053/133] (792s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[230.545059] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[230.550039] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[230.645912] [054/133] (792s left) core_getstats (basic)
[230.698917] Starting subtest: basic
[230.701393] Subtest basic: SUCCESS (0.000s)
[230.804472] [055/133] (792s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[230.908489] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[237.835857] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.930s)
[237.972836] [056/133] (785s left) kms_psr (psr2-primary-mmap-cpu)
[238.055236] Starting subtest: psr2-primary-mmap-cpu
[238.057542] Starting dynamic subtest: eDP-1
[239.781196] Dynamic subtest eDP-1: SUCCESS (1.725s)
[239.783216] Subtest psr2-primary-mmap-cpu: SUCCESS (1.726s)
[240.655032] [057/133] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[240.752353] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[240.756355] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[240.847361] [058/133] (782s left) prime_mmap_coherency (read)
[240.896892] Starting subtest: read
[246.275061] Subtest read: SUCCESS (5.377s)
[246.399116] [059/133] (777s left) kms_pm_rpm (pc8-residency)
[248.041031] Starting subtest: pc8-residency
[248.046513] Subtest pc8-residency: SKIP (0.000s)
[248.698750] [060/133] (775s left) gem_userptr_blits (set-cache-level)
[248.766299] Starting subtest: set-cache-level
[248.770750] Subtest set-cache-level: SKIP (0.000s)
[248.880718] [061/133] (774s left) gem_exec_fence (basic-busy-all)
[248.943550] Starting subtest: basic-busy-all
[249.029903] Subtest basic-busy-all: SUCCESS (0.087s)
[250.954252] [062/133] (772s left) gem_eio (throttle)
[251.182019] Starting subtest: throttle
[251.534150] Subtest throttle: SUCCESS (0.351s)
[251.671282] [063/133] (772s left) i915_pm_rps (basic-api)
[251.725093] Starting subtest: basic-api
[251.729754] Subtest basic-api: SKIP (0.001s)
[251.831156] [064/133] (772s left) gem_mmap_gtt (basic-write-read)
[251.891378] Subtest basic-write-read: SKIP (0.000s)
[251.954053] [065/133] (771s left) kms_pm_rpm (cursor)
[254.076715] Starting subtest: cursor
[254.082053] Subtest cursor: SKIP (0.000s)
[254.449634] [066/133] (769s left) gem_exec_schedule (u-submit-early-slice)
[254.520306] Starting subtest: u-submit-early-slice
[254.522370] Starting dynamic subtest: rcs0
[254.554138] Dynamic subtest rcs0: SUCCESS (0.043s)
[254.565153] Starting dynamic subtest: bcs0
[254.591980] Dynamic subtest bcs0: SUCCESS (0.037s)
[254.601391] Starting dynamic subtest: vcs0
[254.635287] Dynamic subtest vcs0: SUCCESS (0.043s)
[254.645601] Starting dynamic subtest: vcs1
[254.675473] Dynamic subtest vcs1: SUCCESS (0.039s)
[254.685325] Starting dynamic subtest: vecs0
[254.715333] Dynamic subtest vecs0: SUCCESS (0.039s)
[254.730210] Starting dynamic subtest: ccs0
[254.757964] Dynamic subtest ccs0: SUCCESS (0.042s)
[254.760601] Subtest u-submit-early-slice: SUCCESS (0.248s)
[255.992010] [067/133] (767s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[256.115648] Starting subtest: basic-flip-before-cursor-legacy
[257.059636] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.943s)
[257.874707] [068/133] (766s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[257.929562] Starting subtest: multi-wait-for-submit-submitted-signaled
[257.931827] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[258.028853] [069/133] (766s left) perf (invalid-oa-format-id)
[258.114592] Starting subtest: invalid-oa-format-id
[258.117085] Subtest invalid-oa-format-id: SUCCESS (0.006s)
[258.159700] [070/133] (765s left) gem_mmap_wc (write-cpu-read-wc)
[258.217347] Subtest write-cpu-read-wc: SKIP (0.000s)
[258.272462] [071/133] (765s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[258.371244] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[258.375305] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[258.483934] [072/133] (765s left) gem_ctx_persistence (userptr)
[258.529363] Starting subtest: userptr
[258.700713] Subtest userptr: SUCCESS (0.171s)
[258.796976] [073/133] (765s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[258.923677] Starting subtest: cursorB-vs-flipA-atomic-transitions
[258.927444] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[259.068209] [074/133] (765s left) gem_spin_batch (resubmit)
[259.128312] Starting subtest: resubmit
[259.130308] Starting dynamic subtest: rcs0
[259.134641] Dynamic subtest rcs0: SUCCESS (0.007s)
[259.148846] Starting dynamic subtest: bcs0
[259.150460] Dynamic subtest bcs0: SUCCESS (0.003s)
[259.163233] Starting dynamic subtest: vcs0
[259.165232] Dynamic subtest vcs0: SUCCESS (0.003s)
[259.172983] Starting dynamic subtest: vcs1
[259.175076] Dynamic subtest vcs1: SUCCESS (0.002s)
[259.182728] Starting dynamic subtest: vecs0
[259.184589] Dynamic subtest vecs0: SUCCESS (0.002s)
[259.192549] Starting dynamic subtest: ccs0
[259.194336] Dynamic subtest ccs0: SUCCESS (0.002s)
[259.196139] Subtest resubmit: SUCCESS (0.024s)
[259.378920] [075/133] (764s left) gem_exec_reloc (basic-cpu)
[259.440691] Subtest basic-cpu: SKIP (0.000s)
[259.510988] [076/133] (764s left) kms_atomic_transition (plane-toggle-modeset-transition)
[259.606568] Starting subtest: plane-toggle-modeset-transition
[259.608442] Starting dynamic subtest: pipe-A-eDP-1
[272.340240] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.730s)
[272.351099] Starting dynamic subtest: pipe-B-eDP-1
[284.763444] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.423s)
[284.765973] Subtest plane-toggle-modeset-transition: SUCCESS (25.158s)
[285.579044] [077/133] (738s left) gem_ctx_shared (q-independent)
[285.642449] Starting subtest: Q-independent
[285.644800] Starting dynamic subtest: rcs0
[285.712047] Dynamic subtest rcs0: SUCCESS (0.071s)
[285.724503] Starting dynamic subtest: vcs0
[285.758987] Dynamic subtest vcs0: SUCCESS (0.047s)
[285.769849] Starting dynamic subtest: vcs1
[285.807782] Dynamic subtest vcs1: SUCCESS (0.047s)
[285.818725] Starting dynamic subtest: vecs0
[285.850315] Dynamic subtest vecs0: SUCCESS (0.042s)
[285.860434] Starting dynamic subtest: ccs0
[285.904670] Dynamic subtest ccs0: SUCCESS (0.053s)
[285.907325] Subtest Q-independent: SUCCESS (0.265s)
[287.024477] [078/133] (737s left) kms_feature_discovery (display-1x)
[287.127249] Starting subtest: display-1x
[287.129583] Subtest display-1x: SUCCESS (0.000s)
[287.199842] [079/133] (737s left) kms_psr (fbc-psr-primary-mmap-gtt)
[287.284659] Starting subtest: fbc-psr-primary-mmap-gtt
[287.286918] Starting dynamic subtest: eDP-1
[287.291076] Dynamic subtest eDP-1: SKIP (0.000s)
[287.295139] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[287.357298] [080/133] (737s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[287.457975] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[287.460202] Starting dynamic subtest: pipe-A-default-mode
[290.223645] Dynamic subtest pipe-A-default-mode: SUCCESS (2.765s)
[290.225974] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.767s)
[291.083166] [081/133] (733s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[291.185694] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[291.190111] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[291.297848] [082/133] (733s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[291.388223] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[291.390521] Starting dynamic subtest: pipe-A-eDP-1
[291.448273] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[291.457752] Starting dynamic subtest: pipe-B-eDP-1
[291.511588] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[291.520771] Starting dynamic subtest: pipe-C-eDP-1
[291.574417] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[291.583183] Starting dynamic subtest: pipe-D-eDP-1
[291.640827] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[291.644760] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[293.560515] [083/133] (731s left) gem_readwrite (write-bad-handle)
[293.621074] Subtest write-bad-handle: SKIP (0.000s)
[293.679935] [084/133] (731s left) gem_exec_fence (nb-await)
[293.852901] Starting subtest: nb-await
[293.855099] Starting dynamic subtest: rcs0
[293.916910] Dynamic subtest rcs0: SUCCESS (0.064s)
[293.929386] Starting dynamic subtest: bcs0
[293.976258] Dynamic subtest bcs0: SUCCESS (0.057s)
[293.988060] Starting dynamic subtest: vcs0
[294.035673] Dynamic subtest vcs0: SUCCESS (0.057s)
[294.046680] Starting dynamic subtest: vcs1
[294.096067] Dynamic subtest vcs1: SUCCESS (0.057s)
[294.107911] Starting dynamic subtest: vecs0
[294.156444] Dynamic subtest vecs0: SUCCESS (0.058s)
[294.167948] Starting dynamic subtest: ccs0
[294.216093] Dynamic subtest ccs0: SUCCESS (0.057s)
[294.218798] Subtest nb-await: SUCCESS (0.365s)
[295.966884] [085/133] (728s left) kms_scaling_modes (scaling-mode-full-aspect)
[296.067372] Starting subtest: scaling-mode-full-aspect
[296.070205] Starting dynamic subtest: pipe-A-eDP-1
[296.158710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[296.167885] Starting dynamic subtest: pipe-B-eDP-1
[297.289188] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s)
[297.301909] Starting dynamic subtest: pipe-C-eDP-1
[298.400148] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[298.411661] Starting dynamic subtest: pipe-D-eDP-1
[299.529293] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[299.531698] Subtest scaling-mode-full-aspect: SUCCESS (3.467s)
[300.706263] [086/133] (724s left) kms_pipe_crc_basic (hang-read-crc)
[300.821817] Starting subtest: hang-read-crc
[300.824126] Starting dynamic subtest: pipe-A-eDP-1
[302.870072] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.049s)
[302.880179] Starting dynamic subtest: pipe-B-eDP-1
[305.688677] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.816s)
[305.703571] Starting dynamic subtest: pipe-C-eDP-1
[308.378240] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.690s)
[308.387724] Starting dynamic subtest: pipe-D-eDP-1
[311.043488] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.663s)
[311.045844] Subtest hang-read-crc: SUCCESS (10.222s)
[311.872477] [087/133] (712s left) kms_cursor_crc (cursor-offscreen-128x42)
[312.145877] Starting subtest: cursor-offscreen-128x42
[312.192096] Subtest cursor-offscreen-128x42: SKIP (0.041s)
[312.415158] [088/133] (712s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[312.512862] Starting subtest: pixel-format-y-tiled-ccs-modifier
[312.517319] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[312.602685] [089/133] (712s left) kms_cursor_edge_walk (128x128-right-edge)
[312.688048] Starting subtest: 128x128-right-edge
[312.690190] Starting dynamic subtest: pipe-A-eDP-1
[316.139616] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[316.149103] Starting dynamic subtest: pipe-D-eDP-1
[319.258845] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[319.261090] Subtest 128x128-right-edge: SUCCESS (6.572s)
[320.077869] [090/133] (704s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[320.179213] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[320.181506] Starting dynamic subtest: pipe-A-eDP-1
[320.203697] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[320.214063] Starting dynamic subtest: pipe-B-eDP-1
[320.235242] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[320.243249] Starting dynamic subtest: pipe-C-eDP-1
[320.263299] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[320.271381] Starting dynamic subtest: pipe-D-eDP-1
[320.293237] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[320.297563] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[322.342344] [091/133] (702s left) dmabuf_sync_file (export-wait-after-attach)
[322.385657] Starting subtest: export-wait-after-attach
[322.387845] Subtest export-wait-after-attach: SUCCESS (0.001s)
[322.440582] [092/133] (702s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[322.527231] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[322.531168] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[322.622827] [093/133] (702s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[322.688268] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[322.755882] [094/133] (702s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[322.862532] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[322.866574] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[322.968355] [095/133] (702s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[323.058409] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[327.099092] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.044s)
[328.255211] [096/133] (696s left) kms_vrr (flip-dpms)
[328.349056] Starting subtest: flip-dpms
[328.355421] Subtest flip-dpms: SKIP (0.000s)
[328.421508] [097/133] (696s left) prime_vgem (basic-fence-flip)
[328.483623] Starting subtest: basic-fence-flip
[328.773067] Subtest basic-fence-flip: SUCCESS (0.290s)
[328.876721] [098/133] (696s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[328.981356] Starting subtest: psr2-plane-move-sf-dmg-area
[328.983755] Starting dynamic subtest: pipe-A-eDP-1
[333.471834] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.490s)
[333.481516] Starting dynamic subtest: pipe-B-eDP-1
[338.811405] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.335s)
[338.813621] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.830s)
[339.679100] [099/133] (685s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[339.778188] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[339.789489] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[339.879168] [100/133] (685s left) kms_cursor_crc (cursor-size-hints)
[340.011842] Starting subtest: cursor-size-hints
[340.014046] Starting dynamic subtest: pipe-A-eDP-1
[340.652583] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.639s)
[340.662491] Starting dynamic subtest: pipe-D-eDP-1
[341.942539] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.289s)
[341.944992] Subtest cursor-size-hints: SUCCESS (1.931s)
[342.748470] [101/133] (682s left) gem_linear_blits (normal)
[343.209563] Starting subtest: normal
[347.207080] Subtest normal: SUCCESS (3.997s)
[347.426974] [102/133] (677s left) gem_busy (parallel)
[347.635614] Starting subtest: parallel
[347.638184] Starting dynamic subtest: rcs0
[348.883076] Dynamic subtest rcs0: SUCCESS (1.247s)
[348.894340] Starting dynamic subtest: bcs0
[350.933643] Dynamic subtest bcs0: SUCCESS (2.047s)
[350.949255] Starting dynamic subtest: vcs0
[352.918147] Dynamic subtest vcs0: SUCCESS (1.981s)
[352.931079] Starting dynamic subtest: vcs1
[354.903468] Dynamic subtest vcs1: SUCCESS (1.982s)
[354.916056] Starting dynamic subtest: vecs0
[356.886059] Dynamic subtest vecs0: SUCCESS (1.980s)
[356.899103] Starting dynamic subtest: ccs0
[358.933073] Dynamic subtest ccs0: SUCCESS (2.042s)
[358.936102] Subtest parallel: SUCCESS (11.298s)
[359.170289] [103/133] (666s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[359.289695] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[366.279789] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.994s)
[366.420855] [104/133] (659s left) gem_partial_pwrite_pread (write-snoop)
[366.500188] Subtest write-snoop: SKIP (0.000s)
[366.574949] [105/133] (658s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[366.683197] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[366.687410] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[366.777260] [106/133] (658s left) kms_content_protection (type1)
[366.929052] Starting subtest: type1
[366.933796] Subtest type1: SKIP (0.000s)
[367.049356] [107/133] (658s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[367.148774] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[367.153207] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[367.254253] [108/133] (658s left) syncobj_timeline (single-wait-all-signaled)
[367.323457] Starting subtest: single-wait-all-signaled
[367.325502] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[367.431047] [109/133] (658s left) gem_mmap_offset (partial-mmap)
[367.483290] Starting subtest: partial-mmap
[367.484995] Starting dynamic subtest: smem0
[367.486910] Dynamic subtest smem0: SUCCESS (0.004s)
[367.488850] Subtest partial-mmap: SUCCESS (0.005s)
[367.597462] [110/133] (658s left) gem_exec_balancer (parallel-bb-first)
[367.848504] Starting subtest: parallel-bb-first
[368.765309] Subtest parallel-bb-first: SUCCESS (0.917s)
[369.914266] [111/133] (655s left) gem_mmap_wc (read)
[369.970183] Subtest read: SKIP (0.000s)
[370.032154] [112/133] (655s left) syncobj_wait (wait-any-interrupted)
[370.093617] Starting subtest: wait-any-interrupted
[370.195176] Subtest wait-any-interrupted: SUCCESS (0.103s)
[370.285249] [113/133] (655s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[370.401203] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[370.449541] [114/133] (655s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[370.555437] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[370.557929] Starting dynamic subtest: A-eDP1
[374.210514] Dynamic subtest A-eDP1: SUCCESS (3.652s)
[374.220408] Starting dynamic subtest: B-eDP1
[377.404573] Dynamic subtest B-eDP1: SUCCESS (3.192s)
[377.418416] Starting dynamic subtest: C-eDP1
[380.515119] Dynamic subtest C-eDP1: SUCCESS (3.108s)
[380.525069] Starting dynamic subtest: D-eDP1
[383.614300] Dynamic subtest D-eDP1: SUCCESS (3.098s)
[383.616563] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.062s)
[384.421604] [115/133] (641s left) gem_ctx_persistence (engines-hang)
[384.480678] Starting subtest: engines-hang
[384.483134] Starting dynamic subtest: rcs0
[384.614686] Dynamic subtest rcs0: SUCCESS (0.133s)
[384.627168] Starting dynamic subtest: bcs0
[384.685802] Dynamic subtest bcs0: SUCCESS (0.069s)
[384.697202] Starting dynamic subtest: vcs0
[384.797818] Dynamic subtest vcs0: SUCCESS (0.110s)
[384.812134] Starting dynamic subtest: vcs1
[384.892712] Dynamic subtest vcs1: SUCCESS (0.093s)
[384.904561] Starting dynamic subtest: vecs0
[384.981692] Dynamic subtest vecs0: SUCCESS (0.087s)
[384.993424] Starting dynamic subtest: ccs0
[385.074733] Dynamic subtest ccs0: SUCCESS (0.091s)
[385.077271] Subtest engines-hang: SUCCESS (0.595s)
[385.170990] [116/133] (640s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[385.267141] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[385.271068] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[385.346603] [117/133] (640s left) syncobj_wait (multi-wait-for-submit-signaled)
[385.405971] Starting subtest: multi-wait-for-submit-signaled
[385.407991] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[385.534282] [118/133] (640s left) kms_flip (plain-flip-fb-recreate)
[385.624596] Starting subtest: plain-flip-fb-recreate
[385.626474] Starting dynamic subtest: A-eDP1
[394.502535] Dynamic subtest A-eDP1: SUCCESS (8.879s)
[394.513777] Starting dynamic subtest: B-eDP1
[403.331459] Dynamic subtest B-eDP1: SUCCESS (8.827s)
[403.343425] Starting dynamic subtest: C-eDP1
[412.150223] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[412.161794] Starting dynamic subtest: D-eDP1
[420.986287] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[420.991053] Subtest plain-flip-fb-recreate: SUCCESS (35.369s)
[422.168342] [119/133] (603s left) gem_exec_capture (pi)
[422.229476] Starting subtest: pi
[422.231939] Starting dynamic subtest: rcs0
[426.121750] Dynamic subtest rcs0: SUCCESS (3.894s)
[426.136547] Starting dynamic subtest: bcs0
[429.981085] Dynamic subtest bcs0: SUCCESS (3.857s)
[429.993590] Starting dynamic subtest: vcs0
[433.844583] Dynamic subtest vcs0: SUCCESS (3.862s)
[433.855095] Starting dynamic subtest: vcs1
[437.667990] Dynamic subtest vcs1: SUCCESS (3.821s)
[437.678836] Starting dynamic subtest: vecs0
[441.566504] Dynamic subtest vecs0: SUCCESS (3.898s)
[441.576056] Starting dynamic subtest: ccs0
[445.493490] Dynamic subtest ccs0: SUCCESS (3.926s)
[445.496177] Subtest pi: SUCCESS (23.268s)
[445.576553] [120/133] (580s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[445.719248] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[445.723588] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.001s)
[445.815775] [121/133] (580s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[445.909046] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[450.503946] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.598s)
[451.669611] [122/133] (574s left) gem_exec_params (invalid-flag)
[451.730832] Starting subtest: invalid-flag
[451.733289] Subtest invalid-flag: SUCCESS (0.000s)
[451.829099] [123/133] (574s left) gem_exec_schedule (preempt-engines)
[451.910598] Starting subtest: preempt-engines
[451.912581] Starting dynamic subtest: rcs0
[454.155979] Dynamic subtest rcs0: SUCCESS (2.250s)
[454.173140] Starting dynamic subtest: bcs0
[456.499294] Dynamic subtest bcs0: SUCCESS (2.340s)
[456.515731] Starting dynamic subtest: vcs0
[458.863224] Dynamic subtest vcs0: SUCCESS (2.362s)
[458.873190] Starting dynamic subtest: vcs1
[461.162122] Dynamic subtest vcs1: SUCCESS (2.297s)
[461.175750] Starting dynamic subtest: vecs0
[463.473908] Dynamic subtest vecs0: SUCCESS (2.309s)
[463.492274] Starting dynamic subtest: ccs0
[465.795966] Dynamic subtest ccs0: SUCCESS (2.320s)
[465.798566] Subtest preempt-engines: SUCCESS (13.890s)
[466.167590] [124/133] (560s left) kms_color (deep-color)
[466.272328] Starting subtest: deep-color
[467.330332] Starting dynamic subtest: pipe-A-eDP-1-gamma
[468.066454] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.736s)
[468.076014] Starting dynamic subtest: pipe-A-eDP-1-degamma
[469.547130] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.482s)
[469.556893] Starting dynamic subtest: pipe-A-eDP-1-ctm
[470.944700] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.396s)
[471.743437] Starting dynamic subtest: pipe-B-eDP-1-gamma
[472.429065] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.696s)
[472.438754] Starting dynamic subtest: pipe-B-eDP-1-degamma
[473.819420] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.388s)
[473.829463] Starting dynamic subtest: pipe-B-eDP-1-ctm
[475.224737] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.405s)
[476.038565] Starting dynamic subtest: pipe-C-eDP-1-gamma
[476.720469] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.690s)
[476.740029] Starting dynamic subtest: pipe-C-eDP-1-degamma
[478.103504] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.381s)
[478.115040] Starting dynamic subtest: pipe-C-eDP-1-ctm
[479.535671] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.431s)
[480.310969] Starting dynamic subtest: pipe-D-eDP-1-gamma
[481.026411] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.725s)
[481.036083] Starting dynamic subtest: pipe-D-eDP-1-degamma
[482.462105] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.435s)
[482.471687] Starting dynamic subtest: pipe-D-eDP-1-ctm
[483.884864] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.420s)
[483.887181] Subtest deep-color: SUCCESS (17.610s)
[484.760534] [125/133] (541s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[484.852610] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[484.856791] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[484.945931] [126/133] (541s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[485.053242] Starting subtest: fbc-psr2-cursor-plane-update-sf
[485.055593] Starting dynamic subtest: pipe-A-eDP-1
[485.126434] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[485.137613] Starting dynamic subtest: pipe-B-eDP-1
[486.322794] Dynamic subtest pipe-B-eDP-1: SKIP (1.193s)
[486.327225] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.273s)
[487.501757] [127/133] (538s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[487.597754] Starting subtest: psr-rgb565-draw-render
[494.561915] Subtest psr-rgb565-draw-render: SUCCESS (6.967s)
[494.655118] [128/133] (531s left) kms_atomic_transition (modeset-transition-nonblocking)
[494.752921] Starting subtest: modeset-transition-nonblocking
[494.755219] Starting dynamic subtest: 1x-outputs
[505.769893] Dynamic subtest 1x-outputs: SUCCESS (11.018s)
[505.772491] Subtest modeset-transition-nonblocking: SUCCESS (11.020s)
[506.626993] [129/133] (519s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[506.731020] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[507.532915] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.803s)
[507.720792] [130/133] (518s left) gem_lmem_swapping (parallel-random-engines)
[507.764796] Subtest parallel-random-engines: SKIP (0.000s)
[507.815581] [131/133] (518s left) gen7_exec_parse (load-register-reg)
[507.871681] Subtest load-register-reg: SKIP (0.000s)
[507.931917] [132/133] (518s left) gem_mmap_gtt (cpuset-big-copy)
[507.997481] Subtest cpuset-big-copy: SKIP (0.000s)
[508.051151] [133/133] (518s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[508.156062] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[508.526419] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[511.312047] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.784s)
[511.328878] Starting dynamic subtest: pipe-A-eDP-1-4
[513.486905] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[513.498894] Starting dynamic subtest: pipe-A-eDP-1-4
[515.497607] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[515.508457] Starting dynamic subtest: pipe-A-eDP-1-x
[517.687280] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[518.062265] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[520.837893] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.785s)
[520.848761] Starting dynamic subtest: pipe-B-eDP-1-4
[523.035441] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.196s)
[523.048244] Starting dynamic subtest: pipe-B-eDP-1-4
[525.044908] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[525.059993] Starting dynamic subtest: pipe-B-eDP-1-x
[527.246457] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.199s)
[527.611984] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[530.363265] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.758s)
[530.376117] Starting dynamic subtest: pipe-C-eDP-1-4
[532.526212] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.162s)
[532.538420] Starting dynamic subtest: pipe-C-eDP-1-4
[534.537468] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[534.549654] Starting dynamic subtest: pipe-C-eDP-1-x
[536.738736] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.200s)
[537.103955] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[539.900028] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.803s)
[539.918370] Starting dynamic subtest: pipe-D-eDP-1-4
[542.074767] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[542.086193] Starting dynamic subtest: pipe-D-eDP-1-4
[544.084934] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[544.095541] Starting dynamic subtest: pipe-D-eDP-1-x
[546.263304] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[546.265698] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.107s)
[547.493544] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: i915_pm_rps
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_pxp
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: prime_vgem
results: parsing output: 7/ for test: gem_pxp
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_plane_lowres
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: i915_module_load
results: parsing output: 19/ for test: syncobj_basic
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_softpin
results: parsing output: 28/ for test: gen9_exec_parse
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_vrr
results: parsing output: 31/ for test: kms_plane_scaling
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: perf
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: gem_tiled_fence_blits
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gem_exec_whisper
results: parsing output: 42/ for test: sysfs_timeslice_duration
results: parsing output: 43/ for test: sriov_basic
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_invalid_mode
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: gem_create
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: i915_query
results: parsing output: 51/ for test: kms_chamelium_edid
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: core_getstats
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: prime_mmap_coherency
results: parsing output: 58/ for test: kms_pm_rpm
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: gem_exec_fence
results: parsing output: 61/ for test: gem_eio
results: parsing output: 62/ for test: i915_pm_rps
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: perf
results: parsing output: 69/ for test: gem_mmap_wc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: gem_spin_batch
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_atomic_transition
results: parsing output: 76/ for test: gem_ctx_shared
results: parsing output: 77/ for test: kms_feature_discovery
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_readwrite
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: kms_scaling_modes
results: parsing output: 85/ for test: kms_pipe_crc_basic
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: kms_plane
results: parsing output: 88/ for test: kms_cursor_edge_walk
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: dmabuf_sync_file
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_vrr
results: parsing output: 96/ for test: prime_vgem
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: gem_linear_blits
results: parsing output: 101/ for test: gem_busy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_partial_pwrite_pread
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_content_protection
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: gem_mmap_offset
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: gem_mmap_wc
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: kms_tiled_display
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: gem_exec_capture
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_color
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_atomic_transition
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: gen7_exec_parse
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: kms_async_flips
Done.