[57.841965] Initializing watchdogs
[57.842022]   /dev/watchdog0
[57.857108] [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.861813] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.864090] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.867366] [001/133] (960s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[58.281362] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[59.059102] [002/133] (959s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[59.161108] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[59.165487] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[59.262789] [003/133] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[59.369817] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[59.374101] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[59.467002] [004/133] (959s left) kms_hdmi_inject (inject-audio)
[59.801965] Starting subtest: inject-audio
[60.080206] Subtest inject-audio: SUCCESS (0.278s)
[60.662789] [005/133] (957s left) kms_selftest (drm_damage_helper)
[60.717256] Starting subtest: drm_damage_helper
[60.726778] Starting dynamic subtest: drm_test_damage_iter_no_damage
[60.810107] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.083s)
[60.819222] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[60.896639] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.086s)
[60.905616] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[60.986574] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.088s)
[60.995375] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[61.067584] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.080s)
[61.076213] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[61.158056] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.090s)
[61.166925] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[61.243764] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.087s)
[61.252683] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[61.335149] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.089s)
[61.343164] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[61.436445] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.101s)
[61.443436] Starting dynamic subtest: drm_test_damage_iter_single_damage
[61.522596] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.086s)
[61.531206] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[61.601904] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.079s)
[61.610428] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[61.700185] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.097s)
[61.708402] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[61.798781] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.098s)
[61.807133] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[61.887601] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.088s)
[61.895922] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[61.986960] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.098s)
[61.993168] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[62.070436] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.082s)
[62.076829] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[62.182341] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.111s)
[62.189267] Starting dynamic subtest: drm_test_damage_iter_damage
[62.273759] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.091s)
[62.282788] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[62.359456] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.085s)
[62.367907] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[62.461478] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.102s)
[62.469996] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[62.539459] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.078s)
[62.551078] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[62.626670] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.086s)
[62.628756] Subtest drm_damage_helper: SUCCESS (1.905s)
[62.782959] [006/133] (955s left) kms_plane_multiple (2x-tiling-x)
[62.887489] Starting subtest: 2x-tiling-x
[62.891896] Subtest 2x-tiling-x: SKIP (0.000s)
[62.954832] [007/133] (955s left) gem_eio (in-flight-contexts-10ms)
[63.094622] Starting subtest: in-flight-contexts-10ms
[74.919938] Subtest in-flight-contexts-10ms: SUCCESS (11.813s)
[75.041775] [008/133] (943s left) gem_ctx_isolation (nonpriv-switch)
[75.111443] Starting subtest: nonpriv-switch
[75.113830] Starting dynamic subtest: rcs0
[75.398415] Dynamic subtest rcs0: SUCCESS (0.287s)
[75.409027] Starting dynamic subtest: bcs0
[75.670052] Dynamic subtest bcs0: SUCCESS (0.271s)
[75.679449] Starting dynamic subtest: vcs0
[75.964536] Dynamic subtest vcs0: SUCCESS (0.295s)
[75.974282] Starting dynamic subtest: vcs1
[77.124608] Dynamic subtest vcs1: SUCCESS (1.159s)
[77.134030] Starting dynamic subtest: vecs0
[79.228819] Dynamic subtest vecs0: SUCCESS (2.104s)
[79.239410] Starting dynamic subtest: ccs0
[81.241571] Dynamic subtest ccs0: SUCCESS (2.012s)
[81.243875] Subtest nonpriv-switch: SUCCESS (6.129s)
[81.493746] [009/133] (937s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[81.593658] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[81.595955] Starting dynamic subtest: pipe-A-eDP-1
[81.615950] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[81.626975] Starting dynamic subtest: pipe-B-eDP-1
[81.645900] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[81.653213] Starting dynamic subtest: pipe-C-eDP-1
[81.672085] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[81.679371] Starting dynamic subtest: pipe-D-eDP-1
[81.698499] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[81.700392] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[83.850848] [010/133] (934s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[83.943505] Starting subtest: plane-lut1d-pre-ctm3x4
[84.101035] Starting dynamic subtest: pipe-A-plane-0
[84.256986] Dynamic subtest pipe-A-plane-0: SUCCESS (0.156s)
[84.270231] Starting dynamic subtest: pipe-A-plane-1
[84.423220] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[84.432369] Starting dynamic subtest: pipe-A-plane-2
[84.589843] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[85.812326] Starting dynamic subtest: pipe-B-plane-0
[85.973607] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[85.983092] Starting dynamic subtest: pipe-B-plane-1
[86.151124] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[86.160805] Starting dynamic subtest: pipe-B-plane-2
[86.340123] Dynamic subtest pipe-B-plane-2: SUCCESS (0.189s)
[87.498203] Starting dynamic subtest: pipe-C-plane-0
[87.644076] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[87.653755] Starting dynamic subtest: pipe-C-plane-1
[87.789279] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[87.798348] Starting dynamic subtest: pipe-C-plane-2
[87.944070] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[89.096977] Starting dynamic subtest: pipe-D-plane-0
[89.234967] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[89.242766] Starting dynamic subtest: pipe-D-plane-1
[89.390352] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[89.398248] Starting dynamic subtest: pipe-D-plane-2
[89.523747] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[89.808916] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.866s)
[90.647875] [011/133] (928s left) gem_exec_schedule (preempt-self)
[90.728609] Starting subtest: preempt-self
[90.730979] Starting dynamic subtest: rcs0
[90.738736] Dynamic subtest rcs0: SUCCESS (0.018s)
[90.748517] Starting dynamic subtest: bcs0
[90.761880] Dynamic subtest bcs0: SUCCESS (0.023s)
[90.769723] Starting dynamic subtest: vcs0
[90.780737] Dynamic subtest vcs0: SUCCESS (0.018s)
[90.788391] Starting dynamic subtest: vcs1
[90.802609] Dynamic subtest vcs1: SUCCESS (0.021s)
[90.815678] Starting dynamic subtest: vecs0
[90.827028] Dynamic subtest vecs0: SUCCESS (0.024s)
[90.836440] Starting dynamic subtest: ccs0
[90.851672] Dynamic subtest ccs0: SUCCESS (0.024s)
[90.853991] Subtest preempt-self: SUCCESS (0.132s)
[92.008650] [012/133] (926s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[92.106389] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[93.252395] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.148s)
[93.361435] [013/133] (925s left) kms_content_protection (dp-mst-lic-type-0)
[93.502431] Starting subtest: dp-mst-lic-type-0
[93.506221] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[93.630956] [014/133] (925s left) gem_close (many-handles-one-vma)
[93.701403] Starting subtest: many-handles-one-vma
[93.723130] Subtest many-handles-one-vma: SUCCESS (0.024s)
[93.831678] [015/133] (925s left) gem_eio (reset-stress)
[94.065197] Starting subtest: reset-stress
[94.067117] Starting dynamic subtest: render
[99.170709] Dynamic subtest render: SUCCESS (5.104s)
[99.184398] Starting dynamic subtest: bsd1
[117.434343] Dynamic subtest bsd1: SUCCESS (18.260s)
[117.452563] Starting dynamic subtest: bsd2
[135.434711] Dynamic subtest bsd2: SUCCESS (18.002s)
[135.448858] Starting dynamic subtest: blt
[135.453232] Dynamic subtest blt: SKIP (0.000s)
[135.461094] Starting dynamic subtest: vebox
[153.407427] Dynamic subtest vebox: SUCCESS (17.969s)
[153.409642] Subtest reset-stress: SUCCESS (59.338s)
[154.935851] [FACT gem_eio (reset-stress)] new: kernel.kmod_is_loaded.vgem: true
[154.939215] [016/133] (864s left) prime_vgem (fence-write-hang)
[155.017063] Subtest fence-write-hang: SKIP (0.000s)
[155.105629] [017/133] (863s left) syncobj_wait (invalid-wait-illegal-handle)
[155.166047] Starting subtest: invalid-wait-illegal-handle
[155.168468] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[155.265491] [018/133] (863s left) kms_rotation_crc (sprite-rotation-90)
[155.355928] Starting subtest: sprite-rotation-90
[155.360464] Subtest sprite-rotation-90: SKIP (0.001s)
[155.429441] [019/133] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[155.522464] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[155.526859] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[155.622632] [020/133] (863s left) gem_exec_balancer (nop)
[155.677421] Starting subtest: nop
[202.305048] Subtest nop: SUCCESS (46.623s)
[202.604424] [021/133] (816s left) gem_softpin (allocator-nopin-reserve)
[202.656806] Starting subtest: allocator-nopin-reserve
[202.749382] Subtest allocator-nopin-reserve: SUCCESS (0.093s)
[202.881629] [022/133] (816s left) gem_exec_store (pages)
[202.945929] Starting subtest: pages
[202.948075] Starting dynamic subtest: rcs0
[203.039631] Dynamic subtest rcs0: SUCCESS (0.095s)
[203.047701] Starting dynamic subtest: bcs0
[203.118705] Dynamic subtest bcs0: SUCCESS (0.078s)
[203.129563] Starting dynamic subtest: vcs0
[203.182059] Dynamic subtest vcs0: SUCCESS (0.064s)
[203.193078] Starting dynamic subtest: vcs1
[203.248599] Dynamic subtest vcs1: SUCCESS (0.065s)
[203.259080] Starting dynamic subtest: vecs0
[203.315720] Dynamic subtest vecs0: SUCCESS (0.067s)
[203.326278] Starting dynamic subtest: ccs0
[203.384924] Dynamic subtest ccs0: SUCCESS (0.069s)
[203.387524] Subtest pages: SUCCESS (0.441s)
[203.567211] [023/133] (815s left) kms_invalid_mode (bad-vsync-start)
[203.675124] Starting subtest: bad-vsync-start
[203.677434] Starting dynamic subtest: pipe-A-eDP-1
[203.959672] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[203.969308] Starting dynamic subtest: pipe-B-eDP-1
[203.971322] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[203.979643] Starting dynamic subtest: pipe-C-eDP-1
[203.981927] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[203.992080] Starting dynamic subtest: pipe-D-eDP-1
[203.994792] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[203.997333] Subtest bad-vsync-start: SUCCESS (0.290s)
[204.824422] [024/133] (814s left) perf (non-sampling-read-error)
[204.964337] Starting subtest: non-sampling-read-error
[204.978859] Subtest non-sampling-read-error: SUCCESS (0.015s)
[205.025226] [025/133] (814s left) syncobj_timeline (single-wait-all-available-signaled)
[205.090750] Starting subtest: single-wait-all-available-signaled
[205.093150] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[205.201772] [026/133] (814s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[205.300593] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[205.304818] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[205.411964] [027/133] (813s left) gem_exec_reloc (basic-write-read-noreloc)
[205.481729] Subtest basic-write-read-noreloc: SKIP (0.000s)
[205.562135] [028/133] (813s left) gem_exec_params (invalid-ring)
[205.626074] Starting subtest: invalid-ring
[205.628227] Subtest invalid-ring: SUCCESS (0.000s)
[205.743991] [029/133] (813s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[205.834202] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[205.836068] Starting dynamic subtest: pipe-A-eDP-1
[205.855091] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[205.865732] Starting dynamic subtest: pipe-B-eDP-1
[205.884215] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[205.892328] Starting dynamic subtest: pipe-C-eDP-1
[205.909828] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[205.917314] Starting dynamic subtest: pipe-D-eDP-1
[205.935211] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[205.938519] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[208.033867] [030/133] (811s left) kms_debugfs (display-on-read-all)
[208.135421] Starting subtest: display-on-read-all
[208.302841] Subtest display-on-read-all: SUCCESS (0.169s)
[208.427914] [031/133] (811s left) kms_draw_crc (draw-method-blt)
[208.516817] Starting subtest: draw-method-blt
[208.518738] Starting dynamic subtest: xrgb8888-untiled
[208.737461] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[208.746253] Starting dynamic subtest: rgb565-untiled
[208.937702] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[208.946617] Starting dynamic subtest: xrgb2101010-untiled
[209.159593] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[209.169569] Starting dynamic subtest: xbgr16161616f-untiled
[209.381578] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[209.390436] Starting dynamic subtest: xrgb8888-xtiled
[209.503965] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[209.512885] Starting dynamic subtest: rgb565-xtiled
[209.637190] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[209.645989] Starting dynamic subtest: xrgb2101010-xtiled
[209.748530] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[209.757463] Starting dynamic subtest: xbgr16161616f-xtiled
[209.859350] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[209.875461] Starting dynamic subtest: xrgb8888-4tiled
[209.970836] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.111s)
[209.979120] Starting dynamic subtest: rgb565-4tiled
[210.093160] Dynamic subtest rgb565-4tiled: SUCCESS (0.120s)
[210.102864] Starting dynamic subtest: xrgb2101010-4tiled
[210.203824] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[210.212416] Starting dynamic subtest: xbgr16161616f-4tiled
[210.317068] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.111s)
[210.318843] Subtest draw-method-blt: SUCCESS (1.801s)
[210.449569] [032/133] (809s left) kms_big_fb (linear-16bpp-rotate-270)
[210.548702] Starting subtest: linear-16bpp-rotate-270
[210.569104] Subtest linear-16bpp-rotate-270: SKIP (0.020s)
[210.684431] [033/133] (808s left) gem_lmem_swapping (parallel-random-engines)
[210.722369] Subtest parallel-random-engines: SKIP (0.000s)
[210.772626] [034/133] (808s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[210.889707] Starting subtest: cursorB-vs-flipB-toggle
[210.893459] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[211.052873] [035/133] (808s left) syncobj_wait (wait-any-complex)
[211.119248] Starting subtest: wait-any-complex
[211.182224] Subtest wait-any-complex: SUCCESS (0.064s)
[211.265325] [036/133] (808s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[211.362928] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[211.366708] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[211.469361] [037/133] (808s left) dumb_buffer (create-valid-dumb)
[211.527011] Starting subtest: create-valid-dumb
[211.528845] Subtest create-valid-dumb: SUCCESS (0.000s)
[211.634147] [038/133] (808s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[211.732886] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[211.736386] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[211.833253] [039/133] (808s left) i915_hangman (hangcheck-unterminated)
[211.892718] Starting subtest: hangcheck-unterminated
[223.860043] Subtest hangcheck-unterminated: SUCCESS (11.966s)
[223.986439] [040/133] (795s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[224.061480] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[224.066274] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[224.247163] [041/133] (795s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[224.355285] Starting subtest: pr-overlay-plane-move-continuous-sf
[224.359673] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[224.428179] [042/133] (795s left) i915_suspend (basic-s3-without-i915)
[224.472286] Starting subtest: basic-s3-without-i915
[226.129033] Subtest basic-s3-without-i915: SKIP (1.651s)
[227.688222] [043/133] (792s left) kms_prime (basic-crc-hybrid)
[227.783272] Subtest basic-crc-hybrid: SKIP (0.000s)
[227.888902] [044/133] (792s left) kms_cursor_crc (cursor-onscreen-64x64)
[228.071566] Starting subtest: cursor-onscreen-64x64
[228.085508] Starting dynamic subtest: pipe-A-eDP-1
[230.232513] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.148s)
[230.269908] Starting dynamic subtest: pipe-D-eDP-1
[233.052487] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.793s)
[233.054729] Subtest cursor-onscreen-64x64: SUCCESS (4.981s)
[233.925851] [045/133] (786s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[233.987139] Starting subtest: single-wait-all-for-submit-unsubmitted
[234.089948] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[234.164207] [046/133] (786s left) gem_exec_schedule (pi-userfault)
[234.353176] Starting subtest: pi-userfault
[234.355108] Starting dynamic subtest: rcs0
[234.363323] Dynamic subtest rcs0: SUCCESS (0.012s)
[234.372236] Starting dynamic subtest: bcs0
[234.374510] Dynamic subtest bcs0: SUCCESS (0.007s)
[234.382123] Starting dynamic subtest: vcs0
[234.384363] Dynamic subtest vcs0: SUCCESS (0.008s)
[234.392084] Starting dynamic subtest: vcs1
[234.394032] Dynamic subtest vcs1: SUCCESS (0.008s)
[234.402098] Starting dynamic subtest: vecs0
[234.404474] Dynamic subtest vecs0: SUCCESS (0.008s)
[234.412069] Starting dynamic subtest: ccs0
[234.414317] Dynamic subtest ccs0: SUCCESS (0.007s)
[234.416530] Subtest pi-userfault: SUCCESS (0.054s)
[234.590304] [047/133] (785s left) syncobj_eventfd (timeline-wait-signaled)
[234.646019] Starting subtest: timeline-wait-signaled
[234.648200] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[234.756064] [048/133] (785s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[234.860625] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[234.864758] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[234.931130] [049/133] (785s left) gem_exec_fence (syncobj-import)
[235.353025] Starting subtest: syncobj-import
[235.358033] Subtest syncobj-import: SUCCESS (0.005s)
[236.950135] [050/133] (783s left) syncobj_basic (test-valid-cycle)
[237.015362] Starting subtest: test-valid-cycle
[237.017645] Subtest test-valid-cycle: SUCCESS (0.000s)
[237.103571] [051/133] (783s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[237.201674] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[237.228630] Starting dynamic subtest: pipe-A-plane-0
[237.517339] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[237.527738] Starting dynamic subtest: pipe-A-plane-3
[237.751459] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[238.810447] Starting dynamic subtest: pipe-B-plane-0
[239.103049] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[239.111376] Starting dynamic subtest: pipe-B-plane-3
[239.336531] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[239.648953] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.446s)
[240.490807] [052/133] (779s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[240.592690] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[244.136103] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.547s)
[245.284466] [053/133] (775s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[245.401279] Starting subtest: fbc-2p-pri-indfb-multidraw
[245.405613] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[245.487322] [054/133] (775s left) kms_getfb (getfb-handle-closed)
[245.576129] Starting subtest: getfb-handle-closed
[245.578446] Subtest getfb-handle-closed: SUCCESS (0.000s)
[245.674973] [055/133] (774s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[245.772230] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[252.411197] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.638s)
[252.536037] [056/133] (768s left) kms_flip (2x-flip-vs-rmfb)
[252.634729] Starting subtest: 2x-flip-vs-rmfb
[252.646057] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[252.725208] [057/133] (767s left) gem_media_fill (media-fill)
[252.788970] Subtest media-fill: SKIP (0.000s)
[252.908877] [058/133] (767s left) gem_render_copy_redux (flink-interruptible)
[252.968819] Starting subtest: flink-interruptible
[253.795118] Subtest flink-interruptible: SUCCESS (0.827s)
[253.918786] [059/133] (766s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[254.006203] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[254.009602] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[254.110357] [060/133] (766s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[254.203622] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[261.137389] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.938s)
[261.286210] [061/133] (759s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[261.404457] Starting subtest: 2x-flip-vs-cursor-legacy
[261.409255] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[261.550073] [062/133] (759s left) gem_exec_suspend (basic-s3-devices)
[261.613473] Starting subtest: basic-S3-devices
[261.615473] Starting dynamic subtest: smem
[272.917957] Dynamic subtest smem: SUCCESS (11.305s)
[272.920926] Subtest basic-S3-devices: SUCCESS (11.307s)
[277.168135] [063/133] (747s left) kms_flip (flip-vs-expired-vblank-interruptible)
[277.290833] Starting subtest: flip-vs-expired-vblank-interruptible
[277.293231] Starting dynamic subtest: A-eDP1
[285.947959] Dynamic subtest A-eDP1: SUCCESS (8.620s)
[285.959816] Starting dynamic subtest: B-eDP1
[294.577063] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[294.587120] Starting dynamic subtest: C-eDP1
[303.204476] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[303.215841] Starting dynamic subtest: D-eDP1
[311.786593] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[311.791760] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.497s)
[312.954641] [064/133] (712s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[313.010130] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[313.012466] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[313.123184] [065/133] (711s left) perf (invalid-remove-userspace-config)
[313.248565] Starting subtest: invalid-remove-userspace-config
[313.259022] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[313.304256] [066/133] (711s left) gem_ctx_persistence (heartbeat-hostile)
[313.355576] Starting subtest: heartbeat-hostile
[313.359923] Subtest heartbeat-hostile: SKIP (0.000s)
[313.458614] [067/133] (711s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[313.565486] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[313.577659] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[313.655467] [068/133] (711s left) kms_psr (fbc-pr-sprite-blt)
[313.749138] Starting subtest: fbc-pr-sprite-blt
[313.753556] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[313.822182] [069/133] (711s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[313.881512] Starting subtest: multi-wait-all-available-submitted-signaled
[313.883186] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[313.975470] [070/133] (711s left) gem_exec_flush (basic-uc-ro-default)
[314.032091] Starting subtest: basic-uc-ro-default
[319.517957] Subtest basic-uc-ro-default: SUCCESS (5.457s)
[319.678114] [071/133] (705s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[319.781051] Starting subtest: x-tiled-8bpp-rotate-0
[320.986909] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.207s)
[321.129641] [072/133] (704s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[321.216365] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[328.021317] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.806s)
[328.167575] [073/133] (697s left) kms_vrr (seamless-rr-switch-vrr)
[328.259676] Starting subtest: seamless-rr-switch-vrr
[328.266185] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[328.333851] [074/133] (697s left) gem_render_copy (y-tiled)
[328.403859] Starting subtest: y-tiled
[328.408377] Subtest y-tiled: SKIP (0.000s)
[328.590426] [075/133] (696s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[328.705137] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[335.301869] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.598s)
[335.440629] [076/133] (690s left) kms_addfb_basic (unused-modifier)
[335.503466] Starting subtest: unused-modifier
[335.505729] Subtest unused-modifier: SUCCESS (0.000s)
[335.631588] [077/133] (689s left) kms_cursor_crc (cursor-random-32x32)
[335.773699] Starting subtest: cursor-random-32x32
[335.820474] Subtest cursor-random-32x32: SKIP (0.042s)
[336.088462] [078/133] (689s left) kms_atomic (plane-cursor-legacy)
[336.179045] Starting subtest: plane-cursor-legacy
[336.181324] Starting dynamic subtest: pipe-A-eDP-1
[336.556534] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.377s)
[336.558712] Subtest plane-cursor-legacy: SUCCESS (0.378s)
[337.432420] [079/133] (688s left) perf_pmu (busy-start)
[337.474532] Starting subtest: busy-start
[337.476740] Starting dynamic subtest: rcs0
[340.028037] Dynamic subtest rcs0: SUCCESS (2.554s)
[340.039234] Starting dynamic subtest: bcs0
[342.576719] Dynamic subtest bcs0: SUCCESS (2.546s)
[342.588357] Starting dynamic subtest: vcs0
[345.877689] Dynamic subtest vcs0: SUCCESS (3.297s)
[345.889903] Starting dynamic subtest: vcs1
[349.909619] Dynamic subtest vcs1: SUCCESS (4.028s)
[349.922201] Starting dynamic subtest: vecs0
[353.877555] Dynamic subtest vecs0: SUCCESS (3.964s)
[353.889745] Starting dynamic subtest: ccs0
[356.445330] Dynamic subtest ccs0: SUCCESS (2.547s)
[356.447428] Subtest busy-start: SUCCESS (18.952s)
[356.539958] [080/133] (669s left) kms_vblank (ts-continuation-modeset-hang)
[356.641946] Starting subtest: ts-continuation-modeset-hang
[356.644371] Starting dynamic subtest: pipe-A-eDP-1
[383.647644] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.001s)
[383.662260] Starting dynamic subtest: pipe-D-eDP-1
[408.736853] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.086s)
[408.739086] Subtest ts-continuation-modeset-hang: SUCCESS (52.092s)
[409.568749] [081/133] (616s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[409.622072] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[409.686756] [082/133] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[409.783458] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[417.078397] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.297s)
[417.197462] [083/133] (608s left) prime_vgem (sync)
[417.282764] Starting subtest: sync
[417.285114] Starting dynamic subtest: rcs0
[417.337401] Dynamic subtest rcs0: SUCCESS (0.054s)
[417.348672] Starting dynamic subtest: bcs0
[417.386733] Dynamic subtest bcs0: SUCCESS (0.048s)
[417.396185] Starting dynamic subtest: vcs0
[417.438153] Dynamic subtest vcs0: SUCCESS (0.050s)
[417.447265] Starting dynamic subtest: vcs1
[417.484258] Dynamic subtest vcs1: SUCCESS (0.045s)
[417.493690] Starting dynamic subtest: vecs0
[417.532166] Dynamic subtest vecs0: SUCCESS (0.047s)
[417.541286] Starting dynamic subtest: ccs0
[417.577624] Dynamic subtest ccs0: SUCCESS (0.044s)
[417.579811] Subtest sync: SUCCESS (0.295s)
[417.701493] [084/133] (608s left) gem_exec_fence (syncobj-timeline-signal)
[418.231385] Starting subtest: syncobj-timeline-signal
[418.238101] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[419.999085] [085/133] (605s left) core_debugfs (read-all-entries)
[420.052831] Starting subtest: read-all-entries
[420.137090] Subtest read-all-entries: SUCCESS (0.087s)
[420.201126] [086/133] (605s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[420.317276] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[420.321534] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[420.406338] [087/133] (605s left) gem_eio (hibernate)
[420.614645] Starting subtest: hibernate
[435.150766] Subtest hibernate: SUCCESS (14.535s)
[441.303708] [088/133] (590s left) gem_exec_reloc (basic-wc-gtt)
[441.386805] Subtest basic-wc-gtt: SKIP (0.000s)
[441.478280] [089/133] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[441.587680] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[441.592049] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[441.704272] [090/133] (590s left) kms_chamelium_color (ctm-blue-to-red)
[441.799026] Subtest ctm-blue-to-red: SKIP (0.000s)
[441.844573] [091/133] (590s left) kms_prop_blob (blob-multiple)
[441.901629] Starting subtest: blob-multiple
[441.903930] Subtest blob-multiple: SUCCESS (0.002s)
[442.019096] [092/133] (590s left) gem_close (basic)
[442.092753] Starting subtest: basic
[442.095799] Subtest basic: SUCCESS (0.000s)
[442.233096] [093/133] (590s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[442.308602] Subtest no-spare-fences-busy: SKIP (0.000s)
[442.385947] [094/133] (589s left) kms_psr (fbc-psr-no-drrs)
[442.471695] Starting subtest: fbc-psr-no-drrs
[442.473684] Starting dynamic subtest: eDP-1
[442.477286] Dynamic subtest eDP-1: SKIP (0.000s)
[442.480804] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[442.545285] [095/133] (589s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[442.631357] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[442.634916] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[442.714340] [096/133] (589s left) gem_basic (multigpu-create-close)
[442.763212] Starting subtest: multigpu-create-close
[442.766837] Subtest multigpu-create-close: SKIP (0.000s)
[442.861066] [097/133] (589s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[442.970396] Starting subtest: psr2-plane-move-sf-dmg-area
[442.972248] Starting dynamic subtest: pipe-A-eDP-1
[447.530240] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.555s)
[447.541322] Starting dynamic subtest: pipe-B-eDP-1
[452.850071] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.320s)
[452.852480] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.879s)
[453.754602] [098/133] (578s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[453.846020] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[453.848344] Starting dynamic subtest: pipe-A
[453.969782] Dynamic subtest pipe-A: SKIP (0.120s)
[453.980205] Starting dynamic subtest: pipe-B
[455.136656] Dynamic subtest pipe-B: SKIP (1.166s)
[455.148352] Starting dynamic subtest: pipe-C
[456.349092] Dynamic subtest pipe-C: SUCCESS (1.217s)
[456.360132] Starting dynamic subtest: pipe-D
[457.588813] Dynamic subtest pipe-D: SUCCESS (1.239s)
[457.591039] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.746s)
[458.779569] [099/133] (573s left) kms_pm_rpm (basic-rte)
[458.819251] Starting subtest: basic-rte
[462.487978] Subtest basic-rte: SUCCESS (3.669s)
[463.996467] [100/133] (568s left) kms_properties (plane-properties-legacy)
[464.091289] Starting subtest: plane-properties-legacy
[464.093646] Starting dynamic subtest: pipe-A-eDP-1
[464.636478] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[464.647589] Starting dynamic subtest: pipe-B-eDP-1
[465.943648] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.308s)
[465.954598] Starting dynamic subtest: pipe-C-eDP-1
[467.178647] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[467.189279] Starting dynamic subtest: pipe-D-eDP-1
[468.413324] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[468.415626] Subtest plane-properties-legacy: SUCCESS (4.325s)
[469.212287] [101/133] (563s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[469.314619] Starting subtest: fbc-rgb565-draw-pwrite
[473.928879] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.617s)
[475.118577] [102/133] (557s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[475.212715] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[475.216822] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[475.312273] [103/133] (557s left) gem_wait (busy)
[475.372902] Starting subtest: busy
[475.374823] Starting dynamic subtest: all-engines
[476.885372] Dynamic subtest all-engines: SUCCESS (1.513s)
[476.898107] Starting dynamic subtest: rcs0
[477.425744] Dynamic subtest rcs0: SUCCESS (0.539s)
[477.437700] Starting dynamic subtest: bcs0
[477.965052] Dynamic subtest bcs0: SUCCESS (0.538s)
[477.976600] Starting dynamic subtest: vcs0
[479.894382] Dynamic subtest vcs0: SUCCESS (1.926s)
[479.906503] Starting dynamic subtest: vcs1
[481.941026] Dynamic subtest vcs1: SUCCESS (2.044s)
[481.953785] Starting dynamic subtest: vecs0
[483.925077] Dynamic subtest vecs0: SUCCESS (1.981s)
[483.936342] Starting dynamic subtest: ccs0
[484.469797] Dynamic subtest ccs0: SUCCESS (0.543s)
[484.472787] Subtest busy: SUCCESS (9.098s)
[484.671954] [104/133] (548s left) gem_ppgtt (shrink-vs-evict-any)
[484.745790] Starting subtest: shrink-vs-evict-any
[491.934905] Subtest shrink-vs-evict-any: SUCCESS (7.136s)
[491.973990] [105/133] (540s left) i915_drm_fdinfo (context-close-stress)
[492.017639] Starting subtest: context-close-stress
[502.813679] Subtest context-close-stress: SUCCESS (10.745s)
[502.860249] [106/133] (530s left) gem_exec_balancer (persistence)
[503.237224] Starting subtest: persistence
[504.163758] Subtest persistence: SUCCESS (0.925s)
[504.282495] [107/133] (528s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[504.381988] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[504.384173] Starting dynamic subtest: pipe-A-eDP-1
[521.171885] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s)
[521.188792] Starting dynamic subtest: pipe-B-eDP-1
[539.124898] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.836s)
[539.135662] Starting dynamic subtest: pipe-C-eDP-1
[557.097121] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.722s)
[557.108592] Starting dynamic subtest: pipe-D-eDP-1
[575.114377] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.783s)
[575.116555] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.154s)
[582.348747] [108/133] (456s left) sysfs_heartbeat_interval (invalid)
[582.415368] Starting subtest: invalid
[582.417698] Starting dynamic subtest: vecs0
[582.420045] Dynamic subtest vecs0: SUCCESS (0.000s)
[582.430341] Starting dynamic subtest: ccs0
[582.432745] Dynamic subtest ccs0: SUCCESS (0.000s)
[582.442846] Starting dynamic subtest: vcs0
[582.445127] Dynamic subtest vcs0: SUCCESS (0.000s)
[582.455468] Starting dynamic subtest: bcs0
[582.457820] Dynamic subtest bcs0: SUCCESS (0.000s)
[582.468188] Starting dynamic subtest: rcs0
[582.470181] Dynamic subtest rcs0: SUCCESS (0.000s)
[582.480936] Starting dynamic subtest: vcs1
[582.483215] Dynamic subtest vcs1: SUCCESS (0.000s)
[582.485519] Subtest invalid: SUCCESS (0.005s)
[582.528332] [109/133] (456s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[582.631979] Starting subtest: plane-all-modeset-transition-fencing
[582.636700] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[582.733206] [110/133] (456s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[582.785792] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[582.845159] [111/133] (456s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[582.963256] Starting subtest: protected-encrypted-src-copy-not-readible
[583.084631] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.120s)
[583.203227] [112/133] (455s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[583.611843] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[584.486432] [113/133] (454s left) kms_async_flips (async-flip-hang)
[584.586034] Starting subtest: async-flip-hang
[584.965544] Starting dynamic subtest: pipe-A-eDP-1
[600.057033] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.976s)
[600.441048] Starting dynamic subtest: pipe-B-eDP-1
[616.022818] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.570s)
[616.404556] Starting dynamic subtest: pipe-C-eDP-1
[631.953884] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.553s)
[632.329837] Starting dynamic subtest: pipe-D-eDP-1
[647.958292] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.628s)
[647.960746] Subtest async-flip-hang: SUCCESS (63.234s)
[649.199170] [114/133] (390s left) gen9_exec_parse (cmd-crossing-page)
[649.271755] Subtest cmd-crossing-page: SKIP (0.000s)
[649.351099] [115/133] (389s left) gem_ctx_shared (q-smoketest-all)
[649.420904] Starting subtest: Q-smoketest-all
[681.812592] Subtest Q-smoketest-all: SUCCESS (32.335s)
[683.624240] [116/133] (355s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[683.713818] Starting subtest: primary-4-tiled-reflect-x-180
[690.684356] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.973s)
[691.867886] [117/133] (347s left) gem_userptr_blits (process-exit)
[691.936911] Starting subtest: process-exit
[691.942643] Subtest process-exit: SUCCESS (0.009s)
[692.065527] [118/133] (347s left) kms_addfb_basic (clobberred-modifier)
[692.121766] Starting subtest: clobberred-modifier
[692.126537] Subtest clobberred-modifier: SKIP (0.000s)
[692.259578] [119/133] (347s left) gem_mmap_offset (open-flood)
[692.312494] Starting subtest: open-flood
[713.797741] Subtest open-flood: SUCCESS (21.489s)
[713.901839] [120/133] (325s left) kms_cursor_crc (cursor-sliding-64x64)
[714.087817] Starting subtest: cursor-sliding-64x64
[714.092014] Starting dynamic subtest: pipe-A-eDP-1
[717.327926] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.235s)
[717.365892] Starting dynamic subtest: pipe-D-eDP-1
[721.274078] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.925s)
[721.276530] Subtest cursor-sliding-64x64: SUCCESS (7.185s)
[722.145730] [121/133] (317s left) kms_legacy_colorkey (invalid-plane)
[722.242734] Starting subtest: invalid-plane
[722.244878] Starting dynamic subtest: zero-id
[722.246773] Dynamic subtest zero-id: SUCCESS (0.000s)
[722.257853] Starting dynamic subtest: outrange-id
[722.259930] Dynamic subtest outrange-id: SUCCESS (0.000s)
[722.261998] Subtest invalid-plane: SUCCESS (0.001s)
[722.317627] [122/133] (317s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[722.420761] Starting subtest: y-tiled-64bpp-rotate-180
[722.424948] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[722.527454] [123/133] (317s left) gem_compute (compute-square)
[722.580851] Starting subtest: compute-square
[722.589401] Subtest compute-square: SUCCESS (0.008s)
[722.710391] [124/133] (316s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[722.814483] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[722.818774] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[724.009135] [125/133] (315s left) kms_psr (pr-primary-page-flip)
[724.101897] Starting subtest: pr-primary-page-flip
[724.106276] Subtest pr-primary-page-flip: SKIP (0.000s)
[724.196313] [126/133] (315s left) i915_pm_freq_mult (media-freq)
[724.255946] Starting subtest: media-freq
[724.258283] Starting dynamic subtest: gt0
[724.262347] Dynamic subtest gt0: SKIP (0.000s)
[724.277926] Starting dynamic subtest: gt1
[724.281939] Dynamic subtest gt1: SKIP (0.000s)
[724.285976] Subtest media-freq: SKIP (0.004s)
[724.395756] [127/133] (315s left) kms_rotation_crc (sprite-rotation-180)
[724.481384] Starting subtest: sprite-rotation-180
[731.299105] Subtest sprite-rotation-180: SUCCESS (6.818s)
[732.545725] [128/133] (307s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[732.638316] Starting subtest: plane-upscale-20x20-with-rotation
[732.640699] Starting dynamic subtest: pipe-A
[732.863178] Dynamic subtest pipe-A: SUCCESS (0.227s)
[732.873812] Starting dynamic subtest: pipe-B
[734.127638] Dynamic subtest pipe-B: SUCCESS (1.263s)
[734.139025] Starting dynamic subtest: pipe-C
[735.459311] Dynamic subtest pipe-C: SUCCESS (1.330s)
[735.469965] Starting dynamic subtest: pipe-D
[736.797599] Dynamic subtest pipe-D: SUCCESS (1.337s)
[736.799957] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.161s)
[737.970576] [129/133] (301s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[738.065309] Starting subtest: compare-crc-sanitycheck-nv12
[738.067589] Starting dynamic subtest: pipe-A-eDP-1
[738.782403] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[738.796336] Starting dynamic subtest: pipe-B-eDP-1
[740.063900] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.281s)
[740.075531] Starting dynamic subtest: pipe-C-eDP-1
[741.326012] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.260s)
[741.337032] Starting dynamic subtest: pipe-D-eDP-1
[742.599198] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.271s)
[742.601226] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.533s)
[743.424064] [130/133] (296s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[743.515609] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[743.519894] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[743.618727] [131/133] (296s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[743.674418] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[743.676625] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[743.778843] [132/133] (296s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[743.878278] Starting subtest: 4-tiled-16bpp-rotate-90
[743.902940] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.024s)
[744.011510] [133/133] (296s left) kms_psr (psr2-primary-mmap-gtt)
[744.108942] Starting subtest: psr2-primary-mmap-gtt
[744.111071] Starting dynamic subtest: eDP-1
[745.511472] Dynamic subtest eDP-1: SKIP (1.398s)
[745.516101] Subtest psr2-primary-mmap-gtt: SKIP (1.401s)
[745.640585] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_edid
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_hdmi_inject
results: parsing output: 4/ for test: kms_selftest
results: parsing output: 5/ for test: kms_plane_multiple
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: gem_ctx_isolation
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_color_pipeline
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: gem_close
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: prime_vgem
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_rotation_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: gem_softpin
results: parsing output: 21/ for test: gem_exec_store
results: parsing output: 22/ for test: kms_invalid_mode
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: gem_exec_params
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_debugfs
results: parsing output: 30/ for test: kms_draw_crc
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: dumb_buffer
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: i915_hangman
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: i915_suspend
results: parsing output: 42/ for test: kms_prime
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: syncobj_eventfd
results: parsing output: 47/ for test: kms_flip_scaled_crc
results: parsing output: 48/ for test: gem_exec_fence
results: parsing output: 49/ for test: syncobj_basic
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_getfb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_media_fill
results: parsing output: 57/ for test: gem_render_copy_redux
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: gem_exec_suspend
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_exec_flush
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_vrr
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_vblank
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: prime_vgem
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: core_debugfs
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_eio
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_chamelium_color
results: parsing output: 90/ for test: kms_prop_blob
results: parsing output: 91/ for test: gem_close
results: parsing output: 92/ for test: gem_fenced_exec_thrash
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_basic
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_properties
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_wait
results: parsing output: 103/ for test: gem_ppgtt
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: sysfs_heartbeat_interval
results: parsing output: 108/ for test: kms_atomic_transition
results: parsing output: 109/ for test: kms_pipe_b_c_ivb
results: parsing output: 110/ for test: gem_pxp
results: parsing output: 111/ for test: kms_chamelium_hpd
results: parsing output: 112/ for test: kms_async_flips
results: parsing output: 113/ for test: gen9_exec_parse
results: parsing output: 114/ for test: gem_ctx_shared
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: gem_mmap_offset
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: kms_legacy_colorkey
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_compute
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: i915_pm_freq_mult
results: parsing output: 126/ for test: kms_rotation_crc
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_pipe_crc_basic
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_psr
Done.