[57.883052] Initializing watchdogs
[57.883104]   /dev/watchdog0
[57.897835] [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.902299] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.904476] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.908018] [001/132] (960s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[58.023979] Starting subtest: primary-x-tiled-reflect-x-0
[64.980390] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.927s)
[66.162915] [002/132] (952s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[66.268636] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[72.885094] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.612s)
[73.009680] [003/132] (945s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[73.107514] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[73.111570] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[73.211337] [004/132] (945s left) gem_exec_balancer (invalid-bonds)
[73.274306] Starting subtest: invalid-bonds
[73.278553] Subtest invalid-bonds: SKIP (0.000s)
[73.563204] [005/132] (944s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[73.672224] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[74.718184] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.046s)
[74.838191] [006/132] (943s left) syncobj_timeline (wait-for-submit-snapshot)
[74.881899] Starting subtest: wait-for-submit-snapshot
[74.962746] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[75.031588] [007/132] (943s left) kms_flip (flip-vs-panning-interruptible)
[75.127642] Starting subtest: flip-vs-panning-interruptible
[75.129723] Starting dynamic subtest: A-eDP1
[83.826258] Dynamic subtest A-eDP1: SUCCESS (8.692s)
[83.834103] Starting dynamic subtest: B-eDP1
[92.548568] Dynamic subtest B-eDP1: SUCCESS (8.718s)
[92.556194] Starting dynamic subtest: C-eDP1
[101.268253] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[101.276938] Starting dynamic subtest: D-eDP1
[109.904992] Dynamic subtest D-eDP1: SUCCESS (8.635s)
[109.909756] Subtest flip-vs-panning-interruptible: SUCCESS (34.767s)
[111.067752] [008/132] (907s left) gem_exec_balancer (sequential)
[111.129574] Starting subtest: sequential
[114.203631] Subtest sequential: SUCCESS (3.073s)
[114.527937] [009/132] (904s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[114.634581] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[115.281023] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.648s)
[115.455623] [010/132] (903s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[115.550376] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[115.552573] Starting dynamic subtest: pipe-A-eDP-1
[115.638051] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[115.648249] Starting dynamic subtest: pipe-B-eDP-1
[116.752455] Dynamic subtest pipe-B-eDP-1: SKIP (1.112s)
[116.756904] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.204s)
[117.948869] [011/132] (900s left) kms_vblank (ts-continuation-idle-hang)
[118.053731] Starting subtest: ts-continuation-idle-hang
[118.056015] Starting dynamic subtest: pipe-A-eDP-1
[144.673095] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.617s)
[144.686583] Starting dynamic subtest: pipe-D-eDP-1
[169.697232] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.019s)
[169.699439] Subtest ts-continuation-idle-hang: SUCCESS (51.641s)
[170.509536] [012/132] (848s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[170.633680] Starting subtest: extended-modeset-hang-newfb-with-reset
[170.635909] Starting dynamic subtest: pipe-A
[185.801909] Dynamic subtest pipe-A: SUCCESS (15.165s)
[185.813854] Starting dynamic subtest: pipe-D
[201.880644] Dynamic subtest pipe-D: SUCCESS (16.076s)
[201.882939] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.245s)
[202.681315] [013/132] (816s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[202.809472] Starting subtest: flip-vs-cursor-crc-atomic
[203.565342] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.755s)
[204.437640] [014/132] (814s left) syncobj_wait (wait-all-for-submit-complex)
[204.504668] Starting subtest: wait-all-for-submit-complex
[204.719710] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[204.807992] [015/132] (814s left) kms_cursor_crc (cursor-offscreen-256x85)
[205.073866] Starting subtest: cursor-offscreen-256x85
[205.122468] Subtest cursor-offscreen-256x85: SKIP (0.043s)
[205.290809] [016/132] (813s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[207.116828] Starting subtest: gem-execbuf-stress-pc8
[207.152066] Subtest gem-execbuf-stress-pc8: SKIP (0.035s)
[207.573478] [017/132] (811s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[207.691672] Starting subtest: verify-pxp-key-change-after-suspend-resume
[214.922465] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.233s)
[215.054099] [018/132] (804s left) gem_bad_reloc (negative-reloc-bltcopy)
[215.128110] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[215.198209] [019/132] (803s left) kms_addfb_basic (basic-x-tiled-legacy)
[215.262198] Starting subtest: basic-x-tiled-legacy
[215.266508] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[215.389889] [020/132] (803s left) kms_cursor_edge_walk (64x64-top-bottom)
[215.481239] Starting subtest: 64x64-top-bottom
[215.483511] Starting dynamic subtest: pipe-A-eDP-1
[218.969479] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.487s)
[218.978956] Starting dynamic subtest: pipe-D-eDP-1
[222.091439] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[222.093730] Subtest 64x64-top-bottom: SUCCESS (6.613s)
[222.890548] [021/132] (796s left) gem_mmap_gtt (basic-write-read)
[222.945233] Subtest basic-write-read: SKIP (0.000s)
[222.996487] [022/132] (796s left) sriov_basic (enable-vfs-autoprobe-on)
[223.043021] Starting subtest: enable-vfs-autoprobe-on
[223.044865] Starting dynamic subtest: numvfs-1
[223.116274] Dynamic subtest numvfs-1: FAIL (0.016s)
[223.125072] Starting dynamic subtest: numvfs-2
[223.198576] Dynamic subtest numvfs-2: FAIL (0.004s)
[223.208292] Starting dynamic subtest: numvfs-3
[223.280777] Dynamic subtest numvfs-3: FAIL (0.004s)
[223.291748] Starting dynamic subtest: numvfs-4
[223.365227] Dynamic subtest numvfs-4: FAIL (0.004s)
[223.374990] Starting dynamic subtest: numvfs-5
[223.448170] Dynamic subtest numvfs-5: FAIL (0.004s)
[223.458817] Starting dynamic subtest: numvfs-6
[223.532265] Dynamic subtest numvfs-6: FAIL (0.004s)
[223.542431] Starting dynamic subtest: numvfs-7
[223.616912] Dynamic subtest numvfs-7: FAIL (0.004s)
[223.625545] Starting dynamic subtest: numvfs-random
[223.696973] Dynamic subtest numvfs-random: FAIL (0.004s)
[223.707385] Starting dynamic subtest: numvfs-all
[223.779585] Dynamic subtest numvfs-all: FAIL (0.514s)
[223.781878] Subtest enable-vfs-autoprobe-on: FAIL (0.564s)
[223.819204] [023/132] (795s left) perf_pmu (all-busy-idle-check-all)
[223.860210] Starting subtest: all-busy-idle-check-all
[225.941784] Subtest all-busy-idle-check-all: SUCCESS (2.080s)
[226.043602] [024/132] (793s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[226.146277] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[226.150272] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[226.242309] [025/132] (793s left) syncobj_wait (multi-wait-all-submitted)
[226.287759] Starting subtest: multi-wait-all-submitted
[226.392890] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[226.470157] [026/132] (792s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[226.576126] Starting subtest: y-tiled-32bpp-rotate-0
[226.580715] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[226.674259] [027/132] (792s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[226.767291] Starting subtest: psr2-cursor-plane-update-sf
[226.769676] Starting dynamic subtest: pipe-A-eDP-1
[227.329102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[227.338594] Starting dynamic subtest: pipe-B-eDP-1
[228.583590] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.254s)
[228.585962] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.820s)
[229.450991] [028/132] (790s left) kms_joiner (basic-force-ultra-joiner)
[229.553463] Starting subtest: basic-force-ultra-joiner
[229.557620] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[229.619631] [029/132] (789s left) drm_read (short-buffer-block)
[229.759747] Starting subtest: short-buffer-block
[229.762016] Subtest short-buffer-block: SUCCESS (0.000s)
[229.903054] [030/132] (789s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[230.018755] Starting subtest: plane-upscale-20x20-with-rotation
[230.020899] Starting dynamic subtest: pipe-A
[230.243352] Dynamic subtest pipe-A: SUCCESS (0.227s)
[230.252648] Starting dynamic subtest: pipe-B
[231.538906] Dynamic subtest pipe-B: SUCCESS (1.295s)
[231.547910] Starting dynamic subtest: pipe-C
[232.872395] Dynamic subtest pipe-C: SUCCESS (1.332s)
[232.881433] Starting dynamic subtest: pipe-D
[234.195997] Dynamic subtest pipe-D: SUCCESS (1.323s)
[234.198265] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.181s)
[235.372633] [031/132] (784s left) gem_lmem_swapping (verify)
[235.415206] Subtest verify: SKIP (0.000s)
[235.453408] [032/132] (784s left) gem_exec_whisper (basic-contexts-forked-all)
[235.515769] Starting subtest: basic-contexts-forked-all
[255.769881] Subtest basic-contexts-forked-all: SUCCESS (20.249s)
[255.953488] [033/132] (763s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[256.051302] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[256.055233] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[256.156382] [034/132] (763s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[256.253944] Starting subtest: psr-rgb101010-draw-render
[263.648863] Subtest psr-rgb101010-draw-render: SUCCESS (7.399s)
[263.774935] [035/132] (755s left) api_intel_bb (blit-noreloc-keep-cache)
[263.835081] Starting subtest: blit-noreloc-keep-cache
[263.844421] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s)
[263.976454] [036/132] (755s left) gem_exec_schedule (preempt-engines)
[264.039250] Starting subtest: preempt-engines
[264.041206] Starting dynamic subtest: rcs0
[266.280431] Dynamic subtest rcs0: SUCCESS (2.248s)
[266.292923] Starting dynamic subtest: bcs0
[268.579146] Dynamic subtest bcs0: SUCCESS (2.296s)
[268.589660] Starting dynamic subtest: vcs0
[270.868366] Dynamic subtest vcs0: SUCCESS (2.286s)
[270.878774] Starting dynamic subtest: vcs1
[273.158932] Dynamic subtest vcs1: SUCCESS (2.289s)
[273.170695] Starting dynamic subtest: vecs0
[275.431240] Dynamic subtest vecs0: SUCCESS (2.270s)
[275.442867] Starting dynamic subtest: ccs0
[277.734283] Dynamic subtest ccs0: SUCCESS (2.301s)
[277.737144] Subtest preempt-engines: SUCCESS (13.702s)
[278.036978] [037/132] (741s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[278.140743] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[278.145314] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[278.236289] [038/132] (741s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[278.331020] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[279.101084] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.770s)
[279.271809] [039/132] (740s left) kms_flip (flip-vs-blocking-wf-vblank)
[279.366379] Starting subtest: flip-vs-blocking-wf-vblank
[279.368268] Starting dynamic subtest: A-eDP1
[288.264330] Dynamic subtest A-eDP1: SUCCESS (8.900s)
[288.275919] Starting dynamic subtest: B-eDP1
[297.192177] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[297.201070] Starting dynamic subtest: C-eDP1
[306.116150] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[306.131721] Starting dynamic subtest: D-eDP1
[315.050858] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[315.055214] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.690s)
[316.278971] [040/132] (703s left) kms_psr (fbc-pr-primary-page-flip)
[316.369298] Starting subtest: fbc-pr-primary-page-flip
[316.373364] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[316.443900] [041/132] (703s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[316.530703] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[316.532990] Starting dynamic subtest: pipe-A-eDP-1
[316.555859] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[316.567689] Starting dynamic subtest: pipe-B-eDP-1
[316.591683] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[316.601244] Starting dynamic subtest: pipe-C-eDP-1
[316.622592] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[316.631702] Starting dynamic subtest: pipe-D-eDP-1
[316.653704] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[316.658334] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[318.750303] [042/132] (701s left) i915_query (query-topology-garbage-items)
[318.808307] Starting subtest: query-topology-garbage-items
[318.810681] Subtest query-topology-garbage-items: SUCCESS (0.001s)
[318.914033] [043/132] (701s left) perf_pmu (frequency)
[318.955492] Starting subtest: frequency
[318.960516] Starting dynamic subtest: gt0
[321.085314] Dynamic subtest gt0: SUCCESS (2.122s)
[321.095770] Starting dynamic subtest: idle-gt0
[321.612738] Dynamic subtest idle-gt0: SUCCESS (0.525s)
[321.624953] Starting dynamic subtest: gt1
[325.909061] Dynamic subtest gt1: SUCCESS (4.291s)
[325.921157] Starting dynamic subtest: idle-gt1
[326.416463] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[326.418682] Subtest frequency: SUCCESS (7.463s)
[326.510171] [044/132] (693s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[326.574137] Starting subtest: y-tiled-to-vebox-y-tiled
[326.578722] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[326.758323] [045/132] (693s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[326.857675] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[326.861829] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[326.968447] [046/132] (693s left) gem_ctx_param (invalid-set-ringsize)
[327.019832] Starting subtest: invalid-set-ringsize
[327.022229] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[327.091951] [047/132] (693s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[327.215847] Starting subtest: cursorA-vs-flipA-atomic-transitions
[338.392209] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.175s)
[339.189244] [048/132] (681s left) perf_pmu (busy-idle-check-all)
[339.241853] Starting subtest: busy-idle-check-all
[339.243729] Starting dynamic subtest: rcs0
[339.892717] Dynamic subtest rcs0: SUCCESS (0.651s)
[339.905570] Starting dynamic subtest: bcs0
[340.543697] Dynamic subtest bcs0: SUCCESS (0.649s)
[340.556379] Starting dynamic subtest: vcs0
[341.909450] Dynamic subtest vcs0: SUCCESS (1.361s)
[341.922574] Starting dynamic subtest: vcs1
[343.893619] Dynamic subtest vcs1: SUCCESS (1.980s)
[343.906728] Starting dynamic subtest: vecs0
[345.941595] Dynamic subtest vecs0: SUCCESS (2.044s)
[345.953835] Starting dynamic subtest: ccs0
[346.596944] Dynamic subtest ccs0: SUCCESS (0.654s)
[346.600086] Subtest busy-idle-check-all: SUCCESS (7.357s)
[346.690589] [049/132] (673s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[346.786101] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[346.790047] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[346.863181] [050/132] (673s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[346.964761] Starting subtest: fbc-tiling-linear
[350.688932] Subtest fbc-tiling-linear: SUCCESS (3.728s)
[351.887939] [051/132] (668s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[352.287391] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[353.078902] [052/132] (667s left) gem_partial_pwrite_pread (write)
[353.131269] Subtest write: SKIP (0.000s)
[353.201031] [053/132] (667s left) kms_atomic (plane-cursor-legacy)
[353.282551] Starting subtest: plane-cursor-legacy
[353.284623] Starting dynamic subtest: pipe-A-eDP-1
[353.663050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.381s)
[353.665216] Subtest plane-cursor-legacy: SUCCESS (0.382s)
[354.552191] [054/132] (665s left) gem_mmap_offset (clear-via-pagefault)
[354.606229] Starting subtest: clear-via-pagefault
[354.608338] Starting dynamic subtest: smem0
[392.002873] Dynamic subtest smem0: SUCCESS (37.389s)
[392.005302] Subtest clear-via-pagefault: SUCCESS (37.391s)
[392.118224] [055/132] (628s left) kms_color (invalid-gamma-lut-sizes)
[392.211425] Starting subtest: invalid-gamma-lut-sizes
[392.213693] Starting dynamic subtest: pipe-A
[392.518198] Dynamic subtest pipe-A: SUCCESS (0.306s)
[392.528072] Starting dynamic subtest: pipe-B
[392.530404] Dynamic subtest pipe-B: SUCCESS (0.000s)
[392.540416] Starting dynamic subtest: pipe-C
[392.542701] Dynamic subtest pipe-C: SUCCESS (0.000s)
[392.552251] Starting dynamic subtest: pipe-D
[392.554507] Dynamic subtest pipe-D: SUCCESS (0.000s)
[392.556794] Subtest invalid-gamma-lut-sizes: SUCCESS (0.310s)
[393.381670] [056/132] (627s left) gem_lmem_swapping (massive)
[393.430862] Subtest massive: SKIP (0.000s)
[393.476758] [057/132] (627s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[393.570245] Starting subtest: primary-4-tiled-reflect-x-0
[400.567416] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.000s)
[401.749835] [058/132] (618s left) gem_ppgtt (shrink-vs-evict-any)
[401.821729] Starting subtest: shrink-vs-evict-any
[407.859032] Subtest shrink-vs-evict-any: SUCCESS (6.035s)
[407.952974] [059/132] (612s left) gem_pwrite_snooped
[408.078441] [060/132] (612s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[408.139488] Starting subtest: invalid-single-wait-unsubmitted
[408.141419] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[408.246389] [061/132] (612s left) kms_psr (psr2-sprite-mmap-gtt)
[408.345760] Starting subtest: psr2-sprite-mmap-gtt
[408.347925] Starting dynamic subtest: eDP-1
[409.737590] Dynamic subtest eDP-1: SKIP (1.388s)
[409.742734] Subtest psr2-sprite-mmap-gtt: SKIP (1.390s)
[409.878338] [062/132] (610s left) syncobj_wait (reset-multiple-signaled)
[409.930572] Starting subtest: reset-multiple-signaled
[409.932883] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[410.018800] [063/132] (610s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[410.077277] Starting subtest: multi-wait-for-submit-available-submitted
[410.079487] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[410.187578] [064/132] (610s left) gen7_exec_parse (basic-offset)
[410.257606] Subtest basic-offset: SKIP (0.000s)
[410.334766] [065/132] (610s left) syncobj_basic (bad-fd-to-handle)
[410.394864] Starting subtest: bad-fd-to-handle
[410.397731] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[410.525821] [066/132] (610s left) dumb_buffer (invalid-bpp)
[410.575455] Starting subtest: invalid-bpp
[410.577465] Subtest invalid-bpp: SUCCESS (0.000s)
[410.690243] [067/132] (610s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[410.747907] Starting subtest: single-wait-all-for-submit-available-submitted
[410.749932] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[410.836698] [068/132] (610s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[410.951410] Starting subtest: yf-tiled-addfb-size-overflow
[410.955222] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[411.075174] [069/132] (610s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[411.163361] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[411.167122] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[411.240709] [070/132] (610s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[411.352690] Starting subtest: 4-tiled-8bpp-rotate-0
[412.544647] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.192s)
[412.669511] [071/132] (608s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[412.768275] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[412.770194] Starting dynamic subtest: pipe-A-eDP-1
[412.859600] Dynamic subtest pipe-A-eDP-1: SKIP (0.092s)
[412.870081] Starting dynamic subtest: pipe-B-eDP-1
[414.047845] Dynamic subtest pipe-B-eDP-1: SKIP (1.184s)
[414.052372] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.279s)
[415.249183] [072/132] (606s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[415.385149] Starting subtest: basic-flip-before-cursor-varying-size
[416.358222] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.973s)
[417.166397] [073/132] (604s left) kms_properties (get_properties-sanity-non-atomic)
[417.260350] Starting subtest: get_properties-sanity-non-atomic
[417.262592] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[417.335101] [074/132] (604s left) gem_busy (parallel)
[417.518649] Starting subtest: parallel
[417.520901] Starting dynamic subtest: rcs0
[418.901804] Dynamic subtest rcs0: SUCCESS (1.381s)
[418.913355] Starting dynamic subtest: bcs0
[420.885814] Dynamic subtest bcs0: SUCCESS (1.980s)
[420.898222] Starting dynamic subtest: vcs0
[422.933638] Dynamic subtest vcs0: SUCCESS (2.045s)
[422.945756] Starting dynamic subtest: vcs1
[424.917652] Dynamic subtest vcs1: SUCCESS (1.981s)
[424.930573] Starting dynamic subtest: vecs0
[426.901673] Dynamic subtest vecs0: SUCCESS (1.981s)
[426.914134] Starting dynamic subtest: ccs0
[428.885836] Dynamic subtest ccs0: SUCCESS (1.981s)
[428.888623] Subtest parallel: SUCCESS (11.366s)
[429.121319] [075/132] (592s left) gem_exec_fence (syncobj-unused-fence)
[429.632481] Starting subtest: syncobj-unused-fence
[429.640082] Subtest syncobj-unused-fence: SUCCESS (0.008s)
[431.014673] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[431.020637] [076/132] (590s left) gem_ctx_persistence (legacy-engines-cleanup)
[431.087461] Starting subtest: legacy-engines-cleanup
[431.089855] Starting dynamic subtest: render
[431.146524] Dynamic subtest render: SUCCESS (0.058s)
[431.158744] Starting dynamic subtest: bsd1
[431.164361] Dynamic subtest bsd1: SUCCESS (0.016s)
[431.173683] Starting dynamic subtest: bsd2
[431.227118] Dynamic subtest bsd2: SUCCESS (0.061s)
[431.240204] Starting dynamic subtest: blt
[431.267555] Dynamic subtest blt: SUCCESS (0.039s)
[431.278130] Starting dynamic subtest: vebox
[431.302617] Dynamic subtest vebox: SUCCESS (0.033s)
[431.304967] Subtest legacy-engines-cleanup: SUCCESS (0.216s)
[431.385093] [077/132] (590s left) gem_exec_fence (syncobj-export)
[431.815469] Starting subtest: syncobj-export
[431.822065] Subtest syncobj-export: SUCCESS (0.007s)
[433.020106] [078/132] (588s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[433.417272] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[434.190320] [079/132] (587s left) i915_query (query-garbage)
[434.255823] Starting subtest: query-garbage
[434.258174] Subtest query-garbage: SUCCESS (0.000s)
[434.362728] [080/132] (587s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[434.462813] Starting subtest: coverage-vs-premult-vs-constant
[434.759196] Starting dynamic subtest: pipe-A-eDP-1
[435.368072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s)
[435.378996] Starting dynamic subtest: pipe-D-eDP-1
[436.723192] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[436.725559] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.262s)
[437.583668] [081/132] (584s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[437.676359] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[437.680934] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[437.757592] [082/132] (583s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[437.849655] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[442.026882] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.180s)
[443.186052] [083/132] (578s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[443.278775] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[443.281173] Starting dynamic subtest: pipe-A-default-mode
[444.430301] Dynamic subtest pipe-A-default-mode: SKIP (1.151s)
[444.434547] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.152s)
[444.582467] [084/132] (577s left) gem_exec_reloc (basic-cpu-wc)
[444.647264] Subtest basic-cpu-wc: SKIP (0.000s)
[444.730544] [085/132] (577s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[444.829285] Starting subtest: fbcpsr-shrfb-scaledprimary
[450.633281] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.805s)
[450.765564] [086/132] (571s left) perf (short-reads)
[450.896682] Starting subtest: short-reads
[450.914693] Subtest short-reads: SUCCESS (0.019s)
[450.956324] [087/132] (571s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[451.047111] Starting subtest: fbc-2p-pri-indfb-multidraw
[451.051047] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[451.139696] [088/132] (570s left) kms_flip (flip-vs-modeset-vs-hang)
[451.240533] Starting subtest: flip-vs-modeset-vs-hang
[451.242807] Starting dynamic subtest: A-eDP1
[502.382355] Dynamic subtest A-eDP1: SUCCESS (51.139s)
[502.392226] Starting dynamic subtest: D-eDP1
[552.369983] Dynamic subtest D-eDP1: SUCCESS (49.980s)
[552.372650] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.127s)
[552.751322] [089/132] (469s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[552.845244] Starting subtest: random-ccs-data-y-tiled-ccs
[552.847645] Starting dynamic subtest: pipe-A-eDP-1
[552.873636] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[552.885419] Starting dynamic subtest: pipe-B-eDP-1
[552.909748] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[552.919732] Starting dynamic subtest: pipe-C-eDP-1
[552.943520] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[552.952699] Starting dynamic subtest: pipe-D-eDP-1
[552.976316] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[552.980322] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[555.170677] [090/132] (466s left) kms_getfb (getfb-reject-nv12)
[555.269406] Starting subtest: getfb-reject-nv12
[555.271693] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[555.363127] [091/132] (466s left) i915_pm_freq_api (freq-basic-api)
[555.427356] Starting subtest: freq-basic-api
[555.429764] Starting dynamic subtest: gt0
[555.432136] Dynamic subtest gt0: SUCCESS (0.002s)
[555.455529] Starting dynamic subtest: gt1
[555.458277] Dynamic subtest gt1: SUCCESS (0.003s)
[555.460836] Subtest freq-basic-api: SUCCESS (0.007s)
[555.593763] [092/132] (466s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[555.698723] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[563.159508] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.463s)
[563.287475] [093/132] (459s left) gem_exec_reloc (basic-gtt-read-active)
[563.352353] Subtest basic-gtt-read-active: SKIP (0.000s)
[563.436837] [094/132] (458s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[563.525505] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[563.530096] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[563.637820] [095/132] (458s left) gem_userptr_blits (access-control)
[563.711546] Starting subtest: access-control
[563.715780] Subtest access-control: SKIP (0.000s)
[563.836884] [096/132] (458s left) gem_cs_tlb (engines)
[563.894821] Starting subtest: engines
[563.896778] Starting dynamic subtest: rcs0
[566.048920] Dynamic subtest rcs0: SUCCESS (2.152s)
[566.061835] Starting dynamic subtest: bcs0
[568.201558] Dynamic subtest bcs0: SUCCESS (2.151s)
[568.215248] Starting dynamic subtest: vcs0
[570.355043] Dynamic subtest vcs0: SUCCESS (2.152s)
[570.370273] Starting dynamic subtest: vcs1
[572.510066] Dynamic subtest vcs1: SUCCESS (2.154s)
[572.520184] Starting dynamic subtest: vecs0
[574.662862] Dynamic subtest vecs0: SUCCESS (2.152s)
[574.675679] Starting dynamic subtest: ccs0
[576.816887] Dynamic subtest ccs0: SUCCESS (2.153s)
[576.819335] Subtest engines: SUCCESS (12.921s)
[576.939289] [097/132] (445s left) kms_setmode (basic)
[576.999114] Starting subtest: basic
[577.321940] Starting dynamic subtest: pipe-A-eDP-1
[579.373054] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.047s)
[579.717278] Starting dynamic subtest: pipe-B-eDP-1
[581.804100] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.091s)
[582.112641] Subtest basic: SUCCESS (5.111s)
[582.948166] [098/132] (439s left) kms_cursor_crc (cursor-size-change)
[583.033129] Starting subtest: cursor-size-change
[583.035407] Starting dynamic subtest: pipe-A-eDP-1
[583.842821] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.809s)
[583.855621] Starting dynamic subtest: pipe-D-eDP-1
[585.349480] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.504s)
[585.351449] Subtest cursor-size-change: SUCCESS (2.316s)
[586.226985] [099/132] (436s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[586.277498] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[586.279861] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[586.377852] [100/132] (436s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[586.479241] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[586.483552] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[586.569079] [101/132] (436s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[586.662369] Starting subtest: psr-dirtyfb-ioctl
[586.664747] Starting dynamic subtest: A-eDP-1
[590.632691] Dynamic subtest A-eDP-1: SUCCESS (3.971s)
[590.635218] Subtest psr-dirtyfb-ioctl: SUCCESS (3.972s)
[591.434218] [102/132] (431s left) i915_drm_fdinfo (idle)
[591.479854] Starting subtest: idle
[591.482200] Starting dynamic subtest: rcs0
[592.044374] Dynamic subtest rcs0: SUCCESS (0.565s)
[592.056761] Starting dynamic subtest: bcs0
[592.552086] Dynamic subtest bcs0: SUCCESS (0.504s)
[592.564833] Starting dynamic subtest: vcs0
[593.058118] Dynamic subtest vcs0: SUCCESS (0.503s)
[593.070973] Starting dynamic subtest: vcs1
[593.564266] Dynamic subtest vcs1: SUCCESS (0.503s)
[593.577800] Starting dynamic subtest: vecs0
[594.070252] Dynamic subtest vecs0: SUCCESS (0.503s)
[594.084027] Starting dynamic subtest: ccs0
[594.575855] Dynamic subtest ccs0: SUCCESS (0.503s)
[594.578889] Subtest idle: SUCCESS (3.097s)
[594.653019] [103/132] (428s left) kms_lease (lease-revoke)
[594.754815] Starting subtest: lease-revoke
[594.757155] Starting dynamic subtest: pipe-A-eDP-1
[594.787813] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[594.798177] Starting dynamic subtest: pipe-B-eDP-1
[594.816981] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[594.827438] Starting dynamic subtest: pipe-C-eDP-1
[594.846812] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[594.860796] Starting dynamic subtest: pipe-D-eDP-1
[594.874562] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[594.876784] Subtest lease-revoke: SUCCESS (0.122s)
[595.006086] [104/132] (427s left) gem_exec_async (concurrent-writes)
[595.079379] Starting subtest: concurrent-writes
[595.081718] Starting dynamic subtest: rcs0
[595.095373] Dynamic subtest rcs0: SUCCESS (0.016s)
[595.107530] Starting dynamic subtest: bcs0
[595.109791] Dynamic subtest bcs0: SUCCESS (0.006s)
[595.120068] Starting dynamic subtest: vcs0
[595.122259] Dynamic subtest vcs0: SUCCESS (0.005s)
[595.132544] Starting dynamic subtest: vcs1
[595.134496] Dynamic subtest vcs1: SUCCESS (0.007s)
[595.144326] Starting dynamic subtest: vecs0
[595.146223] Dynamic subtest vecs0: SUCCESS (0.006s)
[595.155465] Starting dynamic subtest: ccs0
[595.157405] Dynamic subtest ccs0: SUCCESS (0.006s)
[595.159291] Subtest concurrent-writes: SUCCESS (0.050s)
[595.354568] [105/132] (427s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[595.455161] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[595.459121] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[595.579432] [106/132] (427s left) kms_dsc (dsc-with-output-formats)
[595.667442] Starting subtest: dsc-with-output-formats
[595.685278] Subtest dsc-with-output-formats: SKIP (0.000s)
[595.739413] [107/132] (427s left) api_intel_bb (destroy-bb)
[595.806031] Starting subtest: destroy-bb
[595.815492] Subtest destroy-bb: SUCCESS (0.009s)
[595.941399] [108/132] (427s left) kms_psr (fbc-psr-cursor-plane-onoff)
[596.034531] Starting subtest: fbc-psr-cursor-plane-onoff
[596.036481] Starting dynamic subtest: eDP-1
[596.040147] Dynamic subtest eDP-1: SKIP (0.000s)
[596.043773] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[596.108996] [109/132] (426s left) kms_pm_backlight (brightness-with-dpms)
[596.215500] Starting subtest: brightness-with-dpms
[596.267109] Starting dynamic subtest: eDP-1
[598.697481] Dynamic subtest eDP-1: SUCCESS (2.431s)
[598.699825] Subtest brightness-with-dpms: SUCCESS (2.482s)
[599.572180] [110/132] (423s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[601.104242] Starting subtest: modeset-lpsp-stress-no-wait
[611.239377] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.134s)
[611.328950] [111/132] (411s left) gem_wait (busy)
[611.399471] Starting subtest: busy
[611.401928] Starting dynamic subtest: all-engines
[612.885484] Dynamic subtest all-engines: SUCCESS (1.484s)
[612.898612] Starting dynamic subtest: rcs0
[613.425512] Dynamic subtest rcs0: SUCCESS (0.539s)
[613.437409] Starting dynamic subtest: bcs0
[613.965335] Dynamic subtest bcs0: SUCCESS (0.539s)
[613.976679] Starting dynamic subtest: vcs0
[615.892559] Dynamic subtest vcs0: SUCCESS (1.924s)
[615.905607] Starting dynamic subtest: vcs1
[617.941496] Dynamic subtest vcs1: SUCCESS (2.046s)
[617.954666] Starting dynamic subtest: vecs0
[619.924475] Dynamic subtest vecs0: SUCCESS (1.980s)
[619.937646] Starting dynamic subtest: ccs0
[620.466612] Dynamic subtest ccs0: SUCCESS (0.540s)
[620.469295] Subtest busy: SUCCESS (9.067s)
[620.668164] [112/132] (402s left) kms_content_protection (content-type-change)
[620.814638] Starting subtest: content-type-change
[620.819102] Subtest content-type-change: SKIP (0.000s)
[620.984074] [113/132] (402s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[621.080207] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[621.084815] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[622.220073] [114/132] (400s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[622.317479] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[626.582219] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.267s)
[627.725806] [115/132] (395s left) kms_vrr (flip-suspend)
[627.822047] Starting subtest: flip-suspend
[627.828524] Subtest flip-suspend: SKIP (0.000s)
[627.907795] [116/132] (395s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[627.994056] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[627.998559] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[629.147516] [117/132] (394s left) kms_atomic_interruptible (atomic-setmode)
[629.243208] Starting subtest: atomic-setmode
[629.245507] Starting dynamic subtest: pipe-A-eDP-1
[636.168882] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.924s)
[636.171245] Subtest atomic-setmode: SUCCESS (6.925s)
[637.034819] [118/132] (386s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[637.134418] Starting subtest: fbcpsr-stridechange
[643.388100] Subtest fbcpsr-stridechange: SUCCESS (6.257s)
[643.518160] [119/132] (379s left) gem_spin_batch (resubmit-new-all)
[643.586817] Starting subtest: resubmit-new-all
[643.589187] Starting dynamic subtest: rcs0
[643.599162] Dynamic subtest rcs0: SUCCESS (0.012s)
[643.614331] Starting dynamic subtest: bcs0
[643.616638] Dynamic subtest bcs0: SUCCESS (0.010s)
[643.626782] Starting dynamic subtest: vcs0
[643.628681] Dynamic subtest vcs0: SUCCESS (0.008s)
[643.638669] Starting dynamic subtest: vcs1
[643.640814] Dynamic subtest vcs1: SUCCESS (0.009s)
[643.650545] Starting dynamic subtest: vecs0
[643.652389] Dynamic subtest vecs0: SUCCESS (0.014s)
[643.662321] Starting dynamic subtest: ccs0
[643.664604] Dynamic subtest ccs0: SUCCESS (0.009s)
[643.666857] Subtest resubmit-new-all: SUCCESS (0.068s)
[644.925394] [120/132] (378s left) kms_plane (plane-position-hole-dpms)
[645.021937] Starting subtest: plane-position-hole-dpms
[645.547925] Starting dynamic subtest: pipe-A-plane-1
[647.912706] Dynamic subtest pipe-A-plane-1: SUCCESS (2.365s)
[647.923747] Starting dynamic subtest: pipe-A-plane-2
[650.284215] Dynamic subtest pipe-A-plane-2: SUCCESS (2.371s)
[650.297065] Starting dynamic subtest: pipe-A-plane-3
[652.639315] Dynamic subtest pipe-A-plane-3: SUCCESS (2.355s)
[652.649449] Starting dynamic subtest: pipe-A-plane-4
[655.019505] Dynamic subtest pipe-A-plane-4: SUCCESS (2.378s)
[655.030063] Starting dynamic subtest: pipe-A-plane-5
[655.044259] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[656.196523] Starting dynamic subtest: pipe-B-plane-1
[658.593464] Dynamic subtest pipe-B-plane-1: SUCCESS (2.406s)
[658.604127] Starting dynamic subtest: pipe-B-plane-2
[660.956064] Dynamic subtest pipe-B-plane-2: SUCCESS (2.360s)
[660.970694] Starting dynamic subtest: pipe-B-plane-3
[663.347955] Dynamic subtest pipe-B-plane-3: SUCCESS (2.392s)
[663.358201] Starting dynamic subtest: pipe-B-plane-4
[665.755857] Dynamic subtest pipe-B-plane-4: SUCCESS (2.405s)
[665.766817] Starting dynamic subtest: pipe-B-plane-5
[665.784292] Dynamic subtest pipe-B-plane-5: SUCCESS (0.028s)
[665.786431] Subtest plane-position-hole-dpms: SUCCESS (20.762s)
[666.584743] [121/132] (356s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[666.650926] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[666.729734] [122/132] (356s left) kms_vblank (query-busy-hang)
[666.824205] Starting subtest: query-busy-hang
[666.826338] Starting dynamic subtest: pipe-A-eDP-1
[693.728198] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.901s)
[693.744801] Starting dynamic subtest: pipe-D-eDP-1
[718.677064] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.944s)
[718.679372] Subtest query-busy-hang: SUCCESS (51.852s)
[719.565658] [123/132] (304s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[719.659916] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[719.662225] Starting dynamic subtest: pipe-A-eDP-1
[719.670748] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[719.681059] Starting dynamic subtest: pipe-B-eDP-1
[719.689555] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[719.702683] Starting dynamic subtest: pipe-C-eDP-1
[719.711160] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[719.720617] Starting dynamic subtest: pipe-D-eDP-1
[719.728965] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[719.733540] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[721.905368] [124/132] (301s left) syncobj_wait (reset-during-wait-for-submit)
[721.971597] Starting subtest: reset-during-wait-for-submit
[722.074548] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[722.168793] [125/132] (301s left) kms_flip (dpms-vs-vblank-race)
[722.263170] Starting subtest: dpms-vs-vblank-race
[722.265102] Starting dynamic subtest: A-eDP1
[726.176663] Dynamic subtest A-eDP1: SUCCESS (3.912s)
[726.187230] Starting dynamic subtest: B-eDP1
[730.811471] Dynamic subtest B-eDP1: SUCCESS (4.631s)
[730.824985] Starting dynamic subtest: C-eDP1
[735.442424] Dynamic subtest C-eDP1: SUCCESS (4.630s)
[735.452973] Starting dynamic subtest: D-eDP1
[740.092212] Dynamic subtest D-eDP1: SUCCESS (4.648s)
[740.099538] Subtest dpms-vs-vblank-race: SUCCESS (17.839s)
[740.973614] [126/132] (282s left) gem_exec_schedule (thriceslice)
[741.050595] Starting subtest: thriceslice
[741.052893] Starting dynamic subtest: rcs0
[741.069586] Dynamic subtest rcs0: SUCCESS (0.030s)
[741.082284] Starting dynamic subtest: bcs0
[741.099285] Dynamic subtest bcs0: SUCCESS (0.029s)
[741.109467] Starting dynamic subtest: vcs0
[741.149243] Dynamic subtest vcs0: SUCCESS (0.049s)
[741.161359] Starting dynamic subtest: vcs1
[741.179917] Dynamic subtest vcs1: SUCCESS (0.029s)
[741.192253] Starting dynamic subtest: vecs0
[741.229437] Dynamic subtest vecs0: SUCCESS (0.048s)
[741.243049] Starting dynamic subtest: ccs0
[741.260291] Dynamic subtest ccs0: SUCCESS (0.029s)
[741.262622] Subtest thriceslice: SUCCESS (0.221s)
[741.596521] [127/132] (282s left) syncobj_eventfd (binary-wait-signaled)
[741.645402] Starting subtest: binary-wait-signaled
[741.647628] Subtest binary-wait-signaled: SUCCESS (0.000s)
[741.761353] [128/132] (282s left) syncobj_wait (invalid-reset-zero-handles)
[741.833968] Starting subtest: invalid-reset-zero-handles
[741.835948] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[741.941122] [129/132] (281s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[742.038056] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[745.787721] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.752s)
[746.959425] [130/132] (276s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[747.016063] Subtest no-spare-fences-busy: SKIP (0.000s)
[747.089230] [131/132] (276s left) kms_psr (pr-primary-render)
[747.173978] Starting subtest: pr-primary-render
[747.178058] Subtest pr-primary-render: SKIP (0.000s)
[747.250348] [132/132] (276s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[747.459668] Starting subtest: cursor-rapid-movement-128x42
[747.508567] Subtest cursor-rapid-movement-128x42: SKIP (0.043s)
[747.701287] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_balancer
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: gem_exec_balancer
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: kms_vblank
results: parsing output: 11/ for test: kms_busy
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: kms_cursor_crc
results: parsing output: 15/ for test: i915_pm_rpm
results: parsing output: 16/ for test: gem_pxp
results: parsing output: 17/ for test: gem_bad_reloc
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: kms_cursor_edge_walk
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: sriov_basic
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_joiner
results: parsing output: 28/ for test: drm_read
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: gem_lmem_swapping
results: parsing output: 31/ for test: gem_exec_whisper
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: api_intel_bb
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: i915_query
results: parsing output: 42/ for test: perf_pmu
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_ctx_param
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: kms_plane
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_chamelium_frames
results: parsing output: 51/ for test: gem_partial_pwrite_pread
results: parsing output: 52/ for test: kms_atomic
results: parsing output: 53/ for test: gem_mmap_offset
results: parsing output: 54/ for test: kms_color
results: parsing output: 55/ for test: gem_lmem_swapping
results: parsing output: 56/ for test: kms_rotation_crc
results: parsing output: 57/ for test: gem_ppgtt
results: parsing output: 58/ for test: gem_pwrite_snooped
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gen7_exec_parse
results: parsing output: 64/ for test: syncobj_basic
results: parsing output: 65/ for test: dumb_buffer
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_properties
results: parsing output: 73/ for test: gem_busy
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: gem_exec_fence
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: i915_query
results: parsing output: 79/ for test: kms_plane_alpha_blend
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_getfb
results: parsing output: 90/ for test: i915_pm_freq_api
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_userptr_blits
results: parsing output: 95/ for test: gem_cs_tlb
results: parsing output: 96/ for test: kms_setmode
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_dirtyfb
results: parsing output: 101/ for test: i915_drm_fdinfo
results: parsing output: 102/ for test: kms_lease
results: parsing output: 103/ for test: gem_exec_async
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_dsc
results: parsing output: 106/ for test: api_intel_bb
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_pm_backlight
results: parsing output: 109/ for test: kms_pm_rpm
results: parsing output: 110/ for test: gem_wait
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_vrr
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_atomic_interruptible
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_spin_batch
results: parsing output: 119/ for test: kms_plane
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: kms_vblank
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: syncobj_eventfd
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_fenced_exec_thrash
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_cursor_crc
Done.