[59.528164] Initializing watchdogs
[59.528211]   /dev/watchdog0
[59.542665] [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]
[59.547134] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.549326] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.551205] [001/133] (960s left) kms_big_fb (linear-64bpp-rotate-0)
[59.656942] Starting subtest: linear-64bpp-rotate-0
[61.345656] Subtest linear-64bpp-rotate-0: SUCCESS (1.690s)
[61.528925] [002/133] (958s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[61.622273] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[61.624040] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[61.693965] [003/133] (958s left) gem_exec_balancer (persistence)
[61.955238] Starting subtest: persistence
[62.904457] Subtest persistence: SUCCESS (0.946s)
[63.016495] [004/133] (957s left) gem_ctx_shared (disjoint-timelines)
[63.087580] Starting subtest: disjoint-timelines
[63.139542] Subtest disjoint-timelines: SUCCESS (0.052s)
[63.393273] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[63.395363] [005/133] (956s left) gen9_exec_parse (bb-secure)
[63.457995] Subtest bb-secure: SKIP (0.000s)
[63.528720] [006/133] (956s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[63.626926] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[68.626071] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.999s)
[69.765620] [007/133] (950s left) kms_cursor_crc (cursor-onscreen-512x170)
[70.066993] Starting subtest: cursor-onscreen-512x170
[70.069013] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[70.239420] [008/133] (950s left) gem_ctx_persistence (engines-mixed-process)
[70.291143] Starting subtest: engines-mixed-process
[70.292171] Starting dynamic subtest: rcs0
[71.916806] Dynamic subtest rcs0: SUCCESS (1.626s)
[71.926362] Starting dynamic subtest: bcs0
[73.914878] Dynamic subtest bcs0: SUCCESS (1.997s)
[73.923663] Starting dynamic subtest: vcs0
[75.954600] Dynamic subtest vcs0: SUCCESS (2.039s)
[75.963703] Starting dynamic subtest: vcs1
[77.871836] Dynamic subtest vcs1: SUCCESS (1.916s)
[77.880868] Starting dynamic subtest: vecs0
[79.877294] Dynamic subtest vecs0: SUCCESS (2.005s)
[79.885166] Starting dynamic subtest: ccs0
[81.902710] Dynamic subtest ccs0: SUCCESS (2.024s)
[81.904290] Subtest engines-mixed-process: SUCCESS (11.613s)
[82.001767] [009/133] (938s left) kms_plane (pixel-format-yf-tiled-modifier)
[82.106025] Starting subtest: pixel-format-yf-tiled-modifier
[82.110980] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[82.183658] [010/133] (938s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[82.285200] Starting subtest: y-tiled-8bpp-rotate-90
[82.287249] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[82.397051] [011/133] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[82.484819] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[82.486399] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[82.575604] [012/133] (937s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[82.670501] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[82.671484] Starting dynamic subtest: pipe-A-eDP-1
[82.680125] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[82.687633] Starting dynamic subtest: pipe-B-eDP-1
[82.695840] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[82.702223] Starting dynamic subtest: pipe-C-eDP-1
[82.710384] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[82.716361] Starting dynamic subtest: pipe-D-eDP-1
[82.724846] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[82.726445] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s)
[84.901883] [013/133] (935s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[85.003348] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[85.005208] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[85.117037] [014/133] (935s left) gem_mmap_gtt (big-copy)
[85.166799] Subtest big-copy: SKIP (0.000s)
[85.224203] [015/133] (935s left) gem_ctx_param (set-priority-not-supported)
[85.285504] Starting subtest: set-priority-not-supported
[85.287721] Subtest set-priority-not-supported: SKIP (0.000s)
[85.364093] [016/133] (935s left) kms_pm_backlight (fade)
[85.450233] Starting subtest: fade
[85.499831] Starting dynamic subtest: eDP-1
[88.184260] Dynamic subtest eDP-1: SUCCESS (2.684s)
[88.185196] Subtest fade: SUCCESS (2.734s)
[89.025268] [017/133] (931s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[89.122177] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[89.123879] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[89.248106] [018/133] (931s left) kms_cursor_crc (cursor-sliding-512x512)
[89.512042] Starting subtest: cursor-sliding-512x512
[89.514039] Subtest cursor-sliding-512x512: SKIP (0.001s)
[89.699171] [019/133] (930s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[89.786636] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[89.788548] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[89.919061] [020/133] (930s left) kms_flip (flip-vs-expired-vblank-interruptible)
[90.017618] Starting subtest: flip-vs-expired-vblank-interruptible
[90.019839] Starting dynamic subtest: A-eDP1
[98.763531] Dynamic subtest A-eDP1: SUCCESS (8.717s)
[98.775175] Starting dynamic subtest: B-eDP1
[107.397768] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[107.404278] Starting dynamic subtest: C-eDP1
[116.025466] Dynamic subtest C-eDP1: SUCCESS (8.616s)
[116.033483] Starting dynamic subtest: D-eDP1
[124.616918] Dynamic subtest D-eDP1: SUCCESS (8.626s)
[124.619481] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.600s)
[125.798170] [021/133] (894s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[125.891733] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[125.893494] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[126.020786] [022/133] (894s left) sw_sync (alloc_timeline)
[126.057627] Starting subtest: alloc_timeline
[126.058708] Subtest alloc_timeline: SUCCESS (0.000s)
[126.124971] [023/133] (894s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[126.173395] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[126.174389] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[126.299662] [024/133] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[126.389023] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[126.390762] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[126.504059] [025/133] (894s left) perf_pmu (semaphore-wait-idle)
[126.541487] Starting subtest: semaphore-wait-idle
[126.542346] Starting dynamic subtest: rcs0
[127.065467] Dynamic subtest rcs0: SUCCESS (0.513s)
[127.074386] Starting dynamic subtest: bcs0
[127.578411] Dynamic subtest bcs0: SUCCESS (0.512s)
[127.588049] Starting dynamic subtest: vcs0
[128.090905] Dynamic subtest vcs0: SUCCESS (0.511s)
[128.100244] Starting dynamic subtest: vcs1
[128.605050] Dynamic subtest vcs1: SUCCESS (0.513s)
[128.614496] Starting dynamic subtest: vecs0
[129.117484] Dynamic subtest vecs0: SUCCESS (0.511s)
[129.127346] Starting dynamic subtest: ccs0
[129.632361] Dynamic subtest ccs0: SUCCESS (0.513s)
[129.633773] Subtest semaphore-wait-idle: SUCCESS (3.080s)
[130.996412] [026/133] (889s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[131.093188] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[137.972881] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.880s)
[138.140320] [027/133] (882s left) kms_vblank (accuracy-idle)
[138.243242] Starting subtest: accuracy-idle
[138.252054] Starting dynamic subtest: pipe-A-eDP-1
[140.008217] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.763s)
[140.017246] Starting dynamic subtest: pipe-D-eDP-1
[142.436700] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.426s)
[142.437532] Subtest accuracy-idle: SUCCESS (4.194s)
[143.276705] [028/133] (877s left) gem_pread (self)
[143.342350] Subtest self: SKIP (0.000s)
[143.405355] [029/133] (877s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[143.801520] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[144.570200] [030/133] (876s left) kms_addfb_basic (invalid-set-prop-any)
[144.628647] Starting subtest: invalid-set-prop-any
[144.629709] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[144.772405] [031/133] (876s left) kms_psr (psr-sprite-render)
[144.865465] Starting subtest: psr-sprite-render
[144.866356] Starting dynamic subtest: eDP-1
[146.613907] Dynamic subtest eDP-1: SUCCESS (1.749s)
[146.614989] Subtest psr-sprite-render: SUCCESS (1.750s)
[147.474507] [032/133] (873s left) gem_mmap_gtt (coherency)
[147.527627] Subtest coherency: SKIP (0.000s)
[147.591719] [033/133] (873s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[147.700191] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[147.701741] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[147.820763] [034/133] (873s left) kms_flip (flip-vs-modeset-vs-hang)
[147.906051] Starting subtest: flip-vs-modeset-vs-hang
[147.907184] Starting dynamic subtest: A-eDP1
[199.342790] Dynamic subtest A-eDP1: SUCCESS (51.438s)
[199.356444] Starting dynamic subtest: D-eDP1
[249.454120] Dynamic subtest D-eDP1: SUCCESS (50.110s)
[249.457633] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.554s)
[249.863698] [035/133] (771s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[249.980041] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[249.991967] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[250.076819] [036/133] (771s left) syncobj_timeline (signal-point-0)
[250.135097] Starting subtest: signal-point-0
[250.136307] Subtest signal-point-0: SUCCESS (0.001s)
[250.259753] [037/133] (771s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[250.349577] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[250.350519] Starting dynamic subtest: pipe-A-eDP-1
[250.471471] Dynamic subtest pipe-A-eDP-1: SKIP (0.121s)
[250.480862] Starting dynamic subtest: pipe-B-eDP-1
[251.633017] Dynamic subtest pipe-B-eDP-1: SKIP (1.159s)
[251.634906] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.283s)
[252.914084] [038/133] (768s left) gem_ctx_persistence (userptr)
[252.975593] Starting subtest: userptr
[253.245744] Subtest userptr: SUCCESS (0.269s)
[253.345323] [039/133] (767s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[253.450540] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[253.452422] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[254.561893] [040/133] (766s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[254.658513] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[258.305318] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.647s)
[259.480342] [041/133] (761s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[259.600623] Starting subtest: basic-flip-after-cursor-atomic
[260.541835] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.941s)
[261.372515] [042/133] (760s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[261.481118] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[261.482954] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[261.570800] [043/133] (759s left) gem_ccs (block-multicopy-compressed)
[261.627777] Starting subtest: block-multicopy-compressed
[261.629554] Subtest block-multicopy-compressed: SKIP (0.000s)
[261.736093] [044/133] (759s left) kms_flip (plain-flip-ts-check)
[261.828432] Starting subtest: plain-flip-ts-check
[261.829439] Starting dynamic subtest: A-eDP1
[270.694044] Dynamic subtest A-eDP1: SUCCESS (8.840s)
[270.704233] Starting dynamic subtest: B-eDP1
[279.532306] Dynamic subtest B-eDP1: SUCCESS (8.838s)
[279.541957] Starting dynamic subtest: C-eDP1
[288.361779] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[288.371709] Starting dynamic subtest: D-eDP1
[297.193299] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[297.194531] Subtest plain-flip-ts-check: SUCCESS (35.335s)
[298.430242] [045/133] (723s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[298.821797] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[299.620604] [046/133] (721s left) gem_exec_flush (basic-wb-ro-before-default)
[299.684489] Starting subtest: basic-wb-ro-before-default
[305.136776] Subtest basic-wb-ro-before-default: SUCCESS (5.452s)
[305.329663] [047/133] (716s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[305.381489] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[305.449809] [048/133] (716s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[305.500893] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[305.563178] [049/133] (716s left) dmabuf_sync_file (export-multiwait)
[305.590923] Starting subtest: export-multiwait
[305.591784] Subtest export-multiwait: SUCCESS (0.000s)
[305.652993] [050/133] (716s left) i915_drm_fdinfo (virtual-busy-hang-all)
[305.682560] Starting subtest: virtual-busy-hang-all
[305.684212] Subtest virtual-busy-hang-all: SKIP (0.000s)
[305.773975] [051/133] (715s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[305.870283] Starting subtest: fbcpsr-slowdraw
[331.099423] Subtest fbcpsr-slowdraw: SUCCESS (25.230s)
[331.289363] [052/133] (690s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[331.385583] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[331.387507] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[331.482544] [053/133] (690s left) gem_mmap_wc (read-write)
[331.538671] Subtest read-write: SKIP (0.000s)
[331.594084] [054/133] (690s left) syncobj_timeline (invalid-signal-illegal-point)
[331.652734] Starting subtest: invalid-signal-illegal-point
[331.654198] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[331.762876] [055/133] (690s left) kms_cursor_crc (cursor-random-64x64)
[331.968495] Starting subtest: cursor-random-64x64
[331.975430] Starting dynamic subtest: pipe-A-eDP-1
[335.328094] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.352s)
[335.355605] Starting dynamic subtest: pipe-D-eDP-1
[339.370398] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.021s)
[339.371608] Subtest cursor-random-64x64: SUCCESS (7.402s)
[340.240236] [056/133] (681s left) kms_force_connector_basic (prune-stale-modes)
[340.314797] Starting subtest: prune-stale-modes
[340.757403] Subtest prune-stale-modes: SUCCESS (0.442s)
[340.915355] [057/133] (681s left) gem_lmem_swapping (basic)
[340.949614] Subtest basic: SKIP (0.000s)
[340.989554] [058/133] (681s left) kms_properties (crtc-properties-legacy)
[341.077123] Starting subtest: crtc-properties-legacy
[341.078074] Starting dynamic subtest: pipe-A-eDP-1
[341.524389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s)
[341.535753] Starting dynamic subtest: pipe-B-eDP-1
[342.685441] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.159s)
[342.695032] Starting dynamic subtest: pipe-C-eDP-1
[343.887389] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s)
[343.895588] Starting dynamic subtest: pipe-D-eDP-1
[345.072857] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.184s)
[345.073752] Subtest crtc-properties-legacy: SUCCESS (3.996s)
[345.968163] [059/133] (676s left) kms_hdr (brightness-with-hdr)
[346.070645] Starting subtest: brightness-with-hdr
[346.073458] Subtest brightness-with-hdr: SKIP (0.000s)
[346.150321] [060/133] (675s left) kms_lease (empty-lease)
[346.233973] Starting subtest: empty-lease
[346.234877] Starting dynamic subtest: pipe-A-eDP-1
[346.235690] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[346.243829] Starting dynamic subtest: pipe-B-eDP-1
[346.244755] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[346.251860] Starting dynamic subtest: pipe-C-eDP-1
[346.252866] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[346.259907] Starting dynamic subtest: pipe-D-eDP-1
[346.260818] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[346.261687] Subtest empty-lease: SUCCESS (0.008s)
[346.368285] [061/133] (675s left) kms_invalid_mode (overflow-vrefresh)
[346.469987] Starting subtest: overflow-vrefresh
[346.471125] Starting dynamic subtest: pipe-A-eDP-1
[346.757557] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[346.772258] Starting dynamic subtest: pipe-B-eDP-1
[346.773180] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[346.780300] Starting dynamic subtest: pipe-C-eDP-1
[346.781133] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[346.788067] Starting dynamic subtest: pipe-D-eDP-1
[346.788852] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[346.789639] Subtest overflow-vrefresh: SUCCESS (0.292s)
[347.580024] [062/133] (674s left) gem_softpin (evict-active-interruptible)
[347.640812] Starting subtest: evict-active-interruptible
[347.646728] Subtest evict-active-interruptible: SUCCESS (0.006s)
[347.800072] [063/133] (674s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[347.894303] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[347.899146] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[347.975964] [064/133] (674s left) kms_content_protection (dp-mst-type-0-hdcp14)
[348.120737] Starting subtest: dp-mst-type-0-hdcp14
[348.122647] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[348.269737] [065/133] (673s left) kms_pm_rpm (pm-caching)
[350.092281] Starting subtest: pm-caching
[350.094689] Subtest pm-caching: SKIP (0.000s)
[350.583096] [066/133] (671s left) syncobj_basic (create-signaled)
[350.640565] Starting subtest: create-signaled
[350.641598] Subtest create-signaled: SUCCESS (0.000s)
[350.769783] [067/133] (671s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[350.885708] Starting subtest: cursor-vs-flip-legacy
[380.177047] Subtest cursor-vs-flip-legacy: SUCCESS (29.291s)
[381.062010] [068/133] (641s left) prime_mmap (test_map_unmap)
[381.122683] Starting subtest: test_map_unmap
[381.123840] Starting dynamic subtest: test_map_unmap-smem
[381.152326] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[381.153446] Subtest test_map_unmap: SUCCESS (0.032s)
[381.258704] [069/133] (641s left) perf (whitelisted-registers-userspace-config)
[381.374331] Starting subtest: whitelisted-registers-userspace-config
[381.375158] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[381.409371] [070/133] (641s left) gem_eio (wait-1us)
[381.645884] Starting subtest: wait-1us
[382.013675] Subtest wait-1us: SUCCESS (0.368s)
[382.166767] [071/133] (640s left) gem_exec_gttfill (engines)
[382.236357] Starting subtest: engines
[382.237436] Starting dynamic subtest: rcs0
[405.209951] Dynamic subtest rcs0: SUCCESS (22.973s)
[405.221247] Starting dynamic subtest: bcs0
[428.557411] Dynamic subtest bcs0: SUCCESS (23.347s)
[428.566757] Starting dynamic subtest: vcs0
[451.876954] Dynamic subtest vcs0: SUCCESS (23.317s)
[451.887789] Starting dynamic subtest: vcs1
[475.233595] Dynamic subtest vcs1: SUCCESS (23.355s)
[475.242485] Starting dynamic subtest: vecs0
[498.604797] Dynamic subtest vecs0: SUCCESS (23.370s)
[498.615937] Starting dynamic subtest: ccs0
[522.035523] Dynamic subtest ccs0: SUCCESS (23.428s)
[522.038540] Subtest engines: SUCCESS (139.802s)
[522.233938] [072/133] (500s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[522.374874] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[529.471741] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.096s)
[529.668622] [073/133] (492s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[529.775195] Starting subtest: plane-lut1d-ctm3x4-lut1d
[529.792227] Starting dynamic subtest: pipe-A-eDP-1
[530.229796] Dynamic subtest pipe-A-eDP-1: FAIL (0.302s)
[531.169571] Starting dynamic subtest: pipe-B-eDP-1
[531.675066] Dynamic subtest pipe-B-eDP-1: FAIL (0.315s)
[532.576772] Starting dynamic subtest: pipe-C-eDP-1
[533.018217] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[533.870797] Starting dynamic subtest: pipe-D-eDP-1
[534.330370] Dynamic subtest pipe-D-eDP-1: FAIL (0.247s)
[534.412357] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.637s)
[535.226981] [074/133] (487s left) gem_userptr_blits (map-fixed-invalidate-busy)
[535.300795] Starting subtest: map-fixed-invalidate-busy
[535.302584] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[535.455980] [075/133] (487s left) gem_exec_balancer (hog)
[535.530175] Starting subtest: hog
[535.532079] Subtest hog: SKIP (0.000s)
[535.850308] [076/133] (486s left) syncobj_timeline (multi-wait-for-submit-signaled)
[535.911957] Starting subtest: multi-wait-for-submit-signaled
[535.913086] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[536.061226] [077/133] (486s left) core_getclient (basic)
[536.107953] Starting subtest: basic
[536.108912] Subtest basic: SUCCESS (0.000s)
[536.219577] [078/133] (486s left) kms_vrr (flip-dpms)
[536.304922] Starting subtest: flip-dpms
[536.307351] Subtest flip-dpms: SKIP (0.000s)
[536.400183] [079/133] (486s left) kms_psr (pr-suspend)
[536.484238] Starting subtest: pr-suspend
[536.485706] Subtest pr-suspend: SKIP (0.000s)
[536.565621] [080/133] (486s left) i915_pm_rc6_residency (rc6-fence)
[536.616991] Starting subtest: rc6-fence
[536.673148] Starting dynamic subtest: gt0
[548.999996] Dynamic subtest gt0: SUCCESS (12.320s)
[549.009876] Starting dynamic subtest: gt1
[563.868577] Dynamic subtest gt1: SUCCESS (14.864s)
[563.869729] Subtest rc6-fence: SUCCESS (27.245s)
[563.945114] [081/133] (458s left) kms_chamelium_audio (dp-audio-edid)
[564.348606] Subtest dp-audio-edid: SKIP (0.000s)
[565.190427] [082/133] (457s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[565.279452] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[565.281123] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[565.358872] [083/133] (457s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[565.437190] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[565.438062] Starting dynamic subtest: pipe-A-eDP-1
[565.446715] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[565.454697] Starting dynamic subtest: pipe-B-eDP-1
[565.462803] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[565.470444] Starting dynamic subtest: pipe-C-eDP-1
[565.478589] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[565.486180] Starting dynamic subtest: pipe-D-eDP-1
[565.494466] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[565.496056] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[567.724535] [084/133] (455s left) prime_vgem (fence-read-hang)
[567.806492] Subtest fence-read-hang: SKIP (0.000s)
[567.940801] [085/133] (455s left) i915_drm_fdinfo (busy-hang)
[567.975270] Starting subtest: busy-hang
[567.976200] Starting dynamic subtest: rcs0
[568.014505] Dynamic subtest rcs0: SKIP (0.039s)
[568.024524] Starting dynamic subtest: bcs0
[568.026347] Dynamic subtest bcs0: SKIP (0.001s)
[568.033860] Starting dynamic subtest: vcs0
[568.036262] Dynamic subtest vcs0: SKIP (0.000s)
[568.043724] Starting dynamic subtest: vcs1
[568.045467] Dynamic subtest vcs1: SKIP (0.001s)
[568.052943] Starting dynamic subtest: vecs0
[568.054827] Dynamic subtest vecs0: SKIP (0.000s)
[568.062147] Starting dynamic subtest: ccs0
[568.063802] Dynamic subtest ccs0: SKIP (0.001s)
[568.065523] Subtest busy-hang: SKIP (0.045s)
[568.096851] [086/133] (454s left) gem_exec_schedule (u-semaphore-user)
[568.159393] Starting subtest: u-semaphore-user
[568.220819] Subtest u-semaphore-user: SUCCESS (0.060s)
[569.922618] [087/133] (453s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[569.980457] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[569.982363] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[570.184747] [088/133] (452s left) perf_pmu (render-node-busy-idle)
[570.280318] Starting subtest: render-node-busy-idle
[570.281652] Starting dynamic subtest: rcs0
[570.951050] Dynamic subtest rcs0: SUCCESS (0.671s)
[570.962145] Starting dynamic subtest: bcs0
[571.620898] Dynamic subtest bcs0: SUCCESS (0.667s)
[571.631886] Starting dynamic subtest: vcs0
[572.892772] Dynamic subtest vcs0: SUCCESS (1.261s)
[572.903576] Starting dynamic subtest: vcs1
[574.878733] Dynamic subtest vcs1: SUCCESS (1.983s)
[574.888703] Starting dynamic subtest: vecs0
[576.925362] Dynamic subtest vecs0: SUCCESS (2.044s)
[576.936221] Starting dynamic subtest: ccs0
[577.590782] Dynamic subtest ccs0: SUCCESS (0.672s)
[577.593765] Subtest render-node-busy-idle: SUCCESS (7.314s)
[577.675917] [089/133] (445s left) vgem_slow (nohang)
[577.720780] Starting subtest: nohang
[587.934306] Subtest nohang: SUCCESS (10.169s)
[587.968686] [090/133] (435s left) i915_pm_rps (waitboost)
[588.036057] Starting subtest: waitboost
[594.127324] Subtest waitboost: SUCCESS (6.084s)
[594.288243] [091/133] (428s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[594.394965] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[594.395844] Starting dynamic subtest: pipe-A-eDP-1
[611.285830] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[611.294209] Starting dynamic subtest: pipe-B-eDP-1
[629.310712] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.826s)
[629.319716] Starting dynamic subtest: pipe-C-eDP-1
[647.265004] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.742s)
[647.273999] Starting dynamic subtest: pipe-D-eDP-1
[665.263284] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.747s)
[665.264349] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.255s)
[672.594854] [092/133] (356s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[672.715141] Starting subtest: fbc-psr-cursor-mmap-gtt
[672.716053] Starting dynamic subtest: eDP-1
[672.717981] Dynamic subtest eDP-1: SKIP (0.000s)
[672.719640] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[672.796833] [093/133] (356s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[672.892726] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[672.894650] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[673.028280] [094/133] (356s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[673.127370] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[673.129165] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[673.250717] [095/133] (356s left) kms_vrr (seamless-rr-switch-drrs)
[673.339103] Starting subtest: seamless-rr-switch-drrs
[673.341588] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[673.422420] [096/133] (355s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[673.514649] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[673.516421] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[673.636857] [097/133] (355s left) kms_getfb (getfb-handle-not-fb)
[673.734493] Starting subtest: getfb-handle-not-fb
[673.735405] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[673.838293] [098/133] (355s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[673.955561] Starting subtest: yf-tiled-16bpp-rotate-270
[673.957300] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[674.088731] [099/133] (355s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[674.183138] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[674.855055] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[675.026555] [100/133] (354s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[675.149140] Starting subtest: flip-vs-cursor-legacy
[682.375517] Subtest flip-vs-cursor-legacy: SUCCESS (7.213s)
[683.251291] [101/133] (346s left) kms_psr (fbc-psr2-basic)
[683.345114] Starting subtest: fbc-psr2-basic
[683.346044] Starting dynamic subtest: eDP-1
[683.347775] Dynamic subtest eDP-1: SKIP (0.000s)
[683.349451] Subtest fbc-psr2-basic: SKIP (0.001s)
[683.425572] [102/133] (346s left) gem_softpin (full)
[683.483348] Starting subtest: full
[683.490480] Subtest full: SUCCESS (0.007s)
[683.639340] [103/133] (345s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[683.738980] Starting subtest: x-tiled-8bpp-rotate-270
[683.760403] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[683.907717] [104/133] (345s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[684.005203] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[684.006068] Starting dynamic subtest: pipe-A
[684.022972] Dynamic subtest pipe-A: SKIP (0.017s)
[684.031981] Starting dynamic subtest: pipe-B
[684.054607] Dynamic subtest pipe-B: SKIP (0.030s)
[684.063279] Starting dynamic subtest: pipe-C
[684.086030] Dynamic subtest pipe-C: SKIP (0.031s)
[684.094470] Starting dynamic subtest: pipe-D
[684.118618] Dynamic subtest pipe-D: SKIP (0.031s)
[684.120353] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.112s)
[684.256621] [105/133] (345s left) gem_close_race (basic-threads)
[684.317759] Starting subtest: basic-threads
[685.700536] Subtest basic-threads: SUCCESS (1.381s)
[685.893161] [106/133] (343s left) syncobj_wait (multi-wait-submitted)
[685.935014] Starting subtest: multi-wait-submitted
[686.038162] Subtest multi-wait-submitted: SUCCESS (0.102s)
[686.122324] [107/133] (343s left) gem_wait (await)
[686.186082] Starting subtest: await
[686.187112] Starting dynamic subtest: all-engines
[687.361722] Dynamic subtest all-engines: SUCCESS (1.174s)
[687.383937] Starting dynamic subtest: rcs0
[688.427668] Dynamic subtest rcs0: SUCCESS (1.062s)
[688.448491] Starting dynamic subtest: bcs0
[689.488338] Dynamic subtest bcs0: SUCCESS (1.057s)
[689.506321] Starting dynamic subtest: vcs0
[690.542927] Dynamic subtest vcs0: SUCCESS (1.051s)
[690.561976] Starting dynamic subtest: vcs1
[691.598563] Dynamic subtest vcs1: SUCCESS (1.053s)
[691.615657] Starting dynamic subtest: vecs0
[692.653744] Dynamic subtest vecs0: SUCCESS (1.052s)
[692.671459] Starting dynamic subtest: ccs0
[693.709795] Dynamic subtest ccs0: SUCCESS (1.053s)
[693.712947] Subtest await: SUCCESS (7.520s)
[693.917308] [108/133] (335s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[693.972380] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[694.078340] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[694.169071] [109/133] (335s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[694.298360] Starting subtest: cursor-vs-flip-toggle
[725.331422] Subtest cursor-vs-flip-toggle: SUCCESS (31.030s)
[726.166501] [110/133] (303s left) gem_exec_whisper (basic-normal-all)
[726.233580] Starting subtest: basic-normal-all
[728.487002] Subtest basic-normal-all: SUCCESS (2.252s)
[728.676328] [111/133] (301s left) gem_ccs (large-ctrl-surf-copy)
[728.741050] Starting subtest: large-ctrl-surf-copy
[728.743049] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[728.867686] [112/133] (301s left) kms_dsc (dsc-with-bpc)
[728.967930] Starting subtest: dsc-with-bpc
[728.978902] Subtest dsc-with-bpc: SKIP (0.001s)
[729.051126] [113/133] (300s left) gem_mmap_offset (clear-via-pagefault)
[729.108629] Starting subtest: clear-via-pagefault
[729.109605] Starting dynamic subtest: smem0
[762.123968] Dynamic subtest smem0: SUCCESS (32.996s)
[762.125007] Subtest clear-via-pagefault: SUCCESS (32.998s)
[762.251755] [114/133] (267s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[762.359160] Starting subtest: async-flip-with-page-flip-events-tiled
[762.732867] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[765.504621] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.764s)
[765.514687] Starting dynamic subtest: pipe-A-eDP-1-4
[767.679026] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[767.690476] Starting dynamic subtest: pipe-A-eDP-1-4
[769.687819] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[769.699444] Starting dynamic subtest: pipe-A-eDP-1-x
[771.877214] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[772.243715] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[775.004418] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.766s)
[775.013690] Starting dynamic subtest: pipe-B-eDP-1-4
[777.189648] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[777.199517] Starting dynamic subtest: pipe-B-eDP-1-4
[779.199190] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[779.210567] Starting dynamic subtest: pipe-B-eDP-1-x
[781.390465] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[781.745427] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[784.500574] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.754s)
[784.511901] Starting dynamic subtest: pipe-C-eDP-1-4
[786.675705] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[786.686250] Starting dynamic subtest: pipe-C-eDP-1-4
[788.685147] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[788.697017] Starting dynamic subtest: pipe-C-eDP-1-x
[790.874716] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.188s)
[791.241371] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[793.997229] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.754s)
[794.013287] Starting dynamic subtest: pipe-D-eDP-1-4
[796.171883] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[796.183255] Starting dynamic subtest: pipe-D-eDP-1-4
[798.182402] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[798.191519] Starting dynamic subtest: pipe-D-eDP-1-x
[800.361169] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[800.361984] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (37.999s)
[801.546850] [115/133] (228s left) gem_exec_fence (keep-in-fence)
[801.728089] Starting subtest: keep-in-fence
[801.729169] Starting dynamic subtest: rcs0
[801.798716] Dynamic subtest rcs0: SUCCESS (0.076s)
[801.811851] Starting dynamic subtest: bcs0
[801.854584] Dynamic subtest bcs0: SUCCESS (0.053s)
[801.866602] Starting dynamic subtest: vcs0
[803.557436] Dynamic subtest vcs0: SUCCESS (1.691s)
[803.568416] Starting dynamic subtest: vcs1
[805.539926] Dynamic subtest vcs1: SUCCESS (1.980s)
[805.550844] Starting dynamic subtest: vecs0
[807.523673] Dynamic subtest vecs0: SUCCESS (1.981s)
[807.534653] Starting dynamic subtest: ccs0
[807.739264] Dynamic subtest ccs0: SUCCESS (0.223s)
[807.740711] Subtest keep-in-fence: SUCCESS (6.019s)
[809.629059] [116/133] (220s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[809.692839] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[809.798939] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[809.895888] [117/133] (220s left) kms_properties (colorop-properties-legacy)
[810.000070] Starting subtest: colorop-properties-legacy
[810.001099] Starting dynamic subtest: pipe-A-eDP-1
[810.366182] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.364s)
[810.376298] Starting dynamic subtest: pipe-B-eDP-1
[811.477193] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.110s)
[811.485991] Starting dynamic subtest: pipe-C-eDP-1
[812.585398] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[812.594121] Starting dynamic subtest: pipe-D-eDP-1
[813.692569] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.105s)
[813.693433] Subtest colorop-properties-legacy: SUCCESS (3.691s)
[814.558715] [118/133] (215s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[814.627307] Starting subtest: yf-tiled-to-vebox-yf-tiled
[814.629096] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[814.827421] [119/133] (215s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[814.895539] Starting subtest: wait-all-for-submit-delayed-submit
[814.997802] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[815.088041] [120/133] (215s left) prime_self_import (basic-with_one_bo)
[815.119242] Starting subtest: basic-with_one_bo
[815.147254] Subtest basic-with_one_bo: SUCCESS (0.029s)
[815.283192] [121/133] (215s left) gem_mmap_gtt (basic-small-copy)
[815.342864] Subtest basic-small-copy: SKIP (0.000s)
[815.418371] [122/133] (214s left) gem_exec_reloc (basic-cpu-read-noreloc)
[815.485389] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[815.570747] [123/133] (214s left) gem_exec_schedule (preempt-hang)
[815.754400] Starting subtest: preempt-hang
[815.755664] Starting dynamic subtest: rcs0
[815.972463] Dynamic subtest rcs0: SUCCESS (0.228s)
[815.982495] Starting dynamic subtest: bcs0
[816.199095] Dynamic subtest bcs0: SUCCESS (0.226s)
[816.209095] Starting dynamic subtest: vcs0
[816.427059] Dynamic subtest vcs0: SUCCESS (0.226s)
[816.437964] Starting dynamic subtest: vcs1
[816.658345] Dynamic subtest vcs1: SUCCESS (0.230s)
[816.668786] Starting dynamic subtest: vecs0
[816.888652] Dynamic subtest vecs0: SUCCESS (0.229s)
[816.901508] Starting dynamic subtest: ccs0
[817.142614] Dynamic subtest ccs0: SUCCESS (0.253s)
[817.144423] Subtest preempt-hang: SUCCESS (1.399s)
[817.634987] [124/133] (212s left) sysfs_preempt_timeout (timeout)
[817.685430] Starting subtest: timeout
[817.686577] Starting dynamic subtest: vecs0
[827.559513] Dynamic subtest vecs0: SUCCESS (9.861s)
[827.570465] Starting dynamic subtest: ccs0
[829.040242] Dynamic subtest ccs0: SUCCESS (1.488s)
[829.053254] Starting dynamic subtest: vcs0
[838.516694] Dynamic subtest vcs0: SUCCESS (9.463s)
[838.526915] Starting dynamic subtest: bcs0
[839.869131] Dynamic subtest bcs0: SUCCESS (1.360s)
[839.881395] Starting dynamic subtest: rcs0
[841.200852] Dynamic subtest rcs0: SUCCESS (1.330s)
[841.213780] Starting dynamic subtest: vcs1
[850.541112] Dynamic subtest vcs1: SUCCESS (9.327s)
[850.542375] Subtest timeout: SUCCESS (32.842s)
[850.616879] [125/133] (179s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[850.735512] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[850.737629] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[850.888651] [126/133] (179s left) kms_psr (psr2-cursor-render)
[850.979181] Starting subtest: psr2-cursor-render
[850.979992] Starting dynamic subtest: eDP-1
[852.699409] Dynamic subtest eDP-1: SUCCESS (1.718s)
[852.700307] Subtest psr2-cursor-render: SUCCESS (1.720s)
[853.558777] [127/133] (176s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[853.653585] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[853.655141] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[853.801111] [128/133] (176s left) kms_psr (fbc-pr-primary-blt)
[853.887885] Starting subtest: fbc-pr-primary-blt
[853.889627] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[853.969812] [129/133] (176s left) kms_fbcon_fbt (psr-suspend)
[854.014648] Starting subtest: psr-suspend
[905.156619] Subtest psr-suspend: SUCCESS (20.590s)
[907.211891] [130/133] (125s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[907.308100] Starting subtest: stress-xrgb8888-ytiled
[907.309977] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[907.392339] [131/133] (125s left) syncobj_eventfd (timeline-wait-signaled)
[907.444302] Starting subtest: timeline-wait-signaled
[907.445139] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[907.565187] [132/133] (125s left) kms_async_flips (test-time-stamp-atomic)
[907.650722] Starting subtest: test-time-stamp-atomic
[908.026081] Starting dynamic subtest: pipe-A-eDP-1
[908.798290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.771s)
[909.187698] Starting dynamic subtest: pipe-B-eDP-1
[910.004926] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.824s)
[910.380390] Starting dynamic subtest: pipe-C-eDP-1
[911.197332] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.824s)
[911.572580] Starting dynamic subtest: pipe-D-eDP-1
[912.396813] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.831s)
[912.397846] Subtest test-time-stamp-atomic: SUCCESS (4.748s)
[913.632414] [133/133] (119s left) kms_plane_scaling (invalid-num-scalers)
[913.742578] Starting subtest: invalid-num-scalers
[913.743484] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[913.762190] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[913.771239] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[913.795597] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[913.804261] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[913.830727] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[913.840759] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[913.866031] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[913.866918] Subtest invalid-num-scalers: SUCCESS (0.124s)
[913.985655] 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.