[57.286116] Initializing watchdogs
[57.286161]   /dev/watchdog0
[57.302076] [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]
[57.305888] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.308101] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.311397] [001/130] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[57.483085] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[58.335407] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.854s)
[58.534185] [002/130] (959s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[58.596185] Starting subtest: multi-wait-all-for-submit-signaled
[58.598629] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[58.706867] [003/130] (959s left) gem_exec_whisper (basic-fds)
[58.774090] Starting subtest: basic-fds
[65.869925] Subtest basic-fds: SUCCESS (7.090s)
[66.048256] [004/130] (951s left) perf_pmu (busy-hang)
[66.089248] Starting subtest: busy-hang
[66.091810] Starting dynamic subtest: rcs0
[67.385550] Dynamic subtest rcs0: SUCCESS (1.293s)
[67.395092] Starting dynamic subtest: bcs0
[68.646390] Dynamic subtest bcs0: SUCCESS (1.261s)
[68.656445] Starting dynamic subtest: vcs0
[70.442993] Dynamic subtest vcs0: SUCCESS (1.799s)
[70.454058] Starting dynamic subtest: vcs1
[72.431165] Dynamic subtest vcs1: SUCCESS (1.985s)
[72.440413] Starting dynamic subtest: vecs0
[74.418448] Dynamic subtest vecs0: SUCCESS (1.988s)
[74.427913] Starting dynamic subtest: ccs0
[75.646322] Dynamic subtest ccs0: SUCCESS (1.227s)
[75.648813] Subtest busy-hang: SUCCESS (9.554s)
[75.722857] [005/130] (942s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[75.776028] Starting subtest: etime-multi-wait-available-unsubmitted
[75.879082] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.102s)
[75.947175] [006/130] (942s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[76.008846] Starting subtest: single-wait-for-submit-available-signaled
[76.011274] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[76.087607] [007/130] (941s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[76.192791] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[76.197471] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[76.306897] [008/130] (941s left) gem_userptr_blits (dmabuf-unsync)
[76.367664] Subtest dmabuf-unsync: SKIP (0.000s)
[76.471421] [009/130] (941s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[76.565811] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[76.568089] Starting dynamic subtest: pipe-A-eDP-1
[76.625916] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[76.635650] Starting dynamic subtest: pipe-B-eDP-1
[76.693541] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[76.702576] Starting dynamic subtest: pipe-C-eDP-1
[76.760069] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[76.768454] Starting dynamic subtest: pipe-D-eDP-1
[76.826561] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[76.830814] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[78.716452] [010/130] (939s left) syncobj_timeline (reset-unsignaled)
[78.770120] Starting subtest: reset-unsignaled
[78.772680] Subtest reset-unsignaled: SUCCESS (0.000s)
[78.872330] [011/130] (939s left) syncobj_wait (multi-wait-all-signaled)
[78.930262] Starting subtest: multi-wait-all-signaled
[78.932815] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[79.020494] [012/130] (939s left) gem_ctx_sseu (mmap-args)
[79.083348] Subtest mmap-args: SKIP (0.000s)
[79.143184] [013/130] (939s left) gen3_mixed_blits
[79.247636] [014/130] (938s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[79.334030] Starting subtest: basic-max-pipe-crc-check
[79.338692] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[79.373422] [015/130] (938s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[79.474351] Starting subtest: 4-tiled-64bpp-rotate-180
[81.707992] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (2.233s)
[81.934629] [016/130] (936s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[82.052958] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[101.980183] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (19.929s)
[102.093621] [017/130] (916s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[102.213469] Starting subtest: flip-vs-cursor-busy-crc-atomic
[102.962337] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.749s)
[103.794656] [018/130] (914s left) gem_exec_params (invalid-ring2)
[103.859526] Starting subtest: invalid-ring2
[103.861948] Subtest invalid-ring2: SUCCESS (0.000s)
[103.983172] [019/130] (914s left) kms_psr (fbc-psr-sprite-plane-move)
[104.083307] Starting subtest: fbc-psr-sprite-plane-move
[104.085698] Starting dynamic subtest: eDP-1
[104.090220] Dynamic subtest eDP-1: SKIP (0.000s)
[104.094710] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[104.155692] [020/130] (914s left) api_intel_allocator (reopen-fork)
[104.220506] Starting subtest: reopen-fork
[107.497257] Subtest reopen-fork: SUCCESS (3.278s)
[107.570458] [021/130] (910s left) gem_exec_fence (syncobj-import)
[108.041693] Starting subtest: syncobj-import
[108.049085] Subtest syncobj-import: SUCCESS (0.008s)
[110.004209] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[110.007292] [022/130] (908s left) kms_psr (psr2-suspend)
[110.119142] Starting subtest: psr2-suspend
[110.121494] Starting dynamic subtest: eDP-1
[112.408579] Dynamic subtest eDP-1: FAIL (1.710s)
[112.410761] Subtest psr2-suspend: FAIL (1.711s)
[112.440436] [023/130] (906s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[112.539715] Starting subtest: x-tiled-32bpp-rotate-0
[114.235272] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.697s)
[114.521277] [024/130] (904s left) gem_ctx_shared (disjoint-timelines)
[114.582621] Starting subtest: disjoint-timelines
[114.603554] Subtest disjoint-timelines: SUCCESS (0.021s)
[114.834517] [025/130] (903s left) gem_exec_await (wide-all)
[115.000524] Starting subtest: wide-all
[138.815576] Subtest wide-all: SUCCESS (23.812s)
[139.000282] [026/130] (879s left) gem_mmap_gtt (close-race)
[139.080797] Subtest close-race: SKIP (0.000s)
[139.139198] [027/130] (879s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[139.256424] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[139.260693] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.002s)
[139.367841] [028/130] (879s left) perf_pmu (module-unload)
[139.470577] Starting subtest: module-unload
[185.295287] Subtest module-unload: SUCCESS (45.823s)
[185.315508] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[185.316216] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[185.319541] [029/130] (833s left) gem_eio (in-flight-1us)
[186.939798] Starting subtest: in-flight-1us
[194.456895] Subtest in-flight-1us: SUCCESS (7.518s)
[194.602410] [FACT gem_eio (in-flight-1us)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[194.604087] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.i915: true
[194.607493] [030/130] (824s left) i915_pm_rps (thresholds-idle-park)
[194.684202] Starting subtest: thresholds-idle-park
[194.688989] Subtest thresholds-idle-park: SKIP (0.000s)
[194.758977] [031/130] (824s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[194.869330] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[194.871975] Starting dynamic subtest: pipe-A
[194.881995] Dynamic subtest pipe-A: SKIP (0.005s)
[194.890759] Starting dynamic subtest: pipe-B
[194.900698] Dynamic subtest pipe-B: SKIP (0.018s)
[194.910646] Starting dynamic subtest: pipe-C
[194.919573] Dynamic subtest pipe-C: SKIP (0.019s)
[194.927286] Starting dynamic subtest: pipe-D
[194.936352] Dynamic subtest pipe-D: SKIP (0.018s)
[194.940571] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.062s)
[195.045101] [032/130] (823s left) gem_basic (create-close)
[195.115563] Starting subtest: create-close
[195.120310] Subtest create-close: SUCCESS (0.000s)
[195.229256] [033/130] (823s left) drm_fdinfo (virtual-busy-idle-all)
[195.268339] Starting subtest: virtual-busy-idle-all
[195.272663] Subtest virtual-busy-idle-all: SKIP (0.000s)
[195.332607] [034/130] (823s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[195.385068] Starting subtest: multi-wait-all-available-submitted-signaled
[195.387106] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[195.475228] [035/130] (823s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[195.578763] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[195.582940] Starting dynamic subtest: A-eDP1
[204.540876] Dynamic subtest A-eDP1: SUCCESS (8.960s)
[204.549928] Starting dynamic subtest: B-eDP1
[213.468978] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[213.482590] Starting dynamic subtest: C-eDP1
[222.385798] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[222.395637] Starting dynamic subtest: D-eDP1
[231.314795] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[231.319791] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.737s)
[232.526869] [036/130] (786s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[232.654624] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[243.866041] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.211s)
[244.658721] [037/130] (774s left) sriov_basic (bind-unbind-vf)
[244.720669] Starting subtest: bind-unbind-vf
[244.723082] Starting dynamic subtest: vf-1
[244.798276] Dynamic subtest vf-1: FAIL (0.006s)
[244.808146] Starting dynamic subtest: vf-2
[244.882883] Dynamic subtest vf-2: FAIL (0.003s)
[244.893057] Starting dynamic subtest: vf-3
[244.969564] Dynamic subtest vf-3: FAIL (0.003s)
[244.979208] Starting dynamic subtest: vf-4
[245.052549] Dynamic subtest vf-4: FAIL (0.003s)
[245.061484] Starting dynamic subtest: vf-5
[245.134915] Dynamic subtest vf-5: FAIL (0.003s)
[245.144215] Starting dynamic subtest: vf-6
[245.218416] Dynamic subtest vf-6: FAIL (0.003s)
[245.226352] Starting dynamic subtest: vf-7
[245.301062] Dynamic subtest vf-7: FAIL (0.003s)
[245.310527] Starting dynamic subtest: vf-random
[245.382750] Dynamic subtest vf-random: FAIL (0.003s)
[245.391079] Starting dynamic subtest: vf-last
[245.460392] Dynamic subtest vf-last: FAIL (0.516s)
[245.462579] Subtest bind-unbind-vf: FAIL (0.549s)
[245.491098] [038/130] (773s left) i915_fb_tiling (basic-x-tiling)
[245.551953] Subtest basic-x-tiling: SKIP (0.000s)
[245.611103] [039/130] (773s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[245.717469] Starting subtest: psr-rgb565-draw-mmap-cpu
[250.214125] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (4.497s)
[250.306662] [040/130] (768s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[250.413646] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[255.666686] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (5.255s)
[255.817538] [041/130] (763s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[255.930191] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[258.980605] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.055s)
[259.134685] [042/130] (760s left) kms_vrr (flip-basic)
[259.245085] Starting subtest: flip-basic
[259.251815] Subtest flip-basic: SKIP (0.000s)
[259.310286] [043/130] (759s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[259.410094] Starting subtest: 2x-absolute-wf_vblank-interruptible
[259.422912] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[259.495417] [044/130] (759s left) syncobj_wait (invalid-signal-one-illegal-handle)
[259.546457] Starting subtest: invalid-signal-one-illegal-handle
[259.548574] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[259.646472] [045/130] (759s left) gem_create (hog-create)
[259.706114] Starting subtest: hog-create
[259.708147] Starting dynamic subtest: smem0
[293.011609] Dynamic subtest smem0: SUCCESS (33.302s)
[293.014645] Subtest hog-create: SUCCESS (33.303s)
[293.196011] [046/130] (726s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[293.286264] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[293.288504] Starting dynamic subtest: pipe-A
[293.297830] Dynamic subtest pipe-A: SKIP (0.004s)
[293.307678] Starting dynamic subtest: pipe-B
[293.316501] Dynamic subtest pipe-B: SKIP (0.014s)
[293.324895] Starting dynamic subtest: pipe-C
[293.333582] Dynamic subtest pipe-C: SKIP (0.015s)
[293.341560] Starting dynamic subtest: pipe-D
[293.349247] Dynamic subtest pipe-D: SKIP (0.015s)
[293.353587] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.050s)
[293.431915] [047/130] (725s left) gem_basic (multigpu-create-close)
[293.492083] Starting subtest: multigpu-create-close
[293.496596] Subtest multigpu-create-close: SKIP (0.000s)
[293.590103] [048/130] (725s left) gem_spin_batch (resubmit)
[293.650248] Starting subtest: resubmit
[293.652537] Starting dynamic subtest: rcs0
[293.656995] Dynamic subtest rcs0: SUCCESS (0.007s)
[293.665991] Starting dynamic subtest: bcs0
[293.668438] Dynamic subtest bcs0: SUCCESS (0.002s)
[293.677271] Starting dynamic subtest: vcs0
[293.679395] Dynamic subtest vcs0: SUCCESS (0.002s)
[293.687296] Starting dynamic subtest: vcs1
[293.689458] Dynamic subtest vcs1: SUCCESS (0.002s)
[293.697326] Starting dynamic subtest: vecs0
[293.699528] Dynamic subtest vecs0: SUCCESS (0.002s)
[293.707579] Starting dynamic subtest: ccs0
[293.709833] Dynamic subtest ccs0: SUCCESS (0.002s)
[293.712094] Subtest resubmit: SUCCESS (0.019s)
[293.913589] [049/130] (725s left) gem_caching (reads)
[293.976507] Subtest reads: SKIP (0.000s)
[294.033023] [050/130] (725s left) gem_userptr_blits (coherency-sync)
[294.108072] Starting subtest: coherency-sync
[294.310675] Subtest coherency-sync: SKIP (0.162s)
[294.409852] [051/130] (725s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[294.579285] Starting subtest: cursorA-vs-flipB-atomic
[294.583274] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[294.706196] [052/130] (724s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[294.801085] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[294.805699] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[295.901577] [053/130] (723s left) gem_exec_fence (concurrent)
[296.075819] Starting subtest: concurrent
[296.080517] Subtest concurrent: SKIP (0.000s)
[297.985670] [054/130] (721s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[298.083089] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[298.085365] Starting dynamic subtest: pipe-A-eDP-1
[299.343357] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.259s)
[299.352346] Starting dynamic subtest: pipe-B-eDP-1
[301.642764] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.298s)
[301.652592] Starting dynamic subtest: pipe-C-eDP-1
[303.973213] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.329s)
[303.981268] Starting dynamic subtest: pipe-D-eDP-1
[306.292816] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.318s)
[306.295228] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.209s)
[307.412935] [055/130] (712s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[307.511116] Starting subtest: fbc-psr2-sprite-plane-onoff
[307.513471] Starting dynamic subtest: eDP-1
[307.517624] Dynamic subtest eDP-1: SKIP (0.000s)
[307.521822] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[307.578527] [056/130] (712s left) kms_psr (psr2-sprite-mmap-gtt)
[307.678252] Starting subtest: psr2-sprite-mmap-gtt
[307.680610] Starting dynamic subtest: eDP-1
[309.109833] Dynamic subtest eDP-1: SKIP (1.429s)
[309.115110] Subtest psr2-sprite-mmap-gtt: SKIP (1.431s)
[309.257891] [057/130] (710s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[309.362140] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[309.366125] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[309.463376] [058/130] (710s left) kms_async_flips (test-cursor-atomic)
[309.561101] Starting subtest: test-cursor-atomic
[309.565377] Subtest test-cursor-atomic: SKIP (0.000s)
[310.762436] [059/130] (708s left) kms_psr (fbc-pr-primary-mmap-gtt)
[310.864977] Starting subtest: fbc-pr-primary-mmap-gtt
[310.869470] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[310.930503] [060/130] (708s left) kms_joiner (basic-ultra-joiner)
[311.028581] Starting subtest: basic-ultra-joiner
[311.032980] Subtest basic-ultra-joiner: SKIP (0.000s)
[311.085940] [061/130] (708s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[311.194614] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[311.199271] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[311.286355] [062/130] (708s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[311.533497] Starting subtest: cursor-rapid-movement-256x85
[311.571062] Subtest cursor-rapid-movement-256x85: SKIP (0.032s)
[311.752671] [063/130] (708s left) gem_exec_reloc (basic-gtt-wc-active)
[311.816064] Subtest basic-gtt-wc-active: SKIP (0.000s)
[311.889291] [064/130] (708s left) kms_vblank (ts-continuation-modeset-rpm)
[311.985701] Starting subtest: ts-continuation-modeset-rpm
[311.987639] Starting dynamic subtest: pipe-A-eDP-1
[314.458718] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.470s)
[314.473805] Starting dynamic subtest: pipe-D-eDP-1
[316.703795] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.243s)
[316.706212] Subtest ts-continuation-modeset-rpm: SUCCESS (4.717s)
[317.477934] [065/130] (702s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[317.592396] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[317.594796] Starting dynamic subtest: pipe-A-eDP-1
[317.619568] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[317.629543] Starting dynamic subtest: pipe-B-eDP-1
[317.651969] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[317.665977] Starting dynamic subtest: pipe-C-eDP-1
[317.688588] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[317.697672] Starting dynamic subtest: pipe-D-eDP-1
[317.721808] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[317.726501] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[319.738602] [066/130] (700s left) syncobj_wait (wait-any-interrupted)
[319.809531] Starting subtest: wait-any-interrupted
[319.913954] Subtest wait-any-interrupted: SUCCESS (0.102s)
[319.983310] [067/130] (700s left) gem_exec_schedule (submit-late-slice)
[320.073084] Starting subtest: submit-late-slice
[320.075016] Starting dynamic subtest: rcs0
[320.101692] Dynamic subtest rcs0: SUCCESS (0.037s)
[320.112917] Starting dynamic subtest: bcs0
[320.138117] Dynamic subtest bcs0: SUCCESS (0.036s)
[320.151894] Starting dynamic subtest: vcs0
[320.175256] Dynamic subtest vcs0: SUCCESS (0.036s)
[320.184780] Starting dynamic subtest: vcs1
[320.212681] Dynamic subtest vcs1: SUCCESS (0.037s)
[320.222931] Starting dynamic subtest: vecs0
[320.244706] Dynamic subtest vecs0: SUCCESS (0.031s)
[320.256467] Starting dynamic subtest: ccs0
[320.282433] Dynamic subtest ccs0: SUCCESS (0.037s)
[320.284926] Subtest submit-late-slice: SUCCESS (0.218s)
[322.040337] [068/130] (698s left) kms_draw_crc (fill-fb)
[322.145898] Starting subtest: fill-fb
[322.571540] Subtest fill-fb: SUCCESS (0.428s)
[322.692968] [069/130] (697s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[322.793070] Starting subtest: bad-aux-stride-y-tiled-ccs
[322.795381] Starting dynamic subtest: pipe-A-eDP-1
[322.819809] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[322.829152] Starting dynamic subtest: pipe-B-eDP-1
[322.850853] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[322.858372] Starting dynamic subtest: pipe-C-eDP-1
[322.880206] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[322.887561] Starting dynamic subtest: pipe-D-eDP-1
[322.909463] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[322.913882] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[324.893108] [070/130] (695s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[325.009558] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[325.013901] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[325.115645] [071/130] (695s left) gem_exec_balancer (nop)
[325.172815] Starting subtest: nop
[371.650558] Subtest nop: SUCCESS (46.476s)
[371.936487] [072/130] (648s left) kms_flip (bo-too-big-interruptible)
[372.044688] Starting subtest: bo-too-big-interruptible
[372.046941] Starting dynamic subtest: A-eDP1
[373.761169] Dynamic subtest A-eDP1: SUCCESS (1.714s)
[373.771888] Starting dynamic subtest: B-eDP1
[375.488928] Dynamic subtest B-eDP1: SUCCESS (1.726s)
[375.498623] Starting dynamic subtest: C-eDP1
[377.213067] Dynamic subtest C-eDP1: SUCCESS (1.723s)
[377.222849] Starting dynamic subtest: D-eDP1
[378.946061] Dynamic subtest D-eDP1: SUCCESS (1.732s)
[378.951240] Subtest bo-too-big-interruptible: SUCCESS (6.904s)
[380.110647] [073/130] (640s left) gem_gpgpu_fill (offset-16x16)
[380.173377] Starting subtest: offset-16x16
[380.179508] Subtest offset-16x16: SUCCESS (0.007s)
[380.303353] [074/130] (639s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[380.404440] Starting subtest: fbcpsr-tiling-y
[380.408663] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[380.528468] [075/130] (639s left) gem_exec_flush (basic-uc-set-default)
[380.588868] Starting subtest: basic-uc-set-default
[386.060359] Subtest basic-uc-set-default: SUCCESS (5.471s)
[386.244544] [076/130] (634s left) gem_exec_flush (basic-wb-pro-default)
[386.313056] Starting subtest: basic-wb-pro-default
[391.799457] Subtest basic-wb-pro-default: SUCCESS (5.486s)
[391.983684] [077/130] (628s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[392.096204] Starting subtest: primary-yf-tiled-reflect-x-90
[392.100959] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[392.165877] [078/130] (628s left) api_intel_bb (render)
[392.233324] Starting subtest: render
[392.235131] Starting dynamic subtest: render-none-512
[392.334845] Dynamic subtest render-none-512: SUCCESS (0.102s)
[392.345926] Starting dynamic subtest: render-none-1024
[392.709232] Dynamic subtest render-none-1024: SUCCESS (0.372s)
[392.720300] Starting dynamic subtest: render-x-512
[392.794353] Dynamic subtest render-x-512: SUCCESS (0.085s)
[392.805439] Starting dynamic subtest: render-x-1024
[393.130072] Dynamic subtest render-x-1024: SUCCESS (0.335s)
[393.141561] Starting dynamic subtest: render-y-512
[393.215609] Dynamic subtest render-y-512: SUCCESS (0.084s)
[393.225221] Starting dynamic subtest: render-y-1024
[393.553019] Dynamic subtest render-y-1024: SUCCESS (0.335s)
[393.555526] Subtest render: SUCCESS (1.319s)
[393.685590] [079/130] (626s left) drm_fdinfo (all-busy-idle-check-all)
[393.726997] Starting subtest: all-busy-idle-check-all
[393.734500] Subtest all-busy-idle-check-all: SKIP (0.004s)
[393.794449] [080/130] (626s left) gem_exec_create (basic)
[393.901034] Starting subtest: basic
[393.903535] Starting dynamic subtest: smem
[395.996689] Dynamic subtest smem: SUCCESS (2.096s)
[395.999206] Subtest basic: SUCCESS (2.097s)
[396.174109] [081/130] (624s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[396.285087] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[396.289080] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[396.390115] [082/130] (624s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[396.502619] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[396.507092] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[396.604048] [083/130] (624s left) gem_exec_schedule (lateslice)
[396.684230] Starting subtest: lateslice
[396.686545] Starting dynamic subtest: rcs0
[396.694223] Dynamic subtest rcs0: SUCCESS (0.021s)
[396.709239] Starting dynamic subtest: bcs0
[396.714421] Dynamic subtest bcs0: SUCCESS (0.017s)
[396.722730] Starting dynamic subtest: vcs0
[396.731265] Dynamic subtest vcs0: SUCCESS (0.019s)
[396.739202] Starting dynamic subtest: vcs1
[396.749238] Dynamic subtest vcs1: SUCCESS (0.017s)
[396.757160] Starting dynamic subtest: vecs0
[396.767680] Dynamic subtest vecs0: SUCCESS (0.018s)
[396.775985] Starting dynamic subtest: ccs0
[396.786257] Dynamic subtest ccs0: SUCCESS (0.018s)
[396.788603] Subtest lateslice: SUCCESS (0.114s)
[398.036428] [084/130] (622s left) syncobj_basic (bad-pad-fd-to-handle)
[398.104796] Starting subtest: bad-pad-fd-to-handle
[398.107161] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[398.215413] [085/130] (622s left) gen9_exec_parse (allowed-all)
[398.283300] Subtest allowed-all: SKIP (0.000s)
[398.370513] [086/130] (622s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[398.456134] Starting subtest: multiplane-rotation-cropping-bottom
[405.659906] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.204s)
[405.769307] [087/130] (614s left) vgem_basic (debugfs)
[405.817069] Starting subtest: debugfs
[405.818701] Subtest debugfs: SUCCESS (0.000s)
[405.868388] [088/130] (614s left) kms_content_protection (atomic-dpms)
[406.039153] Starting subtest: atomic-dpms
[409.439316] Subtest atomic-dpms: SKIP (3.397s)
[410.608947] [089/130] (610s left) syncobj_timeline (host-signal-ordered)
[410.672883] Starting subtest: host-signal-ordered
[410.675644] Subtest host-signal-ordered: SUCCESS (0.000s)
[410.767449] [090/130] (610s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[415.754882] Starting subtest: pr-overlay-plane-move-continuous-sf
[415.759648] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[416.611157] [091/130] (604s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[416.727321] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[416.731591] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[416.831472] [092/130] (604s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[416.929107] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[416.931501] Starting dynamic subtest: pipe-A
[416.947826] Dynamic subtest pipe-A: SKIP (0.013s)
[416.956726] Starting dynamic subtest: pipe-B
[416.974343] Dynamic subtest pipe-B: SKIP (0.024s)
[416.984853] Starting dynamic subtest: pipe-C
[416.997409] Dynamic subtest pipe-C: SKIP (0.024s)
[417.007379] Starting dynamic subtest: pipe-D
[417.023296] Dynamic subtest pipe-D: SKIP (0.024s)
[417.027428] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.088s)
[417.096180] [093/130] (603s left) kms_cursor_crc (cursor-offscreen-64x21)
[417.276388] Starting subtest: cursor-offscreen-64x21
[417.313681] Subtest cursor-offscreen-64x21: SKIP (0.033s)
[417.549031] [094/130] (603s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[417.658166] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[418.471556] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.814s)
[418.669909] [095/130] (602s left) gem_exec_create (forked)
[418.730861] Starting subtest: forked
[418.733357] Starting dynamic subtest: smem
[438.933147] Dynamic subtest smem: SUCCESS (20.201s)
[438.935470] Subtest forked: SUCCESS (20.202s)
[439.114911] [096/130] (581s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[439.513109] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[440.310121] [097/130] (580s left) kms_chamelium_frames (dp-crc-fast)
[440.699467] Subtest dp-crc-fast: SKIP (0.000s)
[441.530984] [098/130] (579s left) gem_mmap_offset (clear-via-pagefault)
[441.595199] Starting subtest: clear-via-pagefault
[441.597339] Starting dynamic subtest: smem0
[501.301595] Dynamic subtest smem0: SUCCESS (59.699s)
[501.303677] Subtest clear-via-pagefault: SUCCESS (59.701s)
[501.617066] [099/130] (519s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[501.733049] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[501.737699] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[501.839037] [100/130] (519s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[501.939533] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[501.943615] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[502.039642] [101/130] (519s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[502.141216] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[502.145142] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[502.225389] [102/130] (519s left) kms_draw_crc (draw-method-mmap-cpu)
[502.321126] Starting subtest: draw-method-mmap-cpu
[502.323248] Starting dynamic subtest: xrgb8888-untiled
[502.537045] Dynamic subtest xrgb8888-untiled: SUCCESS (0.217s)
[502.545958] Starting dynamic subtest: rgb565-untiled
[502.769850] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[502.778348] Starting dynamic subtest: xrgb2101010-untiled
[502.958995] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.188s)
[502.967356] Starting dynamic subtest: xbgr16161616f-untiled
[503.191764] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[503.202205] Starting dynamic subtest: xrgb8888-xtiled
[503.314423] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[503.323041] Starting dynamic subtest: rgb565-xtiled
[503.447786] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[503.456390] Starting dynamic subtest: xrgb2101010-xtiled
[503.569977] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[503.578248] Starting dynamic subtest: xbgr16161616f-xtiled
[503.692114] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[503.700316] Starting dynamic subtest: xrgb8888-4tiled
[503.836628] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[503.844775] Starting dynamic subtest: rgb565-4tiled
[503.958815] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[503.967295] Starting dynamic subtest: xrgb2101010-4tiled
[504.092069] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[504.100328] Starting dynamic subtest: xbgr16161616f-4tiled
[504.236646] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[504.238393] Subtest draw-method-mmap-cpu: SUCCESS (1.918s)
[504.337173] [103/130] (516s left) kms_cursor_edge_walk (128x128-top-bottom)
[504.440742] Starting subtest: 128x128-top-bottom
[504.442679] Starting dynamic subtest: pipe-A-eDP-1
[507.904665] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[507.913890] Starting dynamic subtest: pipe-D-eDP-1
[511.005774] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.098s)
[511.008162] Subtest 128x128-top-bottom: SUCCESS (6.562s)
[511.828965] [104/130] (509s left) kms_plane_alpha_blend (constant-alpha-min)
[511.929149] Starting subtest: constant-alpha-min
[512.338787] Starting dynamic subtest: pipe-A-eDP-1
[513.043551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[513.053836] Starting dynamic subtest: pipe-D-eDP-1
[514.477814] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.437s)
[514.480146] Subtest constant-alpha-min: SUCCESS (2.547s)
[515.280251] [105/130] (506s left) gem_ctx_isolation (preservation)
[515.347785] Starting subtest: preservation
[515.350071] Starting dynamic subtest: rcs0
[515.601696] Dynamic subtest rcs0: SUCCESS (0.252s)
[515.613451] Starting dynamic subtest: bcs0
[515.874640] Dynamic subtest bcs0: SUCCESS (0.272s)
[515.884763] Starting dynamic subtest: vcs0
[516.176555] Dynamic subtest vcs0: SUCCESS (0.301s)
[516.188322] Starting dynamic subtest: vcs1
[518.189754] Dynamic subtest vcs1: SUCCESS (2.012s)
[518.201726] Starting dynamic subtest: vecs0
[520.195333] Dynamic subtest vecs0: SUCCESS (2.004s)
[520.207655] Starting dynamic subtest: ccs0
[522.152185] Dynamic subtest ccs0: SUCCESS (1.957s)
[522.155661] Subtest preservation: SUCCESS (6.802s)
[522.409709] [106/130] (499s left) sysfs_preempt_timeout (timeout)
[522.479019] Starting subtest: timeout
[522.481313] Starting dynamic subtest: vecs0
[531.970284] Dynamic subtest vecs0: SUCCESS (9.487s)
[531.981292] Starting dynamic subtest: ccs0
[533.326922] Dynamic subtest ccs0: SUCCESS (1.358s)
[533.337055] Starting dynamic subtest: vcs0
[542.971061] Dynamic subtest vcs0: SUCCESS (9.639s)
[542.982475] Starting dynamic subtest: bcs0
[544.256146] Dynamic subtest bcs0: SUCCESS (1.285s)
[544.265832] Starting dynamic subtest: rcs0
[545.612748] Dynamic subtest rcs0: SUCCESS (1.353s)
[545.623843] Starting dynamic subtest: vcs1
[554.945686] Dynamic subtest vcs1: SUCCESS (9.329s)
[554.948313] Subtest timeout: SUCCESS (32.462s)
[555.013388] [107/130] (466s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[555.107332] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[555.111647] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[555.205740] [108/130] (466s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[555.276801] Starting subtest: x-tiled-to-vebox-y-tiled
[555.281944] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[555.455327] [109/130] (466s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[555.558464] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[555.562764] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[555.641502] [110/130] (465s left) i915_pm_freq_api (freq-basic-api)
[555.696454] Starting subtest: freq-basic-api
[555.698800] Starting dynamic subtest: gt0
[555.701020] Dynamic subtest gt0: SUCCESS (0.003s)
[555.710682] Starting dynamic subtest: gt1
[555.712575] Dynamic subtest gt1: SUCCESS (0.003s)
[555.714407] Subtest freq-basic-api: SUCCESS (0.007s)
[555.801989] [111/130] (465s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[555.905429] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[555.909745] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[555.988965] [112/130] (465s left) gem_exec_reloc (basic-gtt-cpu)
[556.050557] Subtest basic-gtt-cpu: SKIP (0.000s)
[556.111189] [113/130] (465s left) gem_exec_reloc (basic-wc-cpu-active)
[556.169719] Subtest basic-wc-cpu-active: SKIP (0.000s)
[556.238465] [114/130] (465s left) gem_softpin (evict-prime-sanity-check)
[556.294570] Starting subtest: evict-prime-sanity-check
[556.296931] Starting dynamic subtest: rcs0
[557.447091] Dynamic subtest rcs0: SUCCESS (1.152s)
[557.459126] Starting dynamic subtest: bcs0
[558.574389] Dynamic subtest bcs0: SUCCESS (1.126s)
[558.590343] Starting dynamic subtest: vcs0
[559.928376] Dynamic subtest vcs0: SUCCESS (1.351s)
[559.939590] Starting dynamic subtest: vcs1
[561.931677] Dynamic subtest vcs1: SUCCESS (2.001s)
[561.944235] Starting dynamic subtest: vecs0
[563.928366] Dynamic subtest vecs0: SUCCESS (1.995s)
[563.940412] Starting dynamic subtest: ccs0
[565.123474] Dynamic subtest ccs0: SUCCESS (1.193s)
[565.134206] Starting dynamic subtest: all
[566.274436] Dynamic subtest all: SUCCESS (1.149s)
[566.277050] Subtest evict-prime-sanity-check: SUCCESS (9.980s)
[566.349298] [115/130] (455s left) gem_userptr_blits (readonly-pwrite-unsync)
[566.423633] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[566.559424] [116/130] (455s left) kms_color (ctm-red-to-blue)
[566.674388] Starting subtest: ctm-red-to-blue
[566.676645] Starting dynamic subtest: pipe-A-eDP-1
[567.376229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[567.386488] Starting dynamic subtest: pipe-B-eDP-1
[568.768867] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s)
[568.777671] Starting dynamic subtest: pipe-C-eDP-1
[570.129671] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.359s)
[570.139214] Starting dynamic subtest: pipe-D-eDP-1
[571.462904] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[571.464932] Subtest ctm-red-to-blue: SUCCESS (4.786s)
[572.283965] [117/130] (449s left) gem_pxp (create-protected-buffer)
[572.411729] Starting subtest: create-protected-buffer
[572.414150] Subtest create-protected-buffer: SUCCESS (0.000s)
[572.529252] [118/130] (449s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[572.641213] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[577.350360] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.711s)
[577.489252] [119/130] (444s left) kms_addfb_basic (basic-x-tiled-legacy)
[577.548605] Starting subtest: basic-x-tiled-legacy
[577.553402] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[577.683800] [120/130] (444s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[577.793402] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[582.297942] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (4.507s)
[582.414883] [121/130] (439s left) gem_close (many-handles-one-vma)
[582.490976] Starting subtest: many-handles-one-vma
[582.516759] Subtest many-handles-one-vma: SUCCESS (0.025s)
[582.652009] [122/130] (439s left) kms_flip_event_leak (basic)
[582.759799] Starting subtest: basic
[582.761655] Starting dynamic subtest: pipe-A-eDP-1
[583.201892] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[583.211783] Starting dynamic subtest: pipe-B-eDP-1
[584.335081] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.134s)
[584.344968] Starting dynamic subtest: pipe-C-eDP-1
[585.438197] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.100s)
[585.451320] Starting dynamic subtest: pipe-D-eDP-1
[586.563231] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[586.565470] Subtest basic: SUCCESS (3.805s)
[587.403424] [123/130] (434s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[587.515235] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[587.517683] Starting dynamic subtest: pipe-A-default-mode
[590.214763] Dynamic subtest pipe-A-default-mode: SUCCESS (2.697s)
[590.217211] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.698s)
[591.077630] [124/130] (430s left) gem_exec_schedule (preempt-queue)
[591.144423] Subtest preempt-queue: SKIP (0.000s)
[591.432196] [125/130] (430s left) gem_userptr_blits (create-destroy-unsync)
[591.501456] Subtest create-destroy-unsync: SKIP (0.000s)
[591.634751] [126/130] (430s left) kms_prime (basic-modeset-hybrid)
[593.745863] Subtest basic-modeset-hybrid: SKIP (0.000s)
[593.818835] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.amdgpu: true
[593.819487] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.xe: true
[593.822452] [127/130] (428s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[598.845991] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[598.850705] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[599.688314] [128/130] (422s left) gem_softpin (overlap)
[599.753159] Starting subtest: overlap
[600.597338] Subtest overlap: SUCCESS (0.842s)
[600.737650] [129/130] (421s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[600.831588] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[600.835752] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[600.918271] [130/130] (421s left) gem_eio (in-flight-contexts-10ms)
[601.143866] Starting subtest: in-flight-contexts-10ms
[612.923800] Subtest in-flight-contexts-10ms: SUCCESS (11.779s)
[613.079150] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: gem_exec_whisper
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: gem_ctx_sseu
results: parsing output: 12/ for test: gen3_mixed_blits
results: parsing output: 13/ for test: kms_multipipe_modeset
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: api_intel_allocator
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_ctx_shared
results: parsing output: 24/ for test: gem_exec_await
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: gem_eio
results: parsing output: 29/ for test: i915_pm_rps
results: parsing output: 30/ for test: kms_plane_scaling
results: parsing output: 31/ for test: gem_basic
results: parsing output: 32/ for test: drm_fdinfo
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: sriov_basic
results: parsing output: 37/ for test: i915_fb_tiling
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_vrr
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: gem_create
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: gem_basic
results: parsing output: 47/ for test: gem_spin_batch
results: parsing output: 48/ for test: gem_caching
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_async_flips
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_joiner
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_draw_crc
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_gpgpu_fill
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_flush
results: parsing output: 75/ for test: gem_exec_flush
results: parsing output: 76/ for test: kms_rotation_crc
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: drm_fdinfo
results: parsing output: 79/ for test: gem_exec_create
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: syncobj_basic
results: parsing output: 84/ for test: gen9_exec_parse
results: parsing output: 85/ for test: kms_rotation_crc
results: parsing output: 86/ for test: vgem_basic
results: parsing output: 87/ for test: kms_content_protection
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_exec_create
results: parsing output: 95/ for test: kms_chamelium_frames
results: parsing output: 96/ for test: kms_chamelium_frames
results: parsing output: 97/ for test: gem_mmap_offset
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_draw_crc
results: parsing output: 102/ for test: kms_cursor_edge_walk
results: parsing output: 103/ for test: kms_plane_alpha_blend
results: parsing output: 104/ for test: gem_ctx_isolation
results: parsing output: 105/ for test: sysfs_preempt_timeout
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: i915_pm_freq_api
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: gem_softpin
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: kms_color
results: parsing output: 116/ for test: gem_pxp
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_addfb_basic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_close
results: parsing output: 121/ for test: kms_flip_event_leak
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_prime
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_eio
Done.