[57.919799] Initializing watchdogs
[57.919845]   /dev/watchdog0
[57.934018] [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.938350] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.940948] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.944977] [001/133] (960s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[58.071427] Starting subtest: y-tiled-8bpp-rotate-0
[58.075562] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[58.168049] [002/133] (960s left) gem_softpin (zero)
[58.234450] Starting subtest: zero
[58.238637] Subtest zero: SUCCESS (0.006s)
[58.354454] [003/133] (960s left) kms_draw_crc (draw-method-pwrite)
[58.453783] Starting subtest: draw-method-pwrite
[58.456090] Starting dynamic subtest: xrgb8888-untiled
[59.038543] Dynamic subtest xrgb8888-untiled: SUCCESS (0.589s)
[59.046657] Starting dynamic subtest: rgb565-untiled
[59.525477] Dynamic subtest rgb565-untiled: SUCCESS (0.488s)
[59.533396] Starting dynamic subtest: xrgb2101010-untiled
[60.089830] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.566s)
[60.097136] Starting dynamic subtest: xbgr16161616f-untiled
[60.875752] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.788s)
[60.883657] Starting dynamic subtest: xrgb8888-xtiled
[62.715080] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.844s)
[62.724050] Starting dynamic subtest: rgb565-xtiled
[63.846349] Dynamic subtest rgb565-xtiled: SUCCESS (1.133s)
[63.855682] Starting dynamic subtest: xrgb2101010-xtiled
[65.697305] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.854s)
[65.706591] Starting dynamic subtest: xbgr16161616f-xtiled
[69.358725] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.666s)
[69.367871] Starting dynamic subtest: xrgb8888-4tiled
[70.491081] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.133s)
[70.502654] Starting dynamic subtest: rgb565-4tiled
[71.112820] Dynamic subtest rgb565-4tiled: SUCCESS (0.622s)
[71.121422] Starting dynamic subtest: xrgb2101010-4tiled
[72.233922] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.121s)
[72.241525] Starting dynamic subtest: xbgr16161616f-4tiled
[75.309716] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.077s)
[75.312075] Subtest draw-method-pwrite: SUCCESS (16.889s)
[75.424651] [004/133] (943s left) gem_mmap_gtt (pf-nonblock)
[75.485962] Subtest pf-nonblock: SKIP (0.000s)
[75.537518] [005/133] (943s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[75.636744] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[75.641149] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[75.710665] [006/133] (942s left) kms_chamelium_hpd (dp-hpd)
[76.122255] Subtest dp-hpd: SKIP (0.000s)
[76.972633] [007/133] (941s left) syncobj_timeline (reset-unsignaled)
[77.026755] Starting subtest: reset-unsignaled
[77.028635] Subtest reset-unsignaled: SUCCESS (0.000s)
[77.131183] [008/133] (941s left) gem_exec_params (no-blt)
[77.185989] Starting subtest: no-blt
[77.188440] Subtest no-blt: SUCCESS (0.002s)
[77.316608] [009/133] (941s left) gem_gtt_cpu_tlb
[77.449157] [010/133] (941s left) sriov_basic (enable-vfs-bind-unbind-each)
[77.504470] Starting subtest: enable-vfs-bind-unbind-each
[77.506700] Starting dynamic subtest: numvfs-1
[77.585287] Dynamic subtest numvfs-1: FAIL (0.031s)
[77.592200] Starting dynamic subtest: numvfs-2
[77.664901] Dynamic subtest numvfs-2: FAIL (0.005s)
[77.673069] Starting dynamic subtest: numvfs-3
[77.745450] Dynamic subtest numvfs-3: FAIL (0.004s)
[77.754224] Starting dynamic subtest: numvfs-4
[77.825685] Dynamic subtest numvfs-4: FAIL (0.004s)
[77.833948] Starting dynamic subtest: numvfs-5
[77.898517] Dynamic subtest numvfs-5: FAIL (0.004s)
[77.906044] Starting dynamic subtest: numvfs-6
[77.965199] Dynamic subtest numvfs-6: FAIL (0.004s)
[77.973422] Starting dynamic subtest: numvfs-7
[78.032078] Dynamic subtest numvfs-7: FAIL (0.004s)
[78.038532] Starting dynamic subtest: numvfs-random
[78.094706] Dynamic subtest numvfs-random: FAIL (0.005s)
[78.096269] Subtest enable-vfs-bind-unbind-each: FAIL (0.063s)
[78.128382] [011/133] (940s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[78.238463] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[78.240119] Starting dynamic subtest: pipe-A-eDP-1
[78.260590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[78.268851] Starting dynamic subtest: pipe-B-eDP-1
[78.286045] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[78.292933] Starting dynamic subtest: pipe-C-eDP-1
[78.309731] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[78.316512] Starting dynamic subtest: pipe-D-eDP-1
[78.335615] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[78.337377] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[80.579665] [012/133] (938s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[82.125388] Starting subtest: modeset-non-lpsp-stress-no-wait
[82.179575] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.051s)
[82.812348] [013/133] (936s left) perf (blocking)
[82.957586] Starting subtest: blocking
[82.959791] Starting dynamic subtest: 0-rcs0
[92.989499] Dynamic subtest 0-rcs0: SUCCESS (10.030s)
[92.997052] Starting dynamic subtest: 1-vecs0
[103.009398] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[103.012186] Subtest blocking: SUCCESS (20.049s)
[103.054940] [014/133] (915s left) kms_psr (pr-sprite-plane-onoff)
[103.160986] Starting subtest: pr-sprite-plane-onoff
[103.165419] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[103.240807] [015/133] (915s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[103.287653] Starting subtest: etime-single-wait-for-submit-submitted
[103.394115] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s)
[103.481912] [016/133] (915s left) syncobj_timeline (wait-zero-handles)
[103.533538] Starting subtest: wait-zero-handles
[103.535452] Subtest wait-zero-handles: SUCCESS (0.000s)
[103.615889] [017/133] (915s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[103.708415] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[103.710718] Starting dynamic subtest: pipe-A-default-mode
[104.878575] Dynamic subtest pipe-A-default-mode: SKIP (1.168s)
[104.882915] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.170s)
[105.021460] [018/133] (914s left) kms_psr2_su (page_flip-p010)
[105.084293] Subtest page_flip-P010: SKIP (0.000s)
[105.134336] [019/133] (914s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[105.262771] Starting subtest: short-flip-before-cursor-toggle
[106.192123] Subtest short-flip-before-cursor-toggle: SUCCESS (0.927s)
[106.982559] [020/133] (912s left) gem_exec_schedule (lateslice)
[107.051281] Starting subtest: lateslice
[107.053601] Starting dynamic subtest: rcs0
[107.063435] Dynamic subtest rcs0: SUCCESS (0.023s)
[107.073209] Starting dynamic subtest: bcs0
[107.081605] Dynamic subtest bcs0: SUCCESS (0.018s)
[107.088789] Starting dynamic subtest: vcs0
[107.099727] Dynamic subtest vcs0: SUCCESS (0.018s)
[107.106738] Starting dynamic subtest: vcs1
[107.118073] Dynamic subtest vcs1: SUCCESS (0.018s)
[107.125267] Starting dynamic subtest: vecs0
[107.135809] Dynamic subtest vecs0: SUCCESS (0.017s)
[107.143536] Starting dynamic subtest: ccs0
[107.153201] Dynamic subtest ccs0: SUCCESS (0.017s)
[107.155487] Subtest lateslice: SUCCESS (0.113s)
[108.949921] [021/133] (910s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[109.043475] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[109.047452] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[109.134117] [022/133] (910s left) template (a)
[109.190641] Starting subtest: A
[109.192853] Subtest A: SUCCESS (0.000s)
[109.274974] [023/133] (910s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[109.375612] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[109.379599] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[109.446837] [024/133] (909s left) gem_lmem_swapping (smem-oom)
[109.488771] Subtest smem-oom: SKIP (0.000s)
[109.533370] [025/133] (909s left) gem_pxp (create-valid-protected-context)
[109.654759] Starting subtest: create-valid-protected-context
[109.657293] Subtest create-valid-protected-context: SUCCESS (0.002s)
[109.771496] [026/133] (909s left) gem_eio (in-flight-contexts-immediate)
[109.951477] Starting subtest: in-flight-contexts-immediate
[123.878889] Subtest in-flight-contexts-immediate: SUCCESS (13.926s)
[124.041100] [027/133] (895s left) gem_exec_endless (dispatch)
[124.134168] Starting subtest: dispatch
[124.136542] Starting dynamic subtest: rcs0
[124.145048] Dynamic subtest rcs0: SUCCESS (0.010s)
[124.155810] Starting dynamic subtest: bcs0
[124.160307] Dynamic subtest bcs0: SUCCESS (0.007s)
[124.167948] Starting dynamic subtest: vcs0
[124.172408] Dynamic subtest vcs0: SUCCESS (0.005s)
[124.181103] Starting dynamic subtest: vcs1
[124.185291] Dynamic subtest vcs1: SUCCESS (0.005s)
[124.192510] Starting dynamic subtest: vecs0
[124.196872] Dynamic subtest vecs0: SUCCESS (0.008s)
[124.204038] Starting dynamic subtest: ccs0
[124.208351] Dynamic subtest ccs0: SUCCESS (0.004s)
[124.210528] Subtest dispatch: SUCCESS (0.043s)
[125.890643] [028/133] (893s left) gem_ctx_sseu (invalid-args)
[125.959275] Subtest invalid-args: SKIP (0.000s)
[126.023732] [029/133] (893s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[126.122196] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[126.126595] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[126.213922] [030/133] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[126.304591] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[126.308758] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[126.388404] [031/133] (893s left) perf (enable-disable)
[126.471104] Starting subtest: enable-disable
[126.473512] Starting dynamic subtest: 0-rcs0
[128.730861] Dynamic subtest 0-rcs0: SUCCESS (2.258s)
[128.738762] Starting dynamic subtest: 1-vecs0
[133.230333] Dynamic subtest 1-vecs0: SUCCESS (4.500s)
[133.232847] Subtest enable-disable: SUCCESS (6.758s)
[133.276996] [032/133] (886s left) core_setmaster_vs_auth
[133.437633] [033/133] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[133.538017] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[133.542104] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[133.653078] [034/133] (886s left) kms_big_fb (linear-64bpp-rotate-270)
[133.757901] Starting subtest: linear-64bpp-rotate-270
[133.776683] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[133.877312] [035/133] (885s left) kms_content_protection (uevent)
[134.009729] Starting subtest: uevent
[134.014352] Subtest uevent: SKIP (0.000s)
[134.137223] [036/133] (885s left) kms_chamelium_frames (dp-frame-dump)
[134.512812] Subtest dp-frame-dump: SKIP (0.000s)
[135.290357] [037/133] (884s left) kms_psr (psr-primary-page-flip)
[135.383306] Starting subtest: psr-primary-page-flip
[135.385764] Starting dynamic subtest: eDP-1
[137.119619] Dynamic subtest eDP-1: SUCCESS (1.737s)
[137.122040] Subtest psr-primary-page-flip: SUCCESS (1.737s)
[137.976410] [038/133] (881s left) api_intel_allocator (alloc-simple)
[138.021865] Starting subtest: alloc-simple
[138.024161] Subtest alloc-simple: SUCCESS (0.003s)
[138.138426] [039/133] (881s left) gem_ctx_param (invalid-size-set)
[138.183699] Starting subtest: invalid-size-set
[138.186075] Subtest invalid-size-set: SUCCESS (0.001s)
[138.273623] [040/133] (881s left) gem_unref_active_buffers
[138.456921] [041/133] (881s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[138.540674] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[138.542595] Starting dynamic subtest: pipe-A-eDP-1
[139.382200] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s)
[139.396786] Starting dynamic subtest: pipe-B-eDP-1
[141.047645] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.660s)
[141.056655] Starting dynamic subtest: pipe-C-eDP-1
[142.530729] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.484s)
[142.540078] Starting dynamic subtest: pipe-D-eDP-1
[144.111583] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.581s)
[144.113823] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.564s)
[145.331414] [042/133] (874s left) gem_partial_pwrite_pread (writes-after-reads)
[145.402395] Subtest writes-after-reads: SKIP (0.000s)
[145.457203] [043/133] (874s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[145.551620] Starting subtest: 4-tiled-32bpp-rotate-180
[147.051754] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.501s)
[147.182914] [044/133] (872s left) drm_read (empty-block)
[147.335971] Starting subtest: empty-block
[148.340652] Subtest empty-block: SUCCESS (1.000s)
[148.468810] [045/133] (871s left) i915_pm_rc6_residency (rc6-idle)
[148.516574] Starting subtest: rc6-idle
[148.538081] Starting dynamic subtest: gt0-rcs0
[172.930205] Dynamic subtest gt0-rcs0: SUCCESS (24.391s)
[172.938077] Starting dynamic subtest: gt0-bcs0
[197.146028] Dynamic subtest gt0-bcs0: SUCCESS (24.214s)
[197.153811] Starting dynamic subtest: gt0-ccs0
[221.430981] Dynamic subtest gt0-ccs0: SUCCESS (24.283s)
[221.441079] Starting dynamic subtest: gt1-vcs0
[227.605488] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[227.616674] Starting dynamic subtest: gt1-vecs0
[233.776971] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[233.779598] Subtest rc6-idle: SUCCESS (85.260s)
[233.853610] [046/133] (786s left) syncobj_timeline (signal-array)
[233.929650] Starting subtest: signal-array
[233.932233] Subtest signal-array: SUCCESS (0.000s)
[234.021547] [047/133] (786s left) perf (disabled-read-error)
[234.097385] Starting subtest: disabled-read-error
[234.114188] Subtest disabled-read-error: SUCCESS (0.017s)
[234.157872] [048/133] (786s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[234.263314] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[234.265757] Starting dynamic subtest: pipe-A
[234.624737] Dynamic subtest pipe-A: SUCCESS (0.364s)
[234.634025] Starting dynamic subtest: pipe-B
[236.016112] Dynamic subtest pipe-B: SUCCESS (1.390s)
[236.024611] Starting dynamic subtest: pipe-C
[237.441075] Dynamic subtest pipe-C: SUCCESS (1.424s)
[237.451248] Starting dynamic subtest: pipe-D
[238.893026] Dynamic subtest pipe-D: SUCCESS (1.451s)
[238.895326] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.633s)
[240.072119] [049/133] (780s left) kms_flip (2x-flip-vs-dpms)
[240.181858] Starting subtest: 2x-flip-vs-dpms
[240.190725] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[240.267971] [050/133] (780s left) gem_exec_reloc (basic-wc-noreloc)
[240.340091] Subtest basic-wc-noreloc: SKIP (0.000s)
[240.399849] [051/133] (780s left) kms_getfb (getfb2-handle-protection)
[240.487182] Starting subtest: getfb2-handle-protection
[240.503097] Subtest getfb2-handle-protection: SUCCESS (0.018s)
[240.606228] [052/133] (779s left) kms_flip (2x-modeset-vs-vblank-race)
[240.702104] Starting subtest: 2x-modeset-vs-vblank-race
[240.711571] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[240.800965] [053/133] (779s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[240.862351] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[240.866849] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[241.044324] [054/133] (779s left) gem_userptr_blits (set-cache-level)
[241.106239] Starting subtest: set-cache-level
[241.110520] Subtest set-cache-level: SKIP (0.000s)
[241.231801] [055/133] (779s left) kms_async_flips (alternate-sync-async-flip-atomic)
[241.325021] Starting subtest: alternate-sync-async-flip-atomic
[241.709056] Starting dynamic subtest: pipe-A-eDP-1
[244.462424] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.754s)
[244.847206] Starting dynamic subtest: pipe-B-eDP-1
[247.590884] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.753s)
[247.973888] Starting dynamic subtest: pipe-C-eDP-1
[250.719065] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.752s)
[251.094118] Starting dynamic subtest: pipe-D-eDP-1
[253.857706] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[253.859721] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.535s)
[255.013805] [056/133] (765s left) kms_selftest (drm_damage_helper)
[255.051554] Starting subtest: drm_damage_helper
[255.105501] Starting dynamic subtest: drm_test_damage_iter_no_damage
[255.207400] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.099s)
[255.216998] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[255.298904] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.092s)
[255.307882] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[255.396538] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.095s)
[255.405349] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[255.504300] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.107s)
[255.513552] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[255.607404] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.104s)
[255.616257] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[255.699185] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.090s)
[255.708539] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[255.802904] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.103s)
[255.812099] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[255.891776] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.088s)
[255.900074] Starting dynamic subtest: drm_test_damage_iter_single_damage
[255.994566] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.102s)
[256.002304] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[256.083777] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.088s)
[256.092636] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[256.175776] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.091s)
[256.183762] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[256.265636] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.089s)
[256.274348] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[256.352608] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.086s)
[256.361136] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[256.438096] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.085s)
[256.447289] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[256.534915] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.097s)
[256.543699] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[256.619619] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.084s)
[256.628304] Starting dynamic subtest: drm_test_damage_iter_damage
[256.705509] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.084s)
[256.714158] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[256.792527] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.087s)
[256.802086] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[256.881579] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.087s)
[256.891319] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[256.971515] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.088s)
[256.980070] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[257.054248] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.081s)
[257.056101] Subtest drm_damage_helper: SUCCESS (2.004s)
[257.212260] [057/133] (763s left) i915_hangman (detector)
[257.281020] Starting subtest: detector
[257.282607] Starting dynamic subtest: rcs0
[268.852236] Dynamic subtest rcs0: SUCCESS (11.569s)
[268.863695] Starting dynamic subtest: bcs0
[280.882677] Dynamic subtest bcs0: SUCCESS (12.027s)
[280.894531] Starting dynamic subtest: vcs0
[291.890999] Dynamic subtest vcs0: SUCCESS (11.005s)
[291.902470] Starting dynamic subtest: vcs1
[303.859754] Dynamic subtest vcs1: SUCCESS (11.966s)
[303.871384] Starting dynamic subtest: vecs0
[315.891055] Dynamic subtest vecs0: SUCCESS (12.028s)
[315.902355] Starting dynamic subtest: ccs0
[327.859230] Dynamic subtest ccs0: SUCCESS (11.965s)
[327.861917] Subtest detector: SUCCESS (70.578s)
[327.992961] [058/133] (692s left) kms_vrr (negative-basic)
[328.097807] Starting subtest: negative-basic
[328.104358] Starting dynamic subtest: pipe-A-eDP-1
[333.522068] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.416s)
[333.821466] Subtest negative-basic: SUCCESS (5.723s)
[334.631527] [059/133] (686s left) kms_plane_cursor (overlay)
[334.728202] Starting subtest: overlay
[334.732693] Starting dynamic subtest: pipe-A-eDP-1-size-64
[337.236169] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.508s)
[337.300694] Starting dynamic subtest: pipe-A-eDP-1-size-128
[339.871045] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.582s)
[339.928837] Starting dynamic subtest: pipe-A-eDP-1-size-256
[342.527057] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.605s)
[342.886696] Starting dynamic subtest: pipe-B-eDP-1-size-64
[346.114927] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.235s)
[346.174342] Starting dynamic subtest: pipe-B-eDP-1-size-128
[348.839473] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.673s)
[348.898410] Starting dynamic subtest: pipe-B-eDP-1-size-256
[351.406456] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.516s)
[351.752390] Starting dynamic subtest: pipe-C-eDP-1-size-64
[354.681433] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.938s)
[354.719222] Starting dynamic subtest: pipe-C-eDP-1-size-128
[356.815382] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.102s)
[356.852179] Starting dynamic subtest: pipe-C-eDP-1-size-256
[359.070321] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s)
[359.398929] Starting dynamic subtest: pipe-D-eDP-1-size-64
[362.268684] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.881s)
[362.306563] Starting dynamic subtest: pipe-D-eDP-1-size-128
[364.480431] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.181s)
[364.518084] Starting dynamic subtest: pipe-D-eDP-1-size-256
[366.736650] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.225s)
[367.066782] Subtest overlay: SUCCESS (32.338s)
[367.878481] [060/133] (652s left) perf_pmu (pmu-read)
[367.924500] Starting subtest: pmu-read
[367.926862] Subtest pmu-read: SUCCESS (0.003s)
[368.033042] [061/133] (652s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[368.128876] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[368.131042] Starting dynamic subtest: pipe-A
[368.150273] Dynamic subtest pipe-A: SKIP (0.018s)
[368.158763] Starting dynamic subtest: pipe-B
[368.182197] Dynamic subtest pipe-B: SKIP (0.032s)
[368.194297] Starting dynamic subtest: pipe-C
[368.216727] Dynamic subtest pipe-C: SKIP (0.032s)
[368.229727] Starting dynamic subtest: pipe-D
[368.248752] Dynamic subtest pipe-D: SKIP (0.032s)
[368.252460] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.116s)
[368.338113] [062/133] (652s left) gem_compute (compute-square)
[368.400382] Starting subtest: compute-square
[368.403936] Subtest compute-square: SUCCESS (0.006s)
[368.535818] [063/133] (652s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[368.634640] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[375.793494] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.162s)
[375.917953] [064/133] (644s left) gem_exec_schedule (fifo)
[375.990513] Starting subtest: fifo
[375.992825] Starting dynamic subtest: rcs0
[376.078907] Dynamic subtest rcs0: SUCCESS (0.098s)
[376.090057] Starting dynamic subtest: vcs0
[376.160395] Dynamic subtest vcs0: SUCCESS (0.080s)
[376.171775] Starting dynamic subtest: vcs1
[376.244288] Dynamic subtest vcs1: SUCCESS (0.083s)
[376.255235] Starting dynamic subtest: vecs0
[376.325362] Dynamic subtest vecs0: SUCCESS (0.080s)
[376.337407] Starting dynamic subtest: ccs0
[376.412921] Dynamic subtest ccs0: SUCCESS (0.087s)
[376.415666] Subtest fifo: SUCCESS (0.433s)
[378.033918] [065/133] (642s left) i915_drm_fdinfo (memory-info-active)
[378.069695] Starting subtest: memory-info-active
[378.071972] Starting dynamic subtest: smem0
[381.056462] Dynamic subtest smem0: SUCCESS (2.988s)
[381.058604] Subtest memory-info-active: SUCCESS (2.989s)
[381.137155] [066/133] (639s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[381.242804] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[381.246261] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[381.336075] [067/133] (639s left) gem_fence_thrash (bo-write-verify-y)
[381.368805] Starting subtest: bo-write-verify-y
[381.393366] Subtest bo-write-verify-y: SKIP (0.021s)
[381.464745] [068/133] (639s left) gem_linear_blits (interruptible)
[381.883926] Starting subtest: interruptible
[386.729484] Subtest interruptible: SUCCESS (4.844s)
[386.903540] [069/133] (634s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[387.049365] Starting subtest: yf-tiled-16bpp-rotate-90
[387.053409] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[387.145706] [070/133] (634s left) kms_chamelium_color (ctm-limited-range)
[387.242633] Subtest ctm-limited-range: SKIP (0.000s)
[387.285652] [071/133] (633s left) gem_eio (in-flight-contexts-10ms)
[387.534951] Starting subtest: in-flight-contexts-10ms
[398.947625] Subtest in-flight-contexts-10ms: SUCCESS (11.412s)
[399.094392] [072/133] (622s left) kms_psr (fbc-psr2-primary-render)
[399.182507] Starting subtest: fbc-psr2-primary-render
[399.184771] Starting dynamic subtest: eDP-1
[399.188890] Dynamic subtest eDP-1: SKIP (0.000s)
[399.193068] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[399.254067] [073/133] (622s left) kms_atomic (plane-invalid-params)
[399.347180] Starting subtest: plane-invalid-params
[399.349449] Starting dynamic subtest: pipe-A-eDP-1
[399.788459] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[399.790767] Subtest plane-invalid-params: SUCCESS (0.443s)
[400.633925] [074/133] (620s left) kms_pipe_crc_basic (nonblocking-crc)
[400.738744] Starting subtest: nonblocking-crc
[400.740781] Starting dynamic subtest: pipe-A-eDP-1
[401.496404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.758s)
[401.505418] Starting dynamic subtest: pipe-B-eDP-1
[402.930831] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.433s)
[402.941227] Starting dynamic subtest: pipe-C-eDP-1
[404.302201] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s)
[404.312577] Starting dynamic subtest: pipe-D-eDP-1
[405.636481] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[405.638948] Subtest nonblocking-crc: SUCCESS (4.900s)
[406.462818] [075/133] (614s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[406.564228] Starting subtest: fbc-psr2-sprite-mmap-gtt
[406.566531] Starting dynamic subtest: eDP-1
[406.570854] Dynamic subtest eDP-1: SKIP (0.000s)
[406.575167] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[406.636251] [076/133] (614s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[406.722220] Starting subtest: primary-x-tiled-reflect-x-0
[413.683647] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.961s)
[414.921575] [077/133] (606s left) syncobj_timeline (invalid-signal-illegal-point)
[414.977698] Starting subtest: invalid-signal-illegal-point
[414.979940] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[415.073115] [078/133] (606s left) gem_exec_whisper (basic-forked-all)
[415.137522] Starting subtest: basic-forked-all
[428.895025] Subtest basic-forked-all: SUCCESS (13.755s)
[429.080703] [079/133] (592s left) tools_test (sysfs_l3_parity)
[429.141544] Starting subtest: sysfs_l3_parity
[429.210268] Subtest sysfs_l3_parity: SKIP (0.082s)
[429.289283] [080/133] (592s left) gem_exec_fence (syncobj-signal)
[429.794624] Starting subtest: syncobj-signal
[429.801528] Subtest syncobj-signal: SUCCESS (0.007s)
[431.020680] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[431.026582] [081/133] (590s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[431.127116] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[431.129304] Starting dynamic subtest: pipe-A-eDP-1
[431.151666] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[431.162628] Starting dynamic subtest: pipe-B-eDP-1
[431.184602] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[431.193762] Starting dynamic subtest: pipe-C-eDP-1
[431.219316] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[431.228997] Starting dynamic subtest: pipe-D-eDP-1
[431.250137] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[431.254059] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[433.305271] [082/133] (588s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[433.373600] Starting subtest: yf-tiled-ccs-to-yf-tiled
[433.378628] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[433.570123] [083/133] (588s left) gem_tiled_partial_pwrite_pread (reads)
[433.639933] Subtest reads: SKIP (0.000s)
[433.716910] [084/133] (588s left) kms_setmode (invalid-clone-single-crtc-stealing)
[433.766264] Starting subtest: invalid-clone-single-crtc-stealing
[433.772316] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[433.882442] [085/133] (587s left) gem_exec_reloc (basic-cpu-read-noreloc)
[433.932970] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[434.004283] [086/133] (587s left) sw_sync (sync_random_merge)
[434.038127] Starting subtest: sync_random_merge
[434.084868] Subtest sync_random_merge: SUCCESS (0.047s)
[434.147203] [087/133] (587s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[434.241315] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[434.245461] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[434.334457] [088/133] (587s left) kms_cursor_edge_walk (64x64-top-edge)
[434.415755] Starting subtest: 64x64-top-edge
[434.418052] Starting dynamic subtest: pipe-A-eDP-1
[437.897666] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s)
[437.907885] Starting dynamic subtest: pipe-D-eDP-1
[441.019350] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[441.021473] Subtest 64x64-top-edge: SUCCESS (6.603s)
[441.824262] [089/133] (580s left) core_getstats (basic)
[441.879596] Starting subtest: basic
[441.881511] Subtest basic: SUCCESS (0.000s)
[441.972851] [090/133] (580s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[442.066509] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[442.077241] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.013s)
[442.161508] [091/133] (579s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[442.254114] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[442.258473] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[442.347244] [092/133] (579s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[442.436619] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[442.440954] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[442.518437] [093/133] (579s left) gem_userptr_blits (input-checking)
[442.583488] Starting subtest: input-checking
[442.585704] Subtest input-checking: SUCCESS (0.000s)
[442.734318] [094/133] (579s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[442.835426] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[442.838844] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[442.932423] [095/133] (579s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[443.029810] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[443.033217] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[443.136425] [096/133] (579s left) gem_exec_whisper (basic-sync-all)
[443.198464] Starting subtest: basic-sync-all
[450.777155] Subtest basic-sync-all: SUCCESS (7.575s)
[450.964915] [097/133] (571s left) kms_rotation_crc (primary-rotation-270)
[451.070054] Starting subtest: primary-rotation-270
[451.074548] Subtest primary-rotation-270: SKIP (0.001s)
[451.140778] [098/133] (571s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[451.270542] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[451.275055] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[451.431309] [099/133] (570s left) gem_ctx_persistence (engines-mixed)
[451.485554] Starting subtest: engines-mixed
[451.487709] Starting dynamic subtest: rcs0
[451.549527] Dynamic subtest rcs0: SUCCESS (0.064s)
[451.560573] Starting dynamic subtest: bcs0
[451.595454] Dynamic subtest bcs0: SUCCESS (0.045s)
[451.605675] Starting dynamic subtest: vcs0
[451.637572] Dynamic subtest vcs0: SUCCESS (0.040s)
[451.649348] Starting dynamic subtest: vcs1
[451.686531] Dynamic subtest vcs1: SUCCESS (0.048s)
[451.696320] Starting dynamic subtest: vecs0
[451.711292] Dynamic subtest vecs0: SUCCESS (0.023s)
[451.720915] Starting dynamic subtest: ccs0
[451.770420] Dynamic subtest ccs0: SUCCESS (0.057s)
[451.772779] Subtest engines-mixed: SUCCESS (0.286s)
[451.850434] [100/133] (570s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[451.957217] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[451.960580] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[452.047583] [101/133] (570s left) syncobj_timeline (32bits-limit)
[452.112514] Starting subtest: 32bits-limit
[452.114484] Subtest 32bits-limit: SUCCESS (0.001s)
[452.207917] [102/133] (570s left) gem_exec_flush (basic-wb-rw-default)
[452.273731] Starting subtest: basic-wb-rw-default
[457.736893] Subtest basic-wb-rw-default: SUCCESS (5.465s)
[457.922524] [103/133] (564s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[458.028192] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[458.032756] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[458.136089] [104/133] (564s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[458.282637] Starting subtest: short-flip-after-cursor-atomic-transitions
[459.247634] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.963s)
[460.058841] [105/133] (562s left) device_reset (unbind-cold-reset-rebind)
[460.117018] Starting subtest: unbind-cold-reset-rebind
[460.121058] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[460.188074] [106/133] (562s left) kms_color (ctm-red-to-blue)
[460.280962] Starting subtest: ctm-red-to-blue
[460.283238] Starting dynamic subtest: pipe-A-eDP-1
[460.995713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[461.006201] Starting dynamic subtest: pipe-B-eDP-1
[462.373345] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[462.383078] Starting dynamic subtest: pipe-C-eDP-1
[463.750541] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[463.761645] Starting dynamic subtest: pipe-D-eDP-1
[465.092329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[465.094529] Subtest ctm-red-to-blue: SUCCESS (4.811s)
[465.893252] [107/133] (556s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[465.983720] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[473.593692] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.614s)
[473.731845] [108/133] (549s left) prime_self_import (basic-with_two_bos)
[473.767118] Starting subtest: basic-with_two_bos
[473.783368] Subtest basic-with_two_bos: SUCCESS (0.015s)
[473.907234] [109/133] (548s left) gem_ctx_param (basic)
[473.959886] Starting subtest: basic
[473.962368] Subtest basic: SUCCESS (0.001s)
[474.057812] [110/133] (548s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[474.163574] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[474.167644] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[474.235994] [111/133] (548s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[474.340441] Starting subtest: x-tiled-8bpp-rotate-0
[475.609777] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.269s)
[475.732083] [112/133] (547s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[475.981187] Starting subtest: cursor-rapid-movement-256x256
[475.985800] Starting dynamic subtest: pipe-A-eDP-1
[476.549130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[476.578950] Starting dynamic subtest: pipe-D-eDP-1
[477.773824] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.201s)
[477.776080] Subtest cursor-rapid-movement-256x256: SUCCESS (1.789s)
[478.610792] [113/133] (544s left) kms_psr (psr2-primary-blt)
[478.709754] Starting subtest: psr2-primary-blt
[478.712172] Starting dynamic subtest: eDP-1
[480.399772] Dynamic subtest eDP-1: SUCCESS (1.689s)
[480.401830] Subtest psr2-primary-blt: SUCCESS (1.691s)
[481.275371] [114/133] (541s left) kms_pm_rpm (cursor)
[483.106462] Starting subtest: cursor
[483.111323] Subtest cursor: SKIP (0.000s)
[483.511424] [115/133] (539s left) kms_cursor_crc (cursor-onscreen-64x64)
[483.680723] Starting subtest: cursor-onscreen-64x64
[483.685762] Starting dynamic subtest: pipe-A-eDP-1
[485.797959] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.111s)
[485.826641] Starting dynamic subtest: pipe-D-eDP-1
[488.603827] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.782s)
[488.606072] Subtest cursor-onscreen-64x64: SUCCESS (4.920s)
[489.471985] [116/133] (533s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[489.566196] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[489.570094] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[489.668303] [117/133] (533s left) kms_vblank (query-forked-busy-hang)
[489.757066] Starting subtest: query-forked-busy-hang
[489.759155] Starting dynamic subtest: pipe-A-eDP-1
[516.692958] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.934s)
[516.710145] Starting dynamic subtest: pipe-D-eDP-1
[541.653383] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.958s)
[541.655755] Subtest query-forked-busy-hang: SUCCESS (51.896s)
[542.529297] [118/133] (480s left) kms_flip (wf_vblank-ts-check-interruptible)
[542.622030] Starting subtest: wf_vblank-ts-check-interruptible
[542.624250] Starting dynamic subtest: A-eDP1
[551.489877] Dynamic subtest A-eDP1: SUCCESS (8.866s)
[551.503637] Starting dynamic subtest: B-eDP1
[560.427491] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[560.438278] Starting dynamic subtest: C-eDP1
[569.351903] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[569.363647] Starting dynamic subtest: D-eDP1
[578.289263] Dynamic subtest D-eDP1: SUCCESS (8.936s)
[578.295387] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.668s)
[579.524165] [119/133] (443s left) kms_flip (2x-flip-vs-expired-vblank)
[579.615537] Starting subtest: 2x-flip-vs-expired-vblank
[579.626790] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[579.721499] [120/133] (443s left) gem_barrier_race (remote-request)
[579.796525] Starting subtest: remote-request
[579.798527] Starting dynamic subtest: rcs0
[584.992809] Dynamic subtest rcs0: SUCCESS (5.196s)
[585.000051] Subtest remote-request: SUCCESS (5.197s)
[585.149249] [121/133] (438s left) gem_ctx_persistence (legacy-engines-hang)
[585.209872] Starting subtest: legacy-engines-hang
[585.211688] Starting dynamic subtest: render
[585.344082] Dynamic subtest render: SUCCESS (0.136s)
[585.356767] Starting dynamic subtest: bsd1
[585.417639] Dynamic subtest bsd1: SUCCESS (0.070s)
[585.428360] Starting dynamic subtest: bsd2
[585.552484] Dynamic subtest bsd2: SUCCESS (0.133s)
[585.566594] Starting dynamic subtest: blt
[585.653191] Dynamic subtest blt: SUCCESS (0.098s)
[585.666161] Starting dynamic subtest: vebox
[585.745180] Dynamic subtest vebox: SUCCESS (0.089s)
[585.747344] Subtest legacy-engines-hang: SUCCESS (0.539s)
[585.827963] [122/133] (437s left) gem_exec_params (secure-non-root)
[585.889006] Starting subtest: secure-non-root
[585.892573] Subtest secure-non-root: SKIP (0.000s)
[585.988578] [123/133] (437s left) kms_lease (invalid-create-leases)
[586.073985] Starting subtest: invalid-create-leases
[586.081847] Subtest invalid-create-leases: SUCCESS (0.007s)
[586.194878] [124/133] (437s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[586.283474] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[586.285225] Starting dynamic subtest: pipe-A-eDP-1
[586.333584] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[586.344593] Starting dynamic subtest: pipe-B-eDP-1
[586.390266] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[586.399650] Starting dynamic subtest: pipe-C-eDP-1
[586.443881] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[586.452482] Starting dynamic subtest: pipe-D-eDP-1
[586.496426] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[586.499757] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[588.584419] [125/133] (434s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[588.684826] Starting subtest: fbcpsr-indfb-scaledprimary
[594.473981] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.793s)
[594.609851] [126/133] (428s left) gen7_exec_parse (batch-without-end)
[594.662076] Subtest batch-without-end: SKIP (0.000s)
[594.722699] [127/133] (428s left) gem_userptr_blits (process-exit-busy)
[594.798089] Starting subtest: process-exit-busy
[594.817123] Subtest process-exit-busy: SUCCESS (0.019s)
[594.947133] [128/133] (428s left) kms_addfb_basic (unused-pitches)
[594.994922] Starting subtest: unused-pitches
[594.997199] Subtest unused-pitches: SUCCESS (0.000s)
[595.131311] [129/133] (428s left) i915_selftest (live)
[598.433632] Starting subtest: live
[598.438314] Starting dynamic subtest: sanitycheck
[602.824699] Dynamic subtest sanitycheck: SUCCESS (4.390s)
[602.834544] Starting dynamic subtest: uncore
[607.151477] Dynamic subtest uncore: SUCCESS (4.325s)
[607.160798] Starting dynamic subtest: workarounds
[610.268812] Dynamic subtest workarounds: SUCCESS (3.115s)
[610.278123] Starting dynamic subtest: gt_engines
[613.323688] Dynamic subtest gt_engines: SUCCESS (3.054s)
[613.332584] Starting dynamic subtest: gt_timelines
[629.597078] Dynamic subtest gt_timelines: SUCCESS (16.269s)
[629.607129] Starting dynamic subtest: gt_contexts
[632.320507] Dynamic subtest gt_contexts: SUCCESS (2.721s)
[632.330184] Starting dynamic subtest: gt_lrc
[636.654639] Dynamic subtest gt_lrc: SUCCESS (4.332s)
[636.664664] Starting dynamic subtest: gt_mocs
[639.546873] Dynamic subtest gt_mocs: SUCCESS (2.891s)
[639.555966] Starting dynamic subtest: gt_pm
[646.369483] Dynamic subtest gt_pm: SUCCESS (6.820s)
[646.384204] Starting dynamic subtest: gt_heartbeat
[649.122340] Dynamic subtest gt_heartbeat: SUCCESS (2.751s)
[649.132508] Starting dynamic subtest: gt_tlb
[658.980303] Dynamic subtest gt_tlb: SUCCESS (9.856s)
[658.990762] Starting dynamic subtest: requests
[670.957500] Dynamic subtest requests: SUCCESS (11.974s)
[670.968966] Starting dynamic subtest: migrate
[678.760096] Dynamic subtest migrate: SUCCESS (7.801s)
[678.769943] Starting dynamic subtest: active
[683.163994] Dynamic subtest active: SUCCESS (4.401s)
[683.173732] Starting dynamic subtest: objects
[687.905773] Dynamic subtest objects: SUCCESS (4.739s)
[687.916514] Starting dynamic subtest: mman
[692.736786] Dynamic subtest mman: SUCCESS (4.829s)
[692.744610] Starting dynamic subtest: dmabuf
[697.118043] Dynamic subtest dmabuf: SUCCESS (4.379s)
[697.129195] Starting dynamic subtest: vma
[701.474068] Dynamic subtest vma: SUCCESS (4.353s)
[701.483905] Starting dynamic subtest: coherency
[707.022079] Dynamic subtest coherency: SUCCESS (5.545s)
[707.032088] Starting dynamic subtest: gtt
[719.019396] Dynamic subtest gtt: SUCCESS (11.995s)
[719.029235] Starting dynamic subtest: gem
[726.589982] Dynamic subtest gem: SUCCESS (7.569s)
[726.599918] Starting dynamic subtest: evict
[732.078406] Dynamic subtest evict: SUCCESS (5.486s)
[732.088300] Starting dynamic subtest: hugepages
[743.376281] Dynamic subtest hugepages: SUCCESS (11.295s)
[743.385565] Starting dynamic subtest: gem_contexts
[768.927306] Dynamic subtest gem_contexts: SUCCESS (25.548s)
[768.937051] Starting dynamic subtest: client
[771.683903] Dynamic subtest client: SUCCESS (2.756s)
[771.701955] Starting dynamic subtest: gem_migrate
[775.995805] Dynamic subtest gem_migrate: SUCCESS (4.310s)
[776.005257] Starting dynamic subtest: reset
[780.322206] Dynamic subtest reset: SUCCESS (4.324s)
[780.330798] Starting dynamic subtest: memory_region
[784.661340] Dynamic subtest memory_region: SUCCESS (4.337s)
[784.671544] Starting dynamic subtest: hangcheck
[798.773954] Dynamic subtest hangcheck: SUCCESS (14.110s)
[798.789439] Starting dynamic subtest: execlists
[803.121961] Dynamic subtest execlists: SUCCESS (4.346s)
[803.131849] Starting dynamic subtest: ring_submission
[807.397028] Dynamic subtest ring_submission: SUCCESS (4.273s)
[807.407160] Starting dynamic subtest: perf
[810.216534] Dynamic subtest perf: SUCCESS (2.819s)
[810.233077] Starting dynamic subtest: slpc
[824.801938] Dynamic subtest slpc: SUCCESS (14.582s)
[824.810763] Starting dynamic subtest: guc
[828.716849] Dynamic subtest guc: SUCCESS (3.912s)
[828.726794] Starting dynamic subtest: guc_multi_lrc
[832.996621] Dynamic subtest guc_multi_lrc: SUCCESS (4.279s)
[833.004635] Starting dynamic subtest: guc_hang
[837.823291] Dynamic subtest guc_hang: SUCCESS (4.825s)
[837.833691] Starting dynamic subtest: late_gt_pm
[840.540920] Dynamic subtest late_gt_pm: SUCCESS (2.716s)
[840.543606] Subtest live: SUCCESS (242.096s)
[840.572692] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[840.573378] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[840.576562] [130/133] (183s left) kms_invalid_mode (bad-hsync-end)
[842.146320] Starting subtest: bad-hsync-end
[842.148609] Starting dynamic subtest: pipe-A-eDP-1
[842.447818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.305s)
[842.457578] Starting dynamic subtest: pipe-B-eDP-1
[842.459934] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[842.467830] Starting dynamic subtest: pipe-C-eDP-1
[842.470176] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[842.478639] Starting dynamic subtest: pipe-D-eDP-1
[842.481011] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[842.483031] Subtest bad-hsync-end: SUCCESS (0.311s)
[843.357626] [FACT kms_invalid_mode (bad-hsync-end)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[843.358846] [FACT kms_invalid_mode (bad-hsync-end)] new: kernel.kmod_is_loaded.i915: true
[843.362520] [131/133] (180s left) gem_exec_balancer (indices)
[843.444390] Starting subtest: indices
[845.875303] Subtest indices: SUCCESS (2.430s)
[846.178022] [132/133] (177s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[846.286718] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[853.815478] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.532s)
[853.947844] [133/133] (169s left) gem_exec_schedule (u-semaphore-noskip)
[854.013056] Starting subtest: u-semaphore-noskip
[854.430617] Subtest u-semaphore-noskip: SUCCESS (0.421s)
[854.762219] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_softpin
results: parsing output: 2/ for test: kms_draw_crc
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: gem_gtt_cpu_tlb
results: parsing output: 9/ for test: sriov_basic
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_pm_rpm
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_psr2_su
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: template
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: gem_lmem_swapping
results: parsing output: 24/ for test: gem_pxp
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: gem_exec_endless
results: parsing output: 27/ for test: gem_ctx_sseu
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: core_setmaster_vs_auth
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_content_protection
results: parsing output: 35/ for test: kms_chamelium_frames
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: api_intel_allocator
results: parsing output: 38/ for test: gem_ctx_param
results: parsing output: 39/ for test: gem_unref_active_buffers
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_partial_pwrite_pread
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: drm_read
results: parsing output: 44/ for test: i915_pm_rc6_residency
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: kms_getfb
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: gem_userptr_blits
results: parsing output: 54/ for test: kms_async_flips
results: parsing output: 55/ for test: kms_selftest
results: parsing output: 56/ for test: i915_hangman
results: parsing output: 57/ for test: kms_vrr
results: parsing output: 58/ for test: kms_plane_cursor
results: parsing output: 59/ for test: perf_pmu
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: gem_compute
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_fence_thrash
results: parsing output: 67/ for test: gem_linear_blits
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_chamelium_color
results: parsing output: 70/ for test: gem_eio
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_atomic
results: parsing output: 73/ for test: kms_pipe_crc_basic
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_rotation_crc
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: gem_exec_whisper
results: parsing output: 78/ for test: tools_test
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 83/ for test: kms_setmode
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: sw_sync
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_cursor_edge_walk
results: parsing output: 88/ for test: core_getstats
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_whisper
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_ctx_persistence
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_exec_flush
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: device_reset
results: parsing output: 105/ for test: kms_color
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: prime_self_import
results: parsing output: 108/ for test: gem_ctx_param
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_vblank
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: gem_barrier_race
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: kms_lease
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gen7_exec_parse
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: i915_selftest
results: parsing output: 129/ for test: kms_invalid_mode
results: parsing output: 130/ for test: gem_exec_balancer
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_schedule
Done.