[57.537614] Initializing watchdogs
[57.537661]   /dev/watchdog0
[57.551994] [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.556769] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.559354] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.562803] [001/132] (960s left) kms_psr (fbc-pr-cursor-blt)
[57.677878] Starting subtest: fbc-pr-cursor-blt
[57.682201] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[57.763228] [002/132] (960s left) gem_mmap_gtt (basic-short)
[57.828754] Subtest basic-short: SKIP (0.000s)
[57.883799] [003/132] (960s left) gem_exec_schedule (u-fairslice-all)
[57.952405] Starting subtest: u-fairslice-all
[60.015944] Subtest u-fairslice-all: SUCCESS (2.071s)
[61.390499] [004/132] (956s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[61.516085] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[61.520518] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.616553] [005/132] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[61.712345] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[61.716726] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[61.818004] [006/132] (956s left) api_intel_allocator (standalone)
[61.868731] Starting subtest: standalone
[61.883480] Subtest standalone: SUCCESS (0.015s)
[62.007108] [007/132] (956s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[62.106362] Starting subtest: yf-tiled-32bpp-rotate-180
[62.110796] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[62.200721] [008/132] (956s left) gem_ctx_persistence (legacy-engines-queued)
[62.268674] Starting subtest: legacy-engines-queued
[62.270718] Starting dynamic subtest: render
[62.347629] Dynamic subtest render: SUCCESS (0.082s)
[62.357984] Starting dynamic subtest: bsd1
[64.285943] Dynamic subtest bsd1: SUCCESS (1.938s)
[64.294910] Starting dynamic subtest: bsd2
[66.268542] Dynamic subtest bsd2: SUCCESS (1.984s)
[66.282186] Starting dynamic subtest: blt
[66.319828] Dynamic subtest blt: SUCCESS (0.051s)
[66.330136] Starting dynamic subtest: vebox
[68.254213] Dynamic subtest vebox: SUCCESS (1.933s)
[68.257036] Subtest legacy-engines-queued: SUCCESS (5.997s)
[68.333157] [009/132] (950s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[68.389739] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[68.392155] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.002s)
[68.483808] [010/132] (949s left) kms_pm_rpm (package-g7)
[70.443231] Starting subtest: package-g7
[70.448271] Subtest package-g7: SKIP (0.000s)
[70.819109] [011/132] (947s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[70.908831] Starting subtest: psr-rgb101010-draw-mmap-wc
[79.025937] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (8.124s)
[79.124356] [012/132] (939s left) syncobj_timeline (single-wait-for-submit-signaled)
[79.180247] Starting subtest: single-wait-for-submit-signaled
[79.182592] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[79.270088] [013/132] (939s left) perf_pmu (busy-accuracy-50)
[79.314908] Starting subtest: busy-accuracy-50
[79.317129] Starting dynamic subtest: rcs0
[80.850352] Dynamic subtest rcs0: SUCCESS (1.535s)
[80.860663] Starting dynamic subtest: bcs0
[82.395557] Dynamic subtest bcs0: SUCCESS (1.544s)
[82.406562] Starting dynamic subtest: vcs0
[83.937078] Dynamic subtest vcs0: SUCCESS (1.541s)
[83.947948] Starting dynamic subtest: vcs1
[85.483244] Dynamic subtest vcs1: SUCCESS (1.545s)
[85.493928] Starting dynamic subtest: vecs0
[87.026994] Dynamic subtest vecs0: SUCCESS (1.541s)
[87.037686] Starting dynamic subtest: ccs0
[88.573758] Dynamic subtest ccs0: SUCCESS (1.547s)
[88.575897] Subtest busy-accuracy-50: SUCCESS (9.259s)
[88.687892] [014/132] (929s left) prime_self_import (basic-llseek-bad)
[88.729075] Starting subtest: basic-llseek-bad
[88.747020] Subtest basic-llseek-bad: SUCCESS (0.018s)
[88.867930] [015/132] (929s left) kms_pipe_crc_basic (nonblocking-crc)
[88.968351] Starting subtest: nonblocking-crc
[88.970645] Starting dynamic subtest: pipe-A-eDP-1
[89.724256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.755s)
[89.733699] Starting dynamic subtest: pipe-B-eDP-1
[91.115571] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s)
[91.127111] Starting dynamic subtest: pipe-C-eDP-1
[92.503504] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.385s)
[92.513956] Starting dynamic subtest: pipe-D-eDP-1
[93.846474] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[93.848804] Subtest nonblocking-crc: SUCCESS (4.876s)
[94.727199] [016/132] (923s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[94.832691] Starting subtest: pr-cursor-plane-update-sf
[94.837309] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[94.899926] [017/132] (923s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[94.997785] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[95.000120] Starting dynamic subtest: pipe-A-eDP-1
[95.021130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[95.031842] Starting dynamic subtest: pipe-B-eDP-1
[95.051412] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[95.059456] Starting dynamic subtest: pipe-C-eDP-1
[95.078998] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[95.086951] Starting dynamic subtest: pipe-D-eDP-1
[95.106477] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[95.108380] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[97.275254] [018/132] (921s left) gem_render_copy (y-tiled-ccs-to-linear)
[97.342972] Starting subtest: y-tiled-ccs-to-linear
[97.347399] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[97.536389] [019/132] (921s left) gem_exec_fence (syncobj-repeat)
[97.973295] Starting subtest: syncobj-repeat
[98.166918] Subtest syncobj-repeat: SUCCESS (0.194s)
[99.343866] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[99.346976] [020/132] (919s left) core_debugfs (read-all-entries)
[99.405825] Starting subtest: read-all-entries
[99.500793] Subtest read-all-entries: SUCCESS (0.098s)
[99.580018] [021/132] (919s left) gem_huc_copy (huc-copy)
[99.658931] Starting subtest: huc-copy
[99.661343] Subtest huc-copy: SUCCESS (0.004s)
[99.774964] [022/132] (919s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[99.828265] Subtest writes-after-reads-uncached: SKIP (0.000s)
[99.916778] [023/132] (919s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[100.006983] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[100.011351] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[100.078085] [024/132] (918s left) gem_close_race (multigpu-basic-threads)
[100.148257] Starting subtest: multigpu-basic-threads
[100.152410] Subtest multigpu-basic-threads: SKIP (0.000s)
[100.393335] [025/132] (918s left) gem_mmap_gtt (big-bo-tiledy)
[100.460224] Subtest big-bo-tiledY: SKIP (0.000s)
[100.527052] [026/132] (918s left) kms_pm_backlight (fade-with-suspend)
[100.631055] Starting subtest: fade-with-suspend
[117.094391] Starting dynamic subtest: eDP-1
[120.088460] Dynamic subtest eDP-1: SUCCESS (3.013s)
[120.091305] Subtest fade-with-suspend: SUCCESS (5.114s)
[120.878608] [027/132] (898s left) gem_ctx_isolation (preservation)
[120.967136] Starting subtest: preservation
[120.969972] Starting dynamic subtest: rcs0
[121.080816] Dynamic subtest rcs0: SUCCESS (0.114s)
[121.090764] Starting dynamic subtest: bcs0
[121.245538] Dynamic subtest bcs0: SUCCESS (0.165s)
[121.255481] Starting dynamic subtest: vcs0
[121.388773] Dynamic subtest vcs0: SUCCESS (0.144s)
[121.401466] Starting dynamic subtest: vcs1
[122.758510] Dynamic subtest vcs1: SUCCESS (1.376s)
[122.771954] Starting dynamic subtest: vecs0
[124.764657] Dynamic subtest vecs0: SUCCESS (2.013s)
[124.777864] Starting dynamic subtest: ccs0
[126.814159] Dynamic subtest ccs0: SUCCESS (2.055s)
[126.817280] Subtest preservation: SUCCESS (5.868s)
[127.058497] [028/132] (892s left) kms_cursor_edge_walk (64x64-top-bottom)
[127.153645] Starting subtest: 64x64-top-bottom
[127.156288] Starting dynamic subtest: pipe-A-eDP-1
[130.618658] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.471s)
[130.628868] Starting dynamic subtest: pipe-D-eDP-1
[133.739144] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[133.741305] Subtest 64x64-top-bottom: SUCCESS (6.597s)
[134.544241] [029/132] (884s left) gem_workarounds (suspend-resume-context)
[134.610187] Starting subtest: suspend-resume-context
[151.095354] Subtest suspend-resume-context: SUCCESS (1.174s)
[151.236296] [030/132] (868s left) gem_exec_parallel (fds)
[151.302734] Starting subtest: fds
[151.304987] Starting dynamic subtest: rcs0
[154.062053] Dynamic subtest rcs0: SUCCESS (2.760s)
[154.072729] Starting dynamic subtest: bcs0
[157.474306] Dynamic subtest bcs0: SUCCESS (3.414s)
[157.485976] Starting dynamic subtest: vcs0
[161.278921] Dynamic subtest vcs0: SUCCESS (3.807s)
[161.289680] Starting dynamic subtest: vcs1
[165.273081] Dynamic subtest vcs1: SUCCESS (3.995s)
[165.285519] Starting dynamic subtest: vecs0
[169.233095] Dynamic subtest vecs0: SUCCESS (3.962s)
[169.244739] Starting dynamic subtest: ccs0
[172.589972] Dynamic subtest ccs0: SUCCESS (3.357s)
[172.592767] Subtest fds: SUCCESS (21.302s)
[172.783885] [031/132] (846s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[172.889438] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[172.891728] Starting dynamic subtest: pipe-A
[173.275654] Dynamic subtest pipe-A: SUCCESS (0.388s)
[173.285496] Starting dynamic subtest: pipe-B
[174.692242] Dynamic subtest pipe-B: SUCCESS (1.416s)
[174.704944] Starting dynamic subtest: pipe-C
[176.140243] Dynamic subtest pipe-C: SUCCESS (1.448s)
[176.150619] Starting dynamic subtest: pipe-D
[177.591471] Dynamic subtest pipe-D: SUCCESS (1.452s)
[177.593836] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.707s)
[178.724425] [032/132] (840s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[178.820350] Starting subtest: yf-tiled-64bpp-rotate-180
[178.824646] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[178.935714] [033/132] (840s left) gem_tiled_swapping (non-threaded)
[178.996112] Subtest non-threaded: SKIP (0.000s)
[179.057208] [034/132] (840s left) dmabuf_sync_file (export-before-signal)
[179.103046] Starting subtest: export-before-signal
[179.105352] Subtest export-before-signal: SUCCESS (0.001s)
[179.170265] [035/132] (840s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[179.275140] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[183.653249] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.390s)
[184.828987] [036/132] (834s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[184.893941] Subtest no-spare-fences-busy: SKIP (0.000s)
[184.972572] [037/132] (834s left) gem_watchdog (default-physical)
[185.047930] Starting subtest: default-physical
[186.809025] Subtest default-physical: SUCCESS (1.779s)
[186.903356] [038/132] (832s left) kms_flip (2x-flip-vs-suspend)
[186.992696] Starting subtest: 2x-flip-vs-suspend
[186.997196] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[187.114206] [039/132] (832s left) i915_query (test-query-geometry-subslices)
[187.167547] Starting subtest: test-query-geometry-subslices
[187.169970] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[187.262759] [040/132] (832s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[187.349965] Starting subtest: fbc-rgb565-draw-render
[191.491951] Subtest fbc-rgb565-draw-render: SUCCESS (4.156s)
[192.607835] [041/132] (827s left) kms_lease (lease-uevent)
[192.697775] Starting subtest: lease-uevent
[193.708702] Subtest lease-uevent: SUCCESS (1.013s)
[193.796021] [042/132] (825s left) kms_vblank (ts-continuation-idle)
[193.886591] Starting subtest: ts-continuation-idle
[193.888793] Starting dynamic subtest: pipe-A-eDP-1
[194.290373] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.405s)
[194.306662] Starting dynamic subtest: pipe-D-eDP-1
[195.371171] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.078s)
[195.373182] Subtest ts-continuation-idle: SUCCESS (1.487s)
[196.239478] [043/132] (823s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[196.344564] Starting subtest: basic-modeset-with-all-modifiers-formats
[196.720567] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[197.517618] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.799s)
[197.528704] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[197.537955] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.020s)
[197.548057] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[197.560396] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[197.570578] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[197.704358] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[197.715689] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[197.726729] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[197.736730] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[197.748904] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[197.760561] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[197.770718] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[197.780503] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[197.793410] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[197.803254] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[197.815555] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[197.825185] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[197.837719] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[197.847475] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[197.859772] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[197.869544] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[197.882069] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[197.891609] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[198.026350] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[198.036911] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[198.048588] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[198.058458] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[198.070796] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[198.082907] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[198.092913] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[198.102688] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[198.115201] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[198.125066] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[198.137347] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[198.147021] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[198.159546] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[198.169208] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[198.181703] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[198.191291] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[198.203877] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[198.213672] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[198.359437] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[198.369946] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[198.381762] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[198.391618] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[198.404020] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[198.415789] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[198.426404] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[198.441237] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[198.448785] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[198.459069] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[198.470814] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[198.484461] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[198.493408] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[198.509549] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[198.514679] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[198.530021] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[198.536968] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[198.926922] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.587s)
[199.696099] [044/132] (820s left) kms_color (ctm-signed)
[199.797770] Starting subtest: ctm-signed
[199.800061] Starting dynamic subtest: pipe-A-eDP-1
[201.984756] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.189s)
[201.995705] Starting dynamic subtest: pipe-B-eDP-1
[204.762763] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.780s)
[204.774300] Starting dynamic subtest: pipe-C-eDP-1
[207.492389] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.729s)
[207.502574] Starting dynamic subtest: pipe-D-eDP-1
[210.144149] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.653s)
[210.146316] Subtest ctm-signed: SUCCESS (10.353s)
[210.965277] [045/132] (808s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[211.081758] Starting subtest: bad-aux-stride-y-tiled-ccs
[211.083931] Starting dynamic subtest: pipe-A-eDP-1
[211.105767] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[211.117556] Starting dynamic subtest: pipe-B-eDP-1
[211.139005] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[211.150092] Starting dynamic subtest: pipe-C-eDP-1
[211.171117] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[211.181139] Starting dynamic subtest: pipe-D-eDP-1
[211.202160] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[211.205994] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[213.322065] [046/132] (806s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[213.422716] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[213.426640] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[213.537948] [047/132] (806s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[213.625838] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[220.450710] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.825s)
[220.587855] [048/132] (799s left) syncobj_timeline (invalid-signal-illegal-handle)
[220.651971] Starting subtest: invalid-signal-illegal-handle
[220.654255] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[220.768856] [049/132] (799s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[220.892012] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[222.333620] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.441s)
[223.215523] [050/132] (796s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[223.317622] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[223.321878] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[223.391752] [051/132] (796s left) fbdev (nullptr)
[223.441131] Starting subtest: nullptr
[223.443429] Subtest nullptr: SUCCESS (0.000s)
[223.499137] [052/132] (796s left) kms_psr (fbc-psr-primary-blt)
[223.586777] Starting subtest: fbc-psr-primary-blt
[223.588949] Starting dynamic subtest: eDP-1
[223.593003] Dynamic subtest eDP-1: SKIP (0.000s)
[223.597004] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[223.663088] [053/132] (796s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[223.778830] Starting subtest: short-busy-flip-before-cursor-toggle
[223.783198] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[223.961273] [054/132] (796s left) syncobj_wait (invalid-reset-one-illegal-handle)
[224.016157] Starting subtest: invalid-reset-one-illegal-handle
[224.018461] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[224.159859] [055/132] (796s left) gem_exec_balancer (full-late)
[224.228749] Starting subtest: full-late
[228.815890] Subtest full-late: SUCCESS (4.586s)
[229.146795] [056/132] (791s left) gem_eio (wait-1us)
[229.377304] Starting subtest: wait-1us
[229.752668] Subtest wait-1us: SUCCESS (0.375s)
[229.924288] [057/132] (790s left) kms_plane_cursor (overlay)
[230.017911] Starting subtest: overlay
[230.022134] Starting dynamic subtest: pipe-A-eDP-1-size-64
[232.596459] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.579s)
[232.655796] Starting dynamic subtest: pipe-A-eDP-1-size-128
[235.229219] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.582s)
[235.289549] Starting dynamic subtest: pipe-A-eDP-1-size-256
[237.830771] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.551s)
[238.182559] Starting dynamic subtest: pipe-B-eDP-1-size-64
[241.382441] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.212s)
[241.444083] Starting dynamic subtest: pipe-B-eDP-1-size-128
[244.004972] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.571s)
[244.068470] Starting dynamic subtest: pipe-B-eDP-1-size-256
[246.650565] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.593s)
[247.008298] Starting dynamic subtest: pipe-C-eDP-1-size-64
[249.927889] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.936s)
[249.967551] Starting dynamic subtest: pipe-C-eDP-1-size-128
[252.060906] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.103s)
[252.100152] Starting dynamic subtest: pipe-C-eDP-1-size-256
[254.248544] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[254.580653] Starting dynamic subtest: pipe-D-eDP-1-size-64
[257.461665] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.896s)
[257.501184] Starting dynamic subtest: pipe-D-eDP-1-size-128
[259.771758] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.281s)
[259.812206] Starting dynamic subtest: pipe-D-eDP-1-size-256
[261.982562] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[262.304187] Subtest overlay: SUCCESS (32.293s)
[263.119890] [058/132] (757s left) sysfs_preempt_timeout (idempotent)
[263.175187] Starting subtest: idempotent
[263.177555] Starting dynamic subtest: vecs0
[263.179741] Dynamic subtest vecs0: SUCCESS (0.001s)
[263.193563] Starting dynamic subtest: ccs0
[263.195701] Dynamic subtest ccs0: SUCCESS (0.000s)
[263.205997] Starting dynamic subtest: vcs0
[263.208205] Dynamic subtest vcs0: SUCCESS (0.000s)
[263.218451] Starting dynamic subtest: bcs0
[263.220787] Dynamic subtest bcs0: SUCCESS (0.000s)
[263.232625] Starting dynamic subtest: rcs0
[263.235109] Dynamic subtest rcs0: SUCCESS (0.000s)
[263.244615] Starting dynamic subtest: vcs1
[263.246972] Dynamic subtest vcs1: SUCCESS (0.000s)
[263.249240] Subtest idempotent: SUCCESS (0.007s)
[263.295157] [059/132] (757s left) i915_pm_rpm (system-suspend-execbuf)
[265.126876] Starting subtest: system-suspend-execbuf
[323.036315] Subtest system-suspend-execbuf: SUCCESS (43.100s)
[323.417124] [060/132] (697s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[323.514100] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[323.519308] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[323.612331] [061/132] (697s left) perf_pmu (semaphore-busy)
[323.668918] Starting subtest: semaphore-busy
[323.671068] Starting dynamic subtest: rcs0
[325.280976] Dynamic subtest rcs0: SUCCESS (1.611s)
[325.292132] Starting dynamic subtest: bcs0
[325.918128] Dynamic subtest bcs0: FAIL (0.565s)
[325.933191] Starting dynamic subtest: vcs0
[330.374182] Dynamic subtest vcs0: SUCCESS (4.523s)
[330.388327] Starting dynamic subtest: vcs1
[336.388480] Dynamic subtest vcs1: SUCCESS (6.013s)
[336.402338] Starting dynamic subtest: vecs0
[342.340630] Dynamic subtest vecs0: SUCCESS (5.950s)
[342.352308] Starting dynamic subtest: ccs0
[345.481308] Dynamic subtest ccs0: SUCCESS (3.139s)
[345.483994] Subtest semaphore-busy: FAIL (21.817s)
[345.614543] [062/132] (675s left) kms_hdr (static-toggle-dpms)
[345.711375] Starting subtest: static-toggle-dpms
[345.719041] Subtest static-toggle-dpms: SKIP (0.000s)
[345.785661] [063/132] (674s left) prime_mmap (test_dup)
[345.841453] Starting subtest: test_dup
[345.844152] Starting dynamic subtest: test_dup-smem
[345.870921] Dynamic subtest test_dup-smem: SUCCESS (0.032s)
[345.873560] Subtest test_dup: SUCCESS (0.032s)
[345.948277] [064/132] (674s left) gem_mmap_gtt (medium-copy-odd)
[346.003872] Subtest medium-copy-odd: SKIP (0.000s)
[346.063957] [065/132] (674s left) syncobj_eventfd (invalid-illegal-handle)
[346.119447] Starting subtest: invalid-illegal-handle
[346.122048] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[346.224590] [066/132] (674s left) gen9_exec_parse (bb-start-cmd)
[346.276087] Subtest bb-start-cmd: SKIP (0.000s)
[346.341401] [067/132] (674s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[346.437951] Starting subtest: primary-4-tiled-reflect-x-180
[353.404302] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.971s)
[354.560120] [068/132] (666s left) kms_psr (fbc-psr2-basic)
[354.655031] Starting subtest: fbc-psr2-basic
[354.657871] Starting dynamic subtest: eDP-1
[354.662986] Dynamic subtest eDP-1: SKIP (0.000s)
[354.668166] Subtest fbc-psr2-basic: SKIP (0.001s)
[354.732367] [069/132] (666s left) kms_flip (blocking-wf_vblank)
[354.826093] Starting subtest: blocking-wf_vblank
[354.829034] Starting dynamic subtest: A-eDP1
[363.706147] Dynamic subtest A-eDP1: SUCCESS (8.883s)
[363.717308] Starting dynamic subtest: B-eDP1
[372.632250] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[372.649204] Starting dynamic subtest: C-eDP1
[381.546118] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[381.557879] Starting dynamic subtest: D-eDP1
[390.485474] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[390.488155] Subtest blocking-wf_vblank: SUCCESS (35.664s)
[391.715425] [070/132] (629s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[391.825054] Starting subtest: cursorB-vs-flipA-legacy
[391.829699] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[391.973751] [071/132] (629s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[392.029956] Subtest tiled-to-untiled: SKIP (0.000s)
[392.096832] [072/132] (629s left) gem_mmap_gtt (cpuset-big-copy-xy)
[392.161100] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[392.230681] [073/132] (628s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[392.330539] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[392.335189] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[392.411812] [074/132] (628s left) kms_atomic (plane-overlay-legacy)
[392.507163] Starting subtest: plane-overlay-legacy
[392.509811] Starting dynamic subtest: pipe-A-eDP-1
[392.926050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[392.928857] Subtest plane-overlay-legacy: SUCCESS (0.422s)
[393.749430] [075/132] (627s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[393.864311] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[393.869568] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[393.952734] [076/132] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[394.060176] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[394.065159] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[394.145379] [077/132] (627s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[394.233965] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[394.238931] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[394.328735] [078/132] (627s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[394.447917] Starting subtest: 2x-flip-vs-cursor-legacy
[394.452955] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[394.601521] [079/132] (626s left) gem_exec_whisper (basic-contexts)
[394.659298] Starting subtest: basic-contexts
[401.771671] Subtest basic-contexts: SUCCESS (7.107s)
[401.973429] [080/132] (619s left) gem_pxp (display-protected-crc)
[402.099879] Starting subtest: display-protected-crc
[403.776858] Subtest display-protected-crc: SUCCESS (1.680s)
[403.898444] [081/132] (617s left) i915_query (query-topology-coherent-slice-mask)
[403.958602] Starting subtest: query-topology-coherent-slice-mask
[403.964109] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[404.060066] [082/132] (617s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[404.461420] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[405.259494] [083/132] (616s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[405.349204] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[405.352016] Starting dynamic subtest: pipe-A
[405.422322] Dynamic subtest pipe-A: SUCCESS (0.075s)
[405.438266] Starting dynamic subtest: pipe-B
[406.593229] Dynamic subtest pipe-B: SUCCESS (1.170s)
[406.607286] Starting dynamic subtest: pipe-C
[407.696324] Dynamic subtest pipe-C: SUCCESS (1.101s)
[407.707435] Starting dynamic subtest: pipe-D
[408.831900] Dynamic subtest pipe-D: SUCCESS (1.135s)
[408.834596] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.485s)
[409.988298] [084/132] (611s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[410.097724] Starting subtest: y-tiled-64bpp-rotate-180
[410.103091] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[410.200583] [085/132] (611s left) perf (invalid-oa-exponent)
[410.316972] Starting subtest: invalid-oa-exponent
[410.331077] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[410.375492] [086/132] (611s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[410.467191] Starting subtest: x-tiled-16bpp-rotate-270
[410.487098] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[410.604061] [087/132] (611s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[410.689913] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[410.692344] Starting dynamic subtest: pipe-A-eDP-1
[427.300285] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.433s)
[427.311612] Starting dynamic subtest: pipe-B-eDP-1
[444.312853] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.472s)
[444.325797] Starting dynamic subtest: pipe-C-eDP-1
[461.216902] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.367s)
[461.227915] Starting dynamic subtest: pipe-D-eDP-1
[478.262906] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.414s)
[478.264901] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.691s)
[479.476332] [088/132] (542s left) kms_chamelium_hpd (dp-hpd-storm)
[479.868898] Subtest dp-hpd-storm: SKIP (0.000s)
[480.685954] [089/132] (541s left) kms_universal_plane (cursor-fb-leak)
[480.768662] Starting subtest: cursor-fb-leak
[480.770917] Starting dynamic subtest: pipe-A-eDP-1
[481.107197] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.342s)
[481.123416] Starting dynamic subtest: pipe-B-eDP-1
[482.512902] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.409s)
[482.526285] Starting dynamic subtest: pipe-C-eDP-1
[483.833289] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.324s)
[483.846575] Starting dynamic subtest: pipe-D-eDP-1
[485.176375] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.347s)
[485.178951] Subtest cursor-fb-leak: SUCCESS (4.431s)
[486.424839] [090/132] (535s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[486.516632] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[486.518883] Starting dynamic subtest: pipe-A-eDP-1
[486.544442] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[486.557376] Starting dynamic subtest: pipe-B-eDP-1
[486.581391] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[486.594708] Starting dynamic subtest: pipe-C-eDP-1
[486.619043] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[486.629302] Starting dynamic subtest: pipe-D-eDP-1
[486.653512] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[486.657613] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[488.779882] [091/132] (533s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[488.869648] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[488.873858] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[488.944852] [092/132] (533s left) prime_mmap (test_userptr)
[489.001877] Starting subtest: test_userptr
[489.004172] Starting dynamic subtest: test_userptr-smem
[489.006309] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[489.008613] Subtest test_userptr: SUCCESS (0.001s)
[489.099623] [093/132] (532s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[489.204208] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[489.208813] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[489.309283] [094/132] (532s left) i915_drm_fdinfo (busy-hang)
[489.363658] Starting subtest: busy-hang
[489.366013] Starting dynamic subtest: rcs0
[489.388465] Dynamic subtest rcs0: SKIP (0.024s)
[489.401773] Starting dynamic subtest: bcs0
[489.406275] Dynamic subtest bcs0: SKIP (0.001s)
[489.417930] Starting dynamic subtest: vcs0
[489.422389] Dynamic subtest vcs0: SKIP (0.000s)
[489.432843] Starting dynamic subtest: vcs1
[489.437186] Dynamic subtest vcs1: SKIP (0.000s)
[489.447623] Starting dynamic subtest: vecs0
[489.451965] Dynamic subtest vecs0: SKIP (0.000s)
[489.462318] Starting dynamic subtest: ccs0
[489.466624] Dynamic subtest ccs0: SKIP (0.000s)
[489.470950] Subtest busy-hang: SKIP (0.030s)
[489.510366] [095/132] (532s left) kms_draw_crc (draw-method-render)
[489.605821] Starting subtest: draw-method-render
[489.607732] Starting dynamic subtest: xrgb8888-untiled
[489.835497] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[489.845545] Starting dynamic subtest: rgb565-untiled
[490.057442] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[490.070339] Starting dynamic subtest: xrgb2101010-untiled
[490.279431] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[490.296708] Starting dynamic subtest: xbgr16161616f-untiled
[490.512197] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[490.523143] Starting dynamic subtest: xrgb8888-xtiled
[490.634174] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[490.646995] Starting dynamic subtest: rgb565-xtiled
[490.767378] Dynamic subtest rgb565-xtiled: SUCCESS (0.131s)
[490.780417] Starting dynamic subtest: xrgb2101010-xtiled
[490.893226] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[490.904027] Starting dynamic subtest: xbgr16161616f-xtiled
[491.022398] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[491.032796] Starting dynamic subtest: xrgb8888-4tiled
[491.144563] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[491.157167] Starting dynamic subtest: rgb565-4tiled
[491.277501] Dynamic subtest rgb565-4tiled: SUCCESS (0.131s)
[491.288034] Starting dynamic subtest: xrgb2101010-4tiled
[491.399414] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[491.409914] Starting dynamic subtest: xbgr16161616f-4tiled
[491.533464] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[491.535250] Subtest draw-method-render: SUCCESS (1.933s)
[491.638606] [096/132] (530s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[491.726819] Starting subtest: plane-all-modeset-transition-internal-panels
[491.728700] Starting dynamic subtest: pipe-A-eDP-1
[493.024996] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.299s)
[493.309797] Starting dynamic subtest: pipe-B-eDP-1
[494.346584] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.047s)
[494.627418] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.904s)
[495.476117] [097/132] (526s left) kms_content_protection (suspend-resume)
[495.619017] Starting subtest: suspend-resume
[495.623602] Subtest suspend-resume: SKIP (0.000s)
[495.729863] [098/132] (526s left) gem_spin_batch (legacy-resubmit)
[495.787547] Starting subtest: legacy-resubmit
[495.789449] Starting dynamic subtest: default
[495.791852] Dynamic subtest default: SUCCESS (0.005s)
[495.807595] Starting dynamic subtest: render
[495.809935] Dynamic subtest render: SUCCESS (0.001s)
[495.821234] Starting dynamic subtest: bsd
[495.823135] Dynamic subtest bsd: SUCCESS (0.003s)
[495.833044] Starting dynamic subtest: bsd1
[495.834861] Dynamic subtest bsd1: SUCCESS (0.003s)
[495.844730] Starting dynamic subtest: bsd2
[495.846618] Dynamic subtest bsd2: SUCCESS (0.001s)
[495.856344] Starting dynamic subtest: blt
[495.858211] Dynamic subtest blt: SUCCESS (0.003s)
[495.867950] Starting dynamic subtest: vebox
[495.869785] Dynamic subtest vebox: SUCCESS (0.002s)
[495.871655] Subtest legacy-resubmit: SUCCESS (0.027s)
[496.051138] [099/132] (526s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[496.142827] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[503.127758] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.993s)
[503.297175] [100/132] (519s left) i915_pm_freq_api (freq-reset)
[503.349850] Starting subtest: freq-reset
[503.351770] Starting dynamic subtest: gt0
[503.544619] Dynamic subtest gt0: SUCCESS (0.195s)
[503.555164] Starting dynamic subtest: gt1
[503.719593] Dynamic subtest gt1: SUCCESS (0.174s)
[503.722401] Subtest freq-reset: SUCCESS (0.372s)
[503.793629] [101/132] (518s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[503.886207] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[503.890674] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[503.982990] [102/132] (518s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[504.075181] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[511.402029] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.330s)
[511.539437] [103/132] (510s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[511.592878] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[511.597264] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[511.778333] [104/132] (510s left) kms_cursor_crc (cursor-random-128x42)
[512.014881] Starting subtest: cursor-random-128x42
[512.062797] Subtest cursor-random-128x42: SKIP (0.042s)
[512.265341] [105/132] (510s left) gem_exec_fence (syncobj-timeline-signal)
[512.850342] Starting subtest: syncobj-timeline-signal
[512.856033] Subtest syncobj-timeline-signal: SUCCESS (0.011s)
[513.843236] [106/132] (508s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[513.947172] Starting subtest: 4-tiled-64bpp-rotate-270
[513.967729] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[514.101128] [107/132] (508s left) kms_tv_load_detect (load-detect)
[514.157329] Subtest load-detect: SKIP (0.000s)
[514.219893] [108/132] (508s left) kms_big_fb (linear-32bpp-rotate-90)
[514.313542] Starting subtest: linear-32bpp-rotate-90
[514.333515] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[514.450881] [109/132] (508s left) gem_ringfill (engines-basic)
[519.805465] Starting subtest: engines-basic
[519.808119] Starting dynamic subtest: rcs0
[519.867644] Dynamic subtest rcs0: SUCCESS (0.062s)
[519.880318] Starting dynamic subtest: bcs0
[519.912953] Dynamic subtest bcs0: SUCCESS (0.043s)
[519.924642] Starting dynamic subtest: vcs0
[519.956682] Dynamic subtest vcs0: SUCCESS (0.042s)
[519.968516] Starting dynamic subtest: vcs1
[520.000748] Dynamic subtest vcs1: SUCCESS (0.042s)
[520.012389] Starting dynamic subtest: vecs0
[520.043602] Dynamic subtest vecs0: SUCCESS (0.041s)
[520.055349] Starting dynamic subtest: ccs0
[520.089443] Dynamic subtest ccs0: SUCCESS (0.044s)
[520.091934] Subtest engines-basic: SUCCESS (0.286s)
[520.182271] [110/132] (502s left) sw_sync (alloc_fence_invalid_timeline)
[520.221269] Starting subtest: alloc_fence_invalid_timeline
[520.223623] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[520.282549] [111/132] (502s left) gem_ctx_shared (exec-single-timeline)
[520.345722] Starting subtest: exec-single-timeline
[520.347956] Starting dynamic subtest: rcs0
[521.431667] Dynamic subtest rcs0: SUCCESS (1.084s)
[521.450713] Starting dynamic subtest: bcs0
[522.519329] Dynamic subtest bcs0: SUCCESS (1.084s)
[522.532601] Starting dynamic subtest: vcs0
[523.608243] Dynamic subtest vcs0: SUCCESS (1.086s)
[523.622653] Starting dynamic subtest: vcs1
[524.697175] Dynamic subtest vcs1: SUCCESS (1.085s)
[524.711658] Starting dynamic subtest: vecs0
[525.784515] Dynamic subtest vecs0: SUCCESS (1.084s)
[525.798191] Starting dynamic subtest: ccs0
[526.871992] Dynamic subtest ccs0: SUCCESS (1.084s)
[526.874676] Subtest exec-single-timeline: SUCCESS (6.524s)
[527.079431] [112/132] (495s left) gem_exec_balancer (sequential)
[527.142014] Starting subtest: sequential
[530.381180] Subtest sequential: SUCCESS (3.238s)
[530.721099] [113/132] (492s left) kms_cursor_crc (cursor-offscreen-128x128)
[530.946532] Starting subtest: cursor-offscreen-128x128
[530.951949] Starting dynamic subtest: pipe-A-eDP-1
[532.874795] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s)
[532.929579] Starting dynamic subtest: pipe-D-eDP-1
[535.509654] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.602s)
[535.511985] Subtest cursor-offscreen-128x128: SUCCESS (4.563s)
[536.378978] [114/132] (486s left) kms_properties (invalid-properties-atomic)
[536.460482] Starting subtest: invalid-properties-atomic
[536.775000] Subtest invalid-properties-atomic: SUCCESS (0.315s)
[536.850756] [115/132] (486s left) i915_query (query-topology-matches-eu-total)
[536.913076] Starting subtest: query-topology-matches-eu-total
[536.915130] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[537.024362] [116/132] (486s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[537.128375] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[537.132720] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[537.235245] [117/132] (485s left) perf_pmu (rc6)
[537.273225] Starting subtest: rc6
[537.275414] Starting dynamic subtest: gt0
[543.628667] Dynamic subtest gt0: SUCCESS (6.355s)
[543.642406] Starting dynamic subtest: runtime-pm-gt0
[551.391440] Dynamic subtest runtime-pm-gt0: SUCCESS (7.761s)
[551.404306] Starting dynamic subtest: runtime-pm-long-gt0
[563.840882] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.449s)
[563.854518] Starting dynamic subtest: other-idle-gt0
[570.184764] Dynamic subtest other-idle-gt0: SUCCESS (6.344s)
[570.198039] Starting dynamic subtest: gt1
[576.526594] Dynamic subtest gt1: SUCCESS (6.340s)
[576.540239] Starting dynamic subtest: runtime-pm-gt1
[583.955194] Dynamic subtest runtime-pm-gt1: SUCCESS (7.423s)
[583.968725] Starting dynamic subtest: runtime-pm-long-gt1
[596.404631] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.444s)
[596.418380] Starting dynamic subtest: other-idle-gt1
[602.748826] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[602.751683] Subtest rc6: SUCCESS (65.476s)
[603.886912] [118/132] (419s left) gem_fenced_exec_thrash (2-spare-fences)
[603.961385] Subtest 2-spare-fences: SKIP (0.000s)
[604.043780] [119/132] (419s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[604.142881] Starting subtest: fbc-pr-cursor-plane-update-sf
[604.146173] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[604.189405] [120/132] (419s left) gem_exec_reloc (basic-gtt-read)
[604.248776] Subtest basic-gtt-read: SKIP (0.000s)
[604.323373] [121/132] (418s left) sw_sync (sync_multi_timeline_wait)
[604.356952] Starting subtest: sync_multi_timeline_wait
[604.358815] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[604.400010] [122/132] (418s left) kms_psr (pr-dpms)
[604.493081] Starting subtest: pr-dpms
[604.496773] Subtest pr-dpms: SKIP (0.000s)
[604.543921] [123/132] (418s left) gem_softpin (noreloc-s3)
[604.610052] Starting subtest: noreloc-S3
[625.167145] Subtest noreloc-S3: SUCCESS (5.385s)
[625.274583] [124/132] (398s left) gem_exec_schedule (pi-common)
[625.468136] Starting subtest: pi-common
[625.470175] Starting dynamic subtest: rcs0
[625.506341] Dynamic subtest rcs0: SUCCESS (0.042s)
[625.519457] Starting dynamic subtest: bcs0
[625.561239] Dynamic subtest bcs0: SUCCESS (0.054s)
[625.572605] Starting dynamic subtest: vcs0
[625.603430] Dynamic subtest vcs0: SUCCESS (0.041s)
[625.614268] Starting dynamic subtest: vcs1
[625.640903] Dynamic subtest vcs1: SUCCESS (0.037s)
[625.655897] Starting dynamic subtest: vecs0
[625.674583] Dynamic subtest vecs0: SUCCESS (0.033s)
[625.688798] Starting dynamic subtest: ccs0
[625.706681] Dynamic subtest ccs0: SUCCESS (0.031s)
[625.708905] Subtest pi-common: SUCCESS (0.244s)
[625.910515] [125/132] (397s left) kms_flip (flip-vs-expired-vblank)
[626.012040] Starting subtest: flip-vs-expired-vblank
[626.014367] Starting dynamic subtest: A-eDP1
[634.732330] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[634.747480] Starting dynamic subtest: B-eDP1
[643.445271] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[643.460371] Starting dynamic subtest: C-eDP1
[652.150529] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[652.172641] Starting dynamic subtest: D-eDP1
[660.880243] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[660.885451] Subtest flip-vs-expired-vblank: SUCCESS (34.908s)
[662.041339] [126/132] (361s left) gem_mmap_gtt (isolation)
[662.101375] Subtest isolation: SKIP (0.000s)
[662.165304] [127/132] (361s left) syncobj_timeline (host-signal-ordered)
[662.224140] Starting subtest: host-signal-ordered
[662.226541] Subtest host-signal-ordered: SUCCESS (0.000s)
[662.296041] [128/132] (361s left) kms_psr (psr2-sprite-mmap-gtt)
[662.382189] Starting subtest: psr2-sprite-mmap-gtt
[662.384471] Starting dynamic subtest: eDP-1
[663.865044] Dynamic subtest eDP-1: SKIP (1.480s)
[663.869495] Subtest psr2-sprite-mmap-gtt: SKIP (1.482s)
[663.999352] [129/132] (359s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[664.085455] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[664.089471] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[664.157342] [130/132] (359s left) perf_pmu (most-busy-idle-check-all)
[664.200486] Starting subtest: most-busy-idle-check-all
[664.202821] Starting dynamic subtest: rcs0
[664.903476] Dynamic subtest rcs0: FAIL (0.626s)
[664.915716] Starting dynamic subtest: bcs0
[666.005296] Dynamic subtest bcs0: SUCCESS (1.175s)
[666.019441] Starting dynamic subtest: vcs0
[667.989450] Dynamic subtest vcs0: SUCCESS (1.980s)
[668.003277] Starting dynamic subtest: vcs1
[669.973216] Dynamic subtest vcs1: SUCCESS (1.980s)
[669.986277] Starting dynamic subtest: vecs0
[671.893455] Dynamic subtest vecs0: SUCCESS (1.916s)
[671.915680] Starting dynamic subtest: ccs0
[673.941907] Dynamic subtest ccs0: SUCCESS (2.045s)
[673.944812] Subtest most-busy-idle-check-all: FAIL (9.740s)
[674.033022] [131/132] (349s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[674.151461] Starting subtest: cursorB-vs-flipA-atomic-transitions
[674.156013] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[674.273770] [132/132] (349s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[674.360743] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[674.362992] Starting dynamic subtest: pipe-A-eDP-1
[674.385788] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[674.398914] Starting dynamic subtest: pipe-B-eDP-1
[674.420951] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[674.433223] Starting dynamic subtest: pipe-C-eDP-1
[674.455787] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[674.468098] Starting dynamic subtest: pipe-D-eDP-1
[674.490884] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[674.495026] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[676.628279] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: api_intel_allocator
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: prime_self_import
results: parsing output: 14/ for test: kms_pipe_crc_basic
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: core_debugfs
results: parsing output: 20/ for test: gem_huc_copy
results: parsing output: 21/ for test: gem_partial_pwrite_pread
results: parsing output: 22/ for test: kms_plane
results: parsing output: 23/ for test: gem_close_race
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_pm_backlight
results: parsing output: 26/ for test: gem_ctx_isolation
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: gem_workarounds
results: parsing output: 29/ for test: gem_exec_parallel
results: parsing output: 30/ for test: kms_plane_scaling
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_tiled_swapping
results: parsing output: 33/ for test: dmabuf_sync_file
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_fenced_exec_thrash
results: parsing output: 36/ for test: gem_watchdog
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: i915_query
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_lease
results: parsing output: 41/ for test: kms_vblank
results: parsing output: 42/ for test: kms_async_flips
results: parsing output: 43/ for test: kms_color
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: fbdev
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: kms_plane_cursor
results: parsing output: 57/ for test: sysfs_preempt_timeout
results: parsing output: 58/ for test: i915_pm_rpm
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_hdr
results: parsing output: 62/ for test: prime_mmap
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: syncobj_eventfd
results: parsing output: 65/ for test: gen9_exec_parse
results: parsing output: 66/ for test: kms_rotation_crc
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: gem_set_tiling_vs_blt
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_atomic
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_exec_whisper
results: parsing output: 79/ for test: gem_pxp
results: parsing output: 80/ for test: i915_query
results: parsing output: 81/ for test: kms_chamelium_frames
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: perf
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_chamelium_hpd
results: parsing output: 88/ for test: kms_universal_plane
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: prime_mmap
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: kms_draw_crc
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: kms_content_protection
results: parsing output: 97/ for test: gem_spin_batch
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: i915_pm_freq_api
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_render_copy
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: gem_exec_fence
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_tv_load_detect
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_ringfill
results: parsing output: 109/ for test: sw_sync
results: parsing output: 110/ for test: gem_ctx_shared
results: parsing output: 111/ for test: gem_exec_balancer
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: kms_properties
results: parsing output: 114/ for test: i915_query
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: perf_pmu
results: parsing output: 117/ for test: gem_fenced_exec_thrash
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: sw_sync
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_softpin
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_ccs
Done.