[56.269485] Initializing watchdogs
[56.269542]   /dev/watchdog0
[56.281955] [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]
[56.286314] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.288331] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.291560] [001/130] (960s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[56.443282] Starting subtest: addfb25-yf-tiled-legacy
[56.445126] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[56.542523] [002/130] (960s left) kms_cdclk (mode-transition)
[56.639971] Starting subtest: mode-transition
[56.642433] Starting dynamic subtest: pipe-A-eDP-1
[56.930448] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[56.937510] Starting dynamic subtest: pipe-B-eDP-1
[56.942152] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[56.949858] Starting dynamic subtest: pipe-C-eDP-1
[56.954795] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[56.962605] Starting dynamic subtest: pipe-D-eDP-1
[56.966937] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[56.971289] Subtest mode-transition: SKIP (0.291s)
[57.765520] [003/130] (959s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[57.865646] Starting subtest: primary-y-tiled-reflect-x-180
[57.927526] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[58.020230] [004/130] (958s left) gem_mmap_offset (bad-flags)
[58.081230] Starting subtest: bad-flags
[58.083634] Subtest bad-flags: SUCCESS (0.000s)
[58.185230] [005/130] (958s left) gem_userptr_blits (invalid-null-pointer)
[58.243053] Starting subtest: invalid-null-pointer
[58.245496] Subtest invalid-null-pointer: SUCCESS (0.001s)
[58.367883] [006/130] (958s left) kms_fbcon_fbt (psr)
[58.418960] Starting subtest: psr
[63.808670] Subtest psr: SUCCESS (5.390s)
[63.884705] [007/130] (953s left) gem_ctx_persistence (legacy-engines-persistence)
[63.946430] Starting subtest: legacy-engines-persistence
[63.948717] Starting dynamic subtest: render
[64.765854] Dynamic subtest render: SUCCESS (0.818s)
[64.775298] Starting dynamic subtest: bsd1
[65.535522] Dynamic subtest bsd1: SUCCESS (0.769s)
[65.545212] Starting dynamic subtest: bsd2
[66.296343] Dynamic subtest bsd2: SUCCESS (0.760s)
[66.305344] Starting dynamic subtest: blt
[67.082970] Dynamic subtest blt: SUCCESS (0.786s)
[67.092829] Starting dynamic subtest: vebox
[67.907121] Dynamic subtest vebox: SUCCESS (0.823s)
[67.909860] Subtest legacy-engines-persistence: SUCCESS (3.960s)
[67.980901] [008/130] (949s left) gem_exec_flush (basic-uc-prw-default)
[68.048419] Starting subtest: basic-uc-prw-default
[73.541092] Subtest basic-uc-prw-default: SUCCESS (5.492s)
[73.720767] [009/130] (943s left) kms_big_fb (linear-16bpp-rotate-90)
[73.837372] Starting subtest: linear-16bpp-rotate-90
[73.856452] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[73.981656] [010/130] (943s left) gem_mmap_gtt (flink-race)
[74.046606] Subtest flink-race: SKIP (0.000s)
[74.090585] [011/130] (943s left) kms_cursor_edge_walk (64x64-top-edge)
[74.187750] Starting subtest: 64x64-top-edge
[74.190149] Starting dynamic subtest: pipe-A-eDP-1
[77.672661] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.483s)
[77.680748] Starting dynamic subtest: pipe-D-eDP-1
[80.780088] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.106s)
[80.782120] Subtest 64x64-top-edge: SUCCESS (6.590s)
[81.590526] [012/130] (935s left) kms_plane_scaling (planes-upscale-factor-0-25)
[81.689071] Starting subtest: planes-upscale-factor-0-25
[81.691483] Starting dynamic subtest: pipe-A
[81.753475] Dynamic subtest pipe-A: SUCCESS (0.064s)
[81.759764] Starting dynamic subtest: pipe-B
[82.923178] Dynamic subtest pipe-B: SUCCESS (1.170s)
[82.933392] Starting dynamic subtest: pipe-C
[84.029490] Dynamic subtest pipe-C: SUCCESS (1.106s)
[84.035903] Starting dynamic subtest: pipe-D
[85.162572] Dynamic subtest pipe-D: SUCCESS (1.133s)
[85.165043] Subtest planes-upscale-factor-0-25: SUCCESS (3.474s)
[86.299955] [013/130] (930s left) kms_busy (basic)
[86.399544] Starting subtest: basic
[86.401800] Starting dynamic subtest: flip
[87.013181] Dynamic subtest flip: SUCCESS (0.611s)
[87.020534] Starting dynamic subtest: modeset
[90.428782] Dynamic subtest modeset: SUCCESS (3.414s)
[90.431368] Subtest basic: SUCCESS (4.026s)
[91.217991] [014/130] (925s left) drm_fdinfo (virtual-busy-idle-all)
[91.260770] Starting subtest: virtual-busy-idle-all
[91.265276] Subtest virtual-busy-idle-all: SKIP (0.000s)
[91.313510] [015/130] (925s left) i915_pm_rc6_residency (rc6-accuracy)
[91.375524] Starting subtest: rc6-accuracy
[91.377914] Starting dynamic subtest: gt0
[94.553284] Dynamic subtest gt0: SUCCESS (3.168s)
[94.561793] Starting dynamic subtest: gt1
[97.715527] Dynamic subtest gt1: SUCCESS (3.168s)
[97.718115] Subtest rc6-accuracy: SUCCESS (6.337s)
[97.777059] [016/130] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[97.888321] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[97.892536] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[97.989388] [017/130] (919s left) api_intel_bb (intel-bb-blit-x)
[98.046818] Starting subtest: intel-bb-blit-x
[101.473617] Subtest intel-bb-blit-x: SUCCESS (3.427s)
[101.597763] [018/130] (915s left) prime_mmap_kms (buffer-sharing)
[101.698985] Starting subtest: buffer-sharing
[102.146726] Subtest buffer-sharing: SUCCESS (0.445s)
[102.942939] [019/130] (914s left) gem_mmap_gtt (basic-small-bo)
[103.000535] Subtest basic-small-bo: SKIP (0.000s)
[103.050505] [020/130] (914s left) kms_cursor_crc (cursor-random-512x170)
[103.310542] Starting subtest: cursor-random-512x170
[103.315441] Subtest cursor-random-512x170: SKIP (0.001s)
[103.460602] [021/130] (913s left) gem_ctx_param (invalid-ctx-set)
[103.522636] Starting subtest: invalid-ctx-set
[103.525092] Subtest invalid-ctx-set: SUCCESS (0.001s)
[103.624032] [022/130] (913s left) syncobj_wait (signal)
[103.679085] Starting subtest: signal
[103.681431] Subtest signal: SUCCESS (0.000s)
[103.784331] [023/130] (913s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render)
[103.893962] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render
[108.666626] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SUCCESS (4.775s)
[108.818532] [024/130] (908s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[108.919283] Starting subtest: plane-use-after-nonblocking-unbind
[108.921519] Starting dynamic subtest: pipe-A-eDP-1
[108.990160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.070s)
[109.276871] Starting dynamic subtest: pipe-B-eDP-1
[110.094770] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.826s)
[110.371550] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.451s)
[111.239086] [025/130] (906s left) kms_addfb_basic (bad-pitch-63)
[111.299844] Starting subtest: bad-pitch-63
[111.302224] Subtest bad-pitch-63: SUCCESS (0.000s)
[111.452965] [026/130] (906s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[111.558633] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[111.563208] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[111.641439] [027/130] (905s left) kms_async_flips (test-time-stamp)
[111.739362] Starting subtest: test-time-stamp
[112.110951] Starting dynamic subtest: pipe-A-eDP-1
[112.942837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.829s)
[113.304875] Starting dynamic subtest: pipe-B-eDP-1
[114.069652] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.769s)
[114.430213] Starting dynamic subtest: pipe-C-eDP-1
[115.192150] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[115.549579] Starting dynamic subtest: pipe-D-eDP-1
[116.317983] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[116.320530] Subtest test-time-stamp: SUCCESS (4.576s)
[117.461977] [028/130] (900s left) kms_plane (planar-pixel-format-settings)
[117.556933] Starting subtest: planar-pixel-format-settings
[117.584576] Subtest planar-pixel-format-settings: SUCCESS (0.026s)
[117.657867] [029/130] (899s left) kms_feature_discovery (display)
[117.748880] Starting subtest: display
[117.751210] Subtest display: SUCCESS (0.000s)
[117.811862] [030/130] (899s left) gem_pxp (regular-baseline-src-copy-readible)
[117.935960] Starting subtest: regular-baseline-src-copy-readible
[117.993956] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[118.111164] [031/130] (899s left) kms_psr (fbc-psr-dpms)
[118.209428] Starting subtest: fbc-psr-dpms
[118.211408] Starting dynamic subtest: eDP-1
[118.215667] Dynamic subtest eDP-1: SKIP (0.000s)
[118.219927] Subtest fbc-psr-dpms: SKIP (0.001s)
[118.271239] [032/130] (899s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[118.351661] Subtest tiled-to-tiled: SKIP (0.000s)
[118.413555] [033/130] (899s left) api_intel_bb (object-noreloc-keep-cache-simple)
[118.471631] Starting subtest: object-noreloc-keep-cache-simple
[118.476094] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[118.614245] [034/130] (899s left) gem_exec_capture (capture-recoverable)
[118.673428] Starting subtest: capture-recoverable
[118.675590] Subtest capture-recoverable: SUCCESS (0.002s)
[118.787341] [035/130] (899s left) gem_lmem_swapping (random)
[118.826221] Subtest random: SKIP (0.000s)
[118.858686] [036/130] (899s left) kms_lease (lease-revoke)
[118.958345] Starting subtest: lease-revoke
[118.960501] Starting dynamic subtest: pipe-A-eDP-1
[119.001813] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.043s)
[119.011044] Starting dynamic subtest: pipe-B-eDP-1
[119.046012] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.044s)
[119.055257] Starting dynamic subtest: pipe-C-eDP-1
[119.098178] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.052s)
[119.107767] Starting dynamic subtest: pipe-D-eDP-1
[119.146389] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.048s)
[119.148469] Subtest lease-revoke: SUCCESS (0.188s)
[119.276160] [037/130] (898s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[119.336390] Starting subtest: yf-tiled-ccs-to-y-tiled
[119.340400] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[119.519146] [038/130] (898s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[119.743251] Starting subtest: cursor-rapid-movement-256x85
[119.779173] Subtest cursor-rapid-movement-256x85: SKIP (0.032s)
[119.930692] [039/130] (898s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[124.925244] Starting subtest: pr-overlay-plane-move-continuous-sf
[124.930075] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[125.755318] [040/130] (892s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[125.861611] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[130.426053] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.567s)
[130.530215] [041/130] (887s left) gem_exec_schedule (u-semaphore-codependency)
[130.601221] Starting subtest: u-semaphore-codependency
[130.607287] Subtest u-semaphore-codependency: SUCCESS (0.013s)
[130.957928] [042/130] (887s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[131.065268] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[131.069670] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[131.139197] [043/130] (886s left) gem_exercise_blt (fast-copy)
[131.199550] Starting subtest: fast-copy
[131.202068] Starting dynamic subtest: linear-smem-smem
[131.221968] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[131.231514] Starting dynamic subtest: xmajor-smem-smem
[131.240131] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[131.246672] Starting dynamic subtest: tile4-smem-smem
[131.257842] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[131.264333] Starting dynamic subtest: tile64-smem-smem
[131.277224] Dynamic subtest tile64-smem-smem: SUCCESS (0.019s)
[131.279595] Subtest fast-copy: SUCCESS (0.078s)
[131.396154] [044/130] (886s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[131.503592] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[131.507626] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[131.585279] [045/130] (886s left) kms_dp_linktrain_fallback (dp-fallback)
[131.678135] Starting subtest: dp-fallback
[131.684792] Subtest dp-fallback: SKIP (0.000s)
[131.740204] [046/130] (886s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[131.852521] Starting subtest: x-tiled-32bpp-rotate-90
[131.871072] Subtest x-tiled-32bpp-rotate-90: SKIP (0.018s)
[131.988201] [047/130] (886s left) gem_exec_balancer (persistence)
[132.231531] Starting subtest: persistence
[132.963961] Subtest persistence: SUCCESS (0.732s)
[133.097556] [048/130] (885s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[133.192216] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[133.194610] Starting dynamic subtest: pipe-A-eDP-1
[133.217375] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[133.225840] Starting dynamic subtest: pipe-B-eDP-1
[133.247810] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[133.254297] Starting dynamic subtest: pipe-C-eDP-1
[133.276043] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[133.282301] Starting dynamic subtest: pipe-D-eDP-1
[133.304228] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[133.308679] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.004s)
[135.343997] [049/130] (882s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[135.445809] Starting subtest: flip-primary-invalidate-overlay
[147.860670] Subtest flip-primary-invalidate-overlay: SUCCESS (12.417s)
[148.200671] [050/130] (870s left) gem_ctx_sseu (invalid-args)
[148.265437] Subtest invalid-args: SKIP (0.000s)
[148.348090] [051/130] (869s left) kms_psr (pr-sprite-plane-onoff)
[148.442566] Starting subtest: pr-sprite-plane-onoff
[148.447309] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[148.506397] [052/130] (869s left) kms_vblank (ts-continuation-dpms-rpm)
[148.601067] Starting subtest: ts-continuation-dpms-rpm
[148.606405] Starting dynamic subtest: pipe-A-eDP-1
[151.132555] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.528s)
[151.145085] Starting dynamic subtest: pipe-D-eDP-1
[153.372675] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.238s)
[153.375087] Subtest ts-continuation-dpms-rpm: SUCCESS (4.771s)
[154.148243] [053/130] (864s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[154.253769] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[154.258150] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[154.343287] [054/130] (864s left) vgem_basic (mmap)
[154.425858] Starting subtest: mmap
[154.433933] Subtest mmap: SUCCESS (0.010s)
[154.482181] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[154.485424] [055/130] (863s left) kms_content_protection (legacy)
[154.656624] Starting subtest: legacy
[158.457175] Subtest legacy: SKIP (3.797s)
[159.651125] [056/130] (858s left) gem_exec_fence (syncobj-timeline-unused-fence)
[160.184840] Starting subtest: syncobj-timeline-unused-fence
[160.190361] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[161.996284] [057/130] (856s left) kms_flip (flip-vs-absolute-wf_vblank)
[162.101236] Starting subtest: flip-vs-absolute-wf_vblank
[162.103567] Starting dynamic subtest: A-eDP1
[170.998333] Dynamic subtest A-eDP1: SUCCESS (8.896s)
[171.004835] Starting dynamic subtest: B-eDP1
[179.920884] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[179.932191] Starting dynamic subtest: C-eDP1
[188.836951] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[188.843948] Starting dynamic subtest: D-eDP1
[197.765885] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[197.771401] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.668s)
[198.967309] [058/130] (819s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[199.017836] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[199.078024] [059/130] (819s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[199.186072] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[201.807407] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.626s)
[201.949562] [060/130] (816s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[202.339578] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[203.095264] [061/130] (815s left) kms_flip (dpms-off-confusion-interruptible)
[203.197637] Starting subtest: dpms-off-confusion-interruptible
[203.202482] Starting dynamic subtest: A-eDP1
[211.922679] Dynamic subtest A-eDP1: SUCCESS (8.722s)
[211.930957] Starting dynamic subtest: B-eDP1
[220.559309] Dynamic subtest B-eDP1: SUCCESS (8.635s)
[220.566657] Starting dynamic subtest: C-eDP1
[229.178763] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[229.185839] Starting dynamic subtest: D-eDP1
[237.807277] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[237.809819] Subtest dpms-off-confusion-interruptible: SUCCESS (34.610s)
[238.966110] [062/130] (779s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[239.063822] Starting subtest: plane-scaler-unity-scaling-with-rotation
[239.066068] Starting dynamic subtest: pipe-A
[239.399313] Dynamic subtest pipe-A: SUCCESS (0.337s)
[239.407350] Starting dynamic subtest: pipe-B
[240.752991] Dynamic subtest pipe-B: SUCCESS (1.354s)
[240.761114] Starting dynamic subtest: pipe-C
[242.184054] Dynamic subtest pipe-C: SUCCESS (1.430s)
[242.192881] Starting dynamic subtest: pipe-D
[243.612210] Dynamic subtest pipe-D: SUCCESS (1.427s)
[243.614592] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.551s)
[244.782428] [063/130] (773s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[244.891425] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[244.893800] Starting dynamic subtest: pipe-A-default-mode
[245.179073] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[245.183742] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.285s)
[246.007674] [064/130] (772s left) gem_mmap_gtt (basic-write-gtt)
[246.068468] Subtest basic-write-gtt: SKIP (0.000s)
[246.132044] [065/130] (772s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[246.239717] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[248.836886] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.602s)
[248.956774] [066/130] (769s left) gem_userptr_blits (forbidden-operations)
[249.023987] Starting subtest: forbidden-operations
[249.027699] Subtest forbidden-operations: SKIP (0.000s)
[249.159773] [067/130] (769s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[249.223119] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[249.328742] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[249.397038] [068/130] (769s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[249.498525] Starting subtest: fbcpsr-tiling-y
[249.502698] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[249.596560] [069/130] (769s left) kms_chamelium_hpd (common-hpd-after-suspend)
[249.986964] Subtest common-hpd-after-suspend: SKIP (0.000s)
[250.743765] [070/130] (768s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[250.852824] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[250.856839] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[250.956477] [071/130] (768s left) gem_create (create-ext-cpu-access-sanity-check)
[251.122425] Starting subtest: create-ext-cpu-access-sanity-check
[251.127181] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[251.189212] [072/130] (767s left) gen9_exec_parse (bb-start-param)
[251.250977] Subtest bb-start-param: SKIP (0.000s)
[251.325853] [073/130] (767s left) gem_softpin (evict-prime-sanity-check)
[251.384779] Starting subtest: evict-prime-sanity-check
[251.387109] Starting dynamic subtest: rcs0
[252.562965] Dynamic subtest rcs0: SUCCESS (1.178s)
[252.572472] Starting dynamic subtest: bcs0
[253.710882] Dynamic subtest bcs0: SUCCESS (1.146s)
[253.720219] Starting dynamic subtest: vcs0
[254.881300] Dynamic subtest vcs0: SUCCESS (1.168s)
[254.890891] Starting dynamic subtest: vcs1
[256.958402] Dynamic subtest vcs1: SUCCESS (2.074s)
[256.968623] Starting dynamic subtest: vecs0
[258.941494] Dynamic subtest vecs0: SUCCESS (1.981s)
[258.951241] Starting dynamic subtest: ccs0
[260.074956] Dynamic subtest ccs0: SUCCESS (1.132s)
[260.085748] Starting dynamic subtest: all
[261.203224] Dynamic subtest all: SUCCESS (1.126s)
[261.205869] Subtest evict-prime-sanity-check: SUCCESS (9.819s)
[261.282889] [074/130] (757s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[261.396660] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[261.401300] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[261.507178] [075/130] (757s left) syncobj_wait (wait-all-for-submit-snapshot)
[261.575423] Starting subtest: wait-all-for-submit-snapshot
[261.657602] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[261.728643] [076/130] (757s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[261.831909] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[261.835971] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[261.919313] [077/130] (757s left) gem_exec_params (sol-reset-not-gen7)
[261.971142] Starting subtest: sol-reset-not-gen7
[261.976068] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[262.128449] [078/130] (757s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[262.230839] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[262.234092] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[262.324084] [079/130] (756s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[262.415079] Starting subtest: fbc-pr-sprite-mmap-gtt
[262.418981] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[262.484413] [080/130] (756s left) gem_softpin (noreloc-interruptible)
[262.549657] Starting subtest: noreloc-interruptible
[267.947965] Subtest noreloc-interruptible: SUCCESS (5.396s)
[268.119380] [081/130] (751s left) gem_userptr_blits (vma-merge)
[268.196466] Starting subtest: vma-merge
[268.252678] Subtest vma-merge: SUCCESS (0.056s)
[268.380886] [082/130] (751s left) kms_psr (pr-cursor-plane-move)
[268.485410] Starting subtest: pr-cursor-plane-move
[268.490108] Subtest pr-cursor-plane-move: SKIP (0.000s)
[268.552296] [083/130] (750s left) gem_ccs (ctrl-surf-copy)
[268.627134] Starting subtest: ctrl-surf-copy
[268.631403] Subtest ctrl-surf-copy: SKIP (0.000s)
[268.730553] [084/130] (750s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[268.830162] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[268.832550] Starting dynamic subtest: pipe-A-eDP-1
[268.855767] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[268.864584] Starting dynamic subtest: pipe-B-eDP-1
[268.886492] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[268.893485] Starting dynamic subtest: pipe-C-eDP-1
[268.915505] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[268.923078] Starting dynamic subtest: pipe-D-eDP-1
[268.944968] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[268.949316] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[271.008588] [085/130] (748s left) kms_invalid_mode (bad-vsync-start)
[271.109108] Starting subtest: bad-vsync-start
[271.111298] Starting dynamic subtest: pipe-A-eDP-1
[271.395102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[271.402261] Starting dynamic subtest: pipe-B-eDP-1
[271.404551] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[271.411452] Starting dynamic subtest: pipe-C-eDP-1
[271.413749] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[271.420388] Starting dynamic subtest: pipe-D-eDP-1
[271.422416] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[271.424386] Subtest bad-vsync-start: SUCCESS (0.289s)
[272.232360] [086/130] (747s left) gem_request_retire (retire-vma-not-inactive)
[272.285825] Starting subtest: retire-vma-not-inactive
[272.347166] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[272.465071] [087/130] (747s left) kms_frontbuffer_tracking (psr-suspend)
[272.562320] Starting subtest: psr-suspend
[308.423573] Subtest psr-suspend: SUCCESS (5.548s)
[308.528420] [088/130] (741s left) gem_exec_params (larger-than-life-batch)
[308.595296] Starting subtest: larger-than-life-batch
[312.114027] Subtest larger-than-life-batch: SUCCESS (3.521s)
[313.287120] [089/130] (736s left) gem_userptr_blits (stress-mm-invalidate-close)
[313.404213] Starting subtest: stress-mm-invalidate-close
[315.552251] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[315.695002] [090/130] (734s left) perf (gen12-unprivileged-single-ctx-counters)
[315.838753] Starting subtest: gen12-unprivileged-single-ctx-counters
[315.841082] Starting dynamic subtest: rcs0
[316.439260] Dynamic subtest rcs0: SUCCESS (0.603s)
[316.441655] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.604s)
[316.477066] [091/130] (733s left) gem_softpin (softpin)
[316.587917] Starting subtest: softpin
[348.829128] Subtest softpin: SUCCESS (32.241s)
[348.950811] [092/130] (701s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[349.063562] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[349.065903] Starting dynamic subtest: pipe-A-eDP-1
[349.086576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[349.096636] Starting dynamic subtest: pipe-B-eDP-1
[349.115921] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[349.123810] Starting dynamic subtest: pipe-C-eDP-1
[349.143503] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[349.152048] Starting dynamic subtest: pipe-D-eDP-1
[349.171448] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[349.173294] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[351.168455] [093/130] (698s left) syncobj_timeline (transfer-timeline-point)
[351.227726] Starting subtest: transfer-timeline-point
[351.230043] Subtest transfer-timeline-point: SUCCESS (0.000s)
[351.338289] [094/130] (698s left) kms_cursor_crc (cursor-size-change)
[351.443651] Starting subtest: cursor-size-change
[351.445986] Starting dynamic subtest: pipe-A-eDP-1
[352.288694] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.841s)
[352.297406] Starting dynamic subtest: pipe-D-eDP-1
[353.742355] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.453s)
[353.745005] Subtest cursor-size-change: SUCCESS (2.297s)
[354.615889] [095/130] (695s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[354.720967] Starting subtest: yf-tiled-8bpp-rotate-180
[354.725183] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[354.828455] [096/130] (695s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[354.878321] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[354.880577] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[354.972300] [097/130] (695s left) kms_pipe_stress (stress-xrgb8888-untiled)
[355.075364] Starting subtest: stress-xrgb8888-untiled
[361.238945] Subtest stress-xrgb8888-untiled: SUCCESS (6.164s)
[361.283771] [098/130] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[361.393312] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[361.397038] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[361.500517] [099/130] (688s left) gem_ctx_bad_destroy (invalid-pad)
[361.562983] Starting subtest: invalid-pad
[361.564978] Subtest invalid-pad: SUCCESS (0.000s)
[361.628451] [100/130] (688s left) sysfs_preempt_timeout (idempotent)
[361.684336] Starting subtest: idempotent
[361.686479] Starting dynamic subtest: vecs0
[361.688531] Dynamic subtest vecs0: SUCCESS (0.000s)
[361.698259] Starting dynamic subtest: ccs0
[361.699867] Dynamic subtest ccs0: SUCCESS (0.000s)
[361.707281] Starting dynamic subtest: vcs0
[361.708922] Dynamic subtest vcs0: SUCCESS (0.000s)
[361.716113] Starting dynamic subtest: bcs0
[361.717760] Dynamic subtest bcs0: SUCCESS (0.000s)
[361.724996] Starting dynamic subtest: rcs0
[361.726593] Dynamic subtest rcs0: SUCCESS (0.000s)
[361.733976] Starting dynamic subtest: vcs1
[361.735672] Dynamic subtest vcs1: SUCCESS (0.000s)
[361.737302] Subtest idempotent: SUCCESS (0.005s)
[361.796313] [101/130] (688s left) gem_exec_schedule (out-order)
[361.869054] Starting subtest: out-order
[361.870826] Starting dynamic subtest: rcs0
[361.961575] Dynamic subtest rcs0: SUCCESS (0.096s)
[361.972425] Starting dynamic subtest: vcs0
[362.037308] Dynamic subtest vcs0: SUCCESS (0.076s)
[362.049093] Starting dynamic subtest: vcs1
[362.108367] Dynamic subtest vcs1: SUCCESS (0.070s)
[362.119473] Starting dynamic subtest: vecs0
[362.182338] Dynamic subtest vecs0: SUCCESS (0.074s)
[362.190458] Starting dynamic subtest: ccs0
[362.275380] Dynamic subtest ccs0: SUCCESS (0.092s)
[362.277602] Subtest out-order: SUCCESS (0.411s)
[363.320246] [102/130] (687s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[363.421474] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[363.423752] Starting dynamic subtest: pipe-A-eDP-1
[363.443468] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[363.451993] Starting dynamic subtest: pipe-B-eDP-1
[363.470566] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[363.478187] Starting dynamic subtest: pipe-C-eDP-1
[363.497100] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[363.504527] Starting dynamic subtest: pipe-D-eDP-1
[363.523517] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[363.525628] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[365.567195] [103/130] (684s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[365.691009] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[376.893609] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.203s)
[377.687707] [104/130] (672s left) perf_pmu (most-busy-idle-check-all)
[377.728678] Starting subtest: most-busy-idle-check-all
[377.730850] Starting dynamic subtest: rcs0
[379.226642] Dynamic subtest rcs0: SUCCESS (1.498s)
[379.239158] Starting dynamic subtest: bcs0
[381.273249] Dynamic subtest bcs0: SUCCESS (2.044s)
[381.284221] Starting dynamic subtest: vcs0
[383.256928] Dynamic subtest vcs0: SUCCESS (1.981s)
[383.267667] Starting dynamic subtest: vcs1
[385.240901] Dynamic subtest vcs1: SUCCESS (1.981s)
[385.252752] Starting dynamic subtest: vecs0
[387.224274] Dynamic subtest vecs0: SUCCESS (1.982s)
[387.236170] Starting dynamic subtest: ccs0
[389.273356] Dynamic subtest ccs0: SUCCESS (2.047s)
[389.276463] Subtest most-busy-idle-check-all: SUCCESS (11.547s)
[389.382249] [105/130] (661s left) syncobj_timeline (invalid-wait-bad-flags)
[389.434710] Starting subtest: invalid-wait-bad-flags
[389.437007] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[389.545046] [106/130] (660s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[391.392383] Starting subtest: modeset-lpsp-stress-no-wait
[400.974341] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.583s)
[401.048791] [107/130] (649s left) kms_vblank (wait-forked-busy)
[401.154552] Starting subtest: wait-forked-busy
[401.156858] Starting dynamic subtest: pipe-A-eDP-1
[403.055084] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.899s)
[403.068721] Starting dynamic subtest: pipe-D-eDP-1
[405.586108] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.527s)
[405.588500] Subtest wait-forked-busy: SUCCESS (4.430s)
[406.380203] [108/130] (644s left) dmabuf (all-tests)
[406.418572] Starting subtest: all-tests
[406.421005] Starting dynamic subtest: sanitycheck
[406.626706] Dynamic subtest sanitycheck: SUCCESS (0.206s)
[406.636138] Starting dynamic subtest: dma_fence
[406.951950] Dynamic subtest dma_fence: SUCCESS (0.323s)
[406.962377] Starting dynamic subtest: dma_fence_chain
[415.401603] Dynamic subtest dma_fence_chain: SUCCESS (8.446s)
[415.413536] Starting dynamic subtest: dma_fence_unwrap
[415.552738] Dynamic subtest dma_fence_unwrap: SUCCESS (0.148s)
[415.564236] Starting dynamic subtest: dma_resv
[415.690560] Dynamic subtest dma_resv: SUCCESS (0.136s)
[415.693363] Subtest all-tests: SUCCESS (9.270s)
[415.763235] [109/130] (634s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[415.893864] Starting subtest: cursor-vs-flip-atomic
[445.334044] Subtest cursor-vs-flip-atomic: SUCCESS (29.438s)
[446.205010] [110/130] (604s left) kms_psr (psr-cursor-mmap-cpu)
[446.321910] Starting subtest: psr-cursor-mmap-cpu
[446.324280] Starting dynamic subtest: eDP-1
[447.993522] Dynamic subtest eDP-1: SUCCESS (1.673s)
[447.996278] Subtest psr-cursor-mmap-cpu: SUCCESS (1.674s)
[448.860870] [111/130] (601s left) gem_exec_capture (userptr)
[448.917216] Starting subtest: userptr
[449.730197] Subtest userptr: SUCCESS (0.813s)
[449.838902] [112/130] (600s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[449.902888] Starting subtest: multi-wait-for-submit-submitted-signaled
[449.905323] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[450.010456] [113/130] (600s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[450.117497] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[454.909757] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.794s)
[455.036757] [114/130] (595s left) i915_pm_rps (thresholds)
[455.107941] Starting subtest: thresholds
[455.112928] Subtest thresholds: SKIP (0.000s)
[455.187699] [115/130] (595s left) kms_chamelium_color (ctm-red-to-blue)
[455.285534] Subtest ctm-red-to-blue: SKIP (0.000s)
[455.324602] [116/130] (595s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[460.349647] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[460.354198] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[461.205778] [117/130] (589s left) perf (low-oa-exponent-permissions)
[461.286609] Starting subtest: low-oa-exponent-permissions
[461.326274] Subtest low-oa-exponent-permissions: SUCCESS (0.040s)
[461.360400] [118/130] (589s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[461.459123] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[461.461441] Starting dynamic subtest: pipe-A-default-mode
[464.104040] Dynamic subtest pipe-A-default-mode: SUCCESS (2.641s)
[464.106049] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.642s)
[464.888375] [119/130] (586s left) gem_userptr_blits (probe)
[464.960026] Starting subtest: probe
[465.043386] Subtest probe: SUCCESS (0.083s)
[465.163428] [120/130] (585s left) gem_set_tiling_vs_gtt
[465.260581] [121/130] (585s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[465.381155] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[473.551296] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.168s)
[474.418627] [122/130] (576s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[474.519403] Starting subtest: plane-primary-overlay-mutable-zpos
[477.951598] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.429s)
[479.122249] [123/130] (571s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[479.221455] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[479.226106] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[479.335870] [124/130] (571s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[479.429903] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[479.434301] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[479.526856] [125/130] (571s left) gem_ctx_persistence (hang)
[479.581201] Starting subtest: hang
[479.585970] Subtest hang: SKIP (0.000s)
[479.682216] [126/130] (571s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[479.777414] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[481.012022] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.236s)
[481.212302] [127/130] (570s left) i915_query (query-garbage)
[481.277545] Starting subtest: query-garbage
[481.279555] Subtest query-garbage: SUCCESS (0.000s)
[481.376213] [128/130] (569s left) kms_flip (2x-plain-flip)
[481.472158] Starting subtest: 2x-plain-flip
[481.482790] Subtest 2x-plain-flip: SKIP (0.010s)
[481.602514] [129/130] (569s left) prime_vgem (fence-wait)
[481.694626] Starting subtest: fence-wait
[481.697120] Starting dynamic subtest: rcs0
[482.755556] Dynamic subtest rcs0: SUCCESS (1.061s)
[482.766823] Starting dynamic subtest: bcs0
[483.840414] Dynamic subtest bcs0: SUCCESS (1.084s)
[483.852494] Starting dynamic subtest: vcs0
[484.891411] Dynamic subtest vcs0: SUCCESS (1.048s)
[484.903238] Starting dynamic subtest: vcs1
[485.933653] Dynamic subtest vcs1: SUCCESS (1.041s)
[485.944045] Starting dynamic subtest: vecs0
[486.975665] Dynamic subtest vecs0: SUCCESS (1.041s)
[486.987284] Starting dynamic subtest: ccs0
[488.024346] Dynamic subtest ccs0: SUCCESS (1.047s)
[488.027124] Subtest fence-wait: SUCCESS (6.332s)
[488.162195] [130/130] (563s left) gem_linear_blits (basic)
[488.395130] Starting subtest: basic
[488.411197] Subtest basic: SUCCESS (0.016s)
[488.551622] Closing watchdogs
Done.