[61.760442] Initializing watchdogs
[61.760487]   /dev/watchdog0
[61.773661] [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]
[61.777858] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.780248] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.784136] [001/133] (960s left) kms_big_fb (linear-64bpp-rotate-0)
[61.913290] Starting subtest: linear-64bpp-rotate-0
[63.498331] Subtest linear-64bpp-rotate-0: SUCCESS (1.582s)
[63.684083] [002/133] (958s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[63.768259] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[63.772713] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[63.848979] [003/133] (958s left) gem_exec_balancer (persistence)
[64.111056] Starting subtest: persistence
[65.049372] Subtest persistence: SUCCESS (0.935s)
[65.192015] [004/133] (957s left) gem_ctx_shared (disjoint-timelines)
[65.261522] Starting subtest: disjoint-timelines
[65.305366] Subtest disjoint-timelines: SUCCESS (0.047s)
[65.565973] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[65.569069] [005/133] (956s left) gen9_exec_parse (bb-secure)
[65.624046] Subtest bb-secure: SKIP (0.000s)
[65.698218] [006/133] (956s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[65.803398] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[70.252286] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.446s)
[71.394211] [007/133] (951s left) kms_cursor_crc (cursor-onscreen-512x170)
[71.676181] Starting subtest: cursor-onscreen-512x170
[71.680122] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[71.832955] [008/133] (950s left) gem_ctx_persistence (engines-mixed-process)
[71.882368] Starting subtest: engines-mixed-process
[71.884568] Starting dynamic subtest: rcs0
[73.919229] Dynamic subtest rcs0: SUCCESS (2.037s)
[73.929184] Starting dynamic subtest: bcs0
[75.956365] Dynamic subtest bcs0: SUCCESS (2.035s)
[75.965948] Starting dynamic subtest: vcs0
[77.924853] Dynamic subtest vcs0: SUCCESS (1.967s)
[77.933925] Starting dynamic subtest: vcs1
[79.923203] Dynamic subtest vcs1: SUCCESS (1.997s)
[79.933273] Starting dynamic subtest: vecs0
[81.901879] Dynamic subtest vecs0: SUCCESS (1.977s)
[81.911936] Starting dynamic subtest: ccs0
[83.884943] Dynamic subtest ccs0: SUCCESS (1.979s)
[83.887370] Subtest engines-mixed-process: SUCCESS (11.998s)
[83.977847] [009/133] (938s left) kms_plane (pixel-format-yf-tiled-modifier)
[84.080932] Starting subtest: pixel-format-yf-tiled-modifier
[84.094455] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[84.164732] [010/133] (938s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[84.262705] Starting subtest: y-tiled-8bpp-rotate-90
[84.266968] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[84.370126] [011/133] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[84.467672] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[84.472435] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[84.602741] [012/133] (938s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[84.701706] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[84.704094] Starting dynamic subtest: pipe-A-eDP-1
[84.728271] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[84.738290] Starting dynamic subtest: pipe-B-eDP-1
[84.759734] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[84.766416] Starting dynamic subtest: pipe-C-eDP-1
[84.788043] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[84.794713] Starting dynamic subtest: pipe-D-eDP-1
[84.816759] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[84.821200] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s)
[86.952543] [013/133] (935s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[87.063556] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[87.067652] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[87.196602] [014/133] (935s left) gem_mmap_gtt (big-copy)
[87.257725] Subtest big-copy: SKIP (0.000s)
[87.323849] [015/133] (935s left) gem_ctx_param (set-priority-not-supported)
[87.381634] Starting subtest: set-priority-not-supported
[87.386204] Subtest set-priority-not-supported: SKIP (0.000s)
[87.466428] [016/133] (935s left) kms_pm_backlight (fade)
[87.565996] Starting subtest: fade
[87.614379] Starting dynamic subtest: eDP-1
[90.290460] Dynamic subtest eDP-1: SUCCESS (2.675s)
[90.292753] Subtest fade: SUCCESS (2.725s)
[91.182092] [017/133] (931s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[91.290100] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[91.294263] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[91.419349] [018/133] (931s left) kms_cursor_crc (cursor-sliding-512x512)
[91.699153] Starting subtest: cursor-sliding-512x512
[91.703825] Subtest cursor-sliding-512x512: SKIP (0.001s)
[91.892697] [019/133] (931s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[92.000472] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[92.004600] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[92.125472] [020/133] (930s left) kms_flip (flip-vs-expired-vblank-interruptible)
[92.215056] Starting subtest: flip-vs-expired-vblank-interruptible
[92.217096] Starting dynamic subtest: A-eDP1
[100.878949] Dynamic subtest A-eDP1: SUCCESS (8.661s)
[100.888745] Starting dynamic subtest: B-eDP1
[109.508699] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[109.517867] Starting dynamic subtest: C-eDP1
[118.126704] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[118.134122] Starting dynamic subtest: D-eDP1
[126.755518] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[126.760432] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.541s)
[127.945746] [021/133] (895s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[128.057103] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[128.061615] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[128.170637] [022/133] (894s left) sw_sync (alloc_timeline)
[128.203024] Starting subtest: alloc_timeline
[128.204960] Subtest alloc_timeline: SUCCESS (0.000s)
[128.284670] [023/133] (894s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[128.340412] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[128.342855] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[128.440192] [024/133] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[128.538464] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[128.543066] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[128.670948] [025/133] (894s left) perf_pmu (semaphore-wait-idle)
[128.721521] Starting subtest: semaphore-wait-idle
[128.723862] Starting dynamic subtest: rcs0
[129.237225] Dynamic subtest rcs0: SUCCESS (0.513s)
[129.248144] Starting dynamic subtest: bcs0
[129.752420] Dynamic subtest bcs0: SUCCESS (0.513s)
[129.763278] Starting dynamic subtest: vcs0
[130.267095] Dynamic subtest vcs0: SUCCESS (0.513s)
[130.277830] Starting dynamic subtest: vcs1
[130.779100] Dynamic subtest vcs1: SUCCESS (0.511s)
[130.787629] Starting dynamic subtest: vecs0
[131.293678] Dynamic subtest vecs0: SUCCESS (0.513s)
[131.305612] Starting dynamic subtest: ccs0
[131.808328] Dynamic subtest ccs0: SUCCESS (0.513s)
[131.811280] Subtest semaphore-wait-idle: SUCCESS (3.086s)
[133.049859] [026/133] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[133.162196] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[139.911584] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.751s)
[140.085225] [027/133] (883s left) kms_vblank (accuracy-idle)
[140.177376] Starting subtest: accuracy-idle
[140.179583] Starting dynamic subtest: pipe-A-eDP-1
[141.947258] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.768s)
[141.960120] Starting dynamic subtest: pipe-D-eDP-1
[144.405319] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.457s)
[144.407727] Subtest accuracy-idle: SUCCESS (4.227s)
[145.232966] [028/133] (878s left) gem_pread (self)
[145.294464] Subtest self: SKIP (0.000s)
[145.351508] [029/133] (878s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[145.754711] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[146.537627] [030/133] (876s left) kms_addfb_basic (invalid-set-prop-any)
[146.596948] Starting subtest: invalid-set-prop-any
[146.599204] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[146.754139] [031/133] (876s left) kms_psr (psr-sprite-render)
[146.856221] Starting subtest: psr-sprite-render
[146.858513] Starting dynamic subtest: eDP-1
[148.577464] Dynamic subtest eDP-1: SUCCESS (1.721s)
[148.579460] Subtest psr-sprite-render: SUCCESS (1.722s)
[149.432608] [032/133] (874s left) gem_mmap_gtt (coherency)
[149.495896] Subtest coherency: SKIP (0.000s)
[149.568242] [033/133] (874s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[149.666498] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[149.670629] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[149.795869] [034/133] (873s left) kms_flip (flip-vs-modeset-vs-hang)
[149.884997] Starting subtest: flip-vs-modeset-vs-hang
[149.887319] Starting dynamic subtest: A-eDP1
[201.391910] Dynamic subtest A-eDP1: SUCCESS (51.503s)
[201.403213] Starting dynamic subtest: D-eDP1
[250.350680] Dynamic subtest D-eDP1: SUCCESS (48.955s)
[250.353020] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.464s)
[250.728712] [035/133] (772s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[250.839407] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[250.850356] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[250.945802] [036/133] (772s left) syncobj_timeline (signal-point-0)
[251.007913] Starting subtest: signal-point-0
[251.010193] Subtest signal-point-0: SUCCESS (0.000s)
[251.125176] [037/133] (772s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[251.227182] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[251.229601] Starting dynamic subtest: pipe-A-eDP-1
[251.343014] Dynamic subtest pipe-A-eDP-1: SKIP (0.121s)
[251.353993] Starting dynamic subtest: pipe-B-eDP-1
[252.488546] Dynamic subtest pipe-B-eDP-1: SKIP (1.142s)
[252.493209] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.265s)
[253.785293] [038/133] (770s left) gem_ctx_persistence (userptr)
[253.848486] Starting subtest: userptr
[254.109350] Subtest userptr: SUCCESS (0.261s)
[254.199145] [039/133] (769s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[254.301226] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[254.305830] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[255.418649] [040/133] (768s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[255.520859] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[259.152865] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.636s)
[260.329371] [041/133] (763s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[260.459990] Starting subtest: basic-flip-after-cursor-atomic
[261.375508] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.916s)
[262.253626] [042/133] (761s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[262.362046] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[262.366164] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[262.496756] [043/133] (761s left) gem_ccs (block-multicopy-compressed)
[262.574737] Starting subtest: block-multicopy-compressed
[262.579288] Subtest block-multicopy-compressed: SKIP (0.000s)
[262.693805] [044/133] (761s left) kms_flip (plain-flip-ts-check)
[262.795923] Starting subtest: plain-flip-ts-check
[262.798261] Starting dynamic subtest: A-eDP1
[271.632055] Dynamic subtest A-eDP1: SUCCESS (8.835s)
[271.644521] Starting dynamic subtest: B-eDP1
[280.461405] Dynamic subtest B-eDP1: SUCCESS (8.827s)
[280.471486] Starting dynamic subtest: C-eDP1
[289.280318] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[289.288814] Starting dynamic subtest: D-eDP1
[298.113197] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[298.118243] Subtest plain-flip-ts-check: SUCCESS (35.322s)
[299.295318] [045/133] (724s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[299.697483] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[300.514045] [046/133] (723s left) gem_exec_flush (basic-wb-ro-before-default)
[300.567977] Starting subtest: basic-wb-ro-before-default
[306.057163] Subtest basic-wb-ro-before-default: SUCCESS (5.490s)
[306.255402] [047/133] (717s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[306.316886] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[306.374926] [048/133] (717s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[306.436141] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[306.497950] [049/133] (717s left) dmabuf_sync_file (export-multiwait)
[306.548455] Starting subtest: export-multiwait
[306.550465] Subtest export-multiwait: SUCCESS (0.000s)
[306.619151] [050/133] (717s left) i915_drm_fdinfo (virtual-busy-hang-all)
[306.657314] Starting subtest: virtual-busy-hang-all
[306.661534] Subtest virtual-busy-hang-all: SKIP (0.000s)
[306.741444] [051/133] (717s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[306.850970] Starting subtest: fbcpsr-slowdraw
[332.031073] Subtest fbcpsr-slowdraw: SUCCESS (25.185s)
[332.202226] [052/133] (692s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[332.301795] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[332.305824] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[332.431237] [053/133] (691s left) gem_mmap_wc (read-write)
[332.491099] Subtest read-write: SKIP (0.000s)
[332.549691] [054/133] (691s left) syncobj_timeline (invalid-signal-illegal-point)
[332.600169] Starting subtest: invalid-signal-illegal-point
[332.602434] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[332.712833] [055/133] (691s left) kms_cursor_crc (cursor-random-64x64)
[332.904341] Starting subtest: cursor-random-64x64
[332.908446] Starting dynamic subtest: pipe-A-eDP-1
[336.297347] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.387s)
[336.335679] Starting dynamic subtest: pipe-D-eDP-1
[340.348692] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.018s)
[340.350763] Subtest cursor-random-64x64: SUCCESS (7.442s)
[341.168176] [056/133] (683s left) kms_force_connector_basic (prune-stale-modes)
[341.255627] Starting subtest: prune-stale-modes
[341.699071] Subtest prune-stale-modes: SUCCESS (0.443s)
[341.841642] [057/133] (682s left) gem_lmem_swapping (basic)
[341.879679] Subtest basic: SKIP (0.000s)
[341.918370] [058/133] (682s left) kms_properties (crtc-properties-legacy)
[342.006805] Starting subtest: crtc-properties-legacy
[342.008790] Starting dynamic subtest: pipe-A-eDP-1
[342.457138] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s)
[342.465894] Starting dynamic subtest: pipe-B-eDP-1
[343.621747] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s)
[343.629849] Starting dynamic subtest: pipe-C-eDP-1
[344.739854] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[344.753842] Starting dynamic subtest: pipe-D-eDP-1
[345.874053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[345.876358] Subtest crtc-properties-legacy: SUCCESS (3.865s)
[346.709415] [059/133] (677s left) kms_hdr (brightness-with-hdr)
[346.833134] Starting subtest: brightness-with-hdr
[346.839603] Subtest brightness-with-hdr: SKIP (0.000s)
[346.924354] [060/133] (677s left) kms_lease (empty-lease)
[347.031774] Starting subtest: empty-lease
[347.034133] Starting dynamic subtest: pipe-A-eDP-1
[347.036319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[347.044731] Starting dynamic subtest: pipe-B-eDP-1
[347.046786] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[347.054764] Starting dynamic subtest: pipe-C-eDP-1
[347.056798] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[347.064642] Starting dynamic subtest: pipe-D-eDP-1
[347.066730] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[347.068778] Subtest empty-lease: SUCCESS (0.009s)
[347.183683] [061/133] (677s left) kms_invalid_mode (overflow-vrefresh)
[347.284205] Starting subtest: overflow-vrefresh
[347.286384] Starting dynamic subtest: pipe-A-eDP-1
[347.573256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[347.582535] Starting dynamic subtest: pipe-B-eDP-1
[347.584828] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[347.594536] Starting dynamic subtest: pipe-C-eDP-1
[347.596344] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[347.603653] Starting dynamic subtest: pipe-D-eDP-1
[347.605512] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[347.607321] Subtest overflow-vrefresh: SUCCESS (0.295s)
[348.419931] [062/133] (676s left) gem_softpin (evict-active-interruptible)
[348.483744] Starting subtest: evict-active-interruptible
[348.489434] Subtest evict-active-interruptible: SUCCESS (0.006s)
[348.611691] [063/133] (676s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[348.714417] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[348.727369] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[348.796358] [064/133] (676s left) kms_content_protection (dp-mst-type-0-hdcp14)
[348.935786] Starting subtest: dp-mst-type-0-hdcp14
[348.940299] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[349.087188] [065/133] (675s left) kms_pm_rpm (pm-caching)
[351.117890] Starting subtest: pm-caching
[351.123215] Subtest pm-caching: SKIP (0.000s)
[351.500492] [066/133] (673s left) syncobj_basic (create-signaled)
[351.558452] Starting subtest: create-signaled
[351.560380] Subtest create-signaled: SUCCESS (0.000s)
[351.691533] [067/133] (673s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[351.807006] Starting subtest: cursor-vs-flip-legacy
[381.066641] Subtest cursor-vs-flip-legacy: SUCCESS (29.256s)
[381.916405] [068/133] (643s left) prime_mmap (test_map_unmap)
[381.978762] Starting subtest: test_map_unmap
[381.981044] Starting dynamic subtest: test_map_unmap-smem
[382.028805] Dynamic subtest test_map_unmap-smem: SUCCESS (0.052s)
[382.031567] Subtest test_map_unmap: SUCCESS (0.053s)
[382.166169] [069/133] (642s left) perf (whitelisted-registers-userspace-config)
[382.294135] Starting subtest: whitelisted-registers-userspace-config
[382.296253] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[382.331290] [070/133] (642s left) gem_eio (wait-1us)
[382.557939] Starting subtest: wait-1us
[382.923274] Subtest wait-1us: SUCCESS (0.365s)
[383.075309] [071/133] (642s left) gem_exec_gttfill (engines)
[383.138778] Starting subtest: engines
[383.140722] Starting dynamic subtest: rcs0
[406.083064] Dynamic subtest rcs0: SUCCESS (22.941s)
[406.095737] Starting dynamic subtest: bcs0
[429.425444] Dynamic subtest bcs0: SUCCESS (23.339s)
[429.435817] Starting dynamic subtest: vcs0
[452.705572] Dynamic subtest vcs0: SUCCESS (23.276s)
[452.717204] Starting dynamic subtest: vcs1
[476.023070] Dynamic subtest vcs1: SUCCESS (23.315s)
[476.035368] Starting dynamic subtest: vecs0
[499.324665] Dynamic subtest vecs0: SUCCESS (23.298s)
[499.336262] Starting dynamic subtest: ccs0
[522.638928] Dynamic subtest ccs0: SUCCESS (23.312s)
[522.641745] Subtest engines: SUCCESS (139.495s)
[522.839632] [072/133] (502s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[522.988797] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[529.946349] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.960s)
[530.118866] [073/133] (495s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[530.218062] Starting subtest: plane-lut1d-ctm3x4-lut1d
[530.230649] Starting dynamic subtest: pipe-A-eDP-1
[530.939578] Dynamic subtest pipe-A-eDP-1: FAIL (0.310s)
[531.609363] Starting dynamic subtest: pipe-B-eDP-1
[532.442589] Dynamic subtest pipe-B-eDP-1: FAIL (0.306s)
[532.942015] Starting dynamic subtest: pipe-C-eDP-1
[533.793428] Dynamic subtest pipe-C-eDP-1: FAIL (0.268s)
[534.271618] Starting dynamic subtest: pipe-D-eDP-1
[535.146250] Dynamic subtest pipe-D-eDP-1: FAIL (0.279s)
[535.148626] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.616s)
[535.664414] [074/133] (489s left) gem_userptr_blits (map-fixed-invalidate-busy)
[535.733128] Starting subtest: map-fixed-invalidate-busy
[535.737067] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[535.886543] [075/133] (489s left) gem_exec_balancer (hog)
[535.966034] Starting subtest: hog
[535.970638] Subtest hog: SKIP (0.000s)
[536.283237] [076/133] (489s left) syncobj_timeline (multi-wait-for-submit-signaled)
[536.341463] Starting subtest: multi-wait-for-submit-signaled
[536.343675] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[536.463568] [077/133] (488s left) core_getclient (basic)
[536.519065] Starting subtest: basic
[536.521317] Subtest basic: SUCCESS (0.000s)
[536.628414] [078/133] (488s left) kms_vrr (flip-dpms)
[536.725287] Starting subtest: flip-dpms
[536.732044] Subtest flip-dpms: SKIP (0.000s)
[536.820976] [079/133] (488s left) kms_psr (pr-suspend)
[536.922821] Starting subtest: pr-suspend
[536.927083] Subtest pr-suspend: SKIP (0.000s)
[537.008912] [080/133] (488s left) i915_pm_rc6_residency (rc6-fence)
[537.060890] Starting subtest: rc6-fence
[537.094485] Starting dynamic subtest: gt0
[549.412180] Dynamic subtest gt0: SUCCESS (12.317s)
[549.423094] Starting dynamic subtest: gt1
[562.901223] Dynamic subtest gt1: SUCCESS (13.486s)
[562.903964] Subtest rc6-fence: SUCCESS (25.842s)
[563.008258] [081/133] (462s left) kms_chamelium_audio (dp-audio-edid)
[563.401131] Subtest dp-audio-edid: SKIP (0.000s)
[564.257502] [082/133] (461s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[564.356915] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[564.360962] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[564.441815] [083/133] (461s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[564.545110] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[564.547317] Starting dynamic subtest: pipe-A-eDP-1
[564.569993] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[564.581166] Starting dynamic subtest: pipe-B-eDP-1
[564.602058] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[564.610794] Starting dynamic subtest: pipe-C-eDP-1
[564.631838] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[564.640889] Starting dynamic subtest: pipe-D-eDP-1
[564.664751] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[564.668950] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[566.849301] [084/133] (458s left) prime_vgem (fence-read-hang)
[566.942907] Subtest fence-read-hang: SKIP (0.000s)
[567.069173] [085/133] (458s left) i915_drm_fdinfo (busy-hang)
[567.107243] Starting subtest: busy-hang
[567.109521] Starting dynamic subtest: rcs0
[567.147256] Dynamic subtest rcs0: SKIP (0.037s)
[567.158189] Starting dynamic subtest: bcs0
[567.162754] Dynamic subtest bcs0: SKIP (0.001s)
[567.174050] Starting dynamic subtest: vcs0
[567.178820] Dynamic subtest vcs0: SKIP (0.000s)
[567.189867] Starting dynamic subtest: vcs1
[567.194257] Dynamic subtest vcs1: SKIP (0.001s)
[567.203903] Starting dynamic subtest: vecs0
[567.208234] Dynamic subtest vecs0: SKIP (0.000s)
[567.216783] Starting dynamic subtest: ccs0
[567.221112] Dynamic subtest ccs0: SKIP (0.001s)
[567.225192] Subtest busy-hang: SKIP (0.045s)
[567.261163] [086/133] (458s left) gem_exec_schedule (u-semaphore-user)
[567.340032] Starting subtest: u-semaphore-user
[567.387727] Subtest u-semaphore-user: SUCCESS (0.057s)
[568.982757] [087/133] (456s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[569.049260] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[569.053296] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[569.243232] [088/133] (456s left) perf_pmu (render-node-busy-idle)
[569.307675] Starting subtest: render-node-busy-idle
[569.310080] Starting dynamic subtest: rcs0
[570.016257] Dynamic subtest rcs0: SUCCESS (0.708s)
[570.027439] Starting dynamic subtest: bcs0
[570.690197] Dynamic subtest bcs0: SUCCESS (0.671s)
[570.700785] Starting dynamic subtest: vcs0
[571.926428] Dynamic subtest vcs0: SUCCESS (1.233s)
[571.936897] Starting dynamic subtest: vcs1
[573.911284] Dynamic subtest vcs1: SUCCESS (1.981s)
[573.923284] Starting dynamic subtest: vecs0
[575.895387] Dynamic subtest vecs0: SUCCESS (1.981s)
[575.907292] Starting dynamic subtest: ccs0
[576.567477] Dynamic subtest ccs0: SUCCESS (0.671s)
[576.569979] Subtest render-node-busy-idle: SUCCESS (7.260s)
[576.668138] [089/133] (449s left) vgem_slow (nohang)
[576.719206] Starting subtest: nohang
[586.868049] Subtest nohang: SUCCESS (10.148s)
[586.948832] [090/133] (438s left) i915_pm_rps (waitboost)
[587.022436] Starting subtest: waitboost
[593.397773] Subtest waitboost: SUCCESS (6.373s)
[593.488234] [091/133] (432s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[593.592779] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[593.595091] Starting dynamic subtest: pipe-A-eDP-1
[610.052124] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.301s)
[610.062406] Starting dynamic subtest: pipe-B-eDP-1
[627.080719] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.376s)
[627.091098] Starting dynamic subtest: pipe-C-eDP-1
[644.021244] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.382s)
[644.032240] Starting dynamic subtest: pipe-D-eDP-1
[661.035616] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.368s)
[661.038171] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (9.432s)
[662.324582] [092/133] (363s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[662.424725] Starting subtest: fbc-psr-cursor-mmap-gtt
[662.427314] Starting dynamic subtest: eDP-1
[662.432871] Dynamic subtest eDP-1: SKIP (0.000s)
[662.438163] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[662.514163] [093/133] (363s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[662.623072] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[662.627908] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[662.740804] [094/133] (363s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[662.838986] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[662.843325] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[662.955638] [095/133] (363s left) kms_vrr (seamless-rr-switch-drrs)
[663.040392] Starting subtest: seamless-rr-switch-drrs
[663.048145] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[663.126711] [096/133] (363s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[663.216076] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[663.221117] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[663.358680] [097/133] (362s left) kms_getfb (getfb-handle-not-fb)
[663.456169] Starting subtest: getfb-handle-not-fb
[663.458585] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[663.560498] [098/133] (362s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[663.665854] Starting subtest: yf-tiled-16bpp-rotate-270
[663.670105] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[663.781686] [099/133] (362s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[663.873763] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[664.520143] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s)
[664.685628] [100/133] (361s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[664.800048] Starting subtest: flip-vs-cursor-legacy
[672.002922] Subtest flip-vs-cursor-legacy: SUCCESS (7.126s)
[672.884805] [101/133] (353s left) kms_psr (fbc-psr2-basic)
[672.974280] Starting subtest: fbc-psr2-basic
[672.977077] Starting dynamic subtest: eDP-1
[672.982119] Dynamic subtest eDP-1: SKIP (0.000s)
[672.987159] Subtest fbc-psr2-basic: SKIP (0.001s)
[673.063095] [102/133] (353s left) gem_softpin (full)
[673.129134] Starting subtest: full
[673.137982] Subtest full: SUCCESS (0.009s)
[673.278163] [103/133] (353s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[673.377090] Starting subtest: x-tiled-8bpp-rotate-270
[673.401191] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s)
[673.526269] [104/133] (352s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[673.616676] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[673.618985] Starting dynamic subtest: pipe-A
[673.637003] Dynamic subtest pipe-A: SKIP (0.015s)
[673.647002] Starting dynamic subtest: pipe-B
[673.664894] Dynamic subtest pipe-B: SKIP (0.028s)
[673.674741] Starting dynamic subtest: pipe-C
[673.692824] Dynamic subtest pipe-C: SKIP (0.028s)
[673.702646] Starting dynamic subtest: pipe-D
[673.723168] Dynamic subtest pipe-D: SKIP (0.030s)
[673.727113] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.105s)
[673.839017] [105/133] (352s left) gem_close_race (basic-threads)
[673.903844] Starting subtest: basic-threads
[675.288724] Subtest basic-threads: SUCCESS (1.377s)
[675.487764] [106/133] (351s left) syncobj_wait (multi-wait-submitted)
[675.553474] Starting subtest: multi-wait-submitted
[675.654869] Subtest multi-wait-submitted: SUCCESS (0.102s)
[675.756968] [107/133] (350s left) gem_wait (await)
[675.818647] Starting subtest: await
[675.821343] Starting dynamic subtest: all-engines
[676.950725] Dynamic subtest all-engines: SUCCESS (1.127s)
[676.968533] Starting dynamic subtest: rcs0
[678.021875] Dynamic subtest rcs0: SUCCESS (1.065s)
[678.040375] Starting dynamic subtest: bcs0
[679.086303] Dynamic subtest bcs0: SUCCESS (1.059s)
[679.104275] Starting dynamic subtest: vcs0
[680.145039] Dynamic subtest vcs0: SUCCESS (1.054s)
[680.163109] Starting dynamic subtest: vcs1
[681.203089] Dynamic subtest vcs1: SUCCESS (1.053s)
[681.220500] Starting dynamic subtest: vecs0
[682.263547] Dynamic subtest vecs0: SUCCESS (1.055s)
[682.279619] Starting dynamic subtest: ccs0
[683.328313] Dynamic subtest ccs0: SUCCESS (1.060s)
[683.331417] Subtest await: SUCCESS (7.490s)
[683.538693] [108/133] (343s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[683.597539] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[683.703337] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[683.801554] [109/133] (342s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[683.935466] Starting subtest: cursor-vs-flip-toggle
[714.657220] Subtest cursor-vs-flip-toggle: SUCCESS (30.715s)
[715.462632] [110/133] (311s left) gem_exec_whisper (basic-normal-all)
[715.537548] Starting subtest: basic-normal-all
[717.822150] Subtest basic-normal-all: SUCCESS (2.284s)
[718.017844] [111/133] (308s left) gem_ccs (large-ctrl-surf-copy)
[718.085209] Starting subtest: large-ctrl-surf-copy
[718.090300] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[718.221178] [112/133] (308s left) kms_dsc (dsc-with-bpc)
[718.320344] Starting subtest: dsc-with-bpc
[718.355086] Subtest dsc-with-bpc: SKIP (0.001s)
[718.405766] [113/133] (308s left) gem_mmap_offset (clear-via-pagefault)
[718.470168] Starting subtest: clear-via-pagefault
[718.473041] Starting dynamic subtest: smem0
[748.199293] Dynamic subtest smem0: SUCCESS (29.718s)
[748.201528] Subtest clear-via-pagefault: SUCCESS (29.720s)
[748.312677] [114/133] (278s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[748.426558] Starting subtest: async-flip-with-page-flip-events-tiled
[748.792041] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[751.537952] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.745s)
[751.551082] Starting dynamic subtest: pipe-A-eDP-1-4
[753.779813] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.241s)
[753.797325] Starting dynamic subtest: pipe-A-eDP-1-4
[755.790449] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[755.806981] Starting dynamic subtest: pipe-A-eDP-1-x
[757.992725] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.201s)
[758.377315] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[761.170592] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.803s)
[761.181197] Starting dynamic subtest: pipe-B-eDP-1-4
[763.356117] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[763.367680] Starting dynamic subtest: pipe-B-eDP-1-4
[765.364856] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[765.375704] Starting dynamic subtest: pipe-B-eDP-1-x
[767.565408] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[767.929357] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[770.696538] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[770.710255] Starting dynamic subtest: pipe-C-eDP-1-4
[772.882895] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[772.899959] Starting dynamic subtest: pipe-C-eDP-1-4
[774.892699] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[774.905266] Starting dynamic subtest: pipe-C-eDP-1-x
[777.071007] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[777.435585] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[780.236676] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.809s)
[780.250182] Starting dynamic subtest: pipe-D-eDP-1-4
[782.410984] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[782.424412] Starting dynamic subtest: pipe-D-eDP-1-4
[784.420879] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[784.434030] Starting dynamic subtest: pipe-D-eDP-1-x
[786.599423] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[786.602610] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.176s)
[787.843342] [115/133] (239s left) gem_exec_fence (keep-in-fence)
[788.043744] Starting subtest: keep-in-fence
[788.046050] Starting dynamic subtest: rcs0
[788.096199] Dynamic subtest rcs0: SUCCESS (0.056s)
[788.109431] Starting dynamic subtest: bcs0
[788.151583] Dynamic subtest bcs0: SUCCESS (0.053s)
[788.163406] Starting dynamic subtest: vcs0
[789.779901] Dynamic subtest vcs0: SUCCESS (1.625s)
[789.793665] Starting dynamic subtest: vcs1
[791.763828] Dynamic subtest vcs1: SUCCESS (1.981s)
[791.777095] Starting dynamic subtest: vecs0
[793.747445] Dynamic subtest vecs0: SUCCESS (1.982s)
[793.761272] Starting dynamic subtest: ccs0
[793.986039] Dynamic subtest ccs0: SUCCESS (0.237s)
[793.989108] Subtest keep-in-fence: SUCCESS (5.947s)
[795.916874] [116/133] (231s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[795.992157] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[796.095348] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[796.187753] [117/133] (230s left) kms_properties (colorop-properties-legacy)
[796.301539] Starting subtest: colorop-properties-legacy
[796.303978] Starting dynamic subtest: pipe-A-eDP-1
[796.633956] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.333s)
[796.646001] Starting dynamic subtest: pipe-B-eDP-1
[797.701047] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.064s)
[797.713330] Starting dynamic subtest: pipe-C-eDP-1
[798.743206] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.040s)
[798.759477] Starting dynamic subtest: pipe-D-eDP-1
[799.780858] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.037s)
[799.783010] Subtest colorop-properties-legacy: SUCCESS (3.480s)
[800.589749] [118/133] (226s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[800.652295] Starting subtest: yf-tiled-to-vebox-yf-tiled
[800.658068] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[800.848816] [119/133] (226s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[800.912330] Starting subtest: wait-all-for-submit-delayed-submit
[801.015539] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[801.108660] [120/133] (226s left) prime_self_import (basic-with_one_bo)
[801.155859] Starting subtest: basic-with_one_bo
[801.176061] Subtest basic-with_one_bo: SUCCESS (0.027s)
[801.321753] [121/133] (225s left) gem_mmap_gtt (basic-small-copy)
[801.389595] Subtest basic-small-copy: SKIP (0.000s)
[801.459616] [122/133] (225s left) gem_exec_reloc (basic-cpu-read-noreloc)
[801.527027] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[801.613482] [123/133] (225s left) gem_exec_schedule (preempt-hang)
[801.792941] Starting subtest: preempt-hang
[801.795664] Starting dynamic subtest: rcs0
[802.021191] Dynamic subtest rcs0: SUCCESS (0.228s)
[802.032088] Starting dynamic subtest: bcs0
[802.246055] Dynamic subtest bcs0: SUCCESS (0.223s)
[802.256307] Starting dynamic subtest: vcs0
[802.478532] Dynamic subtest vcs0: SUCCESS (0.228s)
[802.489027] Starting dynamic subtest: vcs1
[802.698797] Dynamic subtest vcs1: SUCCESS (0.221s)
[802.710093] Starting dynamic subtest: vecs0
[802.923941] Dynamic subtest vecs0: SUCCESS (0.223s)
[802.935843] Starting dynamic subtest: ccs0
[803.159768] Dynamic subtest ccs0: SUCCESS (0.239s)
[803.162166] Subtest preempt-hang: SUCCESS (1.368s)
[803.861420] [124/133] (223s left) sysfs_preempt_timeout (timeout)
[803.925309] Starting subtest: timeout
[803.928223] Starting dynamic subtest: vecs0
[813.779773] Dynamic subtest vecs0: SUCCESS (9.849s)
[813.791808] Starting dynamic subtest: ccs0
[815.129234] Dynamic subtest ccs0: SUCCESS (1.348s)
[815.141260] Starting dynamic subtest: vcs0
[824.794071] Dynamic subtest vcs0: SUCCESS (9.660s)
[824.807330] Starting dynamic subtest: bcs0
[826.180413] Dynamic subtest bcs0: SUCCESS (1.383s)
[826.193907] Starting dynamic subtest: rcs0
[827.552739] Dynamic subtest rcs0: SUCCESS (1.372s)
[827.567101] Starting dynamic subtest: vcs1
[836.748015] Dynamic subtest vcs1: SUCCESS (9.191s)
[836.751007] Subtest timeout: SUCCESS (32.813s)
[836.835255] [125/133] (190s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[836.971064] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[836.976268] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[837.117299] [126/133] (190s left) kms_psr (psr2-cursor-render)
[837.212234] Starting subtest: psr2-cursor-render
[837.215035] Starting dynamic subtest: eDP-1
[838.966553] Dynamic subtest eDP-1: SUCCESS (1.754s)
[838.969365] Subtest psr2-cursor-render: SUCCESS (1.755s)
[839.769735] [127/133] (187s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[839.865311] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[839.870180] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[839.959665] [128/133] (187s left) kms_psr (fbc-pr-primary-blt)
[840.073047] Starting subtest: fbc-pr-primary-blt
[840.078531] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[840.165613] [129/133] (187s left) kms_fbcon_fbt (psr-suspend)
[840.229145] Starting subtest: psr-suspend
[889.881317] Subtest psr-suspend: SUCCESS (19.759s)
[889.975004] [130/133] (137s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[890.086975] Starting subtest: stress-xrgb8888-ytiled
[890.091081] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[890.167607] [131/133] (137s left) syncobj_eventfd (timeline-wait-signaled)
[890.238813] Starting subtest: timeline-wait-signaled
[890.240736] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[890.351309] [132/133] (137s left) kms_async_flips (test-time-stamp-atomic)
[890.444561] Starting subtest: test-time-stamp-atomic
[890.942328] Starting dynamic subtest: pipe-A-eDP-1
[891.838313] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.894s)
[892.222854] Starting dynamic subtest: pipe-B-eDP-1
[892.982663] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s)
[893.366622] Starting dynamic subtest: pipe-C-eDP-1
[894.127041] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[894.490058] Starting dynamic subtest: pipe-D-eDP-1
[895.257160] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[895.259554] Subtest test-time-stamp-atomic: SUCCESS (4.815s)
[896.428566] [133/133] (131s left) kms_plane_scaling (invalid-num-scalers)
[896.538137] Starting subtest: invalid-num-scalers
[896.540562] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[896.556322] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[896.566638] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[896.585900] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[896.595689] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[896.616907] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[896.626657] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[896.648195] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[896.649975] Subtest invalid-num-scalers: SUCCESS (0.111s)
[896.778403] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: gem_ctx_shared
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: gem_ctx_param
results: parsing output: 15/ for test: kms_pm_backlight
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: sw_sync
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: gem_pread
results: parsing output: 28/ for test: kms_chamelium_frames
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: gem_ctx_persistence
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_ccs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_chamelium_hpd
results: parsing output: 45/ for test: gem_exec_flush
results: parsing output: 46/ for test: kms_pipe_b_c_ivb
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: dmabuf_sync_file
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_mmap_wc
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: kms_force_connector_basic
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_properties
results: parsing output: 58/ for test: kms_hdr
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: kms_invalid_mode
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: kms_content_protection
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: syncobj_basic
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: prime_mmap
results: parsing output: 68/ for test: perf
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: gem_exec_gttfill
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_color_pipeline
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: core_getclient
results: parsing output: 77/ for test: kms_vrr
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: i915_pm_rc6_residency
results: parsing output: 80/ for test: kms_chamelium_audio
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: prime_vgem
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: vgem_slow
results: parsing output: 89/ for test: i915_pm_rps
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_vrr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_getfb
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: gem_close_race
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: gem_wait
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: gem_ccs
results: parsing output: 111/ for test: kms_dsc
results: parsing output: 112/ for test: gem_mmap_offset
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: kms_properties
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: prime_self_import
results: parsing output: 120/ for test: gem_mmap_gtt
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: sysfs_preempt_timeout
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_fbcon_fbt
results: parsing output: 129/ for test: kms_pipe_stress
results: parsing output: 130/ for test: syncobj_eventfd
results: parsing output: 131/ for test: kms_async_flips
results: parsing output: 132/ for test: kms_plane_scaling
Done.