[57.828856] Initializing watchdogs
[57.828925]   /dev/watchdog0
[57.844385] [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.848860] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.851045] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.854224] [001/133] (960s left) i915_drm_fdinfo (busy-idle-check-all)
[57.920560] Starting subtest: busy-idle-check-all
[57.922864] Starting dynamic subtest: rcs0
[57.929910] Dynamic subtest rcs0: SKIP (0.005s)
[57.937906] Starting dynamic subtest: bcs0
[57.942322] Dynamic subtest bcs0: SKIP (0.001s)
[57.949578] Starting dynamic subtest: vcs0
[57.953691] Dynamic subtest vcs0: SKIP (0.000s)
[57.960497] Starting dynamic subtest: vcs1
[57.964424] Dynamic subtest vcs1: SKIP (0.000s)
[57.970850] Starting dynamic subtest: vecs0
[57.974936] Dynamic subtest vecs0: SKIP (0.000s)
[57.981321] Starting dynamic subtest: ccs0
[57.985431] Dynamic subtest ccs0: SKIP (0.000s)
[57.989693] Subtest busy-idle-check-all: SKIP (0.009s)
[58.023090] [002/133] (960s left) gem_exec_reloc (basic-softpin)
[58.084552] Subtest basic-softpin: SKIP (0.000s)
[58.159758] [003/133] (960s left) kms_vblank (wait-busy-hang)
[58.264078] Starting subtest: wait-busy-hang
[58.266281] Starting dynamic subtest: pipe-A-eDP-1
[85.718487] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.434s)
[85.731766] Starting dynamic subtest: pipe-D-eDP-1
[110.751956] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.030s)
[110.754135] Subtest wait-busy-hang: SUCCESS (52.468s)
[111.580783] [004/133] (906s left) gem_mmap_gtt (hang-user)
[111.637463] Subtest hang-user: SKIP (0.000s)
[111.697986] [005/133] (906s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[111.794734] Starting subtest: bo-too-small-due-to-tiling
[111.799160] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[111.898829] [006/133] (906s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[111.998744] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[112.003210] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[112.102628] [007/133] (906s left) i915_pm_rc6_residency (media-rc6-accuracy)
[112.160985] Starting subtest: media-rc6-accuracy
[112.165571] Subtest media-rc6-accuracy: SKIP (0.000s)
[112.247825] [008/133] (906s left) kms_psr (fbc-psr2-primary-blt)
[112.344775] Starting subtest: fbc-psr2-primary-blt
[112.346994] Starting dynamic subtest: eDP-1
[112.351412] Dynamic subtest eDP-1: SKIP (0.000s)
[112.356448] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[112.412668] [009/133] (906s left) vgem_basic (mmap)
[112.485822] Starting subtest: mmap
[112.487810] Subtest mmap: SUCCESS (0.007s)
[112.535164] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[112.537889] [010/133] (906s left) kms_pm_rpm (modeset-pc8-residency-stress)
[114.084932] Starting subtest: modeset-pc8-residency-stress
[114.089808] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[114.832776] [011/133] (903s left) gem_exec_flush (basic-uc-prw-default)
[114.895953] Starting subtest: basic-uc-prw-default
[120.391405] Subtest basic-uc-prw-default: SUCCESS (5.495s)
[120.592942] [012/133] (898s left) gem_spin_batch (spin-each)
[120.665383] Starting subtest: spin-each
[124.028047] Subtest spin-each: SUCCESS (3.364s)
[125.984718] [013/133] (892s left) gem_exec_create (forked)
[126.045932] Starting subtest: forked
[126.048645] Starting dynamic subtest: smem
[147.862233] Dynamic subtest smem: SUCCESS (21.813s)
[147.865053] Subtest forked: SUCCESS (21.814s)
[148.048077] [014/133] (870s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[148.162063] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[148.166714] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[148.242509] [015/133] (870s left) gem_eio (in-flight-internal-immediate)
[148.484999] Starting subtest: in-flight-internal-immediate
[149.986896] Subtest in-flight-internal-immediate: SUCCESS (1.501s)
[150.102622] [016/133] (868s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[150.208042] Starting subtest: y-tiled-8bpp-rotate-90
[150.212770] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[150.309715] [017/133] (868s left) vgem_basic (sysfs)
[150.354045] Starting subtest: sysfs
[150.356294] Subtest sysfs: SUCCESS (0.000s)
[150.427183] [018/133] (868s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[150.525300] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[157.088696] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.568s)
[157.212727] [019/133] (861s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[157.319918] Starting subtest: x-tiled-16bpp-rotate-180
[158.653009] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.334s)
[158.796495] [020/133] (860s left) kms_cursor_edge_walk (128x128-top-edge)
[158.886091] Starting subtest: 128x128-top-edge
[158.888014] Starting dynamic subtest: pipe-A-eDP-1
[162.327189] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s)
[162.336513] Starting dynamic subtest: pipe-D-eDP-1
[165.461648] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[165.463973] Subtest 128x128-top-edge: SUCCESS (6.575s)
[166.260612] [021/133] (852s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[166.360492] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[173.759664] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.401s)
[173.883871] [022/133] (845s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[173.982375] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[174.363884] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[177.165699] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[177.179395] Starting dynamic subtest: pipe-A-eDP-1-4
[179.363210] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.196s)
[179.373712] Starting dynamic subtest: pipe-A-eDP-1-4
[181.372358] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[181.381024] Starting dynamic subtest: pipe-A-eDP-1-x
[183.573160] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s)
[183.939221] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[186.687910] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.755s)
[186.698617] Starting dynamic subtest: pipe-B-eDP-1-4
[188.882992] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.194s)
[188.893749] Starting dynamic subtest: pipe-B-eDP-1-4
[190.892981] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[190.902793] Starting dynamic subtest: pipe-B-eDP-1-x
[193.105549] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.212s)
[193.481426] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[196.218097] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.741s)
[196.230578] Starting dynamic subtest: pipe-C-eDP-1-4
[198.403716] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[198.411661] Starting dynamic subtest: pipe-C-eDP-1-4
[200.414823] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[200.424020] Starting dynamic subtest: pipe-C-eDP-1-x
[202.604449] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.188s)
[202.971106] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[205.740258] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[205.748910] Starting dynamic subtest: pipe-D-eDP-1-4
[207.914946] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[207.925413] Starting dynamic subtest: pipe-D-eDP-1-4
[209.925284] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[209.935697] Starting dynamic subtest: pipe-D-eDP-1-x
[212.103982] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[212.106418] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.119s)
[213.329271] [023/133] (805s left) kms_scaling_modes (scaling-mode-center)
[213.442792] Starting subtest: scaling-mode-center
[213.445087] Starting dynamic subtest: pipe-A-eDP-1
[213.538596] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[213.547096] Starting dynamic subtest: pipe-B-eDP-1
[214.763486] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.223s)
[214.773031] Starting dynamic subtest: pipe-C-eDP-1
[215.889263] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[215.898130] Starting dynamic subtest: pipe-D-eDP-1
[217.024752] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[217.027075] Subtest scaling-mode-center: SUCCESS (3.585s)
[218.203425] [024/133] (801s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[218.292514] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[218.294686] Starting dynamic subtest: pipe-A-eDP-1
[218.562671] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.240s)
[218.572892] Starting dynamic subtest: pipe-B-eDP-1
[219.884650] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.318s)
[219.895184] Starting dynamic subtest: pipe-C-eDP-1
[221.196442] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.311s)
[221.205488] Starting dynamic subtest: pipe-D-eDP-1
[222.396344] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.200s)
[222.398415] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.074s)
[223.608490] [025/133] (795s left) kms_pm_rpm (dpms-lpsp)
[225.139669] Starting subtest: dpms-lpsp
[225.784285] Subtest dpms-lpsp: SUCCESS (0.644s)
[225.875260] [026/133] (793s left) gem_compute (compute-square)
[225.932773] Starting subtest: compute-square
[225.937368] Subtest compute-square: SUCCESS (0.006s)
[226.052385] [027/133] (793s left) gem_fence_thrash (bo-write-verify-threaded-none)
[226.088818] Starting subtest: bo-write-verify-threaded-none
[226.109565] Subtest bo-write-verify-threaded-none: SKIP (0.018s)
[226.166142] [028/133] (793s left) kms_draw_crc (draw-method-pwrite)
[226.262931] Starting subtest: draw-method-pwrite
[226.265151] Starting dynamic subtest: xrgb8888-untiled
[226.838724] Dynamic subtest xrgb8888-untiled: SUCCESS (0.577s)
[226.847357] Starting dynamic subtest: rgb565-untiled
[227.283549] Dynamic subtest rgb565-untiled: SUCCESS (0.444s)
[227.292761] Starting dynamic subtest: xrgb2101010-untiled
[227.817392] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.533s)
[227.827808] Starting dynamic subtest: xbgr16161616f-untiled
[228.583504] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.766s)
[228.592509] Starting dynamic subtest: xrgb8888-xtiled
[230.383745] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.800s)
[230.392703] Starting dynamic subtest: rgb565-xtiled
[231.461617] Dynamic subtest rgb565-xtiled: SUCCESS (1.076s)
[231.470992] Starting dynamic subtest: xrgb2101010-xtiled
[233.261484] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.798s)
[233.270559] Starting dynamic subtest: xbgr16161616f-xtiled
[236.561502] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.298s)
[236.569915] Starting dynamic subtest: xrgb8888-4tiled
[237.662456] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.099s)
[237.672437] Starting dynamic subtest: rgb565-4tiled
[238.206630] Dynamic subtest rgb565-4tiled: SUCCESS (0.544s)
[238.215281] Starting dynamic subtest: xrgb2101010-4tiled
[239.305943] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.099s)
[239.314145] Starting dynamic subtest: xbgr16161616f-4tiled
[242.350658] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.043s)
[242.352996] Subtest draw-method-pwrite: SUCCESS (16.089s)
[242.443726] [029/133] (777s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[242.548147] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[242.552476] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[242.643983] [030/133] (776s left) kms_psr (fbc-pr-cursor-plane-move)
[242.729932] Starting subtest: fbc-pr-cursor-plane-move
[242.734400] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[242.803915] [031/133] (776s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[242.899750] Starting subtest: extended-pageflip-modeset-hang-oldfb
[242.901628] Starting dynamic subtest: pipe-A
[250.798495] Dynamic subtest pipe-A: SUCCESS (7.898s)
[250.806966] Starting dynamic subtest: pipe-D
[259.455377] Dynamic subtest pipe-D: SUCCESS (8.654s)
[259.457658] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.556s)
[260.322340] [032/133] (759s left) perf_pmu (all-busy-check-all)
[260.363845] Starting subtest: all-busy-check-all
[261.910057] Subtest all-busy-check-all: SUCCESS (1.544s)
[262.011746] [033/133] (757s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[262.111364] Starting subtest: fbcpsr-rgb101010-draw-blt
[268.871432] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.763s)
[269.003382] [034/133] (750s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[269.098587] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[269.103198] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[269.194750] [035/133] (750s left) gem_exec_store (basic)
[269.259555] Starting subtest: basic
[269.352776] Subtest basic: SUCCESS (0.096s)
[269.541260] [036/133] (750s left) gem_exec_capture (capture-invisible)
[269.595474] Starting subtest: capture-invisible
[269.597969] Starting dynamic subtest: smem0
[269.602935] Dynamic subtest smem0: SKIP (0.000s)
[269.608212] Subtest capture-invisible: SKIP (0.000s)
[269.697409] [037/133] (750s left) kms_psr (pr-cursor-mmap-cpu)
[269.803703] Starting subtest: pr-cursor-mmap-cpu
[269.808341] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[269.877450] [038/133] (750s left) gem_exec_whisper (basic-queues-priority)
[269.933801] Starting subtest: basic-queues-priority
[293.103594] Subtest basic-queues-priority: SUCCESS (23.164s)
[293.288605] [039/133] (726s left) vgem_basic (dmabuf-export)
[293.340412] Starting subtest: dmabuf-export
[293.367417] Subtest dmabuf-export: SUCCESS (0.031s)
[293.484864] [040/133] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[293.590211] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[300.349385] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.761s)
[300.499828] [041/133] (719s left) gem_exec_balancer (bonded-sync)
[300.567693] Starting subtest: bonded-sync
[300.572273] Subtest bonded-sync: SKIP (0.000s)
[300.871951] [042/133] (719s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[300.968810] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[304.988962] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.024s)
[306.180616] [043/133] (713s left) api_intel_bb (blit-noreloc-purge-cache)
[306.229571] Starting subtest: blit-noreloc-purge-cache
[306.236337] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[306.382621] [044/133] (713s left) kms_chamelium_frames (hdmi-frame-dump)
[306.767758] Subtest hdmi-frame-dump: SKIP (0.000s)
[307.591313] [045/133] (712s left) fbdev (unaligned-read)
[307.637561] Starting subtest: unaligned-read
[307.651450] Subtest unaligned-read: SUCCESS (0.015s)
[307.706156] [046/133] (712s left) kms_psr (psr2-cursor-plane-move)
[307.801950] Starting subtest: psr2-cursor-plane-move
[307.804243] Starting dynamic subtest: eDP-1
[309.472051] Dynamic subtest eDP-1: SUCCESS (1.672s)
[309.474416] Subtest psr2-cursor-plane-move: SUCCESS (1.673s)
[310.358767] [047/133] (709s left) gem_eio (in-flight-1us)
[310.585723] Starting subtest: in-flight-1us
[318.796805] Subtest in-flight-1us: SUCCESS (8.209s)
[318.981593] [048/133] (701s left) gem_ctx_create (basic-files)
[319.048675] Starting subtest: basic-files
[321.205898] Subtest basic-files: SUCCESS (2.156s)
[322.948192] [049/133] (697s left) kms_selftest (drm_format_helper)
[322.988227] Starting subtest: drm_format_helper
[323.027072] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[323.126521] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.100s)
[323.135470] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[323.228100] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.101s)
[323.238515] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[323.327038] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.097s)
[323.337357] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[323.412951] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.085s)
[323.422959] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[323.509740] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.094s)
[323.518143] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[323.602767] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.092s)
[323.611691] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[323.718053] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.112s)
[323.731688] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[323.819374] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.102s)
[323.828073] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[323.918873] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.099s)
[323.927495] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[324.017366] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.097s)
[324.026023] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[324.135518] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.116s)
[324.144091] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[324.248321] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.112s)
[324.257121] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[324.342189] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.095s)
[324.352492] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[324.434211] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.092s)
[324.444621] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[324.541581] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.103s)
[324.551078] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[324.630609] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.090s)
[324.638946] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[324.744651] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.111s)
[324.746592] Subtest drm_format_helper: SUCCESS (1.755s)
[324.896296] [050/133] (695s left) kms_hdr (static-swap)
[325.004189] Starting subtest: static-swap
[325.010765] Subtest static-swap: SKIP (0.000s)
[325.095415] [051/133] (695s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[325.200117] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[326.025165] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[326.199311] [052/133] (694s left) kms_lease (simple-lease)
[326.287741] Starting subtest: simple-lease
[326.290041] Starting dynamic subtest: pipe-A-eDP-1
[326.789702] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.502s)
[326.799704] Starting dynamic subtest: pipe-B-eDP-1
[328.212238] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.421s)
[328.224490] Starting dynamic subtest: pipe-C-eDP-1
[329.705946] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.487s)
[329.714790] Starting dynamic subtest: pipe-D-eDP-1
[331.162452] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.455s)
[331.164449] Subtest simple-lease: SUCCESS (4.874s)
[331.968966] [053/133] (688s left) kms_addfb_basic (bad-pitch-65536)
[332.024317] Starting subtest: bad-pitch-65536
[332.026570] Subtest bad-pitch-65536: SUCCESS (0.000s)
[332.154212] [054/133] (688s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[332.275375] Starting subtest: cursor-vs-flip-toggle
[363.581083] Subtest cursor-vs-flip-toggle: SUCCESS (31.305s)
[364.403205] [055/133] (656s left) gen9_exec_parse (bb-start-out)
[364.460226] Subtest bb-start-out: SKIP (0.000s)
[364.533015] [056/133] (656s left) kms_frontbuffer_tracking (fbc-tiling-y)
[364.636818] Starting subtest: fbc-tiling-y
[364.640940] Subtest fbc-tiling-y: SKIP (0.000s)
[364.738662] [057/133] (655s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[364.808547] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[364.914031] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[365.002404] [058/133] (655s left) gem_exec_schedule (submit-early-slice)
[365.074433] Starting subtest: submit-early-slice
[365.076658] Starting dynamic subtest: rcs0
[365.121332] Dynamic subtest rcs0: SUCCESS (0.046s)
[365.131879] Starting dynamic subtest: bcs0
[365.163434] Dynamic subtest bcs0: SUCCESS (0.042s)
[365.173637] Starting dynamic subtest: vcs0
[365.210119] Dynamic subtest vcs0: SUCCESS (0.046s)
[365.219556] Starting dynamic subtest: vcs1
[365.260867] Dynamic subtest vcs1: SUCCESS (0.050s)
[365.269805] Starting dynamic subtest: vecs0
[365.299150] Dynamic subtest vecs0: SUCCESS (0.038s)
[365.308074] Starting dynamic subtest: ccs0
[365.341990] Dynamic subtest ccs0: SUCCESS (0.042s)
[365.344569] Subtest submit-early-slice: SUCCESS (0.269s)
[367.022918] [059/133] (653s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[367.125396] Starting subtest: stress-xrgb8888-4tiled
[373.026448] Subtest stress-xrgb8888-4tiled: SUCCESS (5.901s)
[373.078576] [060/133] (647s left) gem_userptr_blits (map-fixed-invalidate-busy)
[373.139720] Starting subtest: map-fixed-invalidate-busy
[373.143115] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[373.272720] [061/133] (647s left) gem_ctx_param (set-priority-invalid-size)
[373.318404] Starting subtest: set-priority-invalid-size
[373.320325] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[373.378733] [062/133] (647s left) kms_atomic (plane-primary-legacy)
[373.475552] Starting subtest: plane-primary-legacy
[373.477456] Starting dynamic subtest: pipe-A-eDP-1
[373.922307] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.445s)
[373.924268] Subtest plane-primary-legacy: SUCCESS (0.447s)
[374.727014] [063/133] (646s left) gem_pxp (create-valid-protected-context)
[374.847530] Starting subtest: create-valid-protected-context
[374.849519] Subtest create-valid-protected-context: SUCCESS (0.001s)
[374.971771] [064/133] (646s left) syncobj_timeline (wait-all-snapshot)
[375.023540] Starting subtest: wait-all-snapshot
[375.105936] Subtest wait-all-snapshot: SUCCESS (0.081s)
[375.182070] [065/133] (645s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[375.283385] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[382.598122] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.318s)
[382.728805] [066/133] (638s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[382.841219] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[382.843437] Starting dynamic subtest: pipe-A-eDP-1
[382.949875] Dynamic subtest pipe-A-eDP-1: SKIP (0.111s)
[382.961375] Starting dynamic subtest: pipe-B-eDP-1
[384.066404] Dynamic subtest pipe-B-eDP-1: SKIP (1.114s)
[384.071154] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.229s)
[385.269667] [067/133] (635s left) kms_chamelium_hpd (hdmi-hpd-fast)
[385.656508] Subtest hdmi-hpd-fast: SKIP (0.000s)
[386.479077] [068/133] (634s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[386.564236] Starting subtest: primary-yf-tiled-reflect-x-180
[386.625274] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[386.730428] [069/133] (634s left) kms_flip (2x-absolute-wf_vblank)
[386.836808] Starting subtest: 2x-absolute-wf_vblank
[386.846614] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[386.941461] [070/133] (634s left) perf (invalid-oa-exponent)
[387.065903] Starting subtest: invalid-oa-exponent
[387.077730] Subtest invalid-oa-exponent: SUCCESS (0.013s)
[387.123999] [071/133] (634s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[387.217706] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[387.219949] Starting dynamic subtest: pipe-A-default-mode
[389.929061] Dynamic subtest pipe-A-default-mode: SUCCESS (2.708s)
[389.931382] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.710s)
[390.806541] [072/133] (630s left) kms_color (ctm-max)
[390.914666] Starting subtest: ctm-max
[390.917126] Starting dynamic subtest: pipe-A-eDP-1
[391.647267] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.733s)
[391.656304] Starting dynamic subtest: pipe-B-eDP-1
[393.114585] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.465s)
[393.124467] Starting dynamic subtest: pipe-C-eDP-1
[394.493237] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[394.503411] Starting dynamic subtest: pipe-D-eDP-1
[395.825145] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[395.827282] Subtest ctm-max: SUCCESS (4.912s)
[396.625232] [073/133] (624s left) gem_ctx_persistence (legacy-engines-hostile)
[396.690039] Starting subtest: legacy-engines-hostile
[396.691932] Starting dynamic subtest: render
[396.751665] Dynamic subtest render: SUCCESS (0.063s)
[396.765611] Starting dynamic subtest: bsd1
[396.837598] Dynamic subtest bsd1: SUCCESS (0.083s)
[396.851601] Starting dynamic subtest: bsd2
[396.942734] Dynamic subtest bsd2: SUCCESS (0.102s)
[396.956109] Starting dynamic subtest: blt
[396.996675] Dynamic subtest blt: SUCCESS (0.051s)
[397.009913] Starting dynamic subtest: vebox
[397.097709] Dynamic subtest vebox: SUCCESS (0.098s)
[397.100193] Subtest legacy-engines-hostile: SUCCESS (0.411s)
[397.182595] [074/133] (624s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[397.255525] Subtest writes-after-reads-snoop: SKIP (0.000s)
[397.335732] [075/133] (624s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[397.437601] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[397.442052] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[397.538063] [076/133] (623s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[397.597753] Starting subtest: multi-wait-for-submit-available-submitted
[397.599801] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[397.697815] [077/133] (623s left) syncobj_timeline (invalid-query-one-illegal-handle)
[397.764031] Starting subtest: invalid-query-one-illegal-handle
[397.766107] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[397.886317] [078/133] (623s left) kms_hdr (invalid-hdr)
[397.969337] Starting subtest: invalid-hdr
[400.037209] Starting dynamic subtest: pipe-A-eDP-1
[402.920077] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.882s)
[402.922473] Subtest invalid-hdr: SUCCESS (4.953s)
[403.029312] [079/133] (618s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[403.131686] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[403.133819] Starting dynamic subtest: pipe-A-eDP-1
[403.158292] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[403.169538] Starting dynamic subtest: pipe-B-eDP-1
[403.195231] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[403.204819] Starting dynamic subtest: pipe-C-eDP-1
[403.228147] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[403.238841] Starting dynamic subtest: pipe-D-eDP-1
[403.261677] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[403.265566] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[405.434568] [080/133] (616s left) kms_cursor_legacy (forked-bo)
[405.570398] Starting subtest: forked-bo
[405.572640] Starting dynamic subtest: pipe-A
[411.035485] Dynamic subtest pipe-A: SUCCESS (5.463s)
[411.052910] Starting dynamic subtest: pipe-B
[416.525726] Dynamic subtest pipe-B: SUCCESS (5.485s)
[416.544416] Starting dynamic subtest: pipe-C
[421.999930] Dynamic subtest pipe-C: SUCCESS (5.474s)
[422.012668] Starting dynamic subtest: pipe-D
[427.480780] Dynamic subtest pipe-D: SUCCESS (5.478s)
[427.492394] Starting dynamic subtest: all-pipes
[433.014777] Dynamic subtest all-pipes: SUCCESS (5.531s)
[433.017543] Subtest forked-bo: SUCCESS (27.442s)
[433.170262] [081/133] (588s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[433.293764] Starting subtest: 4-tiled-addfb-size-offset-overflow
[433.296483] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[433.403157] [082/133] (588s left) kms_flip (blocking-wf_vblank)
[433.491790] Starting subtest: blocking-wf_vblank
[433.494072] Starting dynamic subtest: A-eDP1
[442.379917] Dynamic subtest A-eDP1: SUCCESS (8.888s)
[442.393815] Starting dynamic subtest: B-eDP1
[451.316822] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[451.328853] Starting dynamic subtest: C-eDP1
[460.242271] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[460.257666] Starting dynamic subtest: D-eDP1
[469.180065] Dynamic subtest D-eDP1: SUCCESS (8.936s)
[469.184917] Subtest blocking-wf_vblank: SUCCESS (35.694s)
[470.416465] [083/133] (551s left) perf (global-sseu-config-invalid)
[470.520472] Starting subtest: global-sseu-config-invalid
[470.525136] Subtest global-sseu-config-invalid: SKIP (0.000s)
[470.565530] [084/133] (551s left) kms_cursor_crc (cursor-dpms)
[470.683310] Starting subtest: cursor-dpms
[470.685178] Starting dynamic subtest: pipe-A-eDP-1
[473.782059] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.096s)
[473.792943] Starting dynamic subtest: pipe-D-eDP-1
[477.348398] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.565s)
[477.350675] Subtest cursor-dpms: SUCCESS (6.665s)
[478.209894] [085/133] (543s left) gem_exec_parallel (userptr)
[478.276063] Starting subtest: userptr
[478.278408] Starting dynamic subtest: rcs0
[479.715833] Dynamic subtest rcs0: SUCCESS (1.442s)
[479.725696] Starting dynamic subtest: bcs0
[481.229539] Dynamic subtest bcs0: SUCCESS (1.511s)
[481.240209] Starting dynamic subtest: vcs0
[482.868449] Dynamic subtest vcs0: SUCCESS (1.636s)
[482.880075] Starting dynamic subtest: vcs1
[484.885442] Dynamic subtest vcs1: SUCCESS (2.015s)
[484.898623] Starting dynamic subtest: vecs0
[486.869101] Dynamic subtest vecs0: SUCCESS (1.980s)
[486.881479] Starting dynamic subtest: ccs0
[488.352084] Dynamic subtest ccs0: SUCCESS (1.483s)
[488.354593] Subtest userptr: SUCCESS (10.079s)
[488.542784] [086/133] (533s left) gem_mmap_gtt (basic-read)
[488.597347] Subtest basic-read: SKIP (0.000s)
[488.656346] [087/133] (533s left) gen3_render_tiledy_blits
[488.771835] [088/133] (533s left) i915_hangman (engine-error-state-capture)
[488.838047] Starting subtest: engine-error-state-capture
[488.840357] Starting dynamic subtest: rcs0
[494.900276] Dynamic subtest rcs0: SUCCESS (6.060s)
[494.912778] Starting dynamic subtest: bcs0
[500.852351] Dynamic subtest bcs0: SUCCESS (5.948s)
[500.865070] Starting dynamic subtest: vcs0
[506.867427] Dynamic subtest vcs0: SUCCESS (6.012s)
[506.879689] Starting dynamic subtest: vcs1
[512.884990] Dynamic subtest vcs1: SUCCESS (6.014s)
[512.896938] Starting dynamic subtest: vecs0
[518.837070] Dynamic subtest vecs0: SUCCESS (5.949s)
[518.849770] Starting dynamic subtest: ccs0
[524.852585] Dynamic subtest ccs0: SUCCESS (6.013s)
[524.855567] Subtest engine-error-state-capture: SUCCESS (36.013s)
[524.941068] [089/133] (497s left) drm_read (short-buffer-nonblock)
[525.089286] Starting subtest: short-buffer-nonblock
[525.091318] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[525.201464] [090/133] (496s left) i915_suspend (debugfs-reader)
[525.258801] Starting subtest: debugfs-reader
[543.776145] Subtest debugfs-reader: SUCCESS (3.730s)
[548.958900] [091/133] (478s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[549.082531] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[549.087098] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[549.190754] [092/133] (478s left) gem_render_copy (y-tiled-to-vebox-linear)
[549.238063] Starting subtest: y-tiled-to-vebox-linear
[549.242633] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[549.418029] [093/133] (477s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[549.520854] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[554.098866] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.541s)
[555.325000] [094/133] (472s left) sysfs_heartbeat_interval (nopreempt)
[555.381036] Starting subtest: nopreempt
[555.383467] Starting dynamic subtest: vecs0
[564.705342] Dynamic subtest vecs0: SUCCESS (9.286s)
[564.718401] Starting dynamic subtest: ccs0
[568.607334] Dynamic subtest ccs0: SUCCESS (3.895s)
[568.617288] Starting dynamic subtest: vcs0
[577.683642] Dynamic subtest vcs0: SUCCESS (9.066s)
[577.698883] Starting dynamic subtest: bcs0
[581.566098] Dynamic subtest bcs0: SUCCESS (3.878s)
[581.578394] Starting dynamic subtest: rcs0
[585.533181] Dynamic subtest rcs0: SUCCESS (3.963s)
[585.544077] Starting dynamic subtest: vcs1
[594.712113] Dynamic subtest vcs1: SUCCESS (9.169s)
[594.714710] Subtest nopreempt: SUCCESS (39.269s)
[594.810370] [095/133] (432s left) syncobj_wait (reset-signaled)
[594.871995] Starting subtest: reset-signaled
[594.874435] Subtest reset-signaled: SUCCESS (0.000s)
[594.978731] [096/133] (432s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[595.092827] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[598.574678] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.483s)
[599.746990] [097/133] (427s left) syncobj_wait (invalid-signal-illegal-handle)
[599.816047] Starting subtest: invalid-signal-illegal-handle
[599.818034] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[599.905914] [098/133] (427s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[599.990966] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[599.993093] Starting dynamic subtest: pipe-A-eDP-1
[602.192838] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.202s)
[602.204887] Starting dynamic subtest: pipe-B-eDP-1
[604.583002] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.388s)
[604.593533] Starting dynamic subtest: pipe-C-eDP-1
[606.766348] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.181s)
[606.777419] Starting dynamic subtest: pipe-D-eDP-1
[608.935237] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.166s)
[608.937287] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.943s)
[610.179548] [099/133] (417s left) gem_exec_await (wide-all)
[610.398514] Starting subtest: wide-all
[633.738983] Subtest wide-all: SUCCESS (23.326s)
[633.941799] [100/133] (393s left) gem_vm_create (create-ext)
[634.043313] Starting subtest: create-ext
[634.052161] Subtest create-ext: SUCCESS (0.009s)
[634.177519] [101/133] (393s left) gem_exec_reloc (basic-wc-gtt)
[634.253164] Subtest basic-wc-gtt: SKIP (0.000s)
[634.328496] [102/133] (393s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[634.424260] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[634.450416] Starting dynamic subtest: pipe-A-plane-0
[634.739424] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[634.750237] Starting dynamic subtest: pipe-A-plane-3
[634.972516] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[636.076636] Starting dynamic subtest: pipe-B-plane-0
[636.367777] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[636.380405] Starting dynamic subtest: pipe-B-plane-3
[636.600821] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[636.912178] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.486s)
[637.766335] [103/133] (390s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[637.869187] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[637.871654] Starting dynamic subtest: pipe-A-eDP-1
[637.895497] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[637.911486] Starting dynamic subtest: pipe-B-eDP-1
[637.933541] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[637.943534] Starting dynamic subtest: pipe-C-eDP-1
[637.964781] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[637.974412] Starting dynamic subtest: pipe-D-eDP-1
[637.996419] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[638.000898] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[640.054701] [104/133] (387s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[640.153507] Starting subtest: psr-rgb101010-draw-render
[647.521317] Subtest psr-rgb101010-draw-render: SUCCESS (7.373s)
[647.648880] [105/133] (380s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[647.750596] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[647.754548] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[647.845756] [106/133] (380s left) prime_mmap (test_reprime)
[647.908550] Starting subtest: test_reprime
[647.910485] Starting dynamic subtest: test_reprime-smem
[647.941349] Dynamic subtest test_reprime-smem: SUCCESS (0.034s)
[647.944236] Subtest test_reprime: SUCCESS (0.034s)
[648.042424] [107/133] (379s left) kms_prop_blob (invalid-set-prop-any)
[648.110951] Starting subtest: invalid-set-prop-any
[648.113104] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[648.212730] [108/133] (379s left) perf_pmu (busy-idle-check-all)
[648.257403] Starting subtest: busy-idle-check-all
[648.259584] Starting dynamic subtest: rcs0
[648.906245] Dynamic subtest rcs0: SUCCESS (0.652s)
[648.919482] Starting dynamic subtest: bcs0
[649.556833] Dynamic subtest bcs0: SUCCESS (0.649s)
[649.571814] Starting dynamic subtest: vcs0
[650.715856] Dynamic subtest vcs0: SUCCESS (1.156s)
[650.729231] Starting dynamic subtest: vcs1
[652.700225] Dynamic subtest vcs1: SUCCESS (1.983s)
[652.713534] Starting dynamic subtest: vecs0
[654.683744] Dynamic subtest vecs0: SUCCESS (1.982s)
[654.701657] Starting dynamic subtest: ccs0
[655.339663] Dynamic subtest ccs0: SUCCESS (0.655s)
[655.342119] Subtest busy-idle-check-all: SUCCESS (7.092s)
[655.459336] [109/133] (372s left) gem_render_copy (linear-to-vebox-yf-tiled)
[655.526545] Starting subtest: linear-to-vebox-yf-tiled
[655.530914] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[655.708708] [110/133] (372s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[655.817696] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[655.822543] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[655.922696] [111/133] (372s left) gem_exec_fence (syncobj-invalid-flags)
[656.344963] Starting subtest: syncobj-invalid-flags
[656.347750] Subtest syncobj-invalid-flags: SUCCESS (0.001s)
[657.767073] [112/133] (370s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[657.845442] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[657.847737] Starting dynamic subtest: pipe-A
[657.865482] Dynamic subtest pipe-A: SKIP (0.017s)
[657.876546] Starting dynamic subtest: pipe-B
[657.896752] Dynamic subtest pipe-B: SKIP (0.030s)
[657.907208] Starting dynamic subtest: pipe-C
[657.927048] Dynamic subtest pipe-C: SKIP (0.030s)
[657.937168] Starting dynamic subtest: pipe-D
[657.957685] Dynamic subtest pipe-D: SKIP (0.029s)
[657.961440] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.110s)
[658.071049] [113/133] (370s left) kms_plane_scaling (intel-max-src-size)
[658.150259] Starting subtest: intel-max-src-size
[658.156851] Subtest intel-max-src-size: SKIP (0.000s)
[658.257858] [114/133] (370s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[658.382003] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[659.368090] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.987s)
[660.219144] [115/133] (368s left) gem_ctx_persistence (engines-hostile-preempt)
[660.279008] Starting subtest: engines-hostile-preempt
[660.281228] Starting dynamic subtest: rcs0
[660.327089] Dynamic subtest rcs0: SUCCESS (0.051s)
[660.339984] Starting dynamic subtest: bcs0
[660.421522] Dynamic subtest bcs0: SUCCESS (0.093s)
[660.435187] Starting dynamic subtest: vcs0
[661.725812] Dynamic subtest vcs0: SUCCESS (1.302s)
[661.739462] Starting dynamic subtest: vcs1
[663.706852] Dynamic subtest vcs1: SUCCESS (1.980s)
[663.719721] Starting dynamic subtest: vecs0
[665.685327] Dynamic subtest vecs0: SUCCESS (1.977s)
[665.699050] Starting dynamic subtest: ccs0
[665.709785] Dynamic subtest ccs0: SUCCESS (0.023s)
[665.712134] Subtest engines-hostile-preempt: SUCCESS (5.437s)
[665.827487] [116/133] (362s left) api_intel_bb (lot-of-buffers)
[665.879373] Starting subtest: lot-of-buffers
[666.975574] Subtest lot-of-buffers: SUCCESS (1.098s)
[667.773009] [117/133] (360s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[667.880997] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[667.885300] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[667.979265] [118/133] (360s left) dmabuf_sync_file (import-multiple-read-write)
[668.020888] Starting subtest: import-multiple-read-write
[668.030474] Subtest import-multiple-read-write: SUCCESS (0.014s)
[668.088979] [119/133] (360s left) kms_flip (dpms-vs-vblank-race)
[668.196608] Starting subtest: dpms-vs-vblank-race
[668.199178] Starting dynamic subtest: A-eDP1
[672.090405] Dynamic subtest A-eDP1: SUCCESS (3.894s)
[672.101908] Starting dynamic subtest: B-eDP1
[675.613281] Dynamic subtest B-eDP1: SUCCESS (3.517s)
[675.626958] Starting dynamic subtest: C-eDP1
[680.236412] Dynamic subtest C-eDP1: SUCCESS (4.623s)
[680.247741] Starting dynamic subtest: D-eDP1
[684.866335] Dynamic subtest D-eDP1: SUCCESS (4.627s)
[684.868701] Subtest dpms-vs-vblank-race: SUCCESS (16.677s)
[685.764346] [120/133] (342s left) gem_ctx_shared (q-out-order)
[685.828889] Starting subtest: Q-out-order
[685.831290] Starting dynamic subtest: rcs0
[685.939788] Dynamic subtest rcs0: SUCCESS (0.108s)
[685.961351] Starting dynamic subtest: vcs0
[686.030990] Dynamic subtest vcs0: SUCCESS (0.092s)
[686.051128] Starting dynamic subtest: vcs1
[686.114830] Dynamic subtest vcs1: SUCCESS (0.083s)
[686.132725] Starting dynamic subtest: vecs0
[686.194288] Dynamic subtest vecs0: SUCCESS (0.079s)
[686.214940] Starting dynamic subtest: ccs0
[686.292146] Dynamic subtest ccs0: SUCCESS (0.097s)
[686.294836] Subtest Q-out-order: SUCCESS (0.464s)
[687.797308] [121/133] (340s left) kms_content_protection (type1)
[687.939789] Starting subtest: type1
[687.943844] Subtest type1: SKIP (0.000s)
[688.072233] [122/133] (340s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[688.178504] Starting subtest: x-tiled-addfb-size-offset-overflow
[688.180657] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[688.274518] [123/133] (340s left) gem_exec_schedule (preemptive-hang)
[688.453319] Starting subtest: preemptive-hang
[688.456167] Starting dynamic subtest: rcs0
[697.864072] Dynamic subtest rcs0: SUCCESS (9.410s)
[697.875113] Starting dynamic subtest: bcs0
[706.885210] Dynamic subtest bcs0: SUCCESS (9.021s)
[706.897524] Starting dynamic subtest: vcs0
[715.845368] Dynamic subtest vcs0: SUCCESS (8.955s)
[715.859293] Starting dynamic subtest: vcs1
[724.867810] Dynamic subtest vcs1: SUCCESS (9.019s)
[724.880980] Starting dynamic subtest: vecs0
[733.828693] Dynamic subtest vecs0: SUCCESS (8.957s)
[733.841586] Starting dynamic subtest: ccs0
[742.789085] Dynamic subtest ccs0: SUCCESS (8.958s)
[742.791491] Subtest preemptive-hang: SUCCESS (54.329s)
[743.107063] [124/133] (285s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[743.215119] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[743.219353] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[743.300818] [125/133] (285s left) kms_cursor_crc (cursor-random-256x85)
[743.561504] Starting subtest: cursor-random-256x85
[743.610220] Subtest cursor-random-256x85: SKIP (0.044s)
[743.792714] [126/133] (285s left) kms_plane_multiple (tiling-4)
[743.890477] Starting subtest: tiling-4
[743.892835] Starting dynamic subtest: pipe-A-eDP-1
[747.687954] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.794s)
[747.699749] Starting dynamic subtest: pipe-B-eDP-1
[752.039457] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.350s)
[752.050288] Starting dynamic subtest: pipe-C-eDP-1
[756.359823] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.320s)
[756.370764] Starting dynamic subtest: pipe-D-eDP-1
[760.707068] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.345s)
[760.709523] Subtest tiling-4: SUCCESS (16.815s)
[761.519096] [127/133] (267s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[761.612670] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[761.615103] Starting dynamic subtest: pipe-A-eDP-1
[761.636015] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[761.649049] Starting dynamic subtest: pipe-B-eDP-1
[761.669352] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[761.679992] Starting dynamic subtest: pipe-C-eDP-1
[761.699679] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[761.709740] Starting dynamic subtest: pipe-D-eDP-1
[761.729828] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[761.732095] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[763.877861] [128/133] (265s left) prime_vgem (fence-wait)
[763.963093] Starting subtest: fence-wait
[763.965308] Starting dynamic subtest: rcs0
[765.005930] Dynamic subtest rcs0: SUCCESS (1.042s)
[765.018363] Starting dynamic subtest: bcs0
[766.057823] Dynamic subtest bcs0: SUCCESS (1.050s)
[766.071212] Starting dynamic subtest: vcs0
[767.101661] Dynamic subtest vcs0: SUCCESS (1.042s)
[767.114830] Starting dynamic subtest: vcs1
[768.143324] Dynamic subtest vcs1: SUCCESS (1.039s)
[768.156729] Starting dynamic subtest: vecs0
[769.185012] Dynamic subtest vecs0: SUCCESS (1.039s)
[769.198375] Starting dynamic subtest: ccs0
[770.230881] Dynamic subtest ccs0: SUCCESS (1.043s)
[770.233512] Subtest fence-wait: SUCCESS (6.267s)
[770.375806] [129/133] (258s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[770.488664] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[770.492670] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[770.570350] [130/133] (258s left) kms_psr (fbc-psr2-sprite-plane-move)
[770.651748] Starting subtest: fbc-psr2-sprite-plane-move
[770.654127] Starting dynamic subtest: eDP-1
[770.658744] Dynamic subtest eDP-1: SKIP (0.000s)
[770.663276] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[770.724766] [131/133] (258s left) prime_vgem (coherency-gtt)
[770.789735] Starting subtest: coherency-gtt
[770.794312] Subtest coherency-gtt: SKIP (0.000s)
[770.895213] [132/133] (258s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[770.941464] Starting subtest: etime-multi-wait-all-submitted-signaled
[771.048510] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[771.132589] [133/133] (258s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[771.198033] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[771.266863] Closing watchdogs
results: parsing output: 0/ for test: i915_drm_fdinfo
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_vblank
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: i915_pm_rc6_residency
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: vgem_basic
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: gem_exec_flush
results: parsing output: 11/ for test: gem_spin_batch
results: parsing output: 12/ for test: gem_exec_create
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: vgem_basic
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_cursor_edge_walk
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_async_flips
results: parsing output: 22/ for test: kms_scaling_modes
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: gem_compute
results: parsing output: 26/ for test: gem_fence_thrash
results: parsing output: 27/ for test: kms_draw_crc
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_busy
results: parsing output: 31/ for test: perf_pmu
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_store
results: parsing output: 35/ for test: gem_exec_capture
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_exec_whisper
results: parsing output: 38/ for test: vgem_basic
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: api_intel_bb
results: parsing output: 43/ for test: kms_chamelium_frames
results: parsing output: 44/ for test: fbdev
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_eio
results: parsing output: 47/ for test: gem_ctx_create
results: parsing output: 48/ for test: kms_selftest
results: parsing output: 49/ for test: kms_hdr
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: gen9_exec_parse
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_pipe_stress
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: gem_ctx_param
results: parsing output: 61/ for test: kms_atomic
results: parsing output: 62/ for test: gem_pxp
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: kms_chamelium_hpd
results: parsing output: 67/ for test: kms_rotation_crc
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: perf
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: kms_color
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: gem_partial_pwrite_pread
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_hdr
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: gem_exec_parallel
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: gen3_render_tiledy_blits
results: parsing output: 87/ for test: i915_hangman
results: parsing output: 88/ for test: drm_read
results: parsing output: 89/ for test: i915_suspend
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: sysfs_heartbeat_interval
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: gem_exec_await
results: parsing output: 99/ for test: gem_vm_create
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: prime_mmap
results: parsing output: 106/ for test: kms_prop_blob
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: gem_render_copy
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: dmabuf_sync_file
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: gem_ctx_shared
results: parsing output: 120/ for test: kms_content_protection
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: prime_vgem
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: prime_vgem
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: gem_mmap_gtt
Done.