[60.859991] Initializing watchdogs
[60.860051]   /dev/watchdog0
[60.873217] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.877697] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.880091] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.883855] [001/133] (960s left) syncobj_timeline (multi-wait-available-signaled)
[60.959260] Starting subtest: multi-wait-available-signaled
[60.961764] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[61.057399] [002/133] (960s left) kms_psr (pr-suspend)
[61.161481] Starting subtest: pr-suspend
[61.165632] Subtest pr-suspend: SKIP (0.000s)
[61.247421] [003/133] (960s left) prime_mmap (test_reprime)
[61.305734] Starting subtest: test_reprime
[61.307640] Starting dynamic subtest: test_reprime-smem
[61.334781] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[61.337254] Subtest test_reprime: SUCCESS (0.031s)
[61.420810] [004/133] (960s left) perf (gen12-group-exclusive-stream-sample-oa)
[61.550642] Starting subtest: gen12-group-exclusive-stream-sample-oa
[61.569321] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.019s)
[61.611881] [005/133] (959s left) gem_userptr_blits (stress-mm)
[61.678654] Starting subtest: stress-mm
[67.064916] Subtest stress-mm: SUCCESS (5.369s)
[67.591409] [006/133] (953s left) kms_draw_crc (draw-method-blt)
[67.720215] Starting subtest: draw-method-blt
[67.722674] Starting dynamic subtest: xrgb8888-untiled
[67.989307] Dynamic subtest xrgb8888-untiled: SUCCESS (0.270s)
[67.996674] Starting dynamic subtest: rgb565-untiled
[68.211853] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[68.219958] Starting dynamic subtest: xrgb2101010-untiled
[68.434426] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[68.442666] Starting dynamic subtest: xbgr16161616f-untiled
[68.667920] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[68.674678] Starting dynamic subtest: xrgb8888-xtiled
[68.790227] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[68.798227] Starting dynamic subtest: rgb565-xtiled
[68.901649] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[68.909555] Starting dynamic subtest: xrgb2101010-xtiled
[69.013103] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[69.019688] Starting dynamic subtest: xbgr16161616f-xtiled
[69.113037] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s)
[69.120817] Starting dynamic subtest: xrgb8888-4tiled
[69.235240] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[69.244032] Starting dynamic subtest: rgb565-4tiled
[69.346869] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[69.356751] Starting dynamic subtest: xrgb2101010-4tiled
[69.457938] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[69.466091] Starting dynamic subtest: xbgr16161616f-4tiled
[69.569193] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.111s)
[69.571141] Subtest draw-method-blt: SUCCESS (1.848s)
[69.670897] [007/133] (951s left) gem_exec_params (dr1-dirt)
[69.730914] Starting subtest: DR1-dirt
[69.732952] Subtest DR1-dirt: SUCCESS (0.000s)
[69.817738] [008/133] (951s left) kms_big_fb (linear-8bpp-rotate-180)
[69.915333] Starting subtest: linear-8bpp-rotate-180
[71.124574] Subtest linear-8bpp-rotate-180: SUCCESS (1.208s)
[71.270183] [009/133] (950s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[71.373394] Starting subtest: y-tiled-64bpp-rotate-0
[71.376987] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[71.478422] [010/133] (950s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[71.576097] Starting subtest: psr-1p-pri-indfb-multidraw
[94.350472] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.760s)
[94.475907] [011/133] (927s left) sysfs_preempt_timeout (timeout)
[94.543960] Starting subtest: timeout
[94.546098] Starting dynamic subtest: vecs0
[103.889453] Dynamic subtest vecs0: SUCCESS (9.338s)
[103.899502] Starting dynamic subtest: ccs0
[105.158664] Dynamic subtest ccs0: SUCCESS (1.268s)
[105.169155] Starting dynamic subtest: vcs0
[114.895642] Dynamic subtest vcs0: SUCCESS (9.731s)
[114.905870] Starting dynamic subtest: bcs0
[116.136290] Dynamic subtest bcs0: SUCCESS (1.240s)
[116.145824] Starting dynamic subtest: rcs0
[117.365329] Dynamic subtest rcs0: SUCCESS (1.227s)
[117.373621] Starting dynamic subtest: vcs1
[126.930316] Dynamic subtest vcs1: SUCCESS (9.559s)
[126.933075] Subtest timeout: SUCCESS (32.374s)
[127.017372] [012/133] (894s left) kms_lease (simple-lease)
[127.124166] Starting subtest: simple-lease
[127.126482] Starting dynamic subtest: pipe-A-eDP-1
[127.620606] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s)
[127.628831] Starting dynamic subtest: pipe-B-eDP-1
[129.060214] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.438s)
[129.067859] Starting dynamic subtest: pipe-C-eDP-1
[130.473038] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.410s)
[130.481042] Starting dynamic subtest: pipe-D-eDP-1
[131.876389] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.401s)
[131.878847] Subtest simple-lease: SUCCESS (4.752s)
[132.673592] [013/133] (889s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[132.768059] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[132.770176] Starting dynamic subtest: pipe-A-default-mode
[135.531351] Dynamic subtest pipe-A-default-mode: SUCCESS (2.761s)
[135.533243] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.762s)
[136.374987] [014/133] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[136.469927] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[136.474130] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[136.567456] [015/133] (885s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[136.665439] Starting subtest: 2x-flip-vs-rmfb-interruptible
[136.676255] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[136.770272] [016/133] (885s left) syncobj_wait (invalid-reset-illegal-handle)
[136.829433] Starting subtest: invalid-reset-illegal-handle
[136.831723] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[136.907257] [017/133] (885s left) perf_pmu (render-node-busy-idle)
[136.986990] Starting subtest: render-node-busy-idle
[136.989302] Starting dynamic subtest: rcs0
[137.676863] Dynamic subtest rcs0: SUCCESS (0.689s)
[137.687771] Starting dynamic subtest: bcs0
[138.335913] Dynamic subtest bcs0: SUCCESS (0.657s)
[138.346814] Starting dynamic subtest: vcs0
[139.925273] Dynamic subtest vcs0: SUCCESS (1.585s)
[139.934957] Starting dynamic subtest: vcs1
[141.908977] Dynamic subtest vcs1: SUCCESS (1.981s)
[141.919577] Starting dynamic subtest: vecs0
[143.893385] Dynamic subtest vecs0: SUCCESS (1.982s)
[143.904320] Starting dynamic subtest: ccs0
[144.560330] Dynamic subtest ccs0: SUCCESS (0.666s)
[144.562941] Subtest render-node-busy-idle: SUCCESS (7.574s)
[144.637567] [018/133] (877s left) i915_getparams_basic (basic-subslice-total)
[144.686128] Starting subtest: basic-subslice-total
[144.690188] Subtest basic-subslice-total: SUCCESS (0.000s)
[144.775424] [019/133] (877s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[144.880598] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[144.884643] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[144.944882] [020/133] (877s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[145.047954] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[145.050278] Starting dynamic subtest: pipe-A
[146.097486] Dynamic subtest pipe-A: SUCCESS (1.050s)
[146.105518] Starting dynamic subtest: pipe-B
[148.287828] Dynamic subtest pipe-B: SUCCESS (2.193s)
[148.296506] Starting dynamic subtest: pipe-C
[149.474237] Dynamic subtest pipe-C: SUCCESS (1.185s)
[149.483135] Starting dynamic subtest: pipe-D
[150.613717] Dynamic subtest pipe-D: SUCCESS (1.139s)
[150.615935] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.571s)
[151.805801] [021/133] (870s left) gem_eio (context-create)
[152.006853] Starting subtest: context-create
[152.497561] Subtest context-create: SUCCESS (0.490s)
[152.615708] [022/133] (869s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[152.717720] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[159.442857] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.731s)
[159.587513] [023/133] (862s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[159.678324] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[159.682600] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[159.778493] [024/133] (862s left) kms_busy (basic)
[159.865990] Starting subtest: basic
[159.868527] Starting dynamic subtest: flip
[160.442377] Dynamic subtest flip: SUCCESS (0.577s)
[160.452422] Starting dynamic subtest: modeset
[163.877182] Dynamic subtest modeset: SUCCESS (3.435s)
[163.879554] Subtest basic: SUCCESS (4.015s)
[164.676705] [025/133] (857s left) gem_userptr_blits (probe)
[164.743667] Starting subtest: probe
[164.819341] Subtest probe: SUCCESS (0.075s)
[164.956465] [026/133] (857s left) gen9_exec_parse (bb-start-out)
[165.007044] Subtest bb-start-out: SKIP (0.000s)
[165.067113] [027/133] (857s left) i915_drm_fdinfo (idle)
[165.109787] Starting subtest: idle
[165.112088] Starting dynamic subtest: rcs0
[165.671033] Dynamic subtest rcs0: SUCCESS (0.563s)
[165.680826] Starting dynamic subtest: bcs0
[166.182815] Dynamic subtest bcs0: SUCCESS (0.504s)
[166.192739] Starting dynamic subtest: vcs0
[166.689251] Dynamic subtest vcs0: SUCCESS (0.504s)
[166.699792] Starting dynamic subtest: vcs1
[167.190359] Dynamic subtest vcs1: SUCCESS (0.503s)
[167.200990] Starting dynamic subtest: vecs0
[167.696819] Dynamic subtest vecs0: SUCCESS (0.503s)
[167.707654] Starting dynamic subtest: ccs0
[168.202042] Dynamic subtest ccs0: SUCCESS (0.503s)
[168.205050] Subtest idle: SUCCESS (3.095s)
[168.293528] [028/133] (854s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[168.403975] Starting subtest: bad-aux-stride-y-tiled-ccs
[168.406193] Starting dynamic subtest: pipe-A-eDP-1
[168.428632] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[168.438906] Starting dynamic subtest: pipe-B-eDP-1
[168.460119] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[168.467597] Starting dynamic subtest: pipe-C-eDP-1
[168.488820] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[168.496500] Starting dynamic subtest: pipe-D-eDP-1
[168.517853] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[168.521842] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[170.639432] [029/133] (851s left) kms_content_protection (uevent-hdcp14)
[170.770337] Starting subtest: uevent-hdcp14
[170.774798] Subtest uevent-hdcp14: SKIP (0.000s)
[170.897263] [030/133] (851s left) syncobj_timeline (invalid-query-bad-pad)
[170.951841] Starting subtest: invalid-query-bad-pad
[170.954066] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[171.067870] [031/133] (851s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[171.162196] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[171.166639] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[171.230290] [032/133] (851s left) gem_ccs (block-copy-compressed)
[171.289792] Starting subtest: block-copy-compressed
[171.294344] Subtest block-copy-compressed: SKIP (0.000s)
[171.387518] [033/133] (851s left) kms_cursor_crc (cursor-offscreen-256x85)
[171.658960] Starting subtest: cursor-offscreen-256x85
[171.709708] Subtest cursor-offscreen-256x85: SKIP (0.047s)
[171.869857] [034/133] (850s left) perf (mi-rpc)
[171.957084] Starting subtest: mi-rpc
[171.961057] Subtest mi-rpc: SKIP (0.000s)
[171.995426] [035/133] (850s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[172.075160] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[172.077051] Starting dynamic subtest: pipe-A-eDP-1
[172.096516] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[172.105768] Starting dynamic subtest: pipe-B-eDP-1
[172.123929] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[172.131680] Starting dynamic subtest: pipe-C-eDP-1
[172.149581] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[172.157181] Starting dynamic subtest: pipe-D-eDP-1
[172.175305] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[172.178600] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[174.303334] [036/133] (848s left) gem_partial_pwrite_pread (reads-uncached)
[174.358557] Subtest reads-uncached: SKIP (0.000s)
[174.431100] [037/133] (848s left) perf_pmu (all-busy-idle-check-all)
[174.475067] Starting subtest: all-busy-idle-check-all
[175.893973] Subtest all-busy-idle-check-all: SUCCESS (1.420s)
[175.992162] [038/133] (846s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[176.081922] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[176.084193] Starting dynamic subtest: pipe-A-eDP-1
[176.092848] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[176.102050] Starting dynamic subtest: pipe-B-eDP-1
[176.110391] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[176.118631] Starting dynamic subtest: pipe-C-eDP-1
[176.126892] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[176.134406] Starting dynamic subtest: pipe-D-eDP-1
[176.142573] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[176.146599] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[178.363391] [039/133] (844s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[178.488179] Starting subtest: x-tiled-16bpp-rotate-0
[179.878303] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.387s)
[179.984388] [040/133] (842s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[180.037705] Starting subtest: y-tiled-to-vebox-y-tiled
[180.041473] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[180.225071] [041/133] (842s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[180.324034] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[180.326300] Starting dynamic subtest: pipe-A-eDP-1
[180.408420] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[180.419037] Starting dynamic subtest: pipe-B-eDP-1
[181.545661] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[181.550365] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.226s)
[182.737435] [042/133] (840s left) kms_addfb_basic (addfb25-bad-modifier)
[182.824826] Starting subtest: addfb25-bad-modifier
[182.827130] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[182.924101] [043/133] (840s left) syncobj_basic (bad-fd-to-handle)
[182.987579] Starting subtest: bad-fd-to-handle
[182.989870] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[183.067992] [044/133] (839s left) perf (stress-open-close)
[183.157436] Starting subtest: stress-open-close
[183.159647] Starting dynamic subtest: 0-rcs0
[185.323383] Dynamic subtest 0-rcs0: SUCCESS (2.169s)
[185.332765] Starting dynamic subtest: 1-vcs1
[187.483562] Dynamic subtest 1-vcs1: SUCCESS (2.159s)
[187.485514] Subtest stress-open-close: SUCCESS (4.330s)
[187.527404] [045/133] (835s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[187.616129] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[187.619793] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[187.687221] [046/133] (835s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[187.774203] Starting subtest: primary-yf-tiled-reflect-x-0
[187.834152] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[187.936084] [047/133] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[188.022892] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[188.026142] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[188.118757] [048/133] (835s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[188.211391] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[188.214772] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[188.334064] [049/133] (834s left) kms_color (ctm-signed)
[188.424299] Starting subtest: ctm-signed
[188.426215] Starting dynamic subtest: pipe-A-eDP-1
[190.544404] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.117s)
[190.552553] Starting dynamic subtest: pipe-B-eDP-1
[193.313268] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s)
[193.323897] Starting dynamic subtest: pipe-C-eDP-1
[196.026920] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.711s)
[196.035603] Starting dynamic subtest: pipe-D-eDP-1
[198.690660] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.665s)
[198.693098] Subtest ctm-signed: SUCCESS (10.266s)
[199.511449] [050/133] (823s left) kms_invalid_mode (zero-clock)
[199.614814] Starting subtest: zero-clock
[199.617238] Starting dynamic subtest: pipe-A-eDP-1
[199.908447] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[199.916923] Starting dynamic subtest: pipe-B-eDP-1
[199.919071] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[199.926595] Starting dynamic subtest: pipe-C-eDP-1
[199.928787] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[199.936251] Starting dynamic subtest: pipe-D-eDP-1
[199.938437] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[199.940648] Subtest zero-clock: SUCCESS (0.300s)
[200.751918] [051/133] (822s left) kms_sequence (queue-busy)
[200.838056] Starting subtest: queue-busy
[200.840295] Starting dynamic subtest: pipe-A-eDP-1
[202.771203] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[202.779420] Starting dynamic subtest: pipe-B-eDP-1
[205.355582] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.583s)
[205.364437] Starting dynamic subtest: pipe-C-eDP-1
[207.965515] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.610s)
[207.973940] Starting dynamic subtest: pipe-D-eDP-1
[210.506328] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[210.508684] Subtest queue-busy: SUCCESS (9.671s)
[211.298169] [052/133] (812s left) api_intel_bb (misplaced-blitter)
[211.365126] Starting subtest: misplaced-blitter
[211.371342] Subtest misplaced-blitter: SUCCESS (0.007s)
[211.489633] [053/133] (811s left) gem_ctx_bad_destroy (invalid-default-ctx)
[211.543919] Starting subtest: invalid-default-ctx
[211.546234] Subtest invalid-default-ctx: SUCCESS (0.000s)
[211.617238] [054/133] (811s left) kms_psr (psr2-sprite-plane-move)
[211.712424] Starting subtest: psr2-sprite-plane-move
[211.714595] Starting dynamic subtest: eDP-1
[213.544465] Dynamic subtest eDP-1: SUCCESS (1.828s)
[213.546767] Subtest psr2-sprite-plane-move: SUCCESS (1.830s)
[214.379276] [055/133] (809s left) gem_exec_schedule (submit-early-slice)
[214.451451] Starting subtest: submit-early-slice
[214.453452] Starting dynamic subtest: rcs0
[214.491825] Dynamic subtest rcs0: SUCCESS (0.049s)
[214.502499] Starting dynamic subtest: bcs0
[214.534985] Dynamic subtest bcs0: SUCCESS (0.043s)
[214.544567] Starting dynamic subtest: vcs0
[214.575238] Dynamic subtest vcs0: SUCCESS (0.040s)
[214.584679] Starting dynamic subtest: vcs1
[214.618907] Dynamic subtest vcs1: SUCCESS (0.043s)
[214.630115] Starting dynamic subtest: vecs0
[214.658199] Dynamic subtest vecs0: SUCCESS (0.039s)
[214.667177] Starting dynamic subtest: ccs0
[214.705032] Dynamic subtest ccs0: SUCCESS (0.046s)
[214.707503] Subtest submit-early-slice: SUCCESS (0.263s)
[215.985925] [056/133] (807s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[216.377736] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[217.195759] [057/133] (806s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[217.256874] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[217.361211] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[217.433686] [058/133] (806s left) syncobj_basic (illegal-fd-to-handle)
[217.482086] Starting subtest: illegal-fd-to-handle
[217.483988] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[217.574851] [059/133] (806s left) api_intel_allocator (reserve-simple)
[217.626809] Starting subtest: reserve-simple
[217.628639] Subtest reserve-simple: SUCCESS (0.003s)
[217.734803] [060/133] (805s left) gem_bad_reloc (negative-reloc-bltcopy)
[217.787514] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[217.854405] [061/133] (805s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[217.944250] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[221.580212] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.639s)
[222.713656] [062/133] (801s left) gem_exec_schedule (preempt)
[222.790743] Starting subtest: preempt
[222.793053] Starting dynamic subtest: rcs0
[222.806066] Dynamic subtest rcs0: SUCCESS (0.023s)
[222.816563] Starting dynamic subtest: bcs0
[222.825385] Dynamic subtest bcs0: SUCCESS (0.019s)
[222.833478] Starting dynamic subtest: vcs0
[222.850440] Dynamic subtest vcs0: SUCCESS (0.024s)
[222.858434] Starting dynamic subtest: vcs1
[222.871395] Dynamic subtest vcs1: SUCCESS (0.020s)
[222.879368] Starting dynamic subtest: vecs0
[222.893437] Dynamic subtest vecs0: SUCCESS (0.022s)
[222.901291] Starting dynamic subtest: ccs0
[222.924527] Dynamic subtest ccs0: SUCCESS (0.030s)
[222.926713] Subtest preempt: SUCCESS (0.143s)
[223.973538] [063/133] (799s left) gem_basic (create-fd-close)
[224.027698] Starting subtest: create-fd-close
[224.032407] Subtest create-fd-close: SUCCESS (0.000s)
[224.143115] [064/133] (799s left) i915_pm_rpm (gem-execbuf)
[226.089740] Starting subtest: gem-execbuf
[226.092178] Starting dynamic subtest: smem0
[227.828062] Dynamic subtest smem0: SUCCESS (1.740s)
[227.830428] Subtest gem-execbuf: SUCCESS (1.742s)
[227.907864] [065/133] (795s left) gem_spin_batch (spin-each)
[227.965969] Starting subtest: spin-each
[231.325257] Subtest spin-each: SUCCESS (3.359s)
[231.970200] [066/133] (791s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[232.081532] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[238.755333] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.677s)
[238.887869] [067/133] (785s left) gem_gpgpu_fill (basic)
[238.946694] Starting subtest: basic
[238.949056] Starting dynamic subtest: smem
[238.951455] Dynamic subtest smem: SUCCESS (0.006s)
[238.953883] Subtest basic: SUCCESS (0.007s)
[239.099643] [068/133] (784s left) core_sysfs (read-all-entries)
[239.154109] Starting subtest: read-all-entries
[239.159575] Subtest read-all-entries: SUCCESS (0.008s)
[239.235644] [069/133] (784s left) perf (sysctl-defaults)
[239.304119] Starting subtest: sysctl-defaults
[239.306328] Subtest sysctl-defaults: SUCCESS (0.000s)
[239.377857] [070/133] (784s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[239.469996] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[239.473856] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[239.550955] [071/133] (784s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[239.647890] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[246.498277] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.851s)
[246.644995] [072/133] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[246.763067] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[246.767078] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[246.883492] [073/133] (777s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[246.973599] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[246.978302] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[247.088158] [074/133] (777s left) kms_addfb_basic (addfb25-4-tiled)
[247.200030] Starting subtest: addfb25-4-tiled
[247.202139] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[247.292614] [075/133] (776s left) gem_pxp (reject-modify-context-protection-off-1)
[247.423901] Starting subtest: reject-modify-context-protection-off-1
[247.426641] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[247.529864] [076/133] (776s left) gem_exec_schedule (wide)
[247.712229] Starting subtest: wide
[247.714869] Starting dynamic subtest: rcs0
[257.610817] Dynamic subtest rcs0: SUCCESS (9.897s)
[257.621628] Starting dynamic subtest: vcs0
[269.170906] Dynamic subtest vcs0: SUCCESS (11.559s)
[269.181924] Starting dynamic subtest: vcs1
[280.176021] Dynamic subtest vcs1: SUCCESS (11.002s)
[280.185800] Starting dynamic subtest: vecs0
[291.669761] Dynamic subtest vecs0: SUCCESS (11.491s)
[291.681255] Starting dynamic subtest: ccs0
[305.912025] Dynamic subtest ccs0: SUCCESS (14.238s)
[305.915024] Subtest wide: SUCCESS (58.192s)
[308.177387] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[308.180744] [077/133] (716s left) gem_fence_thrash (bo-write-verify-none)
[308.216523] Starting subtest: bo-write-verify-none
[308.237683] Subtest bo-write-verify-none: SKIP (0.018s)
[308.317883] [078/133] (716s left) gem_ctx_isolation (dirty-switch)
[308.386559] Starting subtest: dirty-switch
[308.389046] Starting dynamic subtest: rcs0
[308.642864] Dynamic subtest rcs0: SUCCESS (0.256s)
[308.657134] Starting dynamic subtest: bcs0
[308.924730] Dynamic subtest bcs0: SUCCESS (0.281s)
[308.936647] Starting dynamic subtest: vcs0
[309.178823] Dynamic subtest vcs0: SUCCESS (0.254s)
[309.187514] Starting dynamic subtest: vcs1
[311.159489] Dynamic subtest vcs1: SUCCESS (1.979s)
[311.171184] Starting dynamic subtest: vecs0
[313.135600] Dynamic subtest vecs0: SUCCESS (1.975s)
[313.146176] Starting dynamic subtest: ccs0
[315.141621] Dynamic subtest ccs0: SUCCESS (2.005s)
[315.144062] Subtest dirty-switch: SUCCESS (6.755s)
[315.381905] [079/133] (709s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[315.516414] Starting subtest: basic-flip-after-cursor-legacy
[316.437915] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.920s)
[317.252378] [080/133] (707s left) kms_psr (fbc-pr-primary-page-flip)
[317.339440] Starting subtest: fbc-pr-primary-page-flip
[317.343395] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[317.423998] [081/133] (707s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[317.516565] Starting subtest: 4-tiled-64bpp-rotate-0
[319.118858] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.603s)
[319.274923] [082/133] (705s left) gem_ctx_persistence (legacy-engines-persistence)
[319.328503] Starting subtest: legacy-engines-persistence
[319.331036] Starting dynamic subtest: render
[320.155730] Dynamic subtest render: SUCCESS (0.827s)
[320.170516] Starting dynamic subtest: bsd1
[320.918099] Dynamic subtest bsd1: SUCCESS (0.759s)
[320.930251] Starting dynamic subtest: bsd2
[321.681041] Dynamic subtest bsd2: SUCCESS (0.760s)
[321.693060] Starting dynamic subtest: blt
[322.448034] Dynamic subtest blt: SUCCESS (0.764s)
[322.459743] Starting dynamic subtest: vebox
[323.216946] Dynamic subtest vebox: SUCCESS (0.766s)
[323.219763] Subtest legacy-engines-persistence: SUCCESS (3.889s)
[323.311532] [083/133] (701s left) syncobj_timeline (wait-all-for-submit-complex)
[323.372200] Starting subtest: wait-all-for-submit-complex
[323.585656] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[323.675140] [084/133] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[323.764758] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[323.769222] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[323.860125] [085/133] (700s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[323.966849] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[323.971036] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[324.062740] [086/133] (700s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[324.161146] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[324.165616] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[324.259968] [087/133] (700s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[324.656127] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[325.466371] [088/133] (699s left) gem_lmem_swapping (smem-oom)
[325.505920] Subtest smem-oom: SKIP (0.000s)
[325.552012] [089/133] (699s left) gem_ctx_param (invalid-ctx-set)
[325.615349] Starting subtest: invalid-ctx-set
[325.617803] Subtest invalid-ctx-set: SUCCESS (0.001s)
[325.715228] [090/133] (699s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[327.244274] Starting subtest: dpms-mode-unset-lpsp
[331.306045] Subtest dpms-mode-unset-lpsp: SUCCESS (4.064s)
[331.679761] [091/133] (693s left) gem_exec_balancer (full)
[331.746010] Starting subtest: full
[336.742454] Subtest full: SUCCESS (4.996s)
[337.056254] [092/133] (687s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[337.114867] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[337.117380] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[337.234253] [093/133] (687s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[337.339557] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[337.344170] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[337.465295] [094/133] (687s left) kms_rotation_crc (exhaust-fences)
[337.557281] Starting subtest: exhaust-fences
[337.561506] Subtest exhaust-fences: SKIP (0.000s)
[337.629977] [095/133] (687s left) kms_dp_link_training (non-uhbr-sst)
[337.722350] Starting subtest: non-uhbr-sst
[337.730795] Subtest non-uhbr-sst: SKIP (0.000s)
[337.797252] [096/133] (687s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[337.887879] Starting subtest: fbcpsr-rgb101010-draw-render
[344.618340] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.733s)
[344.743550] [097/133] (680s left) kms_psr2_su (page_flip-xrgb8888)
[344.792200] Subtest page_flip-XRGB8888: SKIP (0.000s)
[344.849626] [098/133] (680s left) kms_plane_cursor (overlay)
[344.936114] Starting subtest: overlay
[344.940259] Starting dynamic subtest: pipe-A-eDP-1-size-64
[347.467948] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.532s)
[347.528847] Starting dynamic subtest: pipe-A-eDP-1-size-128
[350.046265] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.527s)
[350.106484] Starting dynamic subtest: pipe-A-eDP-1-size-256
[352.625721] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.527s)
[352.981281] Starting dynamic subtest: pipe-B-eDP-1-size-64
[356.167332] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.196s)
[356.226876] Starting dynamic subtest: pipe-B-eDP-1-size-128
[358.689495] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.471s)
[358.752367] Starting dynamic subtest: pipe-B-eDP-1-size-256
[361.179347] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.438s)
[361.531858] Starting dynamic subtest: pipe-C-eDP-1-size-64
[364.365401] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.844s)
[364.403115] Starting dynamic subtest: pipe-C-eDP-1-size-128
[366.634282] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.238s)
[366.670366] Starting dynamic subtest: pipe-C-eDP-1-size-256
[368.910623] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.248s)
[369.245997] Starting dynamic subtest: pipe-D-eDP-1-size-64
[372.082382] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.847s)
[372.120074] Starting dynamic subtest: pipe-D-eDP-1-size-128
[374.304206] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[374.342359] Starting dynamic subtest: pipe-D-eDP-1-size-256
[376.460104] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.125s)
[376.783632] Subtest overlay: SUCCESS (31.843s)
[377.578330] [099/133] (647s left) gem_mmap_offset (partial-unmap)
[377.636314] Starting subtest: partial-unmap
[377.638222] Starting dynamic subtest: smem0
[378.139725] Dynamic subtest smem0: SUCCESS (0.504s)
[378.142568] Subtest partial-unmap: SUCCESS (0.505s)
[378.249621] [100/133] (647s left) gem_tiled_fence_blits (basic)
[378.299621] Subtest basic: SKIP (0.000s)
[378.369468] [101/133] (646s left) kms_plane (plane-panning-top-left)
[378.458024] Starting subtest: plane-panning-top-left
[378.460313] Starting dynamic subtest: pipe-A
[380.143819] Dynamic subtest pipe-A: SUCCESS (1.684s)
[380.153745] Starting dynamic subtest: pipe-B
[382.532708] Dynamic subtest pipe-B: SUCCESS (2.388s)
[382.534928] Subtest plane-panning-top-left: SUCCESS (4.074s)
[383.329170] [102/133] (642s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[383.418931] Starting subtest: fbc-psr2-sprite-mmap-cpu
[383.421226] Starting dynamic subtest: eDP-1
[383.425419] Dynamic subtest eDP-1: SKIP (0.000s)
[383.429800] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[383.507680] [103/133] (641s left) gem_exec_fence (parallel)
[383.683034] Starting subtest: parallel
[383.685202] Starting dynamic subtest: rcs0
[385.829536] Dynamic subtest rcs0: SUCCESS (2.150s)
[385.838883] Starting dynamic subtest: bcs0
[387.980368] Dynamic subtest bcs0: SUCCESS (2.150s)
[387.989934] Starting dynamic subtest: vcs0
[390.133173] Dynamic subtest vcs0: SUCCESS (2.152s)
[390.144005] Starting dynamic subtest: vcs1
[392.283866] Dynamic subtest vcs1: SUCCESS (2.150s)
[392.293020] Starting dynamic subtest: vecs0
[394.435907] Dynamic subtest vecs0: SUCCESS (2.151s)
[394.445713] Starting dynamic subtest: ccs0
[396.585202] Dynamic subtest ccs0: SUCCESS (2.148s)
[396.587235] Subtest parallel: SUCCESS (12.905s)
[397.233936] [104/133] (628s left) kms_flip (flip-vs-dpms-on-nop)
[397.330163] Starting subtest: flip-vs-dpms-on-nop
[397.332465] Starting dynamic subtest: A-eDP1
[399.222415] Dynamic subtest A-eDP1: SUCCESS (1.894s)
[399.232248] Starting dynamic subtest: B-eDP1
[401.058405] Dynamic subtest B-eDP1: SUCCESS (1.834s)
[401.070999] Starting dynamic subtest: C-eDP1
[402.879242] Dynamic subtest C-eDP1: SUCCESS (1.818s)
[402.892094] Starting dynamic subtest: D-eDP1
[404.710870] Dynamic subtest D-eDP1: SUCCESS (1.830s)
[404.716023] Subtest flip-vs-dpms-on-nop: SUCCESS (7.389s)
[405.907633] [105/133] (619s left) prime_vgem (basic-gtt)
[405.996321] Starting subtest: basic-gtt
[406.001205] Subtest basic-gtt: SKIP (0.000s)
[406.098876] [106/133] (619s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[406.195683] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[410.725479] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.533s)
[411.895560] [107/133] (613s left) gem_exec_parallel (engines)
[411.951677] Starting subtest: engines
[411.954166] Starting dynamic subtest: basic
[413.844464] Dynamic subtest basic: SUCCESS (1.891s)
[413.855984] Starting dynamic subtest: contexts
[418.345912] Dynamic subtest contexts: SUCCESS (4.499s)
[418.378008] Starting dynamic subtest: fds
[422.126119] Dynamic subtest fds: SUCCESS (3.777s)
[422.136573] Starting dynamic subtest: userptr
[423.620896] Dynamic subtest userptr: SUCCESS (1.494s)
[423.623601] Subtest engines: SUCCESS (11.670s)
[423.816437] [108/133] (601s left) kms_psr (psr-primary-mmap-cpu)
[423.917049] Starting subtest: psr-primary-mmap-cpu
[423.919394] Starting dynamic subtest: eDP-1
[425.677639] Dynamic subtest eDP-1: SUCCESS (1.760s)
[425.680055] Subtest psr-primary-mmap-cpu: SUCCESS (1.761s)
[426.546983] [109/133] (599s left) gem_softpin (noreloc-s3)
[426.611251] Starting subtest: noreloc-S3
[445.701567] Subtest noreloc-S3: SUCCESS (5.418s)
[445.822408] [110/133] (579s left) gem_exec_params (invalid-flag)
[445.887416] Starting subtest: invalid-flag
[445.889928] Subtest invalid-flag: SUCCESS (0.000s)
[445.997155] [111/133] (579s left) kms_async_flips (test-time-stamp)
[446.097108] Starting subtest: test-time-stamp
[446.474779] Starting dynamic subtest: pipe-A-eDP-1
[447.273081] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.782s)
[447.644034] Starting dynamic subtest: pipe-B-eDP-1
[448.419764] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.769s)
[448.792796] Starting dynamic subtest: pipe-C-eDP-1
[449.564178] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[449.929288] Starting dynamic subtest: pipe-D-eDP-1
[450.710146] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[450.712758] Subtest test-time-stamp: SUCCESS (4.550s)
[451.877353] [112/133] (573s left) gem_exec_fence (basic-wait)
[452.062697] Starting subtest: basic-wait
[452.065165] Starting dynamic subtest: rcs0
[452.119945] Dynamic subtest rcs0: SUCCESS (0.060s)
[452.132375] Starting dynamic subtest: bcs0
[452.176100] Dynamic subtest bcs0: SUCCESS (0.054s)
[452.188098] Starting dynamic subtest: vcs0
[452.238034] Dynamic subtest vcs0: SUCCESS (0.059s)
[452.249555] Starting dynamic subtest: vcs1
[452.293948] Dynamic subtest vcs1: SUCCESS (0.053s)
[452.304985] Starting dynamic subtest: vecs0
[452.354044] Dynamic subtest vecs0: SUCCESS (0.057s)
[452.366552] Starting dynamic subtest: ccs0
[452.408952] Dynamic subtest ccs0: SUCCESS (0.053s)
[452.411407] Subtest basic-wait: SUCCESS (0.348s)
[454.574745] [113/133] (571s left) gem_exec_reloc (basic-cpu-gtt-active)
[454.642055] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[454.714605] [114/133] (571s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[454.820707] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[455.448125] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s)
[455.624789] [115/133] (570s left) kms_pm_rpm (system-suspend-modeset)
[457.655227] Starting subtest: system-suspend-modeset
[476.530436] Subtest system-suspend-modeset: SUCCESS (4.260s)
[476.923932] [116/133] (549s left) perf (per-context-mode-unprivileged)
[477.021119] Starting subtest: per-context-mode-unprivileged
[477.026229] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[477.070030] [117/133] (548s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[477.346357] Starting subtest: cursor-rapid-movement-512x170
[477.350799] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[477.487620] [118/133] (548s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[477.583443] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[484.234244] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.641s)
[484.357660] [119/133] (541s left) kms_vblank (query-forked-busy)
[484.461838] Starting subtest: query-forked-busy
[484.463740] Starting dynamic subtest: pipe-A-eDP-1
[486.340327] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[486.355104] Starting dynamic subtest: pipe-D-eDP-1
[488.935607] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.591s)
[488.938016] Subtest query-forked-busy: SUCCESS (4.470s)
[489.735180] [120/133] (536s left) gem_mmap_wc (bad-object)
[489.800826] Subtest bad-object: SKIP (0.000s)
[489.866203] [121/133] (536s left) kms_cursor_edge_walk (256x256-top-edge)
[489.958414] Starting subtest: 256x256-top-edge
[489.960656] Starting dynamic subtest: pipe-A-eDP-1
[493.403121] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.441s)
[493.415142] Starting dynamic subtest: pipe-D-eDP-1
[496.537147] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[496.539616] Subtest 256x256-top-edge: SUCCESS (6.574s)
[497.345313] [122/133] (528s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[497.450165] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[497.454111] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[497.546432] [123/133] (528s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[497.637834] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[497.640117] Starting dynamic subtest: A-eDP1
[519.057097] Dynamic subtest A-eDP1: FAIL (20.855s)
[519.066370] Starting dynamic subtest: B-eDP1
[527.621658] Dynamic subtest B-eDP1: SUCCESS (8.948s)
[527.634583] Starting dynamic subtest: C-eDP1
[536.554449] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[536.569005] Starting dynamic subtest: D-eDP1
[545.490312] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[545.495594] Subtest flip-vs-absolute-wf_vblank-interruptible: FAIL (47.673s)
[546.733544] [124/133] (479s left) i915_suspend (fence-restore-untiled)
[546.793124] Starting subtest: fence-restore-untiled
[546.797810] Subtest fence-restore-untiled: SKIP (0.000s)
[546.878429] [125/133] (479s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[546.945610] Starting subtest: basic-batch-kernel-default-cmd
[546.950324] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[547.133973] [126/133] (479s left) kms_flip (2x-blocking-absolute-wf_vblank)
[547.233257] Starting subtest: 2x-blocking-absolute-wf_vblank
[547.244977] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[547.321966] [127/133] (479s left) gem_create (create-massive)
[547.377608] Starting subtest: create-massive
[547.379765] Subtest create-massive: SUCCESS (0.000s)
[547.562381] [128/133] (478s left) gem_ppgtt (flink-and-close-vma-leak)
[547.636824] Starting subtest: flink-and-close-vma-leak
[547.675884] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[547.788288] [129/133] (478s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[547.881280] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[547.883791] Starting dynamic subtest: pipe-A-eDP-1
[547.940076] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[547.949596] Starting dynamic subtest: pipe-B-eDP-1
[548.003293] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[548.012634] Starting dynamic subtest: pipe-C-eDP-1
[548.065839] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[548.074770] Starting dynamic subtest: pipe-D-eDP-1
[548.129332] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[548.134139] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[550.178220] [130/133] (476s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[550.270892] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[550.273100] Starting dynamic subtest: pipe-A-eDP-1
[551.491061] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.222s)
[551.501647] Starting dynamic subtest: pipe-B-eDP-1
[553.868248] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.374s)
[553.879911] Starting dynamic subtest: pipe-C-eDP-1
[556.141881] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.273s)
[556.152015] Starting dynamic subtest: pipe-D-eDP-1
[558.482048] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.338s)
[558.484274] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.213s)
[559.628821] [131/133] (466s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[559.707221] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[559.812701] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[559.901147] [132/133] (466s left) kms_plane_alpha_blend (alpha-transparent-fb)
[559.991060] Starting subtest: alpha-transparent-fb
[560.268925] Starting dynamic subtest: pipe-A-eDP-1
[560.902113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s)
[560.912893] Starting dynamic subtest: pipe-D-eDP-1
[562.301799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.397s)
[562.304145] Subtest alpha-transparent-fb: SUCCESS (2.312s)
[563.100487] [133/133] (463s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[563.193496] Starting subtest: sprite-rotation-90-pos-100-0
[563.197852] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[563.262263] 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.