[56.162839] Initializing watchdogs
[56.162883]   /dev/watchdog0
[56.177404] [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]
[56.182418] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.185284] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.188659] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[56.319863] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[64.989806] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.694s)
[65.134473] [002/133] (951s left) kms_plane_multiple (2x-tiling-none)
[65.226543] Starting subtest: 2x-tiling-none
[65.230651] Subtest 2x-tiling-none: SKIP (0.000s)
[65.292207] [003/133] (951s left) syncobj_wait (multi-wait-all-submitted-signaled)
[65.351888] Starting subtest: multi-wait-all-submitted-signaled
[65.459074] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[65.530151] [004/133] (951s left) gem_create (create-clear)
[65.580762] Starting subtest: create-clear
[65.583110] Starting dynamic subtest: smem0
[98.379761] Dynamic subtest smem0: SUCCESS (32.803s)
[98.381774] Subtest create-clear: SUCCESS (32.803s)
[98.565459] [005/133] (918s left) gem_exec_balancer (bonded-pair)
[98.633827] Starting subtest: bonded-pair
[98.639042] Subtest bonded-pair: SKIP (0.000s)
[98.967991] [006/133] (917s left) i915_drm_fdinfo (all-busy-check-all)
[99.016925] Starting subtest: all-busy-check-all
[99.023362] Subtest all-busy-check-all: SKIP (0.006s)
[99.090213] [007/133] (917s left) sriov_basic (bind-unbind-vf)
[99.155022] Starting subtest: bind-unbind-vf
[99.157348] Starting dynamic subtest: vf-1
[99.238733] Dynamic subtest vf-1: FAIL (0.033s)
[99.246105] Starting dynamic subtest: vf-2
[99.319465] Dynamic subtest vf-2: FAIL (0.004s)
[99.328823] Starting dynamic subtest: vf-3
[99.402530] Dynamic subtest vf-3: FAIL (0.004s)
[99.411187] Starting dynamic subtest: vf-4
[99.484058] Dynamic subtest vf-4: FAIL (0.004s)
[99.493029] Starting dynamic subtest: vf-5
[99.565279] Dynamic subtest vf-5: FAIL (0.004s)
[99.574850] Starting dynamic subtest: vf-6
[99.647587] Dynamic subtest vf-6: FAIL (0.004s)
[99.656403] Starting dynamic subtest: vf-7
[99.730480] Dynamic subtest vf-7: FAIL (0.004s)
[99.739993] Starting dynamic subtest: vf-random
[99.810777] Dynamic subtest vf-random: FAIL (0.004s)
[99.821381] Starting dynamic subtest: vf-last
[99.887380] Dynamic subtest vf-last: FAIL (0.503s)
[99.889112] Subtest bind-unbind-vf: FAIL (0.565s)
[99.922871] [008/133] (917s left) kms_vblank (ts-continuation-modeset-rpm)
[100.023093] Starting subtest: ts-continuation-modeset-rpm
[100.025068] Starting dynamic subtest: pipe-A-eDP-1
[102.528927] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.504s)
[102.542993] Starting dynamic subtest: pipe-D-eDP-1
[104.774212] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.243s)
[104.776580] Subtest ts-continuation-modeset-rpm: SUCCESS (4.752s)
[105.578918] [009/133] (911s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[105.671876] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[112.211019] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.543s)
[112.307991] [010/133] (904s left) kms_setmode (basic-clone-single-crtc)
[112.362700] Starting subtest: basic-clone-single-crtc
[112.369319] Subtest basic-clone-single-crtc: SKIP (0.001s)
[112.454936] [011/133] (904s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[112.547155] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[112.549103] Starting dynamic subtest: pipe-A-eDP-1
[129.422856] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.292s)
[129.431662] Starting dynamic subtest: pipe-B-eDP-1
[146.409606] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.380s)
[146.418850] Starting dynamic subtest: pipe-C-eDP-1
[163.396901] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.450s)
[163.405265] Starting dynamic subtest: pipe-D-eDP-1
[180.395168] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.347s)
[180.397334] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.472s)
[181.604880] [012/133] (835s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[181.695299] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[181.698049] Starting dynamic subtest: pipe-A-eDP-1
[181.725033] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[181.734827] Starting dynamic subtest: pipe-B-eDP-1
[181.760335] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[181.768927] Starting dynamic subtest: pipe-C-eDP-1
[181.793615] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[181.802208] Starting dynamic subtest: pipe-D-eDP-1
[181.828207] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[181.832992] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[183.933743] [013/133] (833s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[183.994116] Starting subtest: multi-wait-for-submit-submitted-signaled
[183.997018] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[184.093438] [014/133] (833s left) kms_psr (fbc-psr-primary-blt)
[184.195336] Starting subtest: fbc-psr-primary-blt
[184.197659] Starting dynamic subtest: eDP-1
[184.202308] Dynamic subtest eDP-1: SKIP (0.000s)
[184.207293] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[184.285708] [015/133] (832s left) gem_lmem_swapping (random)
[184.327433] Subtest random: SKIP (0.000s)
[184.377981] [016/133] (832s left) gem_exec_whisper (basic-contexts-forked)
[184.438255] Starting subtest: basic-contexts-forked
[207.991732] Subtest basic-contexts-forked: SUCCESS (23.617s)
[208.171494] [017/133] (809s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[208.301433] Starting subtest: modeset-atomic-cursor-hotspot
[208.306915] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[208.445010] [018/133] (808s left) gem_userptr_blits (map-fixed-invalidate)
[208.518236] Starting subtest: map-fixed-invalidate
[208.523114] Subtest map-fixed-invalidate: SKIP (0.000s)
[208.625761] [019/133] (808s left) perf (gen12-unprivileged-single-ctx-counters)
[208.749131] Starting subtest: gen12-unprivileged-single-ctx-counters
[208.751190] Starting dynamic subtest: rcs0
[208.789368] Dynamic subtest rcs0: SUCCESS (0.042s)
[208.792392] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.043s)
[208.837721] [020/133] (808s left) gem_mmap_wc (close)
[208.913606] Subtest close: SKIP (0.000s)
[208.968722] [021/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[209.063199] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[209.068262] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[209.149767] [022/133] (808s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[209.249038] Starting subtest: primary-yf-tiled-reflect-x-270
[209.252461] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[209.337758] [023/133] (808s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[209.462907] Starting subtest: cursorA-vs-flipB-atomic
[209.467249] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[209.607543] [024/133] (808s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[209.722282] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[210.789531] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.068s)
[210.900103] [025/133] (806s left) kms_chamelium_hpd (hdmi-hpd-storm)
[211.284389] Subtest hdmi-hpd-storm: SKIP (0.000s)
[212.077885] [026/133] (805s left) kms_concurrent (multi-plane-atomic-lowres)
[212.173523] Starting subtest: multi-plane-atomic-lowres
[212.176150] Starting dynamic subtest: pipe-A-eDP-1
[212.709717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.537s)
[212.722984] Starting dynamic subtest: pipe-B-eDP-1
[213.965853] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.254s)
[213.975431] Starting dynamic subtest: pipe-C-eDP-1
[215.166125] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.198s)
[215.176656] Starting dynamic subtest: pipe-D-eDP-1
[216.396531] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[216.399338] Subtest multi-plane-atomic-lowres: SUCCESS (4.224s)
[217.223512] [027/133] (800s left) api_intel_bb (simple-bb-ctx)
[217.285570] Starting subtest: simple-bb-ctx
[217.293989] Subtest simple-bb-ctx: SUCCESS (0.011s)
[217.404141] [028/133] (800s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[217.498925] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[217.501137] Starting dynamic subtest: pipe-A-eDP-1
[217.560505] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[217.856092] Starting dynamic subtest: pipe-B-eDP-1
[218.630988] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.784s)
[218.928711] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.432s)
[219.786007] [029/133] (798s left) gem_exec_fence (syncobj-invalid-wait)
[220.284000] Starting subtest: syncobj-invalid-wait
[220.286671] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[221.434196] [FACT gem_exec_fence (syncobj-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[221.438041] [030/133] (796s left) kms_cursor_crc (cursor-sliding-64x64)
[221.625672] Starting subtest: cursor-sliding-64x64
[221.628364] Starting dynamic subtest: pipe-A-eDP-1
[224.896525] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.265s)
[224.923497] Starting dynamic subtest: pipe-D-eDP-1
[228.810817] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.894s)
[228.813332] Subtest cursor-sliding-64x64: SUCCESS (7.184s)
[229.672468] [031/133] (788s left) gem_sync (basic-each)
[229.767561] Starting subtest: basic-each
[232.256604] Subtest basic-each: SUCCESS (2.505s)
[232.457745] [032/133] (785s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[232.519450] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[232.618833] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[232.698532] [033/133] (785s left) syncobj_wait (wait-all-delayed-signal)
[232.757022] Starting subtest: wait-all-delayed-signal
[232.857368] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[232.957468] [034/133] (785s left) kms_cursor_crc (cursor-random-256x85)
[233.211507] Starting subtest: cursor-random-256x85
[233.258512] Subtest cursor-random-256x85: SKIP (0.041s)
[233.424706] [035/133] (784s left) i915_pm_rpm (gem-pread)
[235.564249] Starting subtest: gem-pread
[237.616192] Subtest gem-pread: SUCCESS (2.052s)
[237.703073] [036/133] (780s left) api_intel_bb (blit-noreloc-keep-cache)
[237.764780] Starting subtest: blit-noreloc-keep-cache
[237.773116] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s)
[237.901508] [037/133] (780s left) sw_sync (timeline_closed_signaled)
[237.940326] Starting subtest: timeline_closed_signaled
[237.942539] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[238.001516] [038/133] (780s left) gem_softpin (allocator-basic-reserve)
[238.059032] Starting subtest: allocator-basic-reserve
[238.127435] Subtest allocator-basic-reserve: SUCCESS (0.070s)
[238.255589] [039/133] (780s left) kms_psr (pr-sprite-render)
[238.349783] Starting subtest: pr-sprite-render
[238.354557] Subtest pr-sprite-render: SKIP (0.000s)
[238.424275] [040/133] (779s left) gem_pread (exhaustion)
[238.483765] Subtest exhaustion: SKIP (0.000s)
[238.557218] [041/133] (779s left) gem_exec_reloc (basic-gtt-read-noreloc)
[238.613534] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[238.691550] [042/133] (779s left) gen7_exec_parse (basic-rejected)
[238.745708] Subtest basic-rejected: SKIP (0.000s)
[238.812705] [043/133] (779s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[238.905199] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[238.907235] Starting dynamic subtest: pipe-A
[238.967980] Dynamic subtest pipe-A: SUCCESS (0.065s)
[238.978785] Starting dynamic subtest: pipe-B
[240.099806] Dynamic subtest pipe-B: SUCCESS (1.131s)
[240.111757] Starting dynamic subtest: pipe-C
[241.218977] Dynamic subtest pipe-C: SUCCESS (1.118s)
[241.228055] Starting dynamic subtest: pipe-D
[242.349858] Dynamic subtest pipe-D: SUCCESS (1.131s)
[242.352229] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.449s)
[243.506957] [044/133] (775s left) gem_ctx_shared (create-shared-gtt)
[243.565155] Starting subtest: create-shared-gtt
[245.716764] Subtest create-shared-gtt: SUCCESS (2.151s)
[246.079979] [045/133] (772s left) kms_psr (psr-primary-mmap-gtt)
[246.179159] Starting subtest: psr-primary-mmap-gtt
[246.181720] Starting dynamic subtest: eDP-1
[247.614284] Dynamic subtest eDP-1: SKIP (1.433s)
[247.619429] Subtest psr-primary-mmap-gtt: SKIP (1.435s)
[247.762091] [046/133] (770s left) kms_chamelium_frames (dp-frame-dump)
[248.141539] Subtest dp-frame-dump: SKIP (0.000s)
[248.953317] [047/133] (769s left) i915_query (query-garbage)
[249.026077] Starting subtest: query-garbage
[249.028895] Subtest query-garbage: SUCCESS (0.000s)
[249.119989] [048/133] (769s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[249.186507] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[249.259758] [049/133] (769s left) kms_flip (plain-flip-fb-recreate)
[249.353283] Starting subtest: plain-flip-fb-recreate
[249.356026] Starting dynamic subtest: A-eDP1
[258.266125] Dynamic subtest A-eDP1: SUCCESS (8.919s)
[258.276019] Starting dynamic subtest: B-eDP1
[267.102043] Dynamic subtest B-eDP1: SUCCESS (8.837s)
[267.112040] Starting dynamic subtest: C-eDP1
[276.021722] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[276.031312] Starting dynamic subtest: D-eDP1
[284.845098] Dynamic subtest D-eDP1: SUCCESS (8.816s)
[284.847080] Subtest plain-flip-fb-recreate: SUCCESS (35.504s)
[286.028737] [050/133] (732s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[286.118452] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[286.121129] Starting dynamic subtest: pipe-A-default-mode
[287.287014] Dynamic subtest pipe-A-default-mode: SKIP (1.165s)
[287.291723] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.167s)
[287.416783] [051/133] (731s left) gem_mmap_offset (partial-remap)
[287.475023] Starting subtest: partial-remap
[287.477275] Starting dynamic subtest: smem0
[287.487757] Dynamic subtest smem0: SUCCESS (0.004s)
[287.490377] Subtest partial-remap: SUCCESS (0.004s)
[287.571861] [052/133] (731s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[287.677670] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[287.690266] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[287.767994] [053/133] (731s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[287.904971] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[305.358204] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.450s)
[306.243260] [054/133] (712s left) perf_pmu (rc6-all-gts)
[306.287563] Starting subtest: rc6-all-gts
[312.640829] Subtest rc6-all-gts: SUCCESS (6.354s)
[313.631290] [055/133] (705s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[313.731328] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[313.757286] Starting dynamic subtest: pipe-A-plane-0
[314.191331] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[314.200867] Starting dynamic subtest: pipe-A-plane-3
[314.446148] Dynamic subtest pipe-A-plane-3: SUCCESS (0.253s)
[315.534399] Starting dynamic subtest: pipe-B-plane-0
[315.959248] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[315.971431] Starting dynamic subtest: pipe-B-plane-3
[316.238357] Dynamic subtest pipe-B-plane-3: SUCCESS (0.275s)
[316.543015] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.814s)
[317.401146] [056/133] (701s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[317.500075] Starting subtest: psr-2p-primscrn-spr-indfb-move
[317.505434] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[317.606148] [057/133] (701s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[319.537389] Starting subtest: modeset-lpsp-stress-no-wait
[329.239448] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.704s)
[329.316583] [058/133] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[329.411333] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[329.416308] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[329.507856] [059/133] (689s left) perf (sysctl-defaults)
[329.578776] Starting subtest: sysctl-defaults
[329.581776] Subtest sysctl-defaults: SUCCESS (0.000s)
[329.653905] [060/133] (689s left) gem_sync (basic-store-each)
[329.723169] Starting subtest: basic-store-each
[332.364507] Subtest basic-store-each: SUCCESS (2.655s)
[332.570287] [061/133] (686s left) drm_read (short-buffer-wakeup)
[332.718289] Starting subtest: short-buffer-wakeup
[364.925796] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[365.056889] [062/133] (654s left) kms_vblank (query-busy)
[365.151418] Starting subtest: query-busy
[365.154337] Starting dynamic subtest: pipe-A-eDP-1
[367.035392] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[367.051541] Starting dynamic subtest: pipe-D-eDP-1
[369.640314] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s)
[369.643101] Subtest query-busy: SUCCESS (4.490s)
[370.441041] [063/133] (648s left) sysfs_heartbeat_interval (idempotent)
[370.504461] Starting subtest: idempotent
[370.507262] Starting dynamic subtest: vecs0
[370.509859] Dynamic subtest vecs0: SUCCESS (0.001s)
[370.521002] Starting dynamic subtest: ccs0
[370.523445] Dynamic subtest ccs0: SUCCESS (0.001s)
[370.533164] Starting dynamic subtest: vcs0
[370.535633] Dynamic subtest vcs0: SUCCESS (0.000s)
[370.545347] Starting dynamic subtest: bcs0
[370.548132] Dynamic subtest bcs0: SUCCESS (0.001s)
[370.558052] Starting dynamic subtest: rcs0
[370.560310] Dynamic subtest rcs0: SUCCESS (0.000s)
[370.570027] Starting dynamic subtest: vcs1
[370.572451] Dynamic subtest vcs1: SUCCESS (0.001s)
[370.575195] Subtest idempotent: SUCCESS (0.009s)
[370.615029] [064/133] (648s left) syncobj_timeline (transfer-timeline-point)
[370.681283] Starting subtest: transfer-timeline-point
[370.684154] Subtest transfer-timeline-point: SUCCESS (0.001s)
[370.782590] [065/133] (648s left) gem_exec_balancer (sliced)
[370.844072] Starting subtest: sliced
[370.849541] Subtest sliced: SKIP (0.000s)
[371.184035] [066/133] (648s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[371.251711] Starting subtest: etime-multi-wait-all-submitted-signaled
[371.354657] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[371.437306] [067/133] (648s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[371.539662] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[371.542137] Starting dynamic subtest: pipe-A-eDP-1
[371.637749] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[371.649267] Starting dynamic subtest: pipe-B-eDP-1
[372.811597] Dynamic subtest pipe-B-eDP-1: SKIP (1.172s)
[372.816057] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.274s)
[374.008129] [068/133] (645s left) kms_cursor_crc (cursor-offscreen-512x512)
[374.288212] Starting subtest: cursor-offscreen-512x512
[374.292186] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[374.440850] [069/133] (645s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[374.545009] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[375.213470] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[375.362899] [070/133] (644s left) gem_fence_thrash (bo-write-verify-y)
[375.404595] Starting subtest: bo-write-verify-y
[375.419372] Subtest bo-write-verify-y: SKIP (0.015s)
[375.486233] [071/133] (644s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[375.594455] Starting subtest: extended-modeset-hang-newfb-with-reset
[375.596900] Starting dynamic subtest: pipe-A
[389.758261] Dynamic subtest pipe-A: SUCCESS (14.166s)
[389.772703] Starting dynamic subtest: pipe-D
[405.250613] Dynamic subtest pipe-D: SUCCESS (15.492s)
[405.253281] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.666s)
[406.064674] [072/133] (613s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[406.128346] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[406.133800] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[406.314063] [073/133] (613s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[406.424740] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[411.374055] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.952s)
[412.590741] [074/133] (607s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[412.691888] Starting subtest: yf-tiled-addfb-size-offset-overflow
[412.697380] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[412.790576] [075/133] (607s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[412.887806] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[412.892561] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[412.988115] [076/133] (606s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[413.108024] Starting subtest: cursorB-vs-flipA-atomic-transitions
[413.113769] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.003s)
[413.265232] [077/133] (606s left) kms_hdr (brightness-with-hdr)
[413.369739] Starting subtest: brightness-with-hdr
[413.377314] Subtest brightness-with-hdr: SKIP (0.000s)
[413.443823] [078/133] (606s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[413.556255] Starting subtest: y-tiled-16bpp-rotate-0
[413.560916] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[413.646920] [079/133] (606s left) kms_addfb_basic (invalid-get-prop-any)
[413.697349] Starting subtest: invalid-get-prop-any
[413.699522] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[413.836914] [080/133] (606s left) gem_exec_params (secure-non-root)
[413.901282] Starting subtest: secure-non-root
[413.906326] Subtest secure-non-root: SKIP (0.000s)
[414.006426] [081/133] (606s left) kms_psr (fbc-psr2-no-drrs)
[414.088845] Starting subtest: fbc-psr2-no-drrs
[414.091217] Starting dynamic subtest: eDP-1
[414.095926] Dynamic subtest eDP-1: SKIP (0.000s)
[414.099968] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[414.163366] [082/133] (606s left) gem_exec_fence (syncobj-timeline-wait)
[414.734983] Starting subtest: syncobj-timeline-wait
[416.388351] Subtest syncobj-timeline-wait: SUCCESS (1.653s)
[418.425922] [083/133] (601s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[418.524442] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[425.707129] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.183s)
[425.844228] [084/133] (594s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[425.931271] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[425.934137] Starting dynamic subtest: pipe-A-eDP-1
[425.962345] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[425.984422] Starting dynamic subtest: pipe-B-eDP-1
[426.012527] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[426.034029] Starting dynamic subtest: pipe-C-eDP-1
[426.061537] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[426.073836] Starting dynamic subtest: pipe-D-eDP-1
[426.097187] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[426.101331] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[428.177189] [085/133] (592s left) kms_invalid_mode (bad-vsync-end)
[428.260442] Starting subtest: bad-vsync-end
[428.262972] Starting dynamic subtest: pipe-A-eDP-1
[428.547282] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[428.558671] Starting dynamic subtest: pipe-B-eDP-1
[428.561211] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[428.572962] Starting dynamic subtest: pipe-C-eDP-1
[428.575190] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[428.584909] Starting dynamic subtest: pipe-D-eDP-1
[428.587415] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[428.590262] Subtest bad-vsync-end: SUCCESS (0.292s)
[429.412726] [086/133] (590s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[429.501463] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[429.506982] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[430.642553] [087/133] (589s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[430.704562] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[430.710151] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[430.900609] [088/133] (589s left) gem_tiling_max_stride
[431.031997] [089/133] (589s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[431.132290] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[435.564716] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.436s)
[436.746416] [090/133] (583s left) gem_exec_params (cliprects_ptr-dirt)
[436.818460] Starting subtest: cliprects_ptr-dirt
[436.821345] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[436.917122] [091/133] (583s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[437.011973] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[437.017012] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[437.110775] [092/133] (583s left) syncobj_wait (invalid-single-wait-unsubmitted)
[437.169231] Starting subtest: invalid-single-wait-unsubmitted
[437.171822] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[437.271910] [093/133] (583s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[437.371751] Starting subtest: plane-lut1d-ctm3x4
[437.541531] Starting dynamic subtest: pipe-A-plane-0
[437.869795] Dynamic subtest pipe-A-plane-0: FAIL (0.165s)
[437.879823] Starting dynamic subtest: pipe-A-plane-1
[438.076682] Dynamic subtest pipe-A-plane-1: FAIL (0.167s)
[438.088133] Starting dynamic subtest: pipe-A-plane-2
[438.312269] Dynamic subtest pipe-A-plane-2: FAIL (0.174s)
[439.231306] Starting dynamic subtest: pipe-B-plane-0
[439.691753] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[439.701913] Starting dynamic subtest: pipe-B-plane-1
[440.073937] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[440.085158] Starting dynamic subtest: pipe-B-plane-2
[440.438092] Dynamic subtest pipe-B-plane-2: FAIL (0.176s)
[441.454144] Starting dynamic subtest: pipe-C-plane-0
[442.006044] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[442.017340] Starting dynamic subtest: pipe-C-plane-1
[442.452409] Dynamic subtest pipe-C-plane-1: FAIL (0.687s)
[442.462080] Starting dynamic subtest: pipe-C-plane-2
[442.877345] Dynamic subtest pipe-C-plane-2: FAIL (0.178s)
[443.693344] Starting dynamic subtest: pipe-D-plane-0
[444.370214] Dynamic subtest pipe-D-plane-0: FAIL (0.152s)
[444.380887] Starting dynamic subtest: pipe-D-plane-1
[444.880030] Dynamic subtest pipe-D-plane-1: FAIL (0.692s)
[444.891238] Starting dynamic subtest: pipe-D-plane-2
[445.413801] Dynamic subtest pipe-D-plane-2: FAIL (0.619s)
[445.441689] Subtest plane-lut1d-ctm3x4: FAIL (8.070s)
[446.258365] [094/133] (574s left) gem_vm_create (isolation)
[446.315364] Starting subtest: isolation
[446.324863] Subtest isolation: SUCCESS (0.009s)
[446.439904] [095/133] (574s left) gem_tiled_blits (normal)
[446.502358] Subtest normal: SKIP (0.000s)
[446.577668] [096/133] (574s left) syncobj_wait (wait-all-complex)
[446.638189] Starting subtest: wait-all-complex
[446.854561] Subtest wait-all-complex: SUCCESS (0.217s)
[446.936011] [097/133] (573s left) kms_rotation_crc (sprite-rotation-270)
[447.032215] Starting subtest: sprite-rotation-270
[447.036979] Subtest sprite-rotation-270: SKIP (0.001s)
[447.108918] [098/133] (573s left) gem_blits (basic)
[447.166354] Starting subtest: basic
[448.666827] Subtest basic: SUCCESS (1.499s)
[448.789583] [099/133] (572s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[448.852107] Subtest no-spare-fences-busy: SKIP (0.000s)
[448.919992] [100/133] (572s left) kms_plane_scaling (2x-scaler-multi-pipe)
[449.011510] Starting subtest: 2x-scaler-multi-pipe
[449.017208] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[449.113727] [101/133] (571s left) kms_dsc (dsc-fractional-bpp)
[449.202725] Starting subtest: dsc-fractional-bpp
[449.216707] Subtest dsc-fractional-bpp: SKIP (0.000s)
[449.275374] [102/133] (571s left) kms_async_flips (invalid-async-flip-atomic)
[449.364758] Starting subtest: invalid-async-flip-atomic
[449.738415] Starting dynamic subtest: pipe-A-eDP-1
[450.585221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s)
[450.948219] Starting dynamic subtest: pipe-B-eDP-1
[451.712335] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.771s)
[452.079236] Starting dynamic subtest: pipe-C-eDP-1
[452.847095] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.779s)
[453.208754] Starting dynamic subtest: pipe-D-eDP-1
[453.976445] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[453.979425] Subtest invalid-async-flip-atomic: SUCCESS (4.613s)
[455.124366] [103/133] (565s left) sw_sync (sync_busy)
[455.165540] Starting subtest: sync_busy
[455.168216] Subtest sync_busy: SUCCESS (0.002s)
[455.219895] [104/133] (565s left) kms_prop_blob (blob-prop-validate)
[455.273914] Starting subtest: blob-prop-validate
[455.276294] Subtest blob-prop-validate: SUCCESS (0.000s)
[455.353903] [105/133] (565s left) i915_hangman (gt-engine-error)
[455.426415] Starting subtest: gt-engine-error
[455.429040] Starting dynamic subtest: rcs0
[457.358689] Dynamic subtest rcs0: SUCCESS (1.931s)
[457.372033] Starting dynamic subtest: bcs0
[459.340818] Dynamic subtest bcs0: SUCCESS (1.979s)
[459.353859] Starting dynamic subtest: vcs0
[461.325662] Dynamic subtest vcs0: SUCCESS (1.981s)
[461.339151] Starting dynamic subtest: vcs1
[463.309642] Dynamic subtest vcs1: SUCCESS (1.981s)
[463.325803] Starting dynamic subtest: vecs0
[465.294128] Dynamic subtest vecs0: SUCCESS (1.982s)
[465.309835] Starting dynamic subtest: ccs0
[467.341776] Dynamic subtest ccs0: SUCCESS (2.045s)
[467.344809] Subtest gt-engine-error: SUCCESS (11.915s)
[467.483278] [106/133] (553s left) intel_hwmon (hwmon-write)
[467.544259] Subtest hwmon-write: SKIP (0.000s)
[467.600776] [107/133] (553s left) gem_exec_params (no-bsd)
[467.665314] Starting subtest: no-bsd
[467.670997] Subtest no-bsd: SUCCESS (0.005s)
[469.423753] [108/133] (551s left) gem_exec_flush (basic-batch-kernel-default-wb)
[469.482409] Starting subtest: basic-batch-kernel-default-wb
[476.729294] Subtest basic-batch-kernel-default-wb: SUCCESS (7.247s)
[476.929048] [109/133] (544s left) gem_exec_schedule (noreorder-priority)
[477.110544] Starting subtest: noreorder-priority
[477.113521] Starting dynamic subtest: rcs0
[478.267974] Dynamic subtest rcs0: SUCCESS (1.157s)
[478.284896] Starting dynamic subtest: vcs0
[481.386864] Dynamic subtest vcs0: SUCCESS (3.115s)
[481.399193] Starting dynamic subtest: vcs1
[483.373705] Dynamic subtest vcs1: SUCCESS (1.984s)
[483.385268] Starting dynamic subtest: vecs0
[485.334877] Dynamic subtest vecs0: SUCCESS (1.959s)
[485.347728] Starting dynamic subtest: ccs0
[486.471410] Dynamic subtest ccs0: SUCCESS (1.135s)
[486.474413] Subtest noreorder-priority: SUCCESS (9.363s)
[486.669807] [110/133] (534s left) gem_exec_schedule (u-lateslice)
[486.738318] Starting subtest: u-lateslice
[486.741330] Starting dynamic subtest: rcs0
[486.757506] Dynamic subtest rcs0: SUCCESS (0.031s)
[486.767590] Starting dynamic subtest: bcs0
[486.781919] Dynamic subtest bcs0: SUCCESS (0.024s)
[486.791706] Starting dynamic subtest: vcs0
[486.805282] Dynamic subtest vcs0: SUCCESS (0.023s)
[486.820265] Starting dynamic subtest: vcs1
[486.830667] Dynamic subtest vcs1: SUCCESS (0.024s)
[486.840561] Starting dynamic subtest: vecs0
[486.853323] Dynamic subtest vecs0: SUCCESS (0.021s)
[486.863252] Starting dynamic subtest: ccs0
[486.876950] Dynamic subtest ccs0: SUCCESS (0.023s)
[486.879397] Subtest u-lateslice: SUCCESS (0.151s)
[488.450579] [111/133] (532s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[488.561096] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[495.227285] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.669s)
[495.332271] [112/133] (526s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[495.422657] Starting subtest: compare-crc-sanitycheck-xr24
[495.425409] Starting dynamic subtest: pipe-A-eDP-1
[496.067018] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.645s)
[496.079166] Starting dynamic subtest: pipe-B-eDP-1
[497.357511] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.289s)
[497.369501] Starting dynamic subtest: pipe-C-eDP-1
[498.627281] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.270s)
[498.638535] Starting dynamic subtest: pipe-D-eDP-1
[499.879361] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[499.882369] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.458s)
[500.695735] [113/133] (520s left) kms_big_fb (linear-64bpp-rotate-180)
[500.798891] Starting subtest: linear-64bpp-rotate-180
[502.387015] Subtest linear-64bpp-rotate-180: SUCCESS (1.589s)
[502.555805] [114/133] (519s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[502.665670] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[503.679394] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.013s)
[503.794050] [115/133] (517s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[503.887918] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[503.890216] Starting dynamic subtest: pipe-A-eDP-1
[504.332177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.416s)
[504.343142] Starting dynamic subtest: pipe-B-eDP-1
[505.707255] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.372s)
[505.719066] Starting dynamic subtest: pipe-C-eDP-1
[507.091252] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s)
[507.101311] Starting dynamic subtest: pipe-D-eDP-1
[508.429301] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[508.431731] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.511s)
[509.611787] [116/133] (512s left) kms_force_connector_basic (prune-stale-modes)
[509.696228] Starting subtest: prune-stale-modes
[510.136385] Subtest prune-stale-modes: SUCCESS (0.440s)
[510.275045] [117/133] (511s left) kms_pm_rpm (fences)
[512.522753] Starting subtest: fences
[512.528343] Subtest fences: SKIP (0.000s)
[512.907389] [118/133] (508s left) kms_flip (basic-flip-vs-dpms)
[513.004248] Starting subtest: basic-flip-vs-dpms
[513.006917] Starting dynamic subtest: A-eDP1
[515.581092] Dynamic subtest A-eDP1: SUCCESS (2.579s)
[515.592845] Starting dynamic subtest: B-eDP1
[517.795507] Dynamic subtest B-eDP1: SUCCESS (2.211s)
[517.805981] Starting dynamic subtest: C-eDP1
[519.969936] Dynamic subtest C-eDP1: SUCCESS (2.176s)
[519.982255] Starting dynamic subtest: D-eDP1
[522.168414] Dynamic subtest D-eDP1: SUCCESS (2.197s)
[522.171354] Subtest basic-flip-vs-dpms: SUCCESS (9.172s)
[523.039420] [119/133] (498s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[523.164214] Starting subtest: 2x-flip-vs-cursor-atomic
[523.170157] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[523.317093] [120/133] (498s left) kms_frontbuffer_tracking (fbc-tiling-4)
[523.405373] Starting subtest: fbc-tiling-4
[527.624322] Subtest fbc-tiling-4: SUCCESS (4.224s)
[528.759143] [121/133] (493s left) kms_lease (cursor-implicit-plane)
[528.852307] Starting subtest: cursor-implicit-plane
[528.854544] Starting dynamic subtest: pipe-A-eDP-1
[529.314542] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.464s)
[529.326154] Starting dynamic subtest: pipe-B-eDP-1
[530.427149] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.112s)
[530.439974] Starting dynamic subtest: pipe-C-eDP-1
[531.502013] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.071s)
[531.513557] Starting dynamic subtest: pipe-D-eDP-1
[532.605060] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.103s)
[532.607860] Subtest cursor-implicit-plane: SUCCESS (3.756s)
[533.438747] [122/133] (488s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[533.524320] Starting subtest: fbc-pr-cursor-mmap-gtt
[533.529301] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[533.603818] [123/133] (488s left) kms_flip (2x-flip-vs-modeset)
[533.691021] Starting subtest: 2x-flip-vs-modeset
[533.699805] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[533.780092] [124/133] (488s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[533.878951] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[533.883872] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[533.980455] [125/133] (488s left) kms_psr (psr2-no-drrs)
[534.069273] Starting subtest: psr2-no-drrs
[534.071903] Starting dynamic subtest: eDP-1
[535.681017] Dynamic subtest eDP-1: SUCCESS (1.609s)
[535.683730] Subtest psr2-no-drrs: SUCCESS (1.610s)
[536.528366] [126/133] (485s left) gem_ctx_persistence (engines-cleanup)
[536.594542] Starting subtest: engines-cleanup
[536.597242] Starting dynamic subtest: rcs0
[536.652229] Dynamic subtest rcs0: SUCCESS (0.058s)
[536.665115] Starting dynamic subtest: bcs0
[536.690510] Dynamic subtest bcs0: SUCCESS (0.036s)
[536.707389] Starting dynamic subtest: vcs0
[536.731943] Dynamic subtest vcs0: SUCCESS (0.038s)
[536.744439] Starting dynamic subtest: vcs1
[536.766797] Dynamic subtest vcs1: SUCCESS (0.033s)
[536.777513] Starting dynamic subtest: vecs0
[536.805620] Dynamic subtest vecs0: SUCCESS (0.038s)
[536.816832] Starting dynamic subtest: ccs0
[536.849645] Dynamic subtest ccs0: SUCCESS (0.042s)
[536.852536] Subtest engines-cleanup: SUCCESS (0.256s)
[536.933535] [127/133] (485s left) kms_plane (plane-position-hole)
[537.022270] Starting subtest: plane-position-hole
[537.525009] Starting dynamic subtest: pipe-A-plane-1
[538.771433] Dynamic subtest pipe-A-plane-1: SUCCESS (1.249s)
[538.783328] Starting dynamic subtest: pipe-A-plane-2
[540.072082] Dynamic subtest pipe-A-plane-2: SUCCESS (1.300s)
[540.084543] Starting dynamic subtest: pipe-A-plane-3
[541.381992] Dynamic subtest pipe-A-plane-3: SUCCESS (1.309s)
[541.394703] Starting dynamic subtest: pipe-A-plane-4
[542.673305] Dynamic subtest pipe-A-plane-4: SUCCESS (1.291s)
[542.684573] Starting dynamic subtest: pipe-A-plane-5
[542.703162] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[543.896259] Starting dynamic subtest: pipe-B-plane-1
[545.219691] Dynamic subtest pipe-B-plane-1: SUCCESS (1.331s)
[545.231552] Starting dynamic subtest: pipe-B-plane-2
[546.509538] Dynamic subtest pipe-B-plane-2: SUCCESS (1.287s)
[546.520205] Starting dynamic subtest: pipe-B-plane-3
[547.772297] Dynamic subtest pipe-B-plane-3: SUCCESS (1.265s)
[547.783824] Starting dynamic subtest: pipe-B-plane-4
[549.059810] Dynamic subtest pipe-B-plane-4: SUCCESS (1.287s)
[549.071593] Starting dynamic subtest: pipe-B-plane-5
[549.087397] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[549.090409] Subtest plane-position-hole: SUCCESS (12.067s)
[549.935349] [128/133] (472s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[550.039070] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[557.355335] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.321s)
[557.490415] [129/133] (464s left) kms_flip (2x-plain-flip-fb-recreate)
[557.584019] Starting subtest: 2x-plain-flip-fb-recreate
[557.592638] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[557.683705] [130/133] (464s left) gem_exec_whisper (basic-queues-forked-all)
[557.755526] Starting subtest: basic-queues-forked-all
[579.589426] Subtest basic-queues-forked-all: SUCCESS (21.833s)
[579.789511] [131/133] (442s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[579.843446] Starting subtest: multi-wait-all-available-submitted-signaled
[579.845960] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[579.949536] [132/133] (442s left) i915_pm_rps (thresholds-park)
[580.005430] Starting subtest: thresholds-park
[580.010945] Subtest thresholds-park: SKIP (0.001s)
[580.082802] [133/133] (442s left) gem_eio (create)
[580.321402] Starting subtest: create
[580.682251] Subtest create: SUCCESS (0.361s)
[580.801039] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_plane_multiple
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: gem_create
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: i915_drm_fdinfo
results: parsing output: 6/ for test: sriov_basic
results: parsing output: 7/ for test: kms_vblank
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_setmode
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_lmem_swapping
results: parsing output: 15/ for test: gem_exec_whisper
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_userptr_blits
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_mmap_wc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_rotation_crc
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: kms_concurrent
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: kms_atomic_transition
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: gem_sync
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: i915_pm_rpm
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: sw_sync
results: parsing output: 37/ for test: gem_softpin
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_pread
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: gen7_exec_parse
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: gem_ctx_shared
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_chamelium_frames
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: gem_mmap_offset
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: gem_sync
results: parsing output: 60/ for test: drm_read
results: parsing output: 61/ for test: kms_vblank
results: parsing output: 62/ for test: sysfs_heartbeat_interval
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_fence_thrash
results: parsing output: 70/ for test: kms_busy
results: parsing output: 71/ for test: gem_render_copy
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_hdr
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_invalid_mode
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_tiling_max_stride
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_color_pipeline
results: parsing output: 93/ for test: gem_vm_create
results: parsing output: 94/ for test: gem_tiled_blits
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: gem_blits
results: parsing output: 98/ for test: gem_fenced_exec_thrash
results: parsing output: 99/ for test: kms_plane_scaling
results: parsing output: 100/ for test: kms_dsc
results: parsing output: 101/ for test: kms_async_flips
results: parsing output: 102/ for test: sw_sync
results: parsing output: 103/ for test: kms_prop_blob
results: parsing output: 104/ for test: i915_hangman
results: parsing output: 105/ for test: intel_hwmon
results: parsing output: 106/ for test: gem_exec_params
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_pipe_crc_basic
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_force_connector_basic
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_lease
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: kms_plane
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: i915_pm_rps
results: parsing output: 132/ for test: gem_eio
Done.