[57.957366] Initializing watchdogs
[57.957411]   /dev/watchdog0
[57.972805] [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.976910] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.979559] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.984840] [001/133] (960s left) syncobj_timeline (multi-wait-available-signaled)
[58.067163] Starting subtest: multi-wait-available-signaled
[58.069505] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[58.170509] [002/133] (960s left) kms_psr (pr-suspend)
[58.272189] Starting subtest: pr-suspend
[58.276442] Subtest pr-suspend: SKIP (0.000s)
[58.335906] [003/133] (960s left) prime_mmap (test_reprime)
[58.389064] Starting subtest: test_reprime
[58.391084] Starting dynamic subtest: test_reprime-smem
[58.419085] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[58.421515] Subtest test_reprime: SUCCESS (0.033s)
[58.521768] [004/133] (960s left) perf (gen12-group-exclusive-stream-sample-oa)
[58.648496] Starting subtest: gen12-group-exclusive-stream-sample-oa
[58.668401] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[58.712636] [005/133] (959s left) gem_userptr_blits (stress-mm)
[58.778554] Starting subtest: stress-mm
[64.119936] Subtest stress-mm: SUCCESS (5.369s)
[64.231994] [006/133] (954s left) kms_draw_crc (draw-method-blt)
[64.324543] Starting subtest: draw-method-blt
[64.326416] Starting dynamic subtest: xrgb8888-untiled
[64.611530] Dynamic subtest xrgb8888-untiled: SUCCESS (0.289s)
[64.619829] Starting dynamic subtest: rgb565-untiled
[64.832858] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[64.840452] Starting dynamic subtest: xrgb2101010-untiled
[65.055137] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[65.061892] Starting dynamic subtest: xbgr16161616f-untiled
[65.275627] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[65.283352] Starting dynamic subtest: xrgb8888-xtiled
[65.386362] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[65.393278] Starting dynamic subtest: rgb565-xtiled
[65.496873] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[65.503410] Starting dynamic subtest: xrgb2101010-xtiled
[65.608249] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[65.617631] Starting dynamic subtest: xbgr16161616f-xtiled
[65.707508] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.100s)
[65.716394] Starting dynamic subtest: xrgb8888-4tiled
[65.829470] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[65.836023] Starting dynamic subtest: rgb565-4tiled
[65.929290] Dynamic subtest rgb565-4tiled: SUCCESS (0.099s)
[65.937506] Starting dynamic subtest: xrgb2101010-4tiled
[66.040197] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[66.047261] Starting dynamic subtest: xbgr16161616f-4tiled
[66.140133] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.100s)
[66.141972] Subtest draw-method-blt: SUCCESS (1.824s)
[66.240733] [007/133] (952s left) gem_exec_params (dr1-dirt)
[66.298987] Starting subtest: DR1-dirt
[66.301042] Subtest DR1-dirt: SUCCESS (0.000s)
[66.409820] [008/133] (952s left) kms_big_fb (linear-8bpp-rotate-180)
[66.517899] Starting subtest: linear-8bpp-rotate-180
[67.828141] Subtest linear-8bpp-rotate-180: SUCCESS (1.313s)
[67.958881] [009/133] (950s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[68.068406] Starting subtest: y-tiled-64bpp-rotate-0
[68.071942] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[68.149204] [010/133] (950s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[68.243171] Starting subtest: psr-1p-pri-indfb-multidraw
[90.846674] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.616s)
[91.009625] [011/133] (927s left) sysfs_preempt_timeout (timeout)
[91.082139] Starting subtest: timeout
[91.084077] Starting dynamic subtest: vecs0
[100.879795] Dynamic subtest vecs0: SUCCESS (9.792s)
[100.893341] Starting dynamic subtest: ccs0
[102.183591] Dynamic subtest ccs0: SUCCESS (1.305s)
[102.194598] Starting dynamic subtest: vcs0
[111.885314] Dynamic subtest vcs0: SUCCESS (9.701s)
[111.895207] Starting dynamic subtest: bcs0
[113.186812] Dynamic subtest bcs0: SUCCESS (1.297s)
[113.197052] Starting dynamic subtest: rcs0
[114.441714] Dynamic subtest rcs0: SUCCESS (1.254s)
[114.449501] Starting dynamic subtest: vcs1
[123.927865] Dynamic subtest vcs1: SUCCESS (9.485s)
[123.930341] Subtest timeout: SUCCESS (32.845s)
[124.005627] [012/133] (894s left) kms_lease (simple-lease)
[124.117668] Starting subtest: simple-lease
[124.119884] Starting dynamic subtest: pipe-A-eDP-1
[124.627736] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.509s)
[124.638919] Starting dynamic subtest: pipe-B-eDP-1
[126.023987] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.396s)
[126.033722] Starting dynamic subtest: pipe-C-eDP-1
[127.443066] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.414s)
[127.451257] Starting dynamic subtest: pipe-D-eDP-1
[128.849793] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s)
[128.852324] Subtest simple-lease: SUCCESS (4.733s)
[129.652175] [013/133] (889s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[129.742264] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[129.744610] Starting dynamic subtest: pipe-A-default-mode
[132.507943] Dynamic subtest pipe-A-default-mode: SUCCESS (2.766s)
[132.510253] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.768s)
[133.326731] [014/133] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[133.423523] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[133.427817] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[133.515515] [015/133] (885s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[133.609913] Starting subtest: 2x-flip-vs-rmfb-interruptible
[133.622499] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.012s)
[133.694641] [016/133] (885s left) syncobj_wait (invalid-reset-illegal-handle)
[133.760045] Starting subtest: invalid-reset-illegal-handle
[133.762314] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[133.849589] [017/133] (885s left) perf_pmu (render-node-busy-idle)
[133.919841] Starting subtest: render-node-busy-idle
[133.922194] Starting dynamic subtest: rcs0
[134.604940] Dynamic subtest rcs0: SUCCESS (0.684s)
[134.615569] Starting dynamic subtest: bcs0
[135.266052] Dynamic subtest bcs0: SUCCESS (0.659s)
[135.276675] Starting dynamic subtest: vcs0
[136.916438] Dynamic subtest vcs0: SUCCESS (1.647s)
[136.927265] Starting dynamic subtest: vcs1
[138.900398] Dynamic subtest vcs1: SUCCESS (1.981s)
[138.911087] Starting dynamic subtest: vecs0
[140.885108] Dynamic subtest vecs0: SUCCESS (1.982s)
[140.894749] Starting dynamic subtest: ccs0
[141.545692] Dynamic subtest ccs0: SUCCESS (0.659s)
[141.548340] Subtest render-node-busy-idle: SUCCESS (7.627s)
[141.621540] [018/133] (877s left) i915_getparams_basic (basic-subslice-total)
[141.681820] Starting subtest: basic-subslice-total
[141.686127] Subtest basic-subslice-total: SUCCESS (0.000s)
[141.766603] [019/133] (877s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[141.870581] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[141.874716] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[141.936199] [020/133] (877s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[142.031027] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[142.033215] Starting dynamic subtest: pipe-A
[143.078717] Dynamic subtest pipe-A: SUCCESS (1.050s)
[143.086177] Starting dynamic subtest: pipe-B
[145.231713] Dynamic subtest pipe-B: SUCCESS (2.152s)
[145.239587] Starting dynamic subtest: pipe-C
[146.430810] Dynamic subtest pipe-C: SUCCESS (1.198s)
[146.438319] Starting dynamic subtest: pipe-D
[147.658643] Dynamic subtest pipe-D: SUCCESS (1.226s)
[147.661205] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.630s)
[148.846191] [021/133] (870s left) gem_eio (context-create)
[149.057467] Starting subtest: context-create
[149.330454] Subtest context-create: SUCCESS (0.271s)
[149.479165] [022/133] (869s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[149.566757] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[156.284058] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.719s)
[156.403217] [023/133] (862s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[156.492536] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[156.496965] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[156.600110] [024/133] (862s left) kms_busy (basic)
[156.688386] Starting subtest: basic
[156.690776] Starting dynamic subtest: flip
[157.275813] Dynamic subtest flip: SUCCESS (0.586s)
[157.284568] Starting dynamic subtest: modeset
[160.734431] Dynamic subtest modeset: SUCCESS (3.459s)
[160.736737] Subtest basic: SUCCESS (4.048s)
[161.594123] [025/133] (857s left) gem_userptr_blits (probe)
[161.672399] Starting subtest: probe
[161.749828] Subtest probe: SUCCESS (0.079s)
[161.857418] [026/133] (857s left) gen9_exec_parse (bb-start-out)
[161.923339] Subtest bb-start-out: SKIP (0.000s)
[162.010108] [027/133] (857s left) i915_drm_fdinfo (idle)
[162.054689] Starting subtest: idle
[162.056799] Starting dynamic subtest: rcs0
[162.600687] Dynamic subtest rcs0: SUCCESS (0.546s)
[162.611705] Starting dynamic subtest: bcs0
[163.108067] Dynamic subtest bcs0: SUCCESS (0.503s)
[163.118810] Starting dynamic subtest: vcs0
[163.614042] Dynamic subtest vcs0: SUCCESS (0.503s)
[163.623812] Starting dynamic subtest: vcs1
[164.122282] Dynamic subtest vcs1: SUCCESS (0.502s)
[164.132415] Starting dynamic subtest: vecs0
[164.625871] Dynamic subtest vecs0: SUCCESS (0.504s)
[164.636918] Starting dynamic subtest: ccs0
[165.133372] Dynamic subtest ccs0: SUCCESS (0.504s)
[165.136160] Subtest idle: SUCCESS (3.078s)
[165.207818] [028/133] (854s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[165.303807] Starting subtest: bad-aux-stride-y-tiled-ccs
[165.305959] Starting dynamic subtest: pipe-A-eDP-1
[165.327704] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[165.337603] Starting dynamic subtest: pipe-B-eDP-1
[165.358870] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[165.366568] Starting dynamic subtest: pipe-C-eDP-1
[165.387663] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[165.395719] Starting dynamic subtest: pipe-D-eDP-1
[165.417525] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[165.421573] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[167.466426] [029/133] (852s left) kms_content_protection (uevent-hdcp14)
[167.611169] Starting subtest: uevent-hdcp14
[167.615596] Subtest uevent-hdcp14: SKIP (0.000s)
[167.739326] [030/133] (851s left) syncobj_timeline (invalid-query-bad-pad)
[167.790840] Starting subtest: invalid-query-bad-pad
[167.792796] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[167.877568] [031/133] (851s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[167.969325] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[167.973726] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[168.052283] [032/133] (851s left) gem_ccs (block-copy-compressed)
[168.107079] Starting subtest: block-copy-compressed
[168.111492] Subtest block-copy-compressed: SKIP (0.000s)
[168.206654] [033/133] (851s left) kms_cursor_crc (cursor-offscreen-256x85)
[168.464227] Starting subtest: cursor-offscreen-256x85
[168.514946] Subtest cursor-offscreen-256x85: SKIP (0.045s)
[168.673086] [034/133] (851s left) perf (mi-rpc)
[168.754722] Starting subtest: mi-rpc
[168.758611] Subtest mi-rpc: SKIP (0.000s)
[168.792039] [035/133] (850s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[168.889457] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[168.891217] Starting dynamic subtest: pipe-A-eDP-1
[168.909496] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[168.925529] Starting dynamic subtest: pipe-B-eDP-1
[168.943503] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[168.950726] Starting dynamic subtest: pipe-C-eDP-1
[168.968372] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[168.975484] Starting dynamic subtest: pipe-D-eDP-1
[168.993579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[168.997113] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[171.055716] [036/133] (848s left) gem_partial_pwrite_pread (reads-uncached)
[171.117477] Subtest reads-uncached: SKIP (0.000s)
[171.184446] [037/133] (848s left) perf_pmu (all-busy-idle-check-all)
[171.228665] Starting subtest: all-busy-idle-check-all
[172.948913] Subtest all-busy-idle-check-all: SUCCESS (1.720s)
[173.035970] [038/133] (846s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[173.132612] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[173.134931] Starting dynamic subtest: pipe-A-eDP-1
[173.143993] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[173.156934] Starting dynamic subtest: pipe-B-eDP-1
[173.165982] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[173.174127] Starting dynamic subtest: pipe-C-eDP-1
[173.183588] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[173.197680] Starting dynamic subtest: pipe-D-eDP-1
[173.210633] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[173.217154] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[175.435237] [039/133] (844s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[175.536590] Starting subtest: x-tiled-16bpp-rotate-0
[176.926432] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.390s)
[177.046242] [040/133] (842s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[177.092383] Starting subtest: y-tiled-to-vebox-y-tiled
[177.096101] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[177.276592] [041/133] (842s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[177.384220] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[177.386351] Starting dynamic subtest: pipe-A-eDP-1
[177.469834] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[177.478198] Starting dynamic subtest: pipe-B-eDP-1
[178.585648] Dynamic subtest pipe-B-eDP-1: SKIP (1.112s)
[178.589918] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.204s)
[179.762398] [042/133] (840s left) kms_addfb_basic (addfb25-bad-modifier)
[179.848823] Starting subtest: addfb25-bad-modifier
[179.850642] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[179.929818] [043/133] (840s left) syncobj_basic (bad-fd-to-handle)
[179.982822] Starting subtest: bad-fd-to-handle
[179.985037] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[180.063628] [044/133] (840s left) perf (stress-open-close)
[180.142723] Starting subtest: stress-open-close
[180.145090] Starting dynamic subtest: 0-rcs0
[182.307725] Dynamic subtest 0-rcs0: SUCCESS (2.166s)
[182.316582] Starting dynamic subtest: 1-vcs0
[184.469690] Dynamic subtest 1-vcs0: SUCCESS (2.161s)
[184.471672] Subtest stress-open-close: SUCCESS (4.328s)
[184.512090] [045/133] (835s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[184.604111] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[184.607874] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[184.674894] [046/133] (835s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[184.758978] Starting subtest: primary-yf-tiled-reflect-x-0
[184.819339] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[184.917607] [047/133] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[185.008761] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[185.012538] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[185.106879] [048/133] (835s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[185.203545] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[185.207124] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[185.291998] [049/133] (835s left) kms_color (ctm-signed)
[185.382650] Starting subtest: ctm-signed
[185.384446] Starting dynamic subtest: pipe-A-eDP-1
[187.443274] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.060s)
[187.452033] Starting dynamic subtest: pipe-B-eDP-1
[190.237939] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.795s)
[190.246349] Starting dynamic subtest: pipe-C-eDP-1
[192.933675] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.696s)
[192.942793] Starting dynamic subtest: pipe-D-eDP-1
[195.603638] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.666s)
[195.606107] Subtest ctm-signed: SUCCESS (10.221s)
[196.450248] [050/133] (823s left) kms_invalid_mode (zero-clock)
[196.542436] Starting subtest: zero-clock
[196.544729] Starting dynamic subtest: pipe-A-eDP-1
[196.841611] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s)
[196.849835] Starting dynamic subtest: pipe-B-eDP-1
[196.851890] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[196.859349] Starting dynamic subtest: pipe-C-eDP-1
[196.861357] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[196.869255] Starting dynamic subtest: pipe-D-eDP-1
[196.871507] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[196.873854] Subtest zero-clock: SUCCESS (0.308s)
[197.675877] [051/133] (822s left) kms_sequence (queue-busy)
[197.778499] Starting subtest: queue-busy
[197.780921] Starting dynamic subtest: pipe-A-eDP-1
[199.728679] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.952s)
[199.740180] Starting dynamic subtest: pipe-B-eDP-1
[202.290898] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.559s)
[202.299609] Starting dynamic subtest: pipe-C-eDP-1
[204.903822] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.611s)
[204.913603] Starting dynamic subtest: pipe-D-eDP-1
[207.439355] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.536s)
[207.441610] Subtest queue-busy: SUCCESS (9.663s)
[208.237176] [052/133] (812s left) api_intel_bb (misplaced-blitter)
[208.286466] Starting subtest: misplaced-blitter
[208.291598] Subtest misplaced-blitter: SUCCESS (0.008s)
[208.401527] [053/133] (812s left) gem_ctx_bad_destroy (invalid-default-ctx)
[208.470147] Starting subtest: invalid-default-ctx
[208.472484] Subtest invalid-default-ctx: SUCCESS (0.000s)
[208.555487] [054/133] (811s left) kms_psr (psr2-sprite-plane-move)
[208.651979] Starting subtest: psr2-sprite-plane-move
[208.654118] Starting dynamic subtest: eDP-1
[210.358259] Dynamic subtest eDP-1: SUCCESS (1.706s)
[210.360406] Subtest psr2-sprite-plane-move: SUCCESS (1.707s)
[211.196933] [055/133] (809s left) gem_exec_schedule (submit-early-slice)
[211.278721] Starting subtest: submit-early-slice
[211.281102] Starting dynamic subtest: rcs0
[211.321064] Dynamic subtest rcs0: SUCCESS (0.047s)
[211.332118] Starting dynamic subtest: bcs0
[211.366810] Dynamic subtest bcs0: SUCCESS (0.045s)
[211.378162] Starting dynamic subtest: vcs0
[211.408601] Dynamic subtest vcs0: SUCCESS (0.041s)
[211.420176] Starting dynamic subtest: vcs1
[211.452601] Dynamic subtest vcs1: SUCCESS (0.043s)
[211.463886] Starting dynamic subtest: vecs0
[211.491427] Dynamic subtest vecs0: SUCCESS (0.038s)
[211.499277] Starting dynamic subtest: ccs0
[211.535859] Dynamic subtest ccs0: SUCCESS (0.043s)
[211.538441] Subtest submit-early-slice: SUCCESS (0.263s)
[212.985800] [056/133] (807s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[213.364199] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[214.211165] [057/133] (806s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[214.271323] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[214.377669] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[214.467312] [058/133] (806s left) syncobj_basic (illegal-fd-to-handle)
[214.528730] Starting subtest: illegal-fd-to-handle
[214.530954] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[214.642139] [059/133] (806s left) api_intel_allocator (reserve-simple)
[214.704577] Starting subtest: reserve-simple
[214.706983] Subtest reserve-simple: SUCCESS (0.003s)
[214.849726] [060/133] (805s left) gem_bad_reloc (negative-reloc-bltcopy)
[214.908071] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[214.990918] [061/133] (805s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[215.090451] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[218.721835] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.634s)
[219.851597] [062/133] (801s left) gem_exec_schedule (preempt)
[219.924403] Starting subtest: preempt
[219.926760] Starting dynamic subtest: rcs0
[219.943522] Dynamic subtest rcs0: SUCCESS (0.025s)
[219.955365] Starting dynamic subtest: bcs0
[219.961488] Dynamic subtest bcs0: SUCCESS (0.017s)
[219.969473] Starting dynamic subtest: vcs0
[219.982820] Dynamic subtest vcs0: SUCCESS (0.020s)
[219.992619] Starting dynamic subtest: vcs1
[220.005277] Dynamic subtest vcs1: SUCCESS (0.022s)
[220.013804] Starting dynamic subtest: vecs0
[220.027552] Dynamic subtest vecs0: SUCCESS (0.021s)
[220.036527] Starting dynamic subtest: ccs0
[220.049399] Dynamic subtest ccs0: SUCCESS (0.021s)
[220.051648] Subtest preempt: SUCCESS (0.132s)
[221.978473] [063/133] (798s left) gem_basic (create-fd-close)
[222.049032] Starting subtest: create-fd-close
[222.053520] Subtest create-fd-close: SUCCESS (0.000s)
[222.147783] [064/133] (798s left) i915_pm_rpm (gem-execbuf)
[224.070185] Starting subtest: gem-execbuf
[224.072348] Starting dynamic subtest: smem0
[225.797654] Dynamic subtest smem0: SUCCESS (1.730s)
[225.799788] Subtest gem-execbuf: SUCCESS (1.732s)
[225.879596] [065/133] (795s left) gem_spin_batch (spin-each)
[225.935586] Starting subtest: spin-each
[229.205163] Subtest spin-each: SUCCESS (3.262s)
[230.957473] [066/133] (790s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[231.058117] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[237.656347] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.600s)
[237.780803] [067/133] (783s left) gem_gpgpu_fill (basic)
[237.835727] Starting subtest: basic
[237.837992] Starting dynamic subtest: smem
[237.840325] Dynamic subtest smem: SUCCESS (0.006s)
[237.842740] Subtest basic: SUCCESS (0.007s)
[237.986165] [068/133] (783s left) core_sysfs (read-all-entries)
[238.045552] Starting subtest: read-all-entries
[238.051297] Subtest read-all-entries: SUCCESS (0.008s)
[238.130909] [069/133] (782s left) perf (sysctl-defaults)
[238.196616] Starting subtest: sysctl-defaults
[238.198605] Subtest sysctl-defaults: SUCCESS (0.000s)
[238.255102] [070/133] (782s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[238.344776] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[238.348960] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[238.445672] [071/133] (782s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[238.540348] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[245.405048] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.867s)
[245.531724] [072/133] (775s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[245.634650] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[245.638749] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[245.745993] [073/133] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[245.836653] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[245.840757] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[245.950681] [074/133] (775s left) kms_addfb_basic (addfb25-4-tiled)
[246.044209] Starting subtest: addfb25-4-tiled
[246.046480] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[246.163990] [075/133] (775s left) gem_pxp (reject-modify-context-protection-off-1)
[246.277867] Starting subtest: reject-modify-context-protection-off-1
[246.280590] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[246.392138] [076/133] (775s left) gem_exec_schedule (wide)
[246.569356] Starting subtest: wide
[246.571690] Starting dynamic subtest: rcs0
[256.796965] Dynamic subtest rcs0: SUCCESS (10.224s)
[256.812549] Starting dynamic subtest: vcs0
[266.886740] Dynamic subtest vcs0: SUCCESS (10.091s)
[266.898292] Starting dynamic subtest: vcs1
[278.197550] Dynamic subtest vcs1: SUCCESS (11.309s)
[278.209671] Starting dynamic subtest: vecs0
[290.571985] Dynamic subtest vecs0: SUCCESS (12.371s)
[290.583776] Starting dynamic subtest: ccs0
[302.832235] Dynamic subtest ccs0: SUCCESS (12.260s)
[302.834572] Subtest wide: SUCCESS (56.261s)
[304.663311] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[304.666074] [077/133] (716s left) gem_fence_thrash (bo-write-verify-none)
[304.705836] Starting subtest: bo-write-verify-none
[304.720691] Subtest bo-write-verify-none: SKIP (0.015s)
[304.783689] [078/133] (716s left) gem_ctx_isolation (dirty-switch)
[304.854514] Starting subtest: dirty-switch
[304.856696] Starting dynamic subtest: rcs0
[305.115647] Dynamic subtest rcs0: SUCCESS (0.263s)
[305.125984] Starting dynamic subtest: bcs0
[305.398822] Dynamic subtest bcs0: SUCCESS (0.282s)
[305.410135] Starting dynamic subtest: vcs0
[305.653716] Dynamic subtest vcs0: SUCCESS (0.254s)
[305.663892] Starting dynamic subtest: vcs1
[307.124274] Dynamic subtest vcs1: SUCCESS (1.469s)
[307.135903] Starting dynamic subtest: vecs0
[309.100543] Dynamic subtest vecs0: SUCCESS (1.975s)
[309.111686] Starting dynamic subtest: ccs0
[311.166951] Dynamic subtest ccs0: SUCCESS (2.065s)
[311.169389] Subtest dirty-switch: SUCCESS (6.316s)
[311.417696] [079/133] (710s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[311.543081] Starting subtest: basic-flip-after-cursor-legacy
[312.472127] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.928s)
[313.310117] [080/133] (708s left) kms_psr (fbc-pr-primary-page-flip)
[313.408572] Starting subtest: fbc-pr-primary-page-flip
[313.412981] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[313.478553] [081/133] (708s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[313.583407] Starting subtest: 4-tiled-64bpp-rotate-0
[315.185867] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.602s)
[315.348657] [082/133] (706s left) gem_ctx_persistence (legacy-engines-persistence)
[315.413151] Starting subtest: legacy-engines-persistence
[315.415591] Starting dynamic subtest: render
[316.235419] Dynamic subtest render: SUCCESS (0.820s)
[316.246967] Starting dynamic subtest: bsd1
[317.013064] Dynamic subtest bsd1: SUCCESS (0.775s)
[317.028348] Starting dynamic subtest: bsd2
[317.780400] Dynamic subtest bsd2: SUCCESS (0.764s)
[317.792823] Starting dynamic subtest: blt
[318.545101] Dynamic subtest blt: SUCCESS (0.762s)
[318.556750] Starting dynamic subtest: vebox
[319.291912] Dynamic subtest vebox: SUCCESS (0.744s)
[319.294369] Subtest legacy-engines-persistence: SUCCESS (3.879s)
[319.422917] [083/133] (702s left) syncobj_timeline (wait-all-for-submit-complex)
[319.478049] Starting subtest: wait-all-for-submit-complex
[319.692028] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[319.765470] [084/133] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[319.862793] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[319.867184] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[319.966778] [085/133] (701s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[320.068237] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[320.072122] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[320.166906] [086/133] (701s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[320.264516] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[320.268846] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[320.356385] [087/133] (701s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[320.763905] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[321.539331] [088/133] (700s left) gem_lmem_swapping (smem-oom)
[321.585830] Subtest smem-oom: SKIP (0.000s)
[321.622373] [089/133] (700s left) gem_ctx_param (invalid-ctx-set)
[321.673875] Starting subtest: invalid-ctx-set
[321.676200] Subtest invalid-ctx-set: SUCCESS (0.001s)
[321.758695] [090/133] (700s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[324.084223] Starting subtest: dpms-mode-unset-lpsp
[328.155920] Subtest dpms-mode-unset-lpsp: SUCCESS (4.071s)
[328.552928] [091/133] (693s left) gem_exec_balancer (full)
[328.614161] Starting subtest: full
[332.728989] Subtest full: SUCCESS (4.114s)
[333.063747] [092/133] (688s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[333.129681] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[333.132086] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[333.242110] [093/133] (688s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[333.336715] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[333.341219] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[333.424091] [094/133] (688s left) kms_rotation_crc (exhaust-fences)
[333.531169] Starting subtest: exhaust-fences
[333.535471] Subtest exhaust-fences: SKIP (0.000s)
[333.604088] [095/133] (688s left) kms_dp_link_training (non-uhbr-sst)
[333.707327] Starting subtest: non-uhbr-sst
[333.715913] Subtest non-uhbr-sst: SKIP (0.000s)
[333.787999] [096/133] (688s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[333.879538] Starting subtest: fbcpsr-rgb101010-draw-render
[340.612469] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.737s)
[340.746297] [097/133] (681s left) kms_psr2_su (page_flip-xrgb8888)
[340.813482] Subtest page_flip-XRGB8888: SKIP (0.000s)
[340.886069] [098/133] (681s left) kms_plane_cursor (overlay)
[340.978100] Starting subtest: overlay
[340.982350] Starting dynamic subtest: pipe-A-eDP-1-size-64
[343.513511] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.535s)
[343.573369] Starting dynamic subtest: pipe-A-eDP-1-size-128
[346.002280] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.438s)
[346.062815] Starting dynamic subtest: pipe-A-eDP-1-size-256
[348.592532] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[348.942142] Starting dynamic subtest: pipe-B-eDP-1-size-64
[352.156510] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.223s)
[352.215671] Starting dynamic subtest: pipe-B-eDP-1-size-128
[354.667333] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.460s)
[354.727714] Starting dynamic subtest: pipe-B-eDP-1-size-256
[357.202983] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.482s)
[357.550241] Starting dynamic subtest: pipe-C-eDP-1-size-64
[360.464281] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.923s)
[360.502846] Starting dynamic subtest: pipe-C-eDP-1-size-128
[362.621479] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.125s)
[362.658943] Starting dynamic subtest: pipe-C-eDP-1-size-256
[364.765388] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.114s)
[365.094776] Starting dynamic subtest: pipe-D-eDP-1-size-64
[367.983334] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.901s)
[368.021418] Starting dynamic subtest: pipe-D-eDP-1-size-128
[370.139663] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.125s)
[370.176922] Starting dynamic subtest: pipe-D-eDP-1-size-256
[372.283395] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.114s)
[372.610256] Subtest overlay: SUCCESS (31.631s)
[373.476637] [099/133] (648s left) gem_mmap_offset (partial-unmap)
[373.536650] Starting subtest: partial-unmap
[373.538947] Starting dynamic subtest: smem0
[374.024969] Dynamic subtest smem0: SUCCESS (0.489s)
[374.027679] Subtest partial-unmap: SUCCESS (0.490s)
[374.132161] [100/133] (648s left) gem_tiled_fence_blits (basic)
[374.191920] Subtest basic: SKIP (0.000s)
[374.273075] [101/133] (648s left) kms_plane (plane-panning-top-left)
[374.371297] Starting subtest: plane-panning-top-left
[374.373550] Starting dynamic subtest: pipe-A
[376.030493] Dynamic subtest pipe-A: SUCCESS (1.659s)
[376.043028] Starting dynamic subtest: pipe-B
[378.432244] Dynamic subtest pipe-B: SUCCESS (2.399s)
[378.434415] Subtest plane-panning-top-left: SUCCESS (4.061s)
[379.336595] [102/133] (643s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[379.435932] Starting subtest: fbc-psr2-sprite-mmap-cpu
[379.438222] Starting dynamic subtest: eDP-1
[379.442361] Dynamic subtest eDP-1: SKIP (0.000s)
[379.446674] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[379.510790] [103/133] (642s left) gem_exec_fence (parallel)
[379.698848] Starting subtest: parallel
[379.701446] Starting dynamic subtest: rcs0
[381.850866] Dynamic subtest rcs0: SUCCESS (2.152s)
[381.859296] Starting dynamic subtest: bcs0
[383.999897] Dynamic subtest bcs0: SUCCESS (2.148s)
[384.010930] Starting dynamic subtest: vcs0
[386.150138] Dynamic subtest vcs0: SUCCESS (2.150s)
[386.159369] Starting dynamic subtest: vcs1
[388.299064] Dynamic subtest vcs1: SUCCESS (2.148s)
[388.307680] Starting dynamic subtest: vecs0
[390.448060] Dynamic subtest vecs0: SUCCESS (2.148s)
[390.458414] Starting dynamic subtest: ccs0
[392.600103] Dynamic subtest ccs0: SUCCESS (2.151s)
[392.601955] Subtest parallel: SUCCESS (12.902s)
[393.998409] [104/133] (628s left) kms_flip (flip-vs-dpms-on-nop)
[394.113138] Starting subtest: flip-vs-dpms-on-nop
[394.115415] Starting dynamic subtest: A-eDP1
[396.013495] Dynamic subtest A-eDP1: SUCCESS (1.899s)
[396.024600] Starting dynamic subtest: B-eDP1
[397.834850] Dynamic subtest B-eDP1: SUCCESS (1.820s)
[397.843929] Starting dynamic subtest: C-eDP1
[399.649096] Dynamic subtest C-eDP1: SUCCESS (1.813s)
[399.659506] Starting dynamic subtest: D-eDP1
[401.475961] Dynamic subtest D-eDP1: SUCCESS (1.825s)
[401.481046] Subtest flip-vs-dpms-on-nop: SUCCESS (7.369s)
[402.655416] [105/133] (619s left) prime_vgem (basic-gtt)
[402.757482] Starting subtest: basic-gtt
[402.762247] Subtest basic-gtt: SKIP (0.000s)
[402.863052] [106/133] (619s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[402.969760] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[407.375212] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.409s)
[408.546220] [107/133] (614s left) gem_exec_parallel (engines)
[408.611473] Starting subtest: engines
[408.613862] Starting dynamic subtest: basic
[411.925562] Dynamic subtest basic: SUCCESS (3.312s)
[411.936805] Starting dynamic subtest: contexts
[416.377385] Dynamic subtest contexts: SUCCESS (4.449s)
[416.390156] Starting dynamic subtest: fds
[420.221492] Dynamic subtest fds: SUCCESS (3.841s)
[420.233708] Starting dynamic subtest: userptr
[421.933063] Dynamic subtest userptr: SUCCESS (1.711s)
[421.935801] Subtest engines: SUCCESS (13.321s)
[422.125565] [108/133] (600s left) kms_psr (psr-primary-mmap-cpu)
[422.227041] Starting subtest: psr-primary-mmap-cpu
[422.229365] Starting dynamic subtest: eDP-1
[423.927674] Dynamic subtest eDP-1: SUCCESS (1.699s)
[423.929910] Subtest psr-primary-mmap-cpu: SUCCESS (1.700s)
[424.790207] [109/133] (597s left) gem_softpin (noreloc-s3)
[424.854629] Starting subtest: noreloc-S3
[444.819339] Subtest noreloc-S3: SUCCESS (5.422s)
[445.000454] [110/133] (577s left) gem_exec_params (invalid-flag)
[445.066584] Starting subtest: invalid-flag
[445.068886] Subtest invalid-flag: SUCCESS (0.000s)
[445.174812] [111/133] (577s left) kms_async_flips (test-time-stamp)
[445.269504] Starting subtest: test-time-stamp
[445.646409] Starting dynamic subtest: pipe-A-eDP-1
[446.426502] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.795s)
[446.808171] Starting dynamic subtest: pipe-B-eDP-1
[447.554860] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s)
[447.944299] Starting dynamic subtest: pipe-C-eDP-1
[448.701839] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.777s)
[449.074225] Starting dynamic subtest: pipe-D-eDP-1
[449.835323] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[449.837975] Subtest test-time-stamp: SUCCESS (4.647s)
[450.997789] [112/133] (571s left) gem_exec_fence (basic-wait)
[451.163622] Starting subtest: basic-wait
[451.165969] Starting dynamic subtest: rcs0
[451.222834] Dynamic subtest rcs0: SUCCESS (0.059s)
[451.232954] Starting dynamic subtest: bcs0
[451.282940] Dynamic subtest bcs0: SUCCESS (0.059s)
[451.293648] Starting dynamic subtest: vcs0
[451.347670] Dynamic subtest vcs0: SUCCESS (0.063s)
[451.358711] Starting dynamic subtest: vcs1
[451.406378] Dynamic subtest vcs1: SUCCESS (0.058s)
[451.417825] Starting dynamic subtest: vecs0
[451.461010] Dynamic subtest vecs0: SUCCESS (0.053s)
[451.472358] Starting dynamic subtest: ccs0
[451.523687] Dynamic subtest ccs0: SUCCESS (0.061s)
[451.526375] Subtest basic-wait: SUCCESS (0.365s)
[453.669277] [113/133] (569s left) gem_exec_reloc (basic-cpu-gtt-active)
[453.737315] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[453.814169] [114/133] (569s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[453.921977] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[454.540867] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.625s)
[454.694061] [115/133] (568s left) kms_pm_rpm (system-suspend-modeset)
[456.710306] Starting subtest: system-suspend-modeset
[479.518090] Subtest system-suspend-modeset: SUCCESS (7.740s)
[479.904013] [116/133] (543s left) perf (per-context-mode-unprivileged)
[480.014057] Starting subtest: per-context-mode-unprivileged
[480.018229] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[480.060791] [117/133] (543s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[480.353502] Starting subtest: cursor-rapid-movement-512x170
[480.357493] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[480.478952] [118/133] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[480.592613] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[487.189877] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.613s)
[487.328414] [119/133] (535s left) kms_vblank (query-forked-busy)
[487.430030] Starting subtest: query-forked-busy
[487.432252] Starting dynamic subtest: pipe-A-eDP-1
[489.306236] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[489.320980] Starting dynamic subtest: pipe-D-eDP-1
[491.857745] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[491.859697] Subtest query-forked-busy: SUCCESS (4.431s)
[492.669865] [120/133] (530s left) gem_mmap_wc (bad-object)
[492.727290] Subtest bad-object: SKIP (0.000s)
[492.796828] [121/133] (530s left) kms_cursor_edge_walk (256x256-top-edge)
[492.903618] Starting subtest: 256x256-top-edge
[492.905843] Starting dynamic subtest: pipe-A-eDP-1
[496.329909] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.429s)
[496.340232] Starting dynamic subtest: pipe-D-eDP-1
[499.447370] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[499.449998] Subtest 256x256-top-edge: SUCCESS (6.549s)
[500.250681] [122/133] (523s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[500.348224] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[500.352175] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[500.443207] [123/133] (522s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[500.533460] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[500.535774] Starting dynamic subtest: A-eDP1
[521.603041] Dynamic subtest A-eDP1: FAIL (20.890s)
[521.612274] Starting dynamic subtest: B-eDP1
[530.103979] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[530.117754] Starting dynamic subtest: C-eDP1
[539.017660] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[539.027427] Starting dynamic subtest: D-eDP1
[547.956384] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[547.962327] Subtest flip-vs-absolute-wf_vblank-interruptible: FAIL (47.684s)
[549.181952] [124/133] (474s left) i915_suspend (fence-restore-untiled)
[549.252636] Starting subtest: fence-restore-untiled
[549.256652] Subtest fence-restore-untiled: SKIP (0.000s)
[549.367623] [125/133] (474s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[549.432169] Starting subtest: basic-batch-kernel-default-cmd
[549.436599] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[549.614819] [126/133] (473s left) kms_flip (2x-blocking-absolute-wf_vblank)
[549.704690] Starting subtest: 2x-blocking-absolute-wf_vblank
[549.716585] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[549.797116] [127/133] (473s left) gem_create (create-massive)
[549.860171] Starting subtest: create-massive
[549.862456] Subtest create-massive: SUCCESS (0.000s)
[550.056731] [128/133] (473s left) gem_ppgtt (flink-and-close-vma-leak)
[550.109077] Starting subtest: flink-and-close-vma-leak
[550.150165] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[550.271203] [129/133] (473s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[550.365869] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[550.368142] Starting dynamic subtest: pipe-A-eDP-1
[550.425050] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[550.435621] Starting dynamic subtest: pipe-B-eDP-1
[550.493766] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[550.503703] Starting dynamic subtest: pipe-C-eDP-1
[550.557145] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[550.566389] Starting dynamic subtest: pipe-D-eDP-1
[550.624468] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[550.628950] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[552.626702] [130/133] (470s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[552.741765] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[552.744008] Starting dynamic subtest: pipe-A-eDP-1
[553.948275] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.208s)
[553.958663] Starting dynamic subtest: pipe-B-eDP-1
[556.242706] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.293s)
[556.253590] Starting dynamic subtest: pipe-C-eDP-1
[558.573847] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.330s)
[558.589486] Starting dynamic subtest: pipe-D-eDP-1
[560.886806] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.312s)
[560.889457] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.149s)
[562.036760] [131/133] (461s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[562.090739] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[562.196147] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[562.273822] [132/133] (461s left) kms_plane_alpha_blend (alpha-transparent-fb)
[562.361630] Starting subtest: alpha-transparent-fb
[562.639940] Starting dynamic subtest: pipe-A-eDP-1
[563.235569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[563.247979] Starting dynamic subtest: pipe-D-eDP-1
[564.615628] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.385s)
[564.617914] Subtest alpha-transparent-fb: SUCCESS (2.257s)
[565.417066] [133/133] (458s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[565.515686] Starting subtest: sprite-rotation-90-pos-100-0
[565.520207] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[565.588022] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: prime_mmap
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_draw_crc
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: sysfs_preempt_timeout
results: parsing output: 11/ for test: kms_lease
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: i915_getparams_basic
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_busy
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: gen9_exec_parse
results: parsing output: 26/ for test: i915_drm_fdinfo
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_content_protection
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_flip_scaled_crc
results: parsing output: 31/ for test: gem_ccs
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_partial_pwrite_pread
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: syncobj_basic
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_color
results: parsing output: 49/ for test: kms_invalid_mode
results: parsing output: 50/ for test: kms_sequence
results: parsing output: 51/ for test: api_intel_bb
results: parsing output: 52/ for test: gem_ctx_bad_destroy
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: kms_chamelium_edid
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: syncobj_basic
results: parsing output: 58/ for test: api_intel_allocator
results: parsing output: 59/ for test: gem_bad_reloc
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: gem_basic
results: parsing output: 63/ for test: i915_pm_rpm
results: parsing output: 64/ for test: gem_spin_batch
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_gpgpu_fill
results: parsing output: 67/ for test: core_sysfs
results: parsing output: 68/ for test: perf
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_addfb_basic
results: parsing output: 74/ for test: gem_pxp
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: gem_fence_thrash
results: parsing output: 77/ for test: gem_ctx_isolation
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_chamelium_hpd
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: gem_ctx_param
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: gem_exec_balancer
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_rotation_crc
results: parsing output: 94/ for test: kms_dp_link_training
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr2_su
results: parsing output: 97/ for test: kms_plane_cursor
results: parsing output: 98/ for test: gem_mmap_offset
results: parsing output: 99/ for test: gem_tiled_fence_blits
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: prime_vgem
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_exec_parallel
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_vblank
results: parsing output: 119/ for test: gem_mmap_wc
results: parsing output: 120/ for test: kms_cursor_edge_walk
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: i915_suspend
results: parsing output: 124/ for test: gem_exec_flush
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: gem_create
results: parsing output: 127/ for test: gem_ppgtt
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_plane_alpha_blend
results: parsing output: 132/ for test: kms_rotation_crc
Done.