[57.155955] Initializing watchdogs
[57.155998]   /dev/watchdog0
[57.169523] [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.173866] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.176465] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.179680] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[57.307595] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[61.796939] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.461s)
[62.980219] [002/133] (954s left) kms_cursor_crc (cursor-offscreen-32x32)
[63.134318] Starting subtest: cursor-offscreen-32x32
[63.185001] Subtest cursor-offscreen-32x32: SKIP (0.045s)
[63.472361] [003/133] (954s left) gem_exec_reloc (basic-gtt-read-noreloc)
[63.543454] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[63.612913] [004/133] (954s left) core_setmaster (master-drop-set-user)
[63.695093] Starting subtest: master-drop-set-user
[63.709445] Subtest master-drop-set-user: SUCCESS (0.017s)
[63.745017] [005/133] (954s left) gem_userptr_blits (invalid-null-pointer)
[63.802715] Starting subtest: invalid-null-pointer
[63.805056] Subtest invalid-null-pointer: SUCCESS (0.001s)
[63.932324] [006/133] (953s left) gem_exec_capture (capture-recoverable)
[63.983480] Starting subtest: capture-recoverable
[63.987656] Subtest capture-recoverable: SUCCESS (0.003s)
[64.109276] [007/133] (953s left) kms_flip (flip-vs-fences)
[64.203930] Starting subtest: flip-vs-fences
[64.207642] Subtest flip-vs-fences: SKIP (0.000s)
[64.294659] [008/133] (953s left) kms_async_flips (test-time-stamp)
[64.387164] Starting subtest: test-time-stamp
[64.778589] Starting dynamic subtest: pipe-A-eDP-1
[65.587198] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.803s)
[65.963673] Starting dynamic subtest: pipe-B-eDP-1
[66.725604] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s)
[67.112992] Starting dynamic subtest: pipe-C-eDP-1
[67.848931] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.740s)
[68.212541] Starting dynamic subtest: pipe-D-eDP-1
[68.983348] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[68.985834] Subtest test-time-stamp: SUCCESS (4.583s)
[70.135184] [009/133] (947s left) gem_lmem_swapping (parallel-random-verify-ccs)
[70.180611] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[70.221808] [010/133] (947s left) gem_exec_params (invalid-batch-start-offset)
[70.271824] Starting subtest: invalid-batch-start-offset
[70.276784] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[70.373420] [011/133] (947s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[70.435591] Starting subtest: yf-tiled-ccs-to-yf-tiled
[70.440158] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[70.611900] [012/133] (947s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[70.722568] Starting subtest: y-tiled-addfb-size-offset-overflow
[70.726869] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[70.807831] [013/133] (947s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[70.856382] Starting subtest: y-tiled-to-vebox-yf-tiled
[70.860842] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[71.038947] [014/133] (947s left) kms_draw_crc (draw-method-mmap-wc)
[71.119803] Starting subtest: draw-method-mmap-wc
[71.121891] Starting dynamic subtest: xrgb8888-untiled
[71.362167] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[71.371704] Starting dynamic subtest: rgb565-untiled
[71.584852] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[71.593982] Starting dynamic subtest: xrgb2101010-untiled
[71.807096] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[71.815650] Starting dynamic subtest: xbgr16161616f-untiled
[72.007512] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.200s)
[72.015712] Starting dynamic subtest: xrgb8888-xtiled
[72.140646] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[72.149295] Starting dynamic subtest: rgb565-xtiled
[72.263401] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[72.271577] Starting dynamic subtest: xrgb2101010-xtiled
[72.374645] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[72.381684] Starting dynamic subtest: xbgr16161616f-xtiled
[72.486123] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[72.494545] Starting dynamic subtest: xrgb8888-4tiled
[72.630042] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[72.639194] Starting dynamic subtest: rgb565-4tiled
[72.763436] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[72.771463] Starting dynamic subtest: xrgb2101010-4tiled
[72.896761] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[72.904209] Starting dynamic subtest: xbgr16161616f-4tiled
[73.064256] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[73.066071] Subtest draw-method-mmap-wc: SUCCESS (1.944s)
[73.153480] [015/133] (945s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[73.247296] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[74.349608] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.100s)
[74.492534] [016/133] (943s left) kms_plane_cursor (viewport)
[74.582327] Starting subtest: viewport
[74.586086] Starting dynamic subtest: pipe-A-eDP-1-size-64
[77.171582] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.587s)
[77.229737] Starting dynamic subtest: pipe-A-eDP-1-size-128
[79.718816] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.493s)
[79.777461] Starting dynamic subtest: pipe-A-eDP-1-size-256
[82.301264] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.529s)
[82.654826] Starting dynamic subtest: pipe-B-eDP-1-size-64
[85.804951] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.163s)
[85.863104] Starting dynamic subtest: pipe-B-eDP-1-size-128
[88.341711] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.483s)
[88.403819] Starting dynamic subtest: pipe-B-eDP-1-size-256
[90.854499] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.460s)
[91.201862] Starting dynamic subtest: pipe-C-eDP-1-size-64
[94.077813] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.884s)
[94.115499] Starting dynamic subtest: pipe-C-eDP-1-size-128
[96.234354] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.125s)
[96.271437] Starting dynamic subtest: pipe-C-eDP-1-size-256
[98.445508] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[98.785681] Starting dynamic subtest: pipe-D-eDP-1-size-64
[101.583419] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.809s)
[101.619940] Starting dynamic subtest: pipe-D-eDP-1-size-128
[103.697021] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.080s)
[103.731076] Starting dynamic subtest: pipe-D-eDP-1-size-256
[105.906420] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[106.227966] Subtest viewport: SUCCESS (31.627s)
[107.103384] [017/133] (911s left) gem_userptr_blits (stress-purge)
[107.170821] Starting subtest: stress-purge
[112.578555] Subtest stress-purge: SUCCESS (5.408s)
[112.705388] [018/133] (905s left) gem_exec_balancer (bonded-true-hang)
[113.005826] Starting subtest: bonded-true-hang
[113.010973] Subtest bonded-true-hang: SKIP (0.000s)
[113.124258] [019/133] (905s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[113.226148] Starting subtest: plane-downscale-factor-0-75-with-rotation
[113.228470] Starting dynamic subtest: pipe-A
[113.455684] Dynamic subtest pipe-A: SUCCESS (0.231s)
[113.463853] Starting dynamic subtest: pipe-B
[114.788447] Dynamic subtest pipe-B: SUCCESS (1.330s)
[114.798856] Starting dynamic subtest: pipe-C
[116.116902] Dynamic subtest pipe-C: SUCCESS (1.328s)
[116.124482] Starting dynamic subtest: pipe-D
[117.478018] Dynamic subtest pipe-D: SUCCESS (1.359s)
[117.480759] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.255s)
[118.633179] [020/133] (899s left) syncobj_timeline (single-wait-available-submitted)
[118.700517] Starting subtest: single-wait-available-submitted
[118.702899] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[118.770549] [021/133] (899s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[119.166225] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[119.940265] [022/133] (898s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[120.051518] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[127.486401] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.435s)
[127.608775] [023/133] (890s left) kms_display_modes (extended-mode-basic)
[127.697673] Starting subtest: extended-mode-basic
[127.702146] Subtest extended-mode-basic: SKIP (0.000s)
[127.742636] [024/133] (890s left) kms_content_protection (dp-mst-type-0)
[127.885862] Starting subtest: dp-mst-type-0
[127.889769] Subtest dp-mst-type-0: SKIP (0.000s)
[127.994398] [025/133] (890s left) kms_setmode (invalid-clone-single-crtc-stealing)
[128.050475] Starting subtest: invalid-clone-single-crtc-stealing
[128.056859] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[128.143204] [026/133] (890s left) kms_psr (pr-suspend)
[128.225945] Starting subtest: pr-suspend
[128.229500] Subtest pr-suspend: SKIP (0.000s)
[128.294383] [027/133] (890s left) gem_tiled_partial_pwrite_pread (writes)
[128.345092] Subtest writes: SKIP (0.000s)
[128.412145] [028/133] (890s left) gem_softpin (evict-prime-sanity-check)
[128.465324] Starting subtest: evict-prime-sanity-check
[128.467297] Starting dynamic subtest: rcs0
[129.616380] Dynamic subtest rcs0: SUCCESS (1.150s)
[129.627216] Starting dynamic subtest: bcs0
[130.730546] Dynamic subtest bcs0: SUCCESS (1.113s)
[130.741501] Starting dynamic subtest: vcs0
[131.899465] Dynamic subtest vcs0: SUCCESS (1.167s)
[131.910079] Starting dynamic subtest: vcs1
[133.909401] Dynamic subtest vcs1: SUCCESS (2.006s)
[133.919996] Starting dynamic subtest: vecs0
[135.867131] Dynamic subtest vecs0: SUCCESS (1.955s)
[135.876045] Starting dynamic subtest: ccs0
[137.011967] Dynamic subtest ccs0: SUCCESS (1.143s)
[137.020714] Starting dynamic subtest: all
[138.150071] Dynamic subtest all: SUCCESS (1.135s)
[138.152673] Subtest evict-prime-sanity-check: SUCCESS (9.684s)
[138.243677] [029/133] (880s left) kms_flip (bo-too-big-interruptible)
[138.344680] Starting subtest: bo-too-big-interruptible
[138.347036] Starting dynamic subtest: A-eDP1
[139.665631] Dynamic subtest A-eDP1: SUCCESS (1.319s)
[139.676875] Starting dynamic subtest: B-eDP1
[140.899440] Dynamic subtest B-eDP1: SUCCESS (1.233s)
[140.908848] Starting dynamic subtest: C-eDP1
[142.158130] Dynamic subtest C-eDP1: SUCCESS (1.258s)
[142.166072] Starting dynamic subtest: D-eDP1
[143.387168] Dynamic subtest D-eDP1: SUCCESS (1.229s)
[143.389555] Subtest bo-too-big-interruptible: SUCCESS (5.046s)
[144.595987] [030/133] (874s left) sriov_basic (enable-vfs-autoprobe-off)
[144.661653] Starting subtest: enable-vfs-autoprobe-off
[144.664051] Starting dynamic subtest: numvfs-1
[144.749778] Dynamic subtest numvfs-1: FAIL (0.035s)
[144.759383] Starting dynamic subtest: numvfs-2
[144.831912] Dynamic subtest numvfs-2: FAIL (0.010s)
[144.840964] Starting dynamic subtest: numvfs-3
[144.914355] Dynamic subtest numvfs-3: FAIL (0.010s)
[144.925771] Starting dynamic subtest: numvfs-4
[144.998837] Dynamic subtest numvfs-4: FAIL (0.010s)
[145.007925] Starting dynamic subtest: numvfs-5
[145.081305] Dynamic subtest numvfs-5: FAIL (0.010s)
[145.090360] Starting dynamic subtest: numvfs-6
[145.163063] Dynamic subtest numvfs-6: FAIL (0.004s)
[145.172272] Starting dynamic subtest: numvfs-7
[145.244730] Dynamic subtest numvfs-7: FAIL (0.004s)
[145.253537] Starting dynamic subtest: numvfs-random
[145.326077] Dynamic subtest numvfs-random: FAIL (0.004s)
[145.335080] Starting dynamic subtest: numvfs-all
[145.407489] Dynamic subtest numvfs-all: FAIL (0.003s)
[145.409790] Subtest enable-vfs-autoprobe-off: FAIL (0.106s)
[145.445566] [031/133] (873s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[145.563077] Starting subtest: cursorB-vs-flipA-atomic
[145.566469] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[145.704244] [032/133] (873s left) kms_atomic_interruptible (atomic-setmode)
[145.801138] Starting subtest: atomic-setmode
[145.802950] Starting dynamic subtest: pipe-A-eDP-1
[152.726107] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.923s)
[152.728014] Subtest atomic-setmode: SUCCESS (6.924s)
[153.576319] [033/133] (865s left) gem_lmem_swapping (basic)
[153.618203] Subtest basic: SKIP (0.000s)
[153.671307] [034/133] (865s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[155.191558] Starting subtest: gem-execbuf-stress-pc8
[155.229570] Subtest gem-execbuf-stress-pc8: SKIP (0.039s)
[155.898479] [035/133] (863s left) kms_pm_lpsp (kms-lpsp)
[157.000437] Starting subtest: kms-lpsp
[157.002714] Starting dynamic subtest: pipe-A-eDP-1
[157.144204] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.147s)
[157.453485] Subtest kms-lpsp: SUCCESS (0.454s)
[158.248919] [036/133] (860s left) gem_render_copy (y-tiled-ccs-to-linear)
[158.308280] Starting subtest: y-tiled-ccs-to-linear
[158.312232] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[158.500506] [037/133] (860s left) gem_workarounds (suspend-resume)
[158.569344] Starting subtest: suspend-resume
[174.231420] Subtest suspend-resume: SUCCESS (1.276s)
[174.378261] [038/133] (844s left) syncobj_wait (wait-delayed-signal)
[174.454647] Starting subtest: wait-delayed-signal
[174.555974] Subtest wait-delayed-signal: SUCCESS (0.102s)
[174.636526] [039/133] (844s left) i915_hangman (gt-error-state-capture)
[174.705303] Starting subtest: gt-error-state-capture
[174.707676] Starting dynamic subtest: rcs0
[186.278669] Dynamic subtest rcs0: SUCCESS (11.324s)
[186.290949] Starting dynamic subtest: bcs0
[198.247079] Dynamic subtest bcs0: SUCCESS (11.906s)
[198.258898] Starting dynamic subtest: vcs0
[210.214634] Dynamic subtest vcs0: SUCCESS (11.949s)
[210.226407] Starting dynamic subtest: vcs1
[221.222501] Dynamic subtest vcs1: SUCCESS (10.998s)
[221.234188] Starting dynamic subtest: vecs0
[233.190408] Dynamic subtest vecs0: SUCCESS (11.957s)
[233.201306] Starting dynamic subtest: ccs0
[244.262742] Dynamic subtest ccs0: SUCCESS (11.064s)
[244.265542] Subtest gt-error-state-capture: SUCCESS (69.215s)
[244.397648] [040/133] (774s left) kms_color_pipeline (plane-lut1d)
[244.505211] Starting subtest: plane-lut1d
[244.628739] Starting dynamic subtest: pipe-A-plane-0
[244.794994] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[244.805165] Starting dynamic subtest: pipe-A-plane-1
[244.928531] Dynamic subtest pipe-A-plane-1: SUCCESS (0.132s)
[244.937715] Starting dynamic subtest: pipe-A-plane-2
[245.062415] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[246.223628] Starting dynamic subtest: pipe-B-plane-0
[246.359808] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[246.369028] Starting dynamic subtest: pipe-B-plane-1
[246.493342] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[246.502533] Starting dynamic subtest: pipe-B-plane-2
[246.627201] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s)
[247.768554] Starting dynamic subtest: pipe-C-plane-0
[247.928242] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[247.937178] Starting dynamic subtest: pipe-C-plane-1
[248.096070] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[248.104897] Starting dynamic subtest: pipe-C-plane-2
[248.250388] Dynamic subtest pipe-C-plane-2: SUCCESS (0.154s)
[249.472256] Starting dynamic subtest: pipe-D-plane-0
[249.628203] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[249.637174] Starting dynamic subtest: pipe-D-plane-1
[249.795077] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[249.804285] Starting dynamic subtest: pipe-D-plane-2
[249.961805] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[250.251368] Subtest plane-lut1d: SUCCESS (5.743s)
[251.103402] [041/133] (768s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[251.162948] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[251.224276] [042/133] (768s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[251.310280] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[251.312592] Starting dynamic subtest: pipe-A-default-mode
[252.461934] Dynamic subtest pipe-A-default-mode: SKIP (1.149s)
[252.466341] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.150s)
[252.604176] [043/133] (766s left) kms_invalid_mode (bad-vsync-end)
[252.701667] Starting subtest: bad-vsync-end
[252.703960] Starting dynamic subtest: pipe-A-eDP-1
[252.983811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[252.993072] Starting dynamic subtest: pipe-B-eDP-1
[252.995074] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[253.003051] Starting dynamic subtest: pipe-C-eDP-1
[253.005419] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[253.013791] Starting dynamic subtest: pipe-D-eDP-1
[253.016066] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[253.018431] Subtest bad-vsync-end: SUCCESS (0.291s)
[253.857066] [044/133] (765s left) gem_ctx_persistence (engines-queued)
[253.926938] Starting subtest: engines-queued
[253.929317] Starting dynamic subtest: rcs0
[253.987077] Dynamic subtest rcs0: SUCCESS (0.060s)
[253.999167] Starting dynamic subtest: bcs0
[254.022558] Dynamic subtest bcs0: SUCCESS (0.034s)
[254.031903] Starting dynamic subtest: vcs0
[255.272961] Dynamic subtest vcs0: SUCCESS (1.245s)
[255.285144] Starting dynamic subtest: vcs1
[257.254499] Dynamic subtest vcs1: SUCCESS (1.977s)
[257.266373] Starting dynamic subtest: vecs0
[259.237982] Dynamic subtest vecs0: SUCCESS (1.979s)
[259.250190] Starting dynamic subtest: ccs0
[259.407805] Dynamic subtest ccs0: SUCCESS (0.169s)
[259.410337] Subtest engines-queued: SUCCESS (5.479s)
[259.550537] [045/133] (759s left) perf_pmu (render-node-busy)
[259.632626] Starting subtest: render-node-busy
[259.634594] Starting dynamic subtest: rcs0
[260.225669] Dynamic subtest rcs0: SUCCESS (0.595s)
[260.237941] Starting dynamic subtest: bcs0
[260.798178] Dynamic subtest bcs0: SUCCESS (0.570s)
[260.810315] Starting dynamic subtest: vcs0
[262.280211] Dynamic subtest vcs0: SUCCESS (1.477s)
[262.292490] Starting dynamic subtest: vcs1
[264.328470] Dynamic subtest vcs1: SUCCESS (2.044s)
[264.338876] Starting dynamic subtest: vecs0
[266.312329] Dynamic subtest vecs0: SUCCESS (1.980s)
[266.324078] Starting dynamic subtest: ccs0
[266.882766] Dynamic subtest ccs0: SUCCESS (0.568s)
[266.885381] Subtest render-node-busy: SUCCESS (7.250s)
[266.957657] [046/133] (752s left) kms_vrr (seamless-rr-switch-vrr)
[267.048955] Starting subtest: seamless-rr-switch-vrr
[267.055094] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[267.121375] [047/133] (752s left) kms_hdmi_inject (inject-audio)
[267.466443] Starting subtest: inject-audio
[267.742464] Subtest inject-audio: SUCCESS (0.277s)
[268.332521] [048/133] (751s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[268.443427] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[268.445740] Starting dynamic subtest: A-eDP1
[272.028556] Dynamic subtest A-eDP1: SUCCESS (3.583s)
[272.037952] Starting dynamic subtest: B-eDP1
[275.228989] Dynamic subtest B-eDP1: SUCCESS (3.203s)
[275.239761] Starting dynamic subtest: C-eDP1
[278.515046] Dynamic subtest C-eDP1: SUCCESS (3.284s)
[278.526781] Starting dynamic subtest: D-eDP1
[281.823778] Dynamic subtest D-eDP1: SUCCESS (3.308s)
[281.826061] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.387s)
[282.686170] [049/133] (736s left) vgem_basic (dmabuf-export)
[282.820292] Starting subtest: dmabuf-export
[282.847599] Subtest dmabuf-export: SUCCESS (0.028s)
[282.943291] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[282.946601] [050/133] (736s left) gem_exec_params (no-bsd)
[282.999942] Starting subtest: no-bsd
[283.002161] Subtest no-bsd: SUCCESS (0.002s)
[284.382738] [051/133] (735s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[284.455564] Starting subtest: invalid-single-wait-all-unsubmitted
[284.457911] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[284.555097] [052/133] (735s left) gem_exec_fence (keep-in-fence)
[284.731876] Starting subtest: keep-in-fence
[284.734348] Starting dynamic subtest: rcs0
[284.786369] Dynamic subtest rcs0: SUCCESS (0.055s)
[284.797957] Starting dynamic subtest: bcs0
[284.839874] Dynamic subtest bcs0: SUCCESS (0.051s)
[284.850668] Starting dynamic subtest: vcs0
[286.280254] Dynamic subtest vcs0: SUCCESS (1.437s)
[286.291954] Starting dynamic subtest: vcs1
[288.381574] Dynamic subtest vcs1: SUCCESS (2.045s)
[288.394157] Starting dynamic subtest: vecs0
[290.311951] Dynamic subtest vecs0: SUCCESS (1.982s)
[290.324425] Starting dynamic subtest: ccs0
[290.551852] Dynamic subtest ccs0: SUCCESS (0.238s)
[290.554726] Subtest keep-in-fence: SUCCESS (5.822s)
[292.382861] [053/133] (727s left) vgem_basic (second-client)
[292.444893] Starting subtest: second-client
[292.469627] Subtest second-client: SUCCESS (0.022s)
[292.524643] [054/133] (727s left) gen9_exec_parse (cmd-crossing-page)
[292.580368] Subtest cmd-crossing-page: SKIP (0.000s)
[292.658932] [055/133] (727s left) kms_vblank (query-busy-hang)
[292.765748] Starting subtest: query-busy-hang
[292.767588] Starting dynamic subtest: pipe-A-eDP-1
[319.059365] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.290s)
[319.074474] Starting dynamic subtest: pipe-D-eDP-1
[344.069978] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.002s)
[344.072125] Subtest query-busy-hang: SUCCESS (51.297s)
[344.883452] [056/133] (674s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[344.984243] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[344.988194] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[345.076731] [057/133] (674s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[345.179572] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[345.183559] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[345.270472] [058/133] (674s left) kms_cursor_crc (cursor-random-512x170)
[345.571607] Starting subtest: cursor-random-512x170
[345.575847] Subtest cursor-random-512x170: SKIP (0.001s)
[345.712066] [059/133] (674s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[345.812541] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[349.772684] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.962s)
[350.911036] [060/133] (669s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[351.014168] Starting subtest: 4-tiled-32bpp-rotate-0
[352.495871] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.481s)
[352.621454] [061/133] (667s left) kms_cursor_crc (cursor-sliding-64x21)
[352.812988] Starting subtest: cursor-sliding-64x21
[352.857668] Subtest cursor-sliding-64x21: SKIP (0.040s)
[353.127752] [062/133] (666s left) kms_plane_scaling (planes-downscale-factor-0-75)
[353.227515] Starting subtest: planes-downscale-factor-0-75
[353.229492] Starting dynamic subtest: pipe-A
[353.250736] Dynamic subtest pipe-A: SKIP (0.019s)
[353.260003] Starting dynamic subtest: pipe-B
[353.283879] Dynamic subtest pipe-B: SKIP (0.033s)
[353.292849] Starting dynamic subtest: pipe-C
[353.318604] Dynamic subtest pipe-C: SKIP (0.033s)
[353.327777] Starting dynamic subtest: pipe-D
[353.349791] Dynamic subtest pipe-D: SKIP (0.032s)
[353.353271] Subtest planes-downscale-factor-0-75: SKIP (0.120s)
[353.434586] [063/133] (666s left) kms_chamelium_hpd (common-hpd-after-suspend)
[353.813084] Subtest common-hpd-after-suspend: SKIP (0.000s)
[354.679406] [064/133] (665s left) syncobj_eventfd (timeline-wait-before-signal)
[354.738369] Starting subtest: timeline-wait-before-signal
[354.767060] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[354.853544] [065/133] (665s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[354.959609] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[354.961961] Starting dynamic subtest: pipe-A-eDP-1
[355.443049] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s)
[355.453802] Starting dynamic subtest: pipe-B-eDP-1
[356.951306] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.500s)
[356.961587] Starting dynamic subtest: pipe-C-eDP-1
[358.326736] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[358.338082] Starting dynamic subtest: pipe-D-eDP-1
[359.791253] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.461s)
[359.793623] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.803s)
[361.003270] [066/133] (659s left) gem_exec_whisper (basic-normal-all)
[361.071925] Starting subtest: basic-normal-all
[363.405634] Subtest basic-normal-all: SUCCESS (2.336s)
[363.591764] [067/133] (656s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[363.703619] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[370.129795] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.427s)
[370.265689] [068/133] (650s left) syncobj_timeline (wait-for-submit-complex)
[370.313625] Starting subtest: wait-for-submit-complex
[370.373847] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[370.454372] [069/133] (649s left) kms_addfb_basic (basic-x-tiled-legacy)
[370.523837] Starting subtest: basic-x-tiled-legacy
[370.528415] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[370.663495] [070/133] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[370.762776] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[370.766898] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[370.861661] [071/133] (649s left) gem_pread (self)
[370.918659] Subtest self: SKIP (0.000s)
[370.976459] [072/133] (649s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[371.065990] Starting subtest: extended-modeset-hang-oldfb-with-reset
[371.068049] Starting dynamic subtest: pipe-A
[382.950069] Dynamic subtest pipe-A: SUCCESS (11.877s)
[382.960913] Starting dynamic subtest: pipe-D
[395.250346] Dynamic subtest pipe-D: SUCCESS (12.293s)
[395.252736] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.174s)
[396.110515] [073/133] (624s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[396.229284] Starting subtest: 2x-long-cursor-vs-flip-atomic
[396.233952] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[396.380036] [074/133] (624s left) gem_exec_schedule (submit-late-slice)
[396.449534] Starting subtest: submit-late-slice
[396.451809] Starting dynamic subtest: rcs0
[396.484282] Dynamic subtest rcs0: SUCCESS (0.043s)
[396.494354] Starting dynamic subtest: bcs0
[396.523276] Dynamic subtest bcs0: SUCCESS (0.038s)
[396.535995] Starting dynamic subtest: vcs0
[396.562659] Dynamic subtest vcs0: SUCCESS (0.038s)
[396.575339] Starting dynamic subtest: vcs1
[396.606638] Dynamic subtest vcs1: SUCCESS (0.043s)
[396.618209] Starting dynamic subtest: vecs0
[396.640179] Dynamic subtest vecs0: SUCCESS (0.033s)
[396.650522] Starting dynamic subtest: ccs0
[396.678598] Dynamic subtest ccs0: SUCCESS (0.038s)
[396.680914] Subtest submit-late-slice: SUCCESS (0.238s)
[398.382430] [075/133] (622s left) kms_force_connector_basic (force-load-detect)
[398.458891] Starting subtest: force-load-detect
[398.463244] Subtest force-load-detect: SKIP (0.000s)
[398.570412] [076/133] (622s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[398.674300] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[402.606614] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.937s)
[403.866887] [077/133] (616s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[403.957165] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[403.959510] Starting dynamic subtest: pipe-A-eDP-1
[405.207054] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.252s)
[405.217313] Starting dynamic subtest: pipe-B-eDP-1
[407.488973] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.281s)
[407.505044] Starting dynamic subtest: pipe-C-eDP-1
[409.790459] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.300s)
[409.801451] Starting dynamic subtest: pipe-D-eDP-1
[412.050982] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.259s)
[412.053372] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.099s)
[413.204051] [078/133] (607s left) gem_caching (reads)
[413.259438] Subtest reads: SKIP (0.000s)
[413.335056] [079/133] (607s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[413.438301] Starting subtest: invalidate-primary-flip-overlay
[424.276276] Subtest invalidate-primary-flip-overlay: SUCCESS (10.843s)
[424.392741] [080/133] (596s left) gem_exec_params (invalid-ring)
[424.452183] Starting subtest: invalid-ring
[424.454348] Subtest invalid-ring: SUCCESS (0.000s)
[424.571859] [081/133] (596s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[424.666233] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[424.669741] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[424.766102] [082/133] (596s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[424.830562] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[424.832396] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[424.933347] [083/133] (596s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[425.018592] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[425.045148] Starting dynamic subtest: pipe-A-plane-0
[425.466950] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[425.476752] Starting dynamic subtest: pipe-A-plane-3
[425.721811] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[426.839712] Starting dynamic subtest: pipe-B-plane-0
[427.263940] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[427.276397] Starting dynamic subtest: pipe-B-plane-3
[427.531371] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[427.842338] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.825s)
[428.686187] [084/133] (592s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[428.788005] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[428.790415] Starting dynamic subtest: pipe-A-eDP-1
[428.861678] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[428.871937] Starting dynamic subtest: pipe-B-eDP-1
[430.030546] Dynamic subtest pipe-B-eDP-1: SKIP (1.166s)
[430.035197] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.246s)
[431.280538] [085/133] (589s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[431.334365] Subtest writes-after-reads-snoop: SKIP (0.000s)
[431.404384] [086/133] (589s left) kms_vrr (flip-dpms)
[431.489141] Starting subtest: flip-dpms
[431.495406] Subtest flip-dpms: SKIP (0.000s)
[431.561862] [087/133] (589s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[431.623328] Starting subtest: y-tiled-ccs-to-y-tiled
[431.627793] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[431.808811] [088/133] (589s left) gem_ctx_engines (execute-allforone)
[431.864515] Starting subtest: execute-allforone
[431.879895] Subtest execute-allforone: SUCCESS (0.015s)
[433.365327] [089/133] (587s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[433.454003] Starting subtest: fbc-psr2-sprite-mmap-gtt
[433.456373] Starting dynamic subtest: eDP-1
[433.460477] Dynamic subtest eDP-1: SKIP (0.000s)
[433.464625] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[433.530894] [090/133] (587s left) api_intel_bb (destroy-bb)
[433.599956] Starting subtest: destroy-bb
[433.607325] Subtest destroy-bb: SUCCESS (0.008s)
[433.736474] [091/133] (587s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[433.839422] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[433.841577] Starting dynamic subtest: A-eDP1
[437.407023] Dynamic subtest A-eDP1: SUCCESS (3.564s)
[437.418192] Starting dynamic subtest: B-eDP1
[440.714776] Dynamic subtest B-eDP1: SUCCESS (3.308s)
[440.725627] Starting dynamic subtest: C-eDP1
[444.019963] Dynamic subtest C-eDP1: SUCCESS (3.303s)
[444.030432] Starting dynamic subtest: D-eDP1
[447.305960] Dynamic subtest D-eDP1: SUCCESS (3.286s)
[447.308186] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.468s)
[448.179706] [092/133] (573s left) gem_basic (multigpu-create-close)
[448.248819] Starting subtest: multigpu-create-close
[448.253300] Subtest multigpu-create-close: SKIP (0.000s)
[448.340474] [093/133] (573s left) kms_lease (cursor-implicit-plane)
[448.432941] Starting subtest: cursor-implicit-plane
[448.434912] Starting dynamic subtest: pipe-A-eDP-1
[448.889489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[448.901867] Starting dynamic subtest: pipe-B-eDP-1
[449.974709] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.086s)
[449.985212] Starting dynamic subtest: pipe-C-eDP-1
[451.049182] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.072s)
[451.059945] Starting dynamic subtest: pipe-D-eDP-1
[452.150458] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.100s)
[452.153090] Subtest cursor-implicit-plane: SUCCESS (3.720s)
[452.979388] [094/133] (568s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[453.043625] Starting subtest: invalid-multi-wait-all-unsubmitted
[453.045893] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[453.155902] [095/133] (568s left) i915_drm_fdinfo (all-busy-idle-check-all)
[453.195126] Starting subtest: all-busy-idle-check-all
[453.199619] Subtest all-busy-idle-check-all: SKIP (0.003s)
[453.260660] [096/133] (568s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[453.384083] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[453.386380] Starting dynamic subtest: pipe-A-eDP-1
[469.449469] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.391s)
[469.461371] Starting dynamic subtest: pipe-B-eDP-1
[486.428649] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.443s)
[486.439994] Starting dynamic subtest: pipe-C-eDP-1
[503.439766] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.408s)
[503.458024] Starting dynamic subtest: pipe-D-eDP-1
[520.403617] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.303s)
[520.406328] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.551s)
[521.599377] [097/133] (499s left) gem_mmap_offset (partial-remap)
[521.668603] Starting subtest: partial-remap
[521.671433] Starting dynamic subtest: smem0
[521.682378] Dynamic subtest smem0: SUCCESS (0.006s)
[521.684957] Subtest partial-remap: SUCCESS (0.007s)
[521.781400] [098/133] (499s left) kms_psr (fbc-psr2-cursor-blt)
[521.871510] Starting subtest: fbc-psr2-cursor-blt
[521.873943] Starting dynamic subtest: eDP-1
[521.878976] Dynamic subtest eDP-1: SKIP (0.000s)
[521.884031] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[521.961485] [099/133] (499s left) gem_ctx_shared (q-out-order)
[522.026437] Starting subtest: Q-out-order
[522.029514] Starting dynamic subtest: rcs0
[522.144892] Dynamic subtest rcs0: SUCCESS (0.113s)
[522.157723] Starting dynamic subtest: vcs0
[522.238313] Dynamic subtest vcs0: SUCCESS (0.091s)
[522.255653] Starting dynamic subtest: vcs1
[522.318064] Dynamic subtest vcs1: SUCCESS (0.076s)
[522.338604] Starting dynamic subtest: vecs0
[522.393631] Dynamic subtest vecs0: SUCCESS (0.071s)
[522.410341] Starting dynamic subtest: ccs0
[522.478359] Dynamic subtest ccs0: SUCCESS (0.081s)
[522.481624] Subtest Q-out-order: SUCCESS (0.438s)
[523.693826] [100/133] (498s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[523.813466] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[523.819101] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[523.915013] [101/133] (497s left) sw_sync (alloc_fence_invalid_timeline)
[523.953036] Starting subtest: alloc_fence_invalid_timeline
[523.955402] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[524.021985] [102/133] (497s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[524.114389] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[524.117038] Starting dynamic subtest: pipe-A-default-mode
[526.887585] Dynamic subtest pipe-A-default-mode: SUCCESS (2.711s)
[526.890149] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.712s)
[527.737397] [103/133] (494s left) kms_big_fb (linear-64bpp-rotate-270)
[527.839974] Starting subtest: linear-64bpp-rotate-270
[527.859507] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[527.988410] [104/133] (493s left) gem_workarounds (reset-fd)
[528.054232] Starting subtest: reset-fd
[528.241452] Subtest reset-fd: SUCCESS (0.181s)
[528.372293] [105/133] (493s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[528.461491] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[528.473373] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[528.560403] [106/133] (493s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[528.656880] Starting subtest: plane-all-transition-nonblocking-fencing
[528.659454] Starting dynamic subtest: pipe-A-eDP-1
[531.181185] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[531.494084] Starting dynamic subtest: pipe-B-eDP-1
[534.709060] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.199s)
[535.026263] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.307s)
[535.883413] [107/133] (486s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[535.982610] Starting subtest: fbcpsr-shrfb-scaledprimary
[541.715203] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.711s)
[541.845005] [108/133] (480s left) gem_render_copy (x-tiled)
[541.903274] Starting subtest: x-tiled
[541.905753] Starting dynamic subtest: smem
[541.942887] Dynamic subtest smem: SUCCESS (0.042s)
[541.945758] Subtest x-tiled: SUCCESS (0.042s)
[542.166441] [109/133] (480s left) gem_mmap_gtt (big-bo)
[542.232398] Subtest big-bo: SKIP (0.000s)
[542.289781] [110/133] (479s left) kms_hdr (bpc-switch-dpms)
[542.379717] Starting subtest: bpc-switch-dpms
[543.478350] Starting dynamic subtest: pipe-A-eDP-1
[547.989052] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.502s)
[547.991462] Subtest bpc-switch-dpms: SUCCESS (5.599s)
[548.091346] [111/133] (474s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[548.182302] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[548.184867] Starting dynamic subtest: pipe-A-eDP-1
[548.602295] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[548.613161] Starting dynamic subtest: pipe-B-eDP-1
[548.636698] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[548.646725] Starting dynamic subtest: pipe-C-eDP-1
[548.668325] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[548.677602] Starting dynamic subtest: pipe-D-eDP-1
[548.700349] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[548.702499] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.435s)
[550.862250] [112/133] (471s left) gem_madvise (dontneed-before-pwrite)
[550.909893] Starting subtest: dontneed-before-pwrite
[550.927307] Subtest dontneed-before-pwrite: SKIP (0.014s)
[550.993165] [113/133] (471s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[551.087371] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[551.092597] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[551.199246] [114/133] (471s left) gem_exec_schedule (preempt-other)
[551.265667] Starting subtest: preempt-other
[551.268444] Starting dynamic subtest: rcs0
[551.326919] Dynamic subtest rcs0: SUCCESS (0.072s)
[551.356379] Starting dynamic subtest: bcs0
[551.404006] Dynamic subtest bcs0: SUCCESS (0.076s)
[551.418023] Starting dynamic subtest: vcs0
[551.474028] Dynamic subtest vcs0: SUCCESS (0.068s)
[551.487293] Starting dynamic subtest: vcs1
[551.543719] Dynamic subtest vcs1: SUCCESS (0.070s)
[551.559191] Starting dynamic subtest: vecs0
[551.615427] Dynamic subtest vecs0: SUCCESS (0.070s)
[551.631821] Starting dynamic subtest: ccs0
[551.689941] Dynamic subtest ccs0: SUCCESS (0.075s)
[551.692498] Subtest preempt-other: SUCCESS (0.436s)
[552.668668] [115/133] (469s left) gem_exec_reloc (basic-write-gtt-noreloc)
[552.726840] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[552.807286] [116/133] (469s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[552.906347] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[553.596505] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.692s)
[553.748158] [117/133] (468s left) kms_psr2_su (frontbuffer-xrgb8888)
[553.804243] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[553.865168] [118/133] (468s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[553.963834] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[560.720923] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.763s)
[560.872563] [119/133] (461s left) kms_draw_crc (fill-fb)
[560.978264] Starting subtest: fill-fb
[561.440941] Subtest fill-fb: SUCCESS (0.464s)
[561.538020] [120/133] (461s left) api_intel_allocator (two-level-inception)
[561.598438] Starting subtest: two-level-inception
[567.057635] Subtest two-level-inception: SUCCESS (5.410s)
[567.118637] [121/133] (455s left) gem_exec_params (cliprects-invalid)
[567.182477] Starting subtest: cliprects-invalid
[567.185352] Subtest cliprects-invalid: SUCCESS (0.000s)
[567.297285] [122/133] (455s left) kms_fbcon_fbt (psr-suspend)
[567.379013] Starting subtest: psr-suspend
[616.290722] Subtest psr-suspend: SUCCESS (19.496s)
[616.338059] [123/133] (406s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[616.446258] Starting subtest: pr-overlay-plane-update-continuous-sf
[616.450480] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[616.524899] [124/133] (406s left) gem_ctx_persistence (legacy-engines-hang)
[616.582623] Starting subtest: legacy-engines-hang
[616.585068] Starting dynamic subtest: render
[616.704860] Dynamic subtest render: SUCCESS (0.119s)
[616.718147] Starting dynamic subtest: bsd1
[616.796762] Dynamic subtest bsd1: SUCCESS (0.087s)
[616.813200] Starting dynamic subtest: bsd2
[616.897901] Dynamic subtest bsd2: SUCCESS (0.093s)
[616.910147] Starting dynamic subtest: blt
[616.986827] Dynamic subtest blt: SUCCESS (0.088s)
[617.002823] Starting dynamic subtest: vebox
[617.067678] Dynamic subtest vebox: SUCCESS (0.076s)
[617.070171] Subtest legacy-engines-hang: SUCCESS (0.476s)
[617.198487] [125/133] (405s left) kms_pm_rpm (fences-dpms)
[618.743883] Starting subtest: fences-dpms
[618.748474] Subtest fences-dpms: SKIP (0.000s)
[619.527175] [126/133] (403s left) kms_psr (psr2-cursor-render)
[619.630878] Starting subtest: psr2-cursor-render
[619.633144] Starting dynamic subtest: eDP-1
[621.397801] Dynamic subtest eDP-1: SUCCESS (1.741s)
[621.400131] Subtest psr2-cursor-render: SUCCESS (1.742s)
[622.253981] [127/133] (400s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[622.346436] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[622.350474] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[622.440164] [128/133] (400s left) kms_properties (crtc-properties-legacy)
[622.531096] Starting subtest: crtc-properties-legacy
[622.533453] Starting dynamic subtest: pipe-A-eDP-1
[622.975406] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s)
[622.985921] Starting dynamic subtest: pipe-B-eDP-1
[624.091110] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.104s)
[624.101746] Starting dynamic subtest: pipe-C-eDP-1
[625.299148] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s)
[625.311602] Starting dynamic subtest: pipe-D-eDP-1
[626.429464] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[626.431819] Subtest crtc-properties-legacy: SUCCESS (3.868s)
[627.295349] [129/133] (395s left) i915_query (test-query-geometry-subslices)
[627.350098] Starting subtest: test-query-geometry-subslices
[627.352325] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[627.446258] [130/133] (395s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[627.547525] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[631.227860] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.667s)
[632.432011] [131/133] (390s left) kms_pipe_crc_basic (hang-read-crc)
[632.524310] Starting subtest: hang-read-crc
[632.526705] Starting dynamic subtest: pipe-A-eDP-1
[634.578973] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.046s)
[634.590706] Starting dynamic subtest: pipe-B-eDP-1
[637.355682] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s)
[637.367935] Starting dynamic subtest: pipe-C-eDP-1
[640.022549] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.661s)
[640.035861] Starting dynamic subtest: pipe-D-eDP-1
[642.639294] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.612s)
[642.641616] Subtest hang-read-crc: SUCCESS (10.095s)
[643.448955] [132/133] (379s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[643.548130] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[643.552392] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[643.647826] [133/133] (379s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[643.742036] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[643.744267] Starting dynamic subtest: pipe-A-eDP-1
[643.764087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[643.775917] Starting dynamic subtest: pipe-B-eDP-1
[643.794891] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[643.805725] Starting dynamic subtest: pipe-C-eDP-1
[643.824163] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[643.834612] Starting dynamic subtest: pipe-D-eDP-1
[643.853491] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[643.855704] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[646.024643] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: core_setmaster
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: gem_exec_capture
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_async_flips
results: parsing output: 8/ for test: gem_lmem_swapping
results: parsing output: 9/ for test: gem_exec_params
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: kms_draw_crc
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_plane_cursor
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_chamelium_edid
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_display_modes
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_setmode
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 27/ for test: gem_softpin
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: sriov_basic
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_atomic_interruptible
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: i915_pm_rpm
results: parsing output: 34/ for test: kms_pm_lpsp
results: parsing output: 35/ for test: gem_render_copy
results: parsing output: 36/ for test: gem_workarounds
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: i915_hangman
results: parsing output: 39/ for test: kms_color_pipeline
results: parsing output: 40/ for test: kms_pipe_b_c_ivb
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_invalid_mode
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_vrr
results: parsing output: 46/ for test: kms_hdmi_inject
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: vgem_basic
results: parsing output: 49/ for test: gem_exec_params
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: vgem_basic
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: kms_vblank
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: syncobj_eventfd
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_pread
results: parsing output: 71/ for test: kms_busy
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: kms_force_connector_basic
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: gem_caching
results: parsing output: 78/ for test: kms_psr_stress_test
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_plane
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: gem_partial_pwrite_pread
results: parsing output: 85/ for test: kms_vrr
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_ctx_engines
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: gem_basic
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_ctx_shared
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: sw_sync
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_workarounds
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_atomic_transition
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_hdr
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: gem_madvise
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_psr2_su
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_draw_crc
results: parsing output: 119/ for test: api_intel_allocator
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: kms_fbcon_fbt
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: kms_pm_rpm
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_properties
results: parsing output: 128/ for test: i915_query
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_pipe_crc_basic
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_ccs
Done.