[57.901904] Initializing watchdogs
[57.901951]   /dev/watchdog0
[57.915359] [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.919797] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.921966] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.925397] [001/132] (960s left) gem_flink_race (flink_close)
[57.978719] Starting subtest: flink_close
[63.106375] Subtest flink_close: SUCCESS (5.060s)
[63.158317] [002/132] (955s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[63.270452] Starting subtest: plane-upscale-20x20-with-pixel-format
[63.272556] Starting dynamic subtest: pipe-A
[64.344618] Dynamic subtest pipe-A: SUCCESS (1.073s)
[64.356367] Starting dynamic subtest: pipe-B
[66.417990] Dynamic subtest pipe-B: SUCCESS (2.067s)
[66.425303] Starting dynamic subtest: pipe-C
[67.618353] Dynamic subtest pipe-C: SUCCESS (1.197s)
[67.629350] Starting dynamic subtest: pipe-D
[68.873947] Dynamic subtest pipe-D: SUCCESS (1.253s)
[68.876330] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.593s)
[70.070218] [003/132] (948s left) gem_exec_schedule (semaphore-noskip)
[70.147718] Starting subtest: semaphore-noskip
[70.557339] Subtest semaphore-noskip: SUCCESS (0.413s)
[70.933048] [004/132] (947s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[71.021603] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[71.026203] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[71.157954] [005/132] (947s left) api_intel_bb (delta-check)
[71.213848] Starting subtest: delta-check
[71.218430] Subtest delta-check: SUCCESS (0.006s)
[71.377521] [006/132] (947s left) gem_exec_flush (basic-batch-kernel-default-uc)
[71.449446] Starting subtest: basic-batch-kernel-default-uc
[78.802682] Subtest basic-batch-kernel-default-uc: SUCCESS (7.349s)
[79.015424] [007/132] (939s left) gem_mmap_gtt (cpuset-big-copy-xy)
[79.082435] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[79.150221] [008/132] (939s left) gem_eio (in-flight-10ms)
[79.375826] Starting subtest: in-flight-10ms
[87.650217] Subtest in-flight-10ms: SUCCESS (8.269s)
[87.841981] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[87.844999] [009/132] (930s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[87.917195] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[87.973990] [010/132] (930s left) drm_read (short-buffer-block)
[88.156833] Starting subtest: short-buffer-block
[88.159256] Subtest short-buffer-block: SUCCESS (0.000s)
[88.320821] [011/132] (930s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[88.426818] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[95.477000] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.052s)
[95.626382] [012/132] (923s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[95.721136] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[95.725206] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[95.856976] [013/132] (923s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[95.964216] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[96.336155] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[99.155764] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.817s)
[99.167303] Starting dynamic subtest: pipe-A-eDP-1-4
[101.332870] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.175s)
[101.344677] Starting dynamic subtest: pipe-A-eDP-1-4
[103.341810] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[103.351340] Starting dynamic subtest: pipe-A-eDP-1-x
[105.520467] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[105.894136] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[108.690832] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[108.702078] Starting dynamic subtest: pipe-B-eDP-1-4
[110.877602] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[110.886060] Starting dynamic subtest: pipe-B-eDP-1-4
[112.887185] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[112.898090] Starting dynamic subtest: pipe-B-eDP-1-x
[115.069086] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.179s)
[115.434208] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[118.217920] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.793s)
[118.229793] Starting dynamic subtest: pipe-C-eDP-1-4
[120.393964] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.175s)
[120.404949] Starting dynamic subtest: pipe-C-eDP-1-4
[122.403084] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[122.413893] Starting dynamic subtest: pipe-C-eDP-1-x
[124.635684] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[124.941640] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[127.747194] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.810s)
[127.761867] Starting dynamic subtest: pipe-D-eDP-1-4
[129.934790] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.186s)
[129.945764] Starting dynamic subtest: pipe-D-eDP-1-4
[131.943427] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[131.954490] Starting dynamic subtest: pipe-D-eDP-1-x
[134.134388] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.190s)
[134.137097] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.165s)
[135.356381] [014/132] (883s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[135.466374] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[135.470635] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[135.571639] [015/132] (883s left) kms_psr (fbc-pr-primary-render)
[135.667570] Starting subtest: fbc-pr-primary-render
[135.671785] Subtest fbc-pr-primary-render: SKIP (0.000s)
[135.769267] [016/132] (883s left) gem_ppgtt (flink-and-close-vma-leak)
[135.825088] Starting subtest: flink-and-close-vma-leak
[135.865140] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[136.027474] [017/132] (883s left) gem_exec_alignment (pi)
[136.090741] Starting subtest: pi
[186.166671] Subtest pi: SUCCESS (50.073s)
[187.338440] [018/132] (831s left) gen9_exec_parse (bb-oversize)
[187.449381] Subtest bb-oversize: SKIP (0.000s)
[187.537313] [019/132] (831s left) kms_dp_linktrain_fallback (dsc-fallback)
[187.642843] Starting subtest: dsc-fallback
[187.649176] Subtest dsc-fallback: SKIP (0.000s)
[187.739642] [020/132] (831s left) kms_vblank (query-idle)
[187.854021] Starting subtest: query-idle
[187.855942] Starting dynamic subtest: pipe-A-eDP-1
[189.612021] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.759s)
[189.625437] Starting dynamic subtest: pipe-D-eDP-1
[192.069158] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.453s)
[192.071345] Subtest query-idle: SUCCESS (4.215s)
[192.904282] [021/132] (826s left) gem_mmap_wc (coherency)
[192.967555] Subtest coherency: SKIP (0.000s)
[193.029157] [022/132] (826s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[198.064818] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[198.069109] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[198.953548] [023/132] (820s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[199.068294] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[199.072720] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[199.194745] [024/132] (820s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[199.293640] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[199.305089] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[199.428302] [025/132] (819s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[199.532166] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[206.341087] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.810s)
[206.501253] [026/132] (812s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[206.611279] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[206.615224] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[206.752289] [027/132] (812s left) kms_pm_rpm (universal-planes-dpms)
[209.018368] Starting subtest: universal-planes-dpms
[209.020404] Starting dynamic subtest: plane-33
[217.335608] Dynamic subtest plane-33: SUCCESS (8.318s)
[217.347510] Starting dynamic subtest: plane-63
[225.951793] Dynamic subtest plane-63: SUCCESS (8.614s)
[225.963324] Starting dynamic subtest: plane-93
[234.264398] Dynamic subtest plane-93: SUCCESS (8.310s)
[234.275811] Starting dynamic subtest: plane-123
[242.908187] Dynamic subtest plane-123: SUCCESS (8.641s)
[242.919023] Starting dynamic subtest: plane-133
[251.190848] Dynamic subtest plane-133: SUCCESS (8.280s)
[251.203024] Starting dynamic subtest: plane-143
[259.487909] Dynamic subtest plane-143: SUCCESS (8.295s)
[259.490322] Subtest universal-planes-dpms: SUCCESS (50.470s)
[259.880369] [028/132] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[259.989600] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[259.994065] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[260.114338] [029/132] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[260.212390] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[260.216942] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[260.336527] [030/132] (759s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[260.389264] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[260.454434] [031/132] (759s left) gem_softpin (allocator-evict)
[260.506501] Starting subtest: allocator-evict
[260.508717] Starting dynamic subtest: rcs0
[283.747806] Dynamic subtest rcs0: SUCCESS (23.240s)
[283.759474] Starting dynamic subtest: bcs0
[307.373923] Dynamic subtest bcs0: SUCCESS (23.624s)
[307.385619] Starting dynamic subtest: vcs0
[330.866428] Dynamic subtest vcs0: SUCCESS (23.490s)
[330.878060] Starting dynamic subtest: vcs1
[354.617937] Dynamic subtest vcs1: SUCCESS (23.749s)
[354.628177] Starting dynamic subtest: vecs0
[378.413100] Dynamic subtest vecs0: SUCCESS (23.793s)
[378.423993] Starting dynamic subtest: ccs0
[402.066354] Dynamic subtest ccs0: SUCCESS (23.651s)
[402.069065] Subtest allocator-evict: SUCCESS (141.554s)
[402.171147] [032/132] (617s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[402.315373] Starting subtest: fbc-rgb565-draw-mmap-wc
[406.395127] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.082s)
[407.567346] [033/132] (612s left) gem_exec_schedule (implicit-read-write)
[407.663213] Starting subtest: implicit-read-write
[407.665260] Starting dynamic subtest: rcs0
[407.764272] Dynamic subtest rcs0: SUCCESS (0.110s)
[407.775876] Starting dynamic subtest: vcs0
[407.843486] Dynamic subtest vcs0: SUCCESS (0.077s)
[407.855617] Starting dynamic subtest: vcs1
[407.920379] Dynamic subtest vcs1: SUCCESS (0.076s)
[407.936276] Starting dynamic subtest: vecs0
[408.000257] Dynamic subtest vecs0: SUCCESS (0.079s)
[408.011738] Starting dynamic subtest: ccs0
[408.088696] Dynamic subtest ccs0: SUCCESS (0.088s)
[408.091104] Subtest implicit-read-write: SUCCESS (0.436s)
[409.053980] [034/132] (610s left) kms_flip (flip-vs-panning-vs-hang)
[409.163342] Starting subtest: flip-vs-panning-vs-hang
[409.165562] Starting dynamic subtest: A-eDP1
[460.419581] Dynamic subtest A-eDP1: SUCCESS (51.255s)
[460.436371] Starting dynamic subtest: D-eDP1
[500.415101] Dynamic subtest D-eDP1: SUCCESS (39.990s)
[500.420449] Subtest flip-vs-panning-vs-hang: SUCCESS (91.254s)
[501.750922] [035/132] (518s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[501.815557] Starting subtest: invalid-multi-wait-unsubmitted
[501.817459] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[501.946659] [036/132] (517s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[502.059016] Starting subtest: y-tiled-addfb-size-offset-overflow
[502.063275] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[502.178620] [037/132] (517s left) kms_addfb_basic (unused-handle)
[502.238907] Starting subtest: unused-handle
[502.241209] Subtest unused-handle: SUCCESS (0.000s)
[502.413346] [038/132] (517s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[502.468756] Starting subtest: multi-wait-for-submit-submitted-signaled
[502.470651] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[502.589587] [039/132] (517s left) kms_selftest (drm_damage_helper)
[502.632965] Starting subtest: drm_damage_helper
[502.670948] Starting dynamic subtest: drm_test_damage_iter_no_damage
[502.783890] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.110s)
[502.792076] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[502.903966] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.120s)
[502.913922] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[503.046133] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.141s)
[503.056305] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[503.183982] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.138s)
[503.192334] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[503.344887] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.161s)
[503.354631] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[503.486891] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.140s)
[503.495655] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[503.621980] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.134s)
[503.632108] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[503.773486] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.151s)
[503.781747] Starting dynamic subtest: drm_test_damage_iter_single_damage
[503.922979] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.149s)
[503.931572] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[504.063094] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.139s)
[504.071652] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[504.207874] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.144s)
[504.216564] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[504.366551] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.158s)
[504.374853] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[504.472808] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.106s)
[504.481290] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[504.599987] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.126s)
[504.608088] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[504.707036] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.106s)
[504.715599] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[504.826631] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.119s)
[504.834994] Starting dynamic subtest: drm_test_damage_iter_damage
[504.975933] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.148s)
[504.986159] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[505.114469] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.138s)
[505.122825] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[505.232825] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.117s)
[505.242846] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[505.349446] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.117s)
[505.357831] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[505.480763] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.130s)
[505.482842] Subtest drm_damage_helper: SUCCESS (2.845s)
[505.684820] [040/132] (514s left) kms_async_flips (test-time-stamp-atomic)
[505.786039] Starting subtest: test-time-stamp-atomic
[506.157684] Starting dynamic subtest: pipe-A-eDP-1
[506.921567] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.761s)
[507.304285] Starting dynamic subtest: pipe-B-eDP-1
[508.057364] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s)
[508.432244] Starting dynamic subtest: pipe-C-eDP-1
[509.187758] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.760s)
[509.548161] Starting dynamic subtest: pipe-D-eDP-1
[510.316029] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[510.318478] Subtest test-time-stamp-atomic: SUCCESS (4.530s)
[511.495509] [041/132] (508s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[511.593978] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[511.596199] Starting dynamic subtest: pipe-A-eDP-1
[511.615812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[511.626589] Starting dynamic subtest: pipe-B-eDP-1
[511.645143] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[511.653639] Starting dynamic subtest: pipe-C-eDP-1
[511.672765] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[511.681783] Starting dynamic subtest: pipe-D-eDP-1
[511.702252] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[511.704266] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.009s)
[513.856260] [042/132] (506s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[514.012461] Starting subtest: dp-mst-lic-type-0-hdcp14
[514.016952] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[514.184236] [043/132] (505s left) kms_joiner (basic-force-big-joiner)
[514.299222] Starting subtest: basic-force-big-joiner
[514.301514] Starting dynamic subtest: single
[517.681331] Dynamic subtest single: SUCCESS (3.392s)
[517.683629] Subtest basic-force-big-joiner: SUCCESS (3.393s)
[518.897270] [044/132] (501s left) gem_workarounds (reset-fd)
[518.974629] Starting subtest: reset-fd
[519.138605] Subtest reset-fd: SUCCESS (0.164s)
[519.286143] [045/132] (500s left) gem_partial_pwrite_pread (reads-snoop)
[519.353405] Subtest reads-snoop: SKIP (0.000s)
[519.439949] [046/132] (500s left) gem_render_copy (y-tiled-ccs-to-linear)
[519.498686] Starting subtest: y-tiled-ccs-to-linear
[519.503194] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[519.700631] [047/132] (500s left) i915_query (query-regions-sanity-check)
[519.765910] Starting subtest: query-regions-sanity-check
[519.784038] Subtest query-regions-sanity-check: SUCCESS (0.019s)
[519.940570] [048/132] (500s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[520.171358] Starting subtest: cursor-rapid-movement-128x42
[520.217819] Subtest cursor-rapid-movement-128x42: SKIP (0.040s)
[520.453440] [049/132] (499s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[520.514688] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[520.516668] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[520.646492] [050/132] (499s left) gem_madvise (dontneed-after-mmap)
[520.691792] Starting subtest: dontneed-after-mmap
[520.713388] Subtest dontneed-after-mmap: SUCCESS (0.022s)
[520.870150] [051/132] (499s left) prime_vgem (shrink)
[520.946383] Starting subtest: shrink
[520.960166] Subtest shrink: SUCCESS (0.014s)
[521.094663] [052/132] (499s left) kms_flip (plain-flip-interruptible)
[521.200940] Starting subtest: plain-flip-interruptible
[521.202844] Starting dynamic subtest: A-eDP1
[522.864368] Dynamic subtest A-eDP1: SUCCESS (1.662s)
[522.875658] Starting dynamic subtest: B-eDP1
[524.491064] Dynamic subtest B-eDP1: SUCCESS (1.625s)
[524.502891] Starting dynamic subtest: C-eDP1
[526.119718] Dynamic subtest C-eDP1: SUCCESS (1.627s)
[526.130913] Starting dynamic subtest: D-eDP1
[527.757039] Dynamic subtest D-eDP1: SUCCESS (1.636s)
[527.762956] Subtest plain-flip-interruptible: SUCCESS (6.563s)
[528.967831] [053/132] (491s left) gem_userptr_blits (sync-unmap-after-close)
[529.041194] Starting subtest: sync-unmap-after-close
[529.052409] Subtest sync-unmap-after-close: SUCCESS (0.012s)
[529.208217] [054/132] (491s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[529.300227] Starting subtest: fbc-psr2-primary-mmap-gtt
[529.302435] Starting dynamic subtest: eDP-1
[529.306728] Dynamic subtest eDP-1: SKIP (0.000s)
[529.311089] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.002s)
[529.399867] [055/132] (491s left) gem_partial_pwrite_pread (writes-after-reads)
[529.449599] Subtest writes-after-reads: SKIP (0.000s)
[529.552210] [056/132] (491s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[529.658218] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[529.660077] Starting dynamic subtest: pipe-A-eDP-1
[530.493782] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[530.502896] Starting dynamic subtest: pipe-B-eDP-1
[532.186277] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.685s)
[532.197397] Starting dynamic subtest: pipe-C-eDP-1
[533.646783] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.462s)
[533.656805] Starting dynamic subtest: pipe-D-eDP-1
[535.091045] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.444s)
[535.093348] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.426s)
[536.302941] [057/132] (484s left) gem_caching (writes)
[536.366995] Subtest writes: SKIP (0.000s)
[536.454090] [058/132] (484s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[536.554158] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[540.233553] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.684s)
[541.397947] [059/132] (479s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[541.497453] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[541.501601] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[541.634585] [060/132] (479s left) gem_exec_async (forked-writes)
[541.702411] Starting subtest: forked-writes
[541.704631] Starting dynamic subtest: rcs0
[541.727082] Dynamic subtest rcs0: SUCCESS (0.024s)
[541.737488] Starting dynamic subtest: bcs0
[541.752129] Dynamic subtest bcs0: SUCCESS (0.023s)
[541.761314] Starting dynamic subtest: vcs0
[541.775274] Dynamic subtest vcs0: SUCCESS (0.022s)
[541.785770] Starting dynamic subtest: vcs1
[541.798722] Dynamic subtest vcs1: SUCCESS (0.023s)
[541.808305] Starting dynamic subtest: vecs0
[541.820706] Dynamic subtest vecs0: SUCCESS (0.021s)
[541.831027] Starting dynamic subtest: ccs0
[541.842227] Dynamic subtest ccs0: SUCCESS (0.021s)
[541.844351] Subtest forked-writes: SUCCESS (0.140s)
[542.114128] [061/132] (478s left) i915_drm_fdinfo (virtual-busy)
[542.159802] Starting subtest: virtual-busy
[542.163948] Subtest virtual-busy: SKIP (0.000s)
[542.255379] [062/132] (478s left) gem_ccs (ctrl-surf-copy)
[542.307896] Starting subtest: ctrl-surf-copy
[542.311902] Subtest ctrl-surf-copy: SKIP (0.000s)
[542.438688] [063/132] (478s left) syncobj_timeline (wait-delayed-signal)
[542.492830] Starting subtest: wait-delayed-signal
[542.594363] Subtest wait-delayed-signal: SUCCESS (0.102s)
[542.693562] [064/132] (478s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[542.804903] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[543.495675] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[543.715198] [065/132] (477s left) kms_color (legacy-gamma)
[543.810755] Starting subtest: legacy-gamma
[543.812903] Starting dynamic subtest: pipe-A-eDP-1
[544.494552] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s)
[544.504513] Starting dynamic subtest: pipe-B-eDP-1
[545.869528] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.373s)
[545.879269] Starting dynamic subtest: pipe-C-eDP-1
[547.239532] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[547.252783] Starting dynamic subtest: pipe-D-eDP-1
[548.568572] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[548.571065] Subtest legacy-gamma: SUCCESS (4.759s)
[549.422757] [066/132] (471s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[549.527943] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[549.539124] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.010s)
[549.681540] [067/132] (471s left) kms_getfb (getfb-handle-zero)
[549.784690] Starting subtest: getfb-handle-zero
[549.786922] Subtest getfb-handle-zero: SUCCESS (0.000s)
[549.923336] [068/132] (471s left) gem_vm_create (invalid-destroy)
[549.986724] Starting subtest: invalid-destroy
[549.991705] Subtest invalid-destroy: SUCCESS (0.002s)
[550.122929] [069/132] (471s left) gem_mmap_offset (bad-flags)
[550.182981] Starting subtest: bad-flags
[550.184880] Subtest bad-flags: SUCCESS (0.000s)
[550.305559] [070/132] (470s left) syncobj_timeline (reset-signaled)
[550.362856] Starting subtest: reset-signaled
[550.364395] Subtest reset-signaled: SUCCESS (0.000s)
[550.466137] [071/132] (470s left) kms_lease (page-flip-implicit-plane)
[550.558063] Starting subtest: page-flip-implicit-plane
[550.559993] Starting dynamic subtest: pipe-A-eDP-1
[551.037382] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s)
[551.046289] Starting dynamic subtest: pipe-B-eDP-1
[552.139491] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.102s)
[552.149891] Starting dynamic subtest: pipe-C-eDP-1
[553.267727] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[553.277742] Starting dynamic subtest: pipe-D-eDP-1
[554.394470] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[554.396762] Subtest page-flip-implicit-plane: SUCCESS (3.839s)
[555.255461] [072/132] (466s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[555.362225] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[555.364541] Starting dynamic subtest: pipe-A-default-mode
[555.665231] Dynamic subtest pipe-A-default-mode: SKIP (0.302s)
[555.669788] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.303s)
[556.492173] [073/132] (464s left) sysfs_preempt_timeout (timeout)
[556.557326] Starting subtest: timeout
[556.559630] Starting dynamic subtest: vecs0
[565.905942] Dynamic subtest vecs0: SUCCESS (9.344s)
[565.919259] Starting dynamic subtest: ccs0
[567.286119] Dynamic subtest ccs0: SUCCESS (1.380s)
[567.298089] Starting dynamic subtest: vcs0
[576.932959] Dynamic subtest vcs0: SUCCESS (9.643s)
[576.945430] Starting dynamic subtest: bcs0
[578.232056] Dynamic subtest bcs0: SUCCESS (1.297s)
[578.243395] Starting dynamic subtest: rcs0
[579.572729] Dynamic subtest rcs0: SUCCESS (1.341s)
[579.583452] Starting dynamic subtest: vcs1
[588.897485] Dynamic subtest vcs1: SUCCESS (9.319s)
[588.899923] Subtest timeout: SUCCESS (32.337s)
[589.005843] [074/132] (432s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[589.101647] Starting subtest: fbcpsr-rgb101010-draw-blt
[595.806275] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.707s)
[595.950780] [075/132] (425s left) kms_psr (psr2-sprite-plane-move)
[596.047673] Starting subtest: psr2-sprite-plane-move
[596.049913] Starting dynamic subtest: eDP-1
[597.787977] Dynamic subtest eDP-1: SUCCESS (1.738s)
[597.790046] Subtest psr2-sprite-plane-move: SUCCESS (1.739s)
[598.651096] [076/132] (422s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[598.760710] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[599.726307] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.967s)
[599.863241] [077/132] (421s left) gem_lmem_swapping (massive-random)
[599.912163] Subtest massive-random: SKIP (0.000s)
[599.958224] [078/132] (421s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[600.077125] Starting subtest: cursor-vs-flip-toggle
[630.763661] Subtest cursor-vs-flip-toggle: SUCCESS (30.684s)
[631.575750] [079/132] (390s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[631.687324] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[631.691651] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[631.817451] [080/132] (389s left) kms_chamelium_frames (dp-crc-fast)
[632.208446] Subtest dp-crc-fast: SKIP (0.000s)
[633.057923] [081/132] (388s left) gem_pxp (hw-rejects-pxp-buffer)
[633.178203] Starting subtest: hw-rejects-pxp-buffer
[633.183051] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[633.319941] [082/132] (388s left) kms_plane_alpha_blend (alpha-opaque-fb)
[633.419830] Starting subtest: alpha-opaque-fb
[633.700739] Starting dynamic subtest: pipe-A-eDP-1
[634.322525] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[634.331513] Starting dynamic subtest: pipe-D-eDP-1
[635.678917] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.356s)
[635.681335] Subtest alpha-opaque-fb: SUCCESS (2.260s)
[636.575677] [083/132] (385s left) gem_exec_flush (basic-uc-ro-default)
[636.644296] Starting subtest: basic-uc-ro-default
[642.124873] Subtest basic-uc-ro-default: SUCCESS (5.463s)
[642.319397] [084/132] (379s left) api_intel_allocator (fork-simple-stress-signal)
[642.375626] Starting subtest: fork-simple-stress-signal
[647.829857] Subtest fork-simple-stress-signal: SUCCESS (5.400s)
[647.931653] [085/132] (373s left) gem_ringfill (engines-basic)
[653.911963] Starting subtest: engines-basic
[653.914611] Starting dynamic subtest: rcs0
[653.999382] Dynamic subtest rcs0: SUCCESS (0.087s)
[654.011718] Starting dynamic subtest: bcs0
[654.045832] Dynamic subtest bcs0: SUCCESS (0.044s)
[654.057029] Starting dynamic subtest: vcs0
[654.093310] Dynamic subtest vcs0: SUCCESS (0.045s)
[654.104031] Starting dynamic subtest: vcs1
[654.138091] Dynamic subtest vcs1: SUCCESS (0.043s)
[654.149744] Starting dynamic subtest: vecs0
[654.181305] Dynamic subtest vecs0: SUCCESS (0.041s)
[654.193567] Starting dynamic subtest: ccs0
[654.225972] Dynamic subtest ccs0: SUCCESS (0.043s)
[654.228488] Subtest engines-basic: SUCCESS (0.316s)
[654.328092] [086/132] (367s left) kms_atomic_transition (plane-toggle-modeset-transition)
[654.428920] Starting subtest: plane-toggle-modeset-transition
[654.430901] Starting dynamic subtest: pipe-A-eDP-1
[667.166927] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.738s)
[667.179706] Starting dynamic subtest: pipe-B-eDP-1
[679.569839] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.399s)
[679.572217] Subtest plane-toggle-modeset-transition: SUCCESS (25.143s)
[680.407664] [087/132] (341s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[680.509827] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[680.514111] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[680.622971] [088/132] (341s left) syncobj_wait (wait-all-delayed-signal)
[680.677524] Starting subtest: wait-all-delayed-signal
[680.780540] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[680.891787] [089/132] (341s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[681.004805] Starting subtest: cursor-tearing-framebuffer-change
[681.006968] Starting dynamic subtest: pipe-A-eDP-1
[681.580329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[681.589337] Starting dynamic subtest: pipe-D-eDP-1
[682.821502] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[682.823424] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.817s)
[683.668929] [090/132] (338s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[683.768448] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[683.772503] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[683.910835] [091/132] (338s left) gem_create (create-ext-placement-each)
[684.086563] Starting subtest: create-ext-placement-each
[684.088626] Subtest create-ext-placement-each: SUCCESS (0.000s)
[684.223359] [092/132] (337s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[684.316026] Starting subtest: plane-use-after-nonblocking-unbind
[684.318287] Starting dynamic subtest: pipe-A-eDP-1
[684.374537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[684.698683] Starting dynamic subtest: pipe-B-eDP-1
[685.457517] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.772s)
[685.757881] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.444s)
[686.643767] [093/132] (335s left) prime_vgem (basic-read)
[686.741546] Starting subtest: basic-read
[686.749083] Subtest basic-read: SKIP (0.005s)
[686.869695] [094/132] (335s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[686.953056] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[686.955277] Starting dynamic subtest: pipe-A-default-mode
[687.241597] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[687.245915] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.288s)
[688.082078] [095/132] (334s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[688.186418] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[688.188274] Starting dynamic subtest: pipe-A-eDP-1
[688.208251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[688.218906] Starting dynamic subtest: pipe-B-eDP-1
[688.239124] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[688.250351] Starting dynamic subtest: pipe-C-eDP-1
[688.269505] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[688.278574] Starting dynamic subtest: pipe-D-eDP-1
[688.297859] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[688.299965] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.091s)
[690.463829] [096/132] (331s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[690.556115] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[697.114324] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.560s)
[697.287453] [097/132] (325s left) gem_exec_capture (capture)
[697.358027] Starting subtest: capture
[697.360382] Starting dynamic subtest: rcs0-smem
[698.188519] Dynamic subtest rcs0-smem: SUCCESS (0.830s)
[698.199431] Starting dynamic subtest: bcs0-smem
[699.179833] Dynamic subtest bcs0-smem: SUCCESS (0.989s)
[699.190245] Starting dynamic subtest: vcs0-smem
[699.998666] Dynamic subtest vcs0-smem: SUCCESS (0.821s)
[700.010692] Starting dynamic subtest: vcs1-smem
[700.822194] Dynamic subtest vcs1-smem: SUCCESS (0.823s)
[700.834435] Starting dynamic subtest: vecs0-smem
[702.220482] Dynamic subtest vecs0-smem: FAIL (1.336s)
[702.229872] Starting dynamic subtest: ccs0-smem
[703.478127] Dynamic subtest ccs0-smem: SUCCESS (1.316s)
[703.480613] Subtest capture: FAIL (6.119s)
[703.635811] [098/132] (318s left) kms_plane_scaling (intel-max-src-size)
[703.732971] Starting subtest: intel-max-src-size
[703.739523] Subtest intel-max-src-size: SKIP (0.000s)
[703.888555] [099/132] (318s left) gem_exec_whisper (basic-contexts)
[703.948913] Starting subtest: basic-contexts
[711.862822] Subtest basic-contexts: SUCCESS (7.909s)
[712.069274] [100/132] (310s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[712.169776] Starting subtest: bad-aux-stride-yf-tiled-ccs
[712.171920] Starting dynamic subtest: pipe-A-eDP-1
[712.193740] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[712.205441] Starting dynamic subtest: pipe-B-eDP-1
[712.226247] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[712.235519] Starting dynamic subtest: pipe-C-eDP-1
[712.256076] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[712.264966] Starting dynamic subtest: pipe-D-eDP-1
[712.287252] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[712.291298] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[714.392694] [101/132] (308s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[714.497734] Starting subtest: fbc-indfb-scaledprimary
[717.542177] Subtest fbc-indfb-scaledprimary: SUCCESS (3.049s)
[718.769678] [102/132] (303s left) gem_exec_fence (long-history)
[719.201426] Starting subtest: long-history
[726.607473] Subtest long-history: SUCCESS (7.406s)
[727.304125] [103/132] (295s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[732.340075] Starting subtest: pr-cursor-plane-move-continuous-sf
[732.344583] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[733.199737] [104/132] (289s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[733.299060] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[733.301335] Starting dynamic subtest: pipe-A-eDP-1
[733.324212] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[733.335878] Starting dynamic subtest: pipe-B-eDP-1
[733.357163] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[733.366391] Starting dynamic subtest: pipe-C-eDP-1
[733.388617] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[733.398416] Starting dynamic subtest: pipe-D-eDP-1
[733.420964] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[733.425536] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[735.483839] [105/132] (287s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[735.593182] Starting subtest: x-tiled-8bpp-rotate-0
[736.795498] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.202s)
[736.964803] [106/132] (285s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[737.069843] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[744.294419] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.224s)
[744.453075] [107/132] (278s left) syncobj_wait (multi-wait-signaled)
[744.525790] Starting subtest: multi-wait-signaled
[744.528141] Subtest multi-wait-signaled: SUCCESS (0.000s)
[744.667121] [108/132] (278s left) kms_chamelium_color (gamma)
[744.761604] Subtest gamma: SKIP (0.000s)
[744.809408] [109/132] (278s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[744.874614] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[744.876642] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[745.011881] [110/132] (278s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[745.394032] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[746.210323] [111/132] (276s left) vgem_basic (debugfs)
[746.262113] Starting subtest: debugfs
[746.264390] Subtest debugfs: SUCCESS (0.000s)
[746.343536] [112/132] (276s left) prime_busy (after)
[746.404266] Starting subtest: after
[746.409466] Starting dynamic subtest: rcs0
[746.439585] Dynamic subtest rcs0: SUCCESS (0.032s)
[746.451480] Starting dynamic subtest: bcs0
[746.488489] Dynamic subtest bcs0: SUCCESS (0.048s)
[746.498503] Starting dynamic subtest: vcs0
[746.529729] Dynamic subtest vcs0: SUCCESS (0.040s)
[746.539430] Starting dynamic subtest: vcs1
[746.571200] Dynamic subtest vcs1: SUCCESS (0.041s)
[746.580759] Starting dynamic subtest: vecs0
[746.612862] Dynamic subtest vecs0: SUCCESS (0.041s)
[746.622771] Starting dynamic subtest: ccs0
[746.654506] Dynamic subtest ccs0: SUCCESS (0.041s)
[746.763361] Subtest after: SUCCESS (0.357s)
[746.866695] [113/132] (276s left) gem_ctx_persistence (heartbeat-close)
[746.920582] Starting subtest: heartbeat-close
[746.925474] Subtest heartbeat-close: SKIP (0.000s)
[747.050653] [114/132] (276s left) kms_big_fb (4-tiled-addfb)
[747.157553] Starting subtest: 4-tiled-addfb
[747.159804] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[747.290830] [115/132] (275s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[747.381184] Starting subtest: dsc-fractional-bpp-with-bpc
[747.412067] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[747.479417] [116/132] (275s left) gem_exec_schedule (deep)
[747.675763] Starting subtest: deep
[747.678118] Starting dynamic subtest: rcs0
[753.375506] Dynamic subtest rcs0: SKIP (5.697s)
[753.387504] Starting dynamic subtest: vcs0
[764.706817] Dynamic subtest vcs0: SUCCESS (11.332s)
[764.721257] Starting dynamic subtest: vcs1
[776.136043] Dynamic subtest vcs1: SUCCESS (11.427s)
[776.148837] Starting dynamic subtest: vecs0
[788.717068] Dynamic subtest vecs0: SUCCESS (12.580s)
[788.732901] Starting dynamic subtest: ccs0
[801.718249] Dynamic subtest ccs0: SUCCESS (12.999s)
[801.721605] Subtest deep: SUCCESS (54.039s)
[802.724736] [117/132] (220s left) core_getstats (basic)
[802.779197] Starting subtest: basic
[802.781203] Subtest basic: SUCCESS (0.000s)
[802.915199] [118/132] (220s left) gem_eio (wait-wedge-immediate)
[803.135927] Starting subtest: wait-wedge-immediate
[804.970848] Subtest wait-wedge-immediate: SUCCESS (1.832s)
[805.110722] [119/132] (218s left) kms_psr (pr-no-drrs)
[805.207158] Starting subtest: pr-no-drrs
[805.211190] Subtest pr-no-drrs: SKIP (0.000s)
[805.302160] [120/132] (218s left) kms_vblank (wait-forked-busy)
[805.404693] Starting subtest: wait-forked-busy
[805.406867] Starting dynamic subtest: pipe-A-eDP-1
[807.290416] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[807.306282] Starting dynamic subtest: pipe-D-eDP-1
[809.900764] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.605s)
[809.903018] Subtest wait-forked-busy: SUCCESS (4.495s)
[810.721309] [121/132] (212s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[810.776666] Starting subtest: etime-multi-wait-available-unsubmitted
[810.881035] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.105s)
[810.981782] [122/132] (212s left) kms_cursor_crc (cursor-offscreen-32x10)
[811.137047] Starting subtest: cursor-offscreen-32x10
[811.185916] Subtest cursor-offscreen-32x10: SKIP (0.044s)
[811.532898] [123/132] (212s left) gem_ctx_param (set-priority-invalid-size)
[811.594250] Starting subtest: set-priority-invalid-size
[811.596585] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[811.691511] [124/132] (211s left) kms_pm_rpm (cursor)
[813.209634] Starting subtest: cursor
[813.214600] Subtest cursor: SKIP (0.000s)
[813.953436] [125/132] (209s left) i915_pm_rpm (system-suspend-execbuf)
[816.089346] Starting subtest: system-suspend-execbuf
[873.414028] Subtest system-suspend-execbuf: SUCCESS (45.980s)
[873.817832] [126/132] (149s left) kms_psr (pr-sprite-plane-move)
[873.912051] Starting subtest: pr-sprite-plane-move
[873.916289] Subtest pr-sprite-plane-move: SKIP (0.000s)
[874.010861] [127/132] (149s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[874.113437] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[874.115695] Starting dynamic subtest: pipe-A
[874.135672] Dynamic subtest pipe-A: SKIP (0.017s)
[874.148254] Starting dynamic subtest: pipe-B
[874.170344] Dynamic subtest pipe-B: SKIP (0.034s)
[874.180104] Starting dynamic subtest: pipe-C
[874.205253] Dynamic subtest pipe-C: SKIP (0.031s)
[874.215153] Starting dynamic subtest: pipe-D
[874.235771] Dynamic subtest pipe-D: SKIP (0.030s)
[874.239869] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.118s)
[874.370107] [128/132] (149s left) gem_ctx_isolation (dirty-create)
[874.429768] Starting subtest: dirty-create
[874.432053] Starting dynamic subtest: rcs0
[874.626110] Dynamic subtest rcs0: SUCCESS (0.199s)
[874.639503] Starting dynamic subtest: bcs0
[874.844211] Dynamic subtest bcs0: SUCCESS (0.218s)
[874.856384] Starting dynamic subtest: vcs0
[875.072904] Dynamic subtest vcs0: SUCCESS (0.228s)
[875.083357] Starting dynamic subtest: vcs1
[876.463971] Dynamic subtest vcs1: SUCCESS (1.390s)
[876.476590] Starting dynamic subtest: vecs0
[878.481337] Dynamic subtest vecs0: SUCCESS (2.016s)
[878.493910] Starting dynamic subtest: ccs0
[880.461025] Dynamic subtest ccs0: SUCCESS (1.978s)
[880.463311] Subtest dirty-create: SUCCESS (6.033s)
[880.751650] [129/132] (143s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[880.861844] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[887.840153] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.980s)
[887.989450] [130/132] (135s left) perf_pmu (init-busy)
[888.031774] Starting subtest: init-busy
[888.033912] Starting dynamic subtest: rcs0
[888.036205] Dynamic subtest rcs0: SUCCESS (0.001s)
[888.052193] Starting dynamic subtest: bcs0
[888.054247] Dynamic subtest bcs0: SUCCESS (0.000s)
[888.066546] Starting dynamic subtest: vcs0
[888.068533] Dynamic subtest vcs0: SUCCESS (0.000s)
[888.078680] Starting dynamic subtest: vcs1
[888.080607] Dynamic subtest vcs1: SUCCESS (0.001s)
[888.089820] Starting dynamic subtest: vecs0
[888.092099] Dynamic subtest vecs0: SUCCESS (0.001s)
[888.101741] Starting dynamic subtest: ccs0
[888.103920] Dynamic subtest ccs0: SUCCESS (0.000s)
[888.105796] Subtest init-busy: SUCCESS (0.007s)
[888.173963] [131/132] (135s left) i915_module_load (reload)
[888.215493] Starting subtest: reload
[894.611721] Subtest reload: SUCCESS (6.392s)
[894.650157] [132/132] (129s left) gem_pread (bench)
[896.205388] Subtest bench: SKIP (0.000s)
[896.266960] Closing watchdogs
results: parsing output: 0/ for test: gem_flink_race
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: api_intel_bb
results: parsing output: 5/ for test: gem_exec_flush
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: gem_eio
results: parsing output: 8/ for test: kms_pipe_b_c_ivb
results: parsing output: 9/ for test: drm_read
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_async_flips
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_ppgtt
results: parsing output: 16/ for test: gem_exec_alignment
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: kms_dp_linktrain_fallback
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_pm_rpm
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: gem_softpin
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_selftest
results: parsing output: 39/ for test: kms_async_flips
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_content_protection
results: parsing output: 42/ for test: kms_joiner
results: parsing output: 43/ for test: gem_workarounds
results: parsing output: 44/ for test: gem_partial_pwrite_pread
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: gem_madvise
results: parsing output: 50/ for test: prime_vgem
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: gem_partial_pwrite_pread
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: gem_caching
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_async
results: parsing output: 60/ for test: i915_drm_fdinfo
results: parsing output: 61/ for test: gem_ccs
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_color
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_getfb
results: parsing output: 67/ for test: gem_vm_create
results: parsing output: 68/ for test: gem_mmap_offset
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: sysfs_preempt_timeout
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_lmem_swapping
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_chamelium_frames
results: parsing output: 80/ for test: gem_pxp
results: parsing output: 81/ for test: kms_plane_alpha_blend
results: parsing output: 82/ for test: gem_exec_flush
results: parsing output: 83/ for test: api_intel_allocator
results: parsing output: 84/ for test: gem_ringfill
results: parsing output: 85/ for test: kms_atomic_transition
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_create
results: parsing output: 91/ for test: kms_atomic_transition
results: parsing output: 92/ for test: prime_vgem
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_capture
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: gem_exec_whisper
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_chamelium_color
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_chamelium_hpd
results: parsing output: 110/ for test: vgem_basic
results: parsing output: 111/ for test: prime_busy
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_dsc
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: core_getstats
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_vblank
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: gem_ctx_param
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: i915_pm_rpm
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: gem_ctx_isolation
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: i915_module_load
results: parsing output: 131/ for test: gem_pread
Done.