[75.133839] Initializing watchdogs
[75.133895]   /dev/watchdog0
[75.148530] [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]
[75.152845] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[75.155067] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[75.158383] [001/133] (960s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[75.297227] Starting subtest: cursorA-vs-flipB-toggle
[75.301785] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[75.451676] [002/133] (960s left) kms_chamelium_frames (dp-crc-fast)
[75.826960] Subtest dp-crc-fast: SKIP (0.000s)
[76.603614] [003/133] (959s left) kms_content_protection (dp-mst-type-1)
[76.753182] Starting subtest: dp-mst-type-1
[76.757529] Subtest dp-mst-type-1: SKIP (0.000s)
[76.903038] [004/133] (958s left) gen9_exec_parse (bb-start-cmd)
[76.959240] Subtest bb-start-cmd: SKIP (0.000s)
[77.033107] [005/133] (958s left) gem_exec_schedule (submit-early-slice)
[77.091227] Starting subtest: submit-early-slice
[77.093523] Starting dynamic subtest: rcs0
[77.124978] Dynamic subtest rcs0: SUCCESS (0.041s)
[77.133900] Starting dynamic subtest: bcs0
[77.160816] Dynamic subtest bcs0: SUCCESS (0.036s)
[77.167935] Starting dynamic subtest: vcs0
[77.201539] Dynamic subtest vcs0: SUCCESS (0.040s)
[77.208690] Starting dynamic subtest: vcs1
[77.240811] Dynamic subtest vcs1: SUCCESS (0.039s)
[77.247744] Starting dynamic subtest: vecs0
[77.276471] Dynamic subtest vecs0: SUCCESS (0.035s)
[77.284228] Starting dynamic subtest: ccs0
[77.307507] Dynamic subtest ccs0: SUCCESS (0.031s)
[77.309845] Subtest submit-early-slice: SUCCESS (0.224s)
[79.022820] [006/133] (956s left) gem_fence_thrash (bo-write-verify-threaded-y)
[79.059757] Starting subtest: bo-write-verify-threaded-y
[79.091330] Subtest bo-write-verify-threaded-y: SKIP (0.028s)
[79.146705] [007/133] (956s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[79.239160] Starting subtest: fbcpsr-tiling-y
[79.243157] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[79.372988] [008/133] (956s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[79.467127] Starting subtest: bo-too-small-due-to-tiling
[79.471621] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[79.596877] [009/133] (956s left) sw_sync (sync_multi_consumer_producer)
[79.630269] Starting subtest: sync_multi_consumer_producer
[79.928111] Subtest sync_multi_consumer_producer: SUCCESS (0.298s)
[79.998700] [010/133] (956s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[80.086411] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[84.672507] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.589s)
[85.852737] [011/133] (950s left) kms_universal_plane (disable-primary-vs-flip)
[85.955310] Starting subtest: disable-primary-vs-flip
[85.957624] Starting dynamic subtest: pipe-A-eDP-1
[87.503379] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.548s)
[87.512803] Starting dynamic subtest: pipe-B-eDP-1
[89.676937] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.173s)
[89.684969] Starting dynamic subtest: pipe-C-eDP-1
[91.860746] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.182s)
[91.870141] Starting dynamic subtest: pipe-D-eDP-1
[94.026232] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.164s)
[94.028697] Subtest disable-primary-vs-flip: SUCCESS (8.072s)
[94.843910] [012/133] (941s left) gem_spin_batch (legacy)
[94.919386] Starting subtest: legacy
[94.921841] Starting dynamic subtest: default
[98.161372] Dynamic subtest default: SUCCESS (3.237s)
[98.170801] Starting dynamic subtest: render
[101.444983] Dynamic subtest render: SUCCESS (3.232s)
[101.455039] Starting dynamic subtest: bsd
[104.681193] Dynamic subtest bsd: SUCCESS (3.235s)
[104.690523] Starting dynamic subtest: bsd1
[107.864911] Dynamic subtest bsd1: SUCCESS (3.233s)
[107.875113] Starting dynamic subtest: bsd2
[111.148467] Dynamic subtest bsd2: SUCCESS (3.232s)
[111.158099] Starting dynamic subtest: blt
[114.385181] Dynamic subtest blt: SUCCESS (3.235s)
[114.394995] Starting dynamic subtest: vebox
[117.620695] Dynamic subtest vebox: SUCCESS (3.234s)
[117.622881] Subtest legacy: SUCCESS (22.646s)
[117.982359] [013/133] (918s left) i915_suspend (fence-restore-tiled2untiled)
[118.037813] Starting subtest: fence-restore-tiled2untiled
[118.042205] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[118.160225] [014/133] (917s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[118.260331] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[118.264319] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[118.371645] [015/133] (917s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[118.434339] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[118.502553] [016/133] (917s left) prime_mmap (test_aperture_limit)
[118.558697] Starting subtest: test_aperture_limit
[118.560919] Starting dynamic subtest: test_aperture_limit-smem
[118.567464] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[118.571321] Subtest test_aperture_limit: SKIP (0.009s)
[118.685012] [017/133] (917s left) kms_flip (blocking-wf_vblank)
[118.770472] Starting subtest: blocking-wf_vblank
[118.772942] Starting dynamic subtest: A-eDP1
[127.678736] Dynamic subtest A-eDP1: SUCCESS (8.908s)
[127.689059] Starting dynamic subtest: B-eDP1
[136.637887] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[136.647888] Starting dynamic subtest: C-eDP1
[145.571326] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[145.578434] Starting dynamic subtest: D-eDP1
[154.505058] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[154.507527] Subtest blocking-wf_vblank: SUCCESS (35.695s)
[155.697653] [018/133] (880s left) kms_psr (psr2-sprite-plane-onoff)
[155.798143] Starting subtest: psr2-sprite-plane-onoff
[155.800508] Starting dynamic subtest: eDP-1
[157.519456] Dynamic subtest eDP-1: SUCCESS (1.722s)
[157.522034] Subtest psr2-sprite-plane-onoff: SUCCESS (1.723s)
[158.354355] [019/133] (877s left) kms_lease (invalid-create-leases)
[158.458243] Starting subtest: invalid-create-leases
[158.463040] Subtest invalid-create-leases: SUCCESS (0.006s)
[158.605126] [020/133] (877s left) kms_plane_multiple (tiling-x)
[158.711223] Starting subtest: tiling-x
[158.713106] Starting dynamic subtest: pipe-A-eDP-1
[162.498840] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.789s)
[162.507829] Starting dynamic subtest: pipe-B-eDP-1
[166.926818] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.426s)
[166.935102] Starting dynamic subtest: pipe-C-eDP-1
[171.256815] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.329s)
[171.265224] Starting dynamic subtest: pipe-D-eDP-1
[175.608882] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.350s)
[175.611197] Subtest tiling-x: SUCCESS (16.899s)
[176.428128] [021/133] (859s left) kms_chamelium_color (gamma)
[176.532588] Subtest gamma: SKIP (0.000s)
[176.573363] [022/133] (859s left) kms_dsc (dsc-basic)
[176.663930] Starting subtest: dsc-basic
[176.677121] Subtest dsc-basic: SKIP (0.000s)
[176.744263] [023/133] (859s left) kms_psr (fbc-psr2-primary-render)
[176.836620] Starting subtest: fbc-psr2-primary-render
[176.838581] Starting dynamic subtest: eDP-1
[176.842694] Dynamic subtest eDP-1: SKIP (0.000s)
[176.846860] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[176.929428] [024/133] (859s left) kms_psr (psr-cursor-mmap-gtt)
[177.014655] Starting subtest: psr-cursor-mmap-gtt
[177.016800] Starting dynamic subtest: eDP-1
[178.709362] Dynamic subtest eDP-1: SUCCESS (1.693s)
[178.711821] Subtest psr-cursor-mmap-gtt: SUCCESS (1.694s)
[179.583877] [025/133] (856s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[179.707404] Starting subtest: verify-pxp-stale-buf-optout-execution
[180.771390] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.065s)
[180.926895] [026/133] (855s left) kms_lease (simple-lease)
[181.033052] Starting subtest: simple-lease
[181.035204] Starting dynamic subtest: pipe-A-eDP-1
[181.531516] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.495s)
[181.546048] Starting dynamic subtest: pipe-B-eDP-1
[183.027160] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.497s)
[183.034803] Starting dynamic subtest: pipe-C-eDP-1
[184.441934] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.413s)
[184.451112] Starting dynamic subtest: pipe-D-eDP-1
[185.859775] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.415s)
[185.862282] Subtest simple-lease: SUCCESS (4.828s)
[186.685079] [027/133] (849s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[186.788404] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[186.792813] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[186.901818] [028/133] (849s left) api_intel_allocator (simple-allocator)
[186.952280] Starting subtest: simple-allocator
[186.954591] Starting dynamic subtest: basic
[186.956790] Dynamic subtest basic: SUCCESS (0.004s)
[186.968264] Starting dynamic subtest: parallel-one
[187.131849] Dynamic subtest parallel-one: SUCCESS (0.176s)
[187.142285] Starting dynamic subtest: print
[187.144412] Dynamic subtest print: SUCCESS (0.000s)
[187.152120] Starting dynamic subtest: reuse
[187.153992] Dynamic subtest reuse: SUCCESS (0.000s)
[187.161158] Starting dynamic subtest: reserve
[187.163060] Dynamic subtest reserve: SUCCESS (0.000s)
[187.170325] Starting dynamic subtest: fork-reopen-allocator
[187.172305] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[187.174180] Subtest simple-allocator: SUCCESS (0.196s)
[187.281722] [029/133] (849s left) api_intel_bb (simple-bb-ctx)
[187.332456] Starting subtest: simple-bb-ctx
[187.337716] Subtest simple-bb-ctx: SUCCESS (0.006s)
[187.495467] [030/133] (849s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[187.584020] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[187.588279] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[187.708325] [031/133] (849s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[192.739523] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[192.744047] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[193.610051] [032/133] (843s left) i915_query (query-topology-coherent-slice-mask)
[193.677166] Starting subtest: query-topology-coherent-slice-mask
[193.681625] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[193.799204] [033/133] (843s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[194.077528] Starting subtest: cursor-rapid-movement-512x170
[194.082166] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[194.247887] [034/133] (842s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[194.372545] Starting subtest: flip-vs-cursor-varying-size
[202.841775] Subtest flip-vs-cursor-varying-size: SUCCESS (8.469s)
[203.658910] [035/133] (833s left) gem_mmap_wc (pf-nonblock)
[203.723566] Subtest pf-nonblock: SKIP (0.000s)
[203.793515] [036/133] (833s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[203.885019] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[203.887315] Starting dynamic subtest: pipe-A-default-mode
[206.608955] Dynamic subtest pipe-A-default-mode: SUCCESS (2.724s)
[206.611677] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.726s)
[207.446701] [037/133] (829s left) kms_addfb_basic (bad-pitch-65536)
[207.509505] Starting subtest: bad-pitch-65536
[207.511683] Subtest bad-pitch-65536: SUCCESS (0.000s)
[207.670742] [038/133] (829s left) gem_lmem_swapping (parallel-random-engines)
[207.712686] Subtest parallel-random-engines: SKIP (0.000s)
[207.753878] [039/133] (829s left) kms_flip (2x-flip-vs-dpms-on-nop)
[207.854977] Starting subtest: 2x-flip-vs-dpms-on-nop
[207.864191] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[207.989311] [040/133] (829s left) syncobj_timeline (invalid-query-illegal-handle)
[208.039284] Starting subtest: invalid-query-illegal-handle
[208.041576] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[208.169677] [041/133] (829s left) syncobj_basic (test-valid-cycle)
[208.226465] Starting subtest: test-valid-cycle
[208.228369] Subtest test-valid-cycle: SUCCESS (0.000s)
[208.347310] [042/133] (828s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[208.909842] Starting subtest: syncobj-timeline-multiple-ext-nodes
[208.912205] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[209.957752] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[209.961080] [043/133] (827s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[210.056154] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[210.058493] Starting dynamic subtest: pipe-A-eDP-1
[210.067598] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.077528] Starting dynamic subtest: pipe-B-eDP-1
[210.086468] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.094723] Starting dynamic subtest: pipe-C-eDP-1
[210.103116] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.110580] Starting dynamic subtest: pipe-D-eDP-1
[210.118974] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.123064] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[212.218938] [044/133] (825s left) gem_wait (await)
[212.283483] Starting subtest: await
[212.285749] Starting dynamic subtest: all-engines
[213.402995] Dynamic subtest all-engines: SUCCESS (1.119s)
[213.417994] Starting dynamic subtest: rcs0
[214.456806] Dynamic subtest rcs0: SUCCESS (1.052s)
[214.474069] Starting dynamic subtest: bcs0
[215.513649] Dynamic subtest bcs0: SUCCESS (1.055s)
[215.530029] Starting dynamic subtest: vcs0
[216.569587] Dynamic subtest vcs0: SUCCESS (1.054s)
[216.586047] Starting dynamic subtest: vcs1
[217.622827] Dynamic subtest vcs1: SUCCESS (1.051s)
[217.638754] Starting dynamic subtest: vecs0
[218.676518] Dynamic subtest vecs0: SUCCESS (1.052s)
[218.692812] Starting dynamic subtest: ccs0
[219.733260] Dynamic subtest ccs0: SUCCESS (1.055s)
[219.735648] Subtest await: SUCCESS (7.451s)
[219.946694] [045/133] (817s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[220.048638] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[220.052692] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[220.189330] [046/133] (817s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[220.290410] Starting subtest: flip-vs-dpms-off-vs-modeset
[220.292611] Starting dynamic subtest: A-eDP1
[223.938434] Dynamic subtest A-eDP1: SUCCESS (3.644s)
[223.947485] Starting dynamic subtest: B-eDP1
[227.157655] Dynamic subtest B-eDP1: SUCCESS (3.220s)
[227.165571] Starting dynamic subtest: C-eDP1
[230.257451] Dynamic subtest C-eDP1: SUCCESS (3.098s)
[230.266698] Starting dynamic subtest: D-eDP1
[233.370222] Dynamic subtest D-eDP1: SUCCESS (3.112s)
[233.372702] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.083s)
[234.197775] [047/133] (803s left) gem_tiling_max_stride
[234.300660] [048/133] (803s left) gem_exec_whisper (basic-contexts-priority)
[234.367028] Starting subtest: basic-contexts-priority
[259.241757] Subtest basic-contexts-priority: SUCCESS (24.822s)
[259.388831] [049/133] (778s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[259.494151] Starting subtest: y-tiled-addfb-size-offset-overflow
[259.498152] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[259.613176] [050/133] (777s left) i915_pm_freq_api (freq-reset)
[259.678684] Starting subtest: freq-reset
[259.681078] Starting dynamic subtest: gt0
[259.867432] Dynamic subtest gt0: SUCCESS (0.185s)
[259.875667] Starting dynamic subtest: gt1
[260.037681] Dynamic subtest gt1: SUCCESS (0.167s)
[260.040574] Subtest freq-reset: SUCCESS (0.354s)
[260.121338] [051/133] (777s left) gem_partial_pwrite_pread (write-display)
[260.171990] Subtest write-display: SKIP (0.000s)
[260.254975] [052/133] (777s left) kms_colorop (plane-xr30-xr30-srgb_inv_eotf_lut)
[260.388245] Subtest plane-XR30-XR30-srgb_inv_eotf_lut: SKIP (0.000s)
[260.480470] [053/133] (777s left) kms_big_fb (linear-8bpp-rotate-0)
[260.581962] Starting subtest: linear-8bpp-rotate-0
[261.853196] Subtest linear-8bpp-rotate-0: SUCCESS (1.271s)
[262.005511] [054/133] (775s left) kms_cursor_legacy (single-bo)
[262.135438] Starting subtest: single-bo
[262.137377] Starting dynamic subtest: pipe-A
[267.571590] Dynamic subtest pipe-A: SUCCESS (5.380s)
[267.582844] Starting dynamic subtest: pipe-B
[272.952415] Dynamic subtest pipe-B: SUCCESS (5.381s)
[272.963047] Starting dynamic subtest: pipe-C
[278.334571] Dynamic subtest pipe-C: SUCCESS (5.379s)
[278.345577] Starting dynamic subtest: pipe-D
[283.715986] Dynamic subtest pipe-D: SUCCESS (5.378s)
[283.726559] Starting dynamic subtest: all-pipes
[289.102965] Dynamic subtest all-pipes: SUCCESS (5.385s)
[289.105347] Subtest single-bo: SUCCESS (26.915s)
[289.242407] [055/133] (748s left) kms_addfb_basic (bad-pitch-0)
[289.306043] Starting subtest: bad-pitch-0
[289.308335] Subtest bad-pitch-0: SUCCESS (0.000s)
[289.481093] [056/133] (748s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[289.578067] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[289.582067] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[289.690403] [057/133] (748s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[289.779428] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[289.781639] Starting dynamic subtest: pipe-A-eDP-1
[290.673262] Dynamic subtest pipe-A-eDP-1: FAIL (0.293s)
[290.684115] Starting dynamic subtest: pipe-B-eDP-1
[291.109040] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.035s)
[291.388763] Subtest plane-all-modeset-transition-fencing-internal-panels: FAIL (1.610s)
[292.242014] [058/133] (745s left) gem_mmap_wc (write-read-distinct)
[292.296826] Subtest write-read-distinct: SKIP (0.000s)
[292.360547] [059/133] (745s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[292.469796] Starting subtest: yf-tiled-32bpp-rotate-180
[292.474116] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[292.589595] [060/133] (745s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[297.612383] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[297.617541] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[298.469411] [061/133] (739s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[298.535843] Starting subtest: saturated-hostile-nopreempt
[298.538290] Starting dynamic subtest: rcs0
[298.656886] Dynamic subtest rcs0: SKIP (0.118s)
[298.665773] Starting dynamic subtest: bcs0
[298.681659] Dynamic subtest bcs0: SKIP (0.024s)
[298.690035] Starting dynamic subtest: vcs0
[298.705276] Dynamic subtest vcs0: SKIP (0.022s)
[298.718725] Starting dynamic subtest: vcs1
[298.729889] Dynamic subtest vcs1: SKIP (0.024s)
[298.740668] Starting dynamic subtest: vecs0
[298.753744] Dynamic subtest vecs0: SKIP (0.023s)
[298.762301] Starting dynamic subtest: ccs0
[298.777595] Dynamic subtest ccs0: SKIP (0.023s)
[298.782166] Subtest saturated-hostile-nopreempt: SKIP (0.240s)
[298.873399] [062/133] (739s left) gem_request_retire (retire-vma-not-inactive)
[298.937031] Starting subtest: retire-vma-not-inactive
[298.997595] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[299.170741] [063/133] (738s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[299.275336] Starting subtest: x-tiled-64bpp-rotate-270
[299.295738] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[299.433838] [064/133] (738s left) syncobj_timeline (invalid-transfer-illegal-handle)
[299.484717] Starting subtest: invalid-transfer-illegal-handle
[299.486587] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[299.606589] [065/133] (738s left) syncobj_timeline (wait-all-for-submit-complex)
[299.652621] Starting subtest: wait-all-for-submit-complex
[299.866578] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[299.967179] [066/133] (738s left) perf_pmu (idle)
[300.003215] Starting subtest: idle
[300.005446] Starting dynamic subtest: rcs0
[300.556551] Dynamic subtest rcs0: SUCCESS (0.552s)
[300.567613] Starting dynamic subtest: bcs0
[301.089798] Dynamic subtest bcs0: SUCCESS (0.530s)
[301.104072] Starting dynamic subtest: vcs0
[301.608985] Dynamic subtest vcs0: SUCCESS (0.515s)
[301.619702] Starting dynamic subtest: vcs1
[302.134979] Dynamic subtest vcs1: SUCCESS (0.523s)
[302.146774] Starting dynamic subtest: vecs0
[302.662789] Dynamic subtest vecs0: SUCCESS (0.525s)
[302.674317] Starting dynamic subtest: ccs0
[303.179865] Dynamic subtest ccs0: SUCCESS (0.514s)
[303.182751] Subtest idle: SUCCESS (3.178s)
[303.310797] [067/133] (734s left) vgem_slow (nohang)
[303.349589] Starting subtest: nohang
[313.509652] Subtest nohang: SUCCESS (10.109s)
[313.555388] [068/133] (724s left) syncobj_timeline (etime-multi-wait-all-submitted)
[313.614647] Starting subtest: etime-multi-wait-all-submitted
[313.721361] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s)
[313.826132] [069/133] (724s left) gem_exec_balancer (parallel-keep-submit-fence)
[314.087984] Starting subtest: parallel-keep-submit-fence
[315.264210] Subtest parallel-keep-submit-fence: SUCCESS (1.177s)
[315.406063] [070/133] (722s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[315.498246] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[315.500590] Starting dynamic subtest: pipe-A
[315.562332] Dynamic subtest pipe-A: SUCCESS (0.065s)
[315.577699] Starting dynamic subtest: pipe-B
[316.670057] Dynamic subtest pipe-B: SUCCESS (1.106s)
[316.679673] Starting dynamic subtest: pipe-C
[317.771166] Dynamic subtest pipe-C: SUCCESS (1.099s)
[317.781771] Starting dynamic subtest: pipe-D
[318.906133] Dynamic subtest pipe-D: SUCCESS (1.135s)
[318.908386] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.411s)
[320.076187] [071/133] (718s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[320.177117] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[320.179459] Starting dynamic subtest: A-eDP1
[323.812756] Dynamic subtest A-eDP1: SUCCESS (3.632s)
[323.822311] Starting dynamic subtest: B-eDP1
[327.006194] Dynamic subtest B-eDP1: SUCCESS (3.194s)
[327.015543] Starting dynamic subtest: C-eDP1
[330.124530] Dynamic subtest C-eDP1: SUCCESS (3.115s)
[330.134210] Starting dynamic subtest: D-eDP1
[333.226854] Dynamic subtest D-eDP1: SUCCESS (3.103s)
[333.229308] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.052s)
[334.040935] [072/133] (704s left) gem_ctx_shared (exec-shared-gtt)
[334.109689] Starting subtest: exec-shared-gtt
[334.111965] Starting dynamic subtest: rcs0
[334.118073] Dynamic subtest rcs0: SUCCESS (0.008s)
[334.127500] Starting dynamic subtest: bcs0
[334.129738] Dynamic subtest bcs0: SUCCESS (0.005s)
[334.139911] Starting dynamic subtest: vcs0
[334.142265] Dynamic subtest vcs0: SUCCESS (0.007s)
[334.151269] Starting dynamic subtest: vcs1
[334.153614] Dynamic subtest vcs1: SUCCESS (0.006s)
[334.162446] Starting dynamic subtest: vecs0
[334.164596] Dynamic subtest vecs0: SUCCESS (0.006s)
[334.173381] Starting dynamic subtest: ccs0
[334.175573] Dynamic subtest ccs0: SUCCESS (0.005s)
[334.177719] Subtest exec-shared-gtt: SUCCESS (0.041s)
[334.412341] [073/133] (704s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[334.500742] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[334.505268] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[334.639575] [074/133] (703s left) core_getversion (basic)
[334.671368] Starting subtest: basic
[334.675311] Subtest basic: SUCCESS (0.000s)
[334.746724] [075/133] (703s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[334.852885] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[342.178525] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.326s)
[342.303309] [076/133] (696s left) syncobj_timeline (reset-unsignaled)
[342.367943] Starting subtest: reset-unsignaled
[342.370127] Subtest reset-unsignaled: SUCCESS (0.000s)
[342.517474] [077/133] (696s left) kms_invalid_mode (bad-htotal)
[342.613375] Starting subtest: bad-htotal
[342.615810] Starting dynamic subtest: pipe-A-eDP-1
[342.910374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[342.920421] Starting dynamic subtest: pipe-B-eDP-1
[342.922538] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[342.931070] Starting dynamic subtest: pipe-C-eDP-1
[342.932874] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[342.940972] Starting dynamic subtest: pipe-D-eDP-1
[342.942869] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[342.945083] Subtest bad-htotal: SUCCESS (0.303s)
[343.800304] [078/133] (694s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[343.861921] Starting subtest: y-tiled-ccs-to-yf-tiled
[343.866490] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[344.057894] [079/133] (694s left) gem_mmap_gtt (fault-concurrent-y)
[344.111973] Subtest fault-concurrent-Y: SKIP (0.000s)
[344.178011] [080/133] (694s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[344.275187] Starting subtest: fbc-pr-sprite-mmap-cpu
[344.279403] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[344.372514] [081/133] (694s left) gem_ccs (block-copy-uncompressed)
[344.430377] Starting subtest: block-copy-uncompressed
[344.432803] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[344.454032] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[344.465259] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[344.471401] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[344.480933] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[344.488953] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[344.499381] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[344.506633] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[344.508941] Subtest block-copy-uncompressed: SUCCESS (0.076s)
[344.657676] [082/133] (694s left) gem_exec_fence (basic-busy-all)
[344.716913] Starting subtest: basic-busy-all
[344.840966] Subtest basic-busy-all: SUCCESS (0.125s)
[346.998434] [083/133] (691s left) gem_mmap_gtt (coherency)
[347.054294] Subtest coherency: SKIP (0.000s)
[347.117802] [084/133] (691s left) gem_exec_reloc (basic-cpu)
[347.177543] Subtest basic-cpu: SKIP (0.000s)
[347.272013] [085/133] (691s left) perf_pmu (multi-client)
[347.306848] Starting subtest: multi-client
[347.308840] Starting dynamic subtest: rcs0
[348.385319] Dynamic subtest rcs0: SUCCESS (1.078s)
[348.397080] Starting dynamic subtest: bcs0
[349.438862] Dynamic subtest bcs0: SUCCESS (1.051s)
[349.455209] Starting dynamic subtest: vcs0
[350.492351] Dynamic subtest vcs0: SUCCESS (1.051s)
[350.504105] Starting dynamic subtest: vcs1
[351.946701] Dynamic subtest vcs1: SUCCESS (1.452s)
[351.958556] Starting dynamic subtest: vecs0
[353.930109] Dynamic subtest vecs0: SUCCESS (1.981s)
[353.941995] Starting dynamic subtest: ccs0
[355.917050] Dynamic subtest ccs0: SUCCESS (1.984s)
[355.920050] Subtest multi-client: SUCCESS (8.612s)
[356.064492] [086/133] (682s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[356.167207] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[356.169471] Starting dynamic subtest: pipe-A-default-mode
[356.461416] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[356.466124] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.291s)
[357.334151] [087/133] (681s left) kms_colorop (plane-xr24-xr24-ctm_3x4_bt709_enc_dec)
[357.471252] Subtest plane-XR24-XR24-ctm_3x4_bt709_enc_dec: SKIP (0.000s)
[357.556167] [088/133] (681s left) sw_sync (sync_busy_fork_unixsocket)
[357.589885] Starting subtest: sync_busy_fork_unixsocket
[357.592337] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[357.659061] [089/133] (681s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[357.762699] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[357.767183] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[357.880429] [090/133] (681s left) gem_exec_balancer (bonded-semaphore)
[357.947461] Starting subtest: bonded-semaphore
[357.952105] Subtest bonded-semaphore: SKIP (0.000s)
[358.268019] [091/133] (680s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[358.354420] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[358.356823] Starting dynamic subtest: pipe-A-eDP-1
[358.507237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s)
[358.517760] Starting dynamic subtest: pipe-B-eDP-1
[358.537077] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[358.548702] Starting dynamic subtest: pipe-C-eDP-1
[358.569254] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[358.578242] Starting dynamic subtest: pipe-D-eDP-1
[358.598122] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[358.600426] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.176s)
[360.797290] [092/133] (678s left) kms_colorop (plane-xr24-xr24-ctm_3x4_oversaturate)
[360.940190] Subtest plane-XR24-XR24-ctm_3x4_oversaturate: SKIP (0.000s)
[361.032924] [093/133] (678s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[361.143652] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[365.512479] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.373s)
[366.717711] [094/133] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[366.829914] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[366.834396] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[366.968977] [095/133] (672s left) vgem_basic (dmabuf-fence)
[367.017643] Starting subtest: dmabuf-fence
[367.019456] Subtest dmabuf-fence: SUCCESS (0.001s)
[367.103233] [096/133] (672s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[367.200598] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[367.204684] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[367.318403] [097/133] (672s left) gem_userptr_blits (relocations)
[367.383499] Starting subtest: relocations
[367.387580] Subtest relocations: SKIP (0.000s)
[367.535444] [098/133] (671s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[367.632234] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[367.634135] Starting dynamic subtest: pipe-A-eDP-1
[367.654871] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.665921] Starting dynamic subtest: pipe-B-eDP-1
[367.685222] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.694144] Starting dynamic subtest: pipe-C-eDP-1
[367.713676] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.723422] Starting dynamic subtest: pipe-D-eDP-1
[367.744371] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.747702] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[369.861584] [099/133] (669s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[369.957513] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[376.768702] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.813s)
[376.895427] [100/133] (662s left) gem_ccs (large-ctrl-surf-copy)
[376.948598] Starting subtest: large-ctrl-surf-copy
[376.952936] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[377.068644] [101/133] (662s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[377.154986] Starting subtest: primary-yf-tiled-reflect-x-90
[377.159481] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[377.274953] [102/133] (662s left) kms_psr (pr-primary-blt)
[377.362146] Starting subtest: pr-primary-blt
[377.366610] Subtest pr-primary-blt: SKIP (0.000s)
[377.448469] [103/133] (662s left) i915_pm_rps (min-max-config-idle)
[377.508154] Starting subtest: min-max-config-idle
[377.512682] Subtest min-max-config-idle: SKIP (0.001s)
[377.628322] [104/133] (662s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[377.728753] Starting subtest: extended-modeset-hang-newfb-with-reset
[377.730412] Starting dynamic subtest: pipe-A
[393.244518] Dynamic subtest pipe-A: SUCCESS (15.516s)
[393.254039] Starting dynamic subtest: pipe-D
[408.735995] Dynamic subtest pipe-D: SUCCESS (15.490s)
[408.738427] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.010s)
[409.557538] [105/133] (630s left) gem_ctx_freq (sysfs)
[409.623615] Starting subtest: sysfs
[409.625934] Starting dynamic subtest: gt0
[415.148771] Dynamic subtest gt0: SUCCESS (5.525s)
[415.158218] Starting dynamic subtest: gt1
[456.915726] Dynamic subtest gt1: SUCCESS (41.764s)
[456.918689] Subtest sysfs: SUCCESS (47.292s)
[457.063959] [106/133] (582s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[457.170766] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[463.914786] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.748s)
[464.086541] [107/133] (575s left) gem_fence_thrash (bo-write-verify-y)
[464.122407] Starting subtest: bo-write-verify-y
[464.137607] Subtest bo-write-verify-y: SKIP (0.014s)
[464.201099] [108/133] (575s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[466.120475] Starting subtest: dpms-mode-unset-lpsp
[470.182959] Subtest dpms-mode-unset-lpsp: SUCCESS (4.064s)
[470.574144] [109/133] (569s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[470.691970] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[488.260445] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.569s)
[489.074385] [110/133] (550s left) perf (blocking-parameterized)
[489.215639] Starting subtest: blocking-parameterized
[509.288761] Subtest blocking-parameterized: SUCCESS (20.023s)
[509.328730] [111/133] (530s left) kms_async_flips (async-flip-dpms)
[509.499200] Starting subtest: async-flip-dpms
[509.868955] Starting dynamic subtest: pipe-A-eDP-1
[511.133184] Dynamic subtest pipe-A-eDP-1: FAIL (0.764s)
[511.145262] Starting dynamic subtest: pipe-B-eDP-1
[512.029602] Dynamic subtest pipe-B-eDP-1: FAIL (0.757s)
[512.150575] Starting dynamic subtest: pipe-C-eDP-1
[516.034947] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.895s)
[516.431642] Starting dynamic subtest: pipe-D-eDP-1
[519.204808] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.780s)
[519.207019] Subtest async-flip-dpms: FAIL (9.707s)
[520.415674] [112/133] (519s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[520.477650] Starting subtest: invalid-bsd1-flag-on-vebox
[520.479842] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[520.611850] [113/133] (519s left) sriov_basic (enable-vfs-autoprobe-on)
[520.671607] Starting subtest: enable-vfs-autoprobe-on
[520.673970] Starting dynamic subtest: numvfs-1
[520.745092] Dynamic subtest numvfs-1: FAIL (0.005s)
[520.754677] Starting dynamic subtest: numvfs-2
[520.823385] Dynamic subtest numvfs-2: FAIL (0.004s)
[520.833046] Starting dynamic subtest: numvfs-3
[520.901655] Dynamic subtest numvfs-3: FAIL (0.003s)
[520.910697] Starting dynamic subtest: numvfs-4
[520.979654] Dynamic subtest numvfs-4: FAIL (0.004s)
[520.989258] Starting dynamic subtest: numvfs-5
[521.057389] Dynamic subtest numvfs-5: FAIL (0.004s)
[521.066818] Starting dynamic subtest: numvfs-6
[521.135601] Dynamic subtest numvfs-6: FAIL (0.004s)
[521.144691] Starting dynamic subtest: numvfs-7
[521.215064] Dynamic subtest numvfs-7: FAIL (0.004s)
[521.223879] Starting dynamic subtest: numvfs-random
[521.285832] Dynamic subtest numvfs-random: FAIL (0.004s)
[521.294627] Starting dynamic subtest: numvfs-all
[521.350672] Dynamic subtest numvfs-all: FAIL (0.483s)
[521.352437] Subtest enable-vfs-autoprobe-on: FAIL (0.521s)
[521.388394] [114/133] (518s left) kms_pm_rpm (basic-rte)
[521.418863] Starting subtest: basic-rte
[524.577676] Subtest basic-rte: SUCCESS (3.159s)
[526.113952] [115/133] (514s left) i915_drm_fdinfo (memory-info-purgeable)
[526.151649] Starting subtest: memory-info-purgeable
[526.153789] Starting dynamic subtest: smem0
[528.756349] Dynamic subtest smem0: SUCCESS (2.605s)
[528.758679] Subtest memory-info-purgeable: SUCCESS (2.606s)
[528.843793] [116/133] (511s left) gem_exec_gttfill (basic)
[528.903146] Starting subtest: basic
[532.368880] Subtest basic: SUCCESS (3.465s)
[532.569143] [117/133] (507s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[532.715442] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[532.719736] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[532.845722] [118/133] (507s left) kms_flip (busy-flip)
[532.951256] Starting subtest: busy-flip
[532.953612] Starting dynamic subtest: A-eDP1
[534.688629] Dynamic subtest A-eDP1: SUCCESS (1.735s)
[534.701836] Starting dynamic subtest: B-eDP1
[536.314075] Dynamic subtest B-eDP1: SUCCESS (1.624s)
[536.324124] Starting dynamic subtest: C-eDP1
[537.923452] Dynamic subtest C-eDP1: SUCCESS (1.608s)
[537.933544] Starting dynamic subtest: D-eDP1
[539.555340] Dynamic subtest D-eDP1: SUCCESS (1.631s)
[539.557683] Subtest busy-flip: SUCCESS (6.606s)
[540.827981] [119/133] (499s left) kms_plane_alpha_blend (alpha-basic)
[540.923024] Starting subtest: alpha-basic
[541.204674] Starting dynamic subtest: pipe-A-eDP-1
[543.141883] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[543.170567] Starting dynamic subtest: pipe-D-eDP-1
[545.797221] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.635s)
[545.799621] Subtest alpha-basic: SUCCESS (4.876s)
[546.605629] [120/133] (493s left) kms_async_flips (crc-atomic)
[546.699857] Starting subtest: crc-atomic
[547.082191] Starting dynamic subtest: pipe-A-eDP-1
[550.029178] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.946s)
[550.405857] Starting dynamic subtest: pipe-B-eDP-1
[553.379460] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.962s)
[553.736321] Starting dynamic subtest: pipe-C-eDP-1
[556.691102] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.934s)
[557.038105] Starting dynamic subtest: pipe-D-eDP-1
[559.913284] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.893s)
[559.915548] Subtest crc-atomic: SUCCESS (13.212s)
[561.069453] [121/133] (479s left) perf (gen8-unprivileged-single-ctx-counters)
[561.198366] Starting subtest: gen8-unprivileged-single-ctx-counters
[561.202941] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[561.243382] [122/133] (479s left) kms_cursor_crc (cursor-random-256x256)
[561.479660] Starting subtest: cursor-random-256x256
[561.484827] Starting dynamic subtest: pipe-A-eDP-1
[564.803587] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.320s)
[564.836692] Starting dynamic subtest: pipe-D-eDP-1
[568.788529] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.960s)
[568.790999] Subtest cursor-random-256x256: SUCCESS (7.306s)
[569.656732] [123/133] (470s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[569.765596] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[569.769690] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[569.892893] [124/133] (470s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[569.994827] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[569.999143] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[570.105260] [125/133] (470s left) gem_exec_schedule (preempt-hang)
[570.283305] Starting subtest: preempt-hang
[570.285239] Starting dynamic subtest: rcs0
[570.520041] Dynamic subtest rcs0: SUCCESS (0.238s)
[570.532685] Starting dynamic subtest: bcs0
[570.752501] Dynamic subtest bcs0: SUCCESS (0.232s)
[570.763801] Starting dynamic subtest: vcs0
[570.978319] Dynamic subtest vcs0: SUCCESS (0.225s)
[570.987682] Starting dynamic subtest: vcs1
[571.203084] Dynamic subtest vcs1: SUCCESS (0.224s)
[571.215745] Starting dynamic subtest: vecs0
[571.430682] Dynamic subtest vecs0: SUCCESS (0.226s)
[571.442574] Starting dynamic subtest: ccs0
[571.664038] Dynamic subtest ccs0: SUCCESS (0.231s)
[571.665879] Subtest preempt-hang: SUCCESS (1.383s)
[572.058805] [126/133] (468s left) gem_exec_whisper (basic-queues-forked-all)
[572.130920] Starting subtest: basic-queues-forked-all
[592.096318] Subtest basic-queues-forked-all: SUCCESS (19.959s)
[592.297784] [127/133] (448s left) kms_vblank (wait-forked)
[592.401073] Starting subtest: wait-forked
[592.403317] Starting dynamic subtest: pipe-A-eDP-1
[594.222985] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s)
[594.239165] Starting dynamic subtest: pipe-D-eDP-1
[596.744224] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.519s)
[596.746487] Subtest wait-forked: SUCCESS (4.342s)
[597.618079] [128/133] (443s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[597.729109] Starting subtest: 4-tiled-32bpp-rotate-270
[597.748761] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[597.898986] [129/133] (442s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[598.292364] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[599.129382] [130/133] (441s left) gem_exec_schedule (fairslice-all)
[599.205953] Starting subtest: fairslice-all
[601.301302] Subtest fairslice-all: SUCCESS (2.054s)
[602.905092] [131/133] (438s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[603.013114] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[603.015406] Starting dynamic subtest: pipe-A-eDP-1
[603.038707] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[603.051688] Starting dynamic subtest: pipe-B-eDP-1
[603.073180] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[603.082527] Starting dynamic subtest: pipe-C-eDP-1
[603.104090] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[603.115902] Starting dynamic subtest: pipe-D-eDP-1
[603.138192] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[603.142696] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[605.359406] [132/133] (435s left) kms_psr2_su (page_flip-nv12)
[605.422668] Subtest page_flip-NV12: SKIP (0.000s)
[605.481556] [133/133] (435s left) gem_flink_basic (bad-flink)
[605.529627] Starting subtest: bad-flink
[605.531590] Subtest bad-flink: SUCCESS (0.000s)
[605.651015] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_chamelium_frames
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: gen9_exec_parse
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: gem_fence_thrash
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: sw_sync
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_universal_plane
results: parsing output: 11/ for test: gem_spin_batch
results: parsing output: 12/ for test: i915_suspend
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: prime_mmap
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_lease
results: parsing output: 19/ for test: kms_plane_multiple
results: parsing output: 20/ for test: kms_chamelium_color
results: parsing output: 21/ for test: kms_dsc
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: gem_pxp
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: api_intel_allocator
results: parsing output: 28/ for test: api_intel_bb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: i915_query
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_mmap_wc
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: gem_lmem_swapping
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: syncobj_basic
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: gem_wait
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_tiling_max_stride
results: parsing output: 47/ for test: gem_exec_whisper
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: i915_pm_freq_api
results: parsing output: 50/ for test: gem_partial_pwrite_pread
results: parsing output: 51/ for test: kms_colorop
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_atomic_transition
results: parsing output: 57/ for test: gem_mmap_wc
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: gem_request_retire
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: vgem_slow
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: gem_exec_balancer
results: parsing output: 69/ for test: kms_plane_scaling
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_ctx_shared
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: core_getversion
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_invalid_mode
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_ccs
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_flip_scaled_crc
results: parsing output: 86/ for test: kms_colorop
results: parsing output: 87/ for test: sw_sync
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_colorop
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: vgem_basic
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_userptr_blits
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_ccs
results: parsing output: 100/ for test: kms_rotation_crc
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: i915_pm_rps
results: parsing output: 103/ for test: kms_busy
results: parsing output: 104/ for test: gem_ctx_freq
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_fence_thrash
results: parsing output: 107/ for test: kms_pm_rpm
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: gem_exec_params
results: parsing output: 112/ for test: sriov_basic
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: i915_drm_fdinfo
results: parsing output: 115/ for test: gem_exec_gttfill
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_plane_alpha_blend
results: parsing output: 119/ for test: kms_async_flips
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_chamelium_hpd
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_psr2_su
results: parsing output: 132/ for test: gem_flink_basic
Done.