[65.492497] Initializing watchdogs
[65.492547]   /dev/watchdog0
[65.507418] [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]
[65.511893] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[65.514277] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.517744] [001/133] (960s left) kms_hdr (bpc-switch-dpms)
[65.648891] Starting subtest: bpc-switch-dpms
[66.679748] Starting dynamic subtest: pipe-A-eDP-1
[71.199549] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.524s)
[71.202093] Subtest bpc-switch-dpms: SUCCESS (5.558s)
[71.298074] [002/133] (954s left) gem_softpin (zero)
[71.365622] Starting subtest: zero
[71.372643] Subtest zero: SUCCESS (0.006s)
[71.512025] [003/133] (954s left) i915_pm_rpm (gem-pread)
[73.039737] Starting subtest: gem-pread
[75.473494] Subtest gem-pread: SUCCESS (2.435s)
[75.553091] [004/133] (950s left) kms_atomic_transition (plane-all-transition-fencing)
[75.636962] Starting subtest: plane-all-transition-fencing
[75.639377] Starting dynamic subtest: pipe-A-eDP-1
[78.132306] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[78.443055] Starting dynamic subtest: pipe-B-eDP-1
[81.662835] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.226s)
[81.967209] Subtest plane-all-transition-fencing: SUCCESS (6.332s)
[82.789009] [005/133] (943s left) gem_exec_reloc (basic-gtt-wc)
[82.853480] Subtest basic-gtt-wc: SKIP (0.000s)
[82.927080] [006/133] (943s left) sysfs_timeslice_duration (idempotent)
[83.000490] Starting subtest: idempotent
[83.002860] Starting dynamic subtest: vecs0
[83.005207] Dynamic subtest vecs0: SUCCESS (0.000s)
[83.014125] Starting dynamic subtest: ccs0
[83.016276] Dynamic subtest ccs0: SUCCESS (0.000s)
[83.023038] Starting dynamic subtest: vcs0
[83.025230] Dynamic subtest vcs0: SUCCESS (0.000s)
[83.034480] Starting dynamic subtest: bcs0
[83.036667] Dynamic subtest bcs0: SUCCESS (0.000s)
[83.043437] Starting dynamic subtest: rcs0
[83.045588] Dynamic subtest rcs0: SUCCESS (0.000s)
[83.052820] Starting dynamic subtest: vcs1
[83.055035] Dynamic subtest vcs1: SUCCESS (0.000s)
[83.057197] Subtest idempotent: SUCCESS (0.004s)
[83.133869] [007/133] (943s left) prime_vgem (basic-gtt)
[83.226071] Starting subtest: basic-gtt
[83.230486] Subtest basic-gtt: SKIP (0.000s)
[83.322450] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[83.325742] [008/133] (942s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[83.416498] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[83.420708] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[83.511401] [009/133] (942s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[83.601734] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[87.161969] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.564s)
[88.291262] [010/133] (938s left) gem_exec_fence (syncobj-invalid-flags)
[88.714188] Starting subtest: syncobj-invalid-flags
[88.716708] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[89.971935] [011/133] (936s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[90.066607] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[96.668547] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.607s)
[96.769823] [012/133] (929s left) api_intel_allocator (reopen)
[96.841196] Starting subtest: reopen
[96.845890] Subtest reopen: SUCCESS (0.005s)
[96.967993] [013/133] (929s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[97.068346] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[97.070678] Starting dynamic subtest: pipe-A-eDP-1
[113.532952] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.343s)
[113.542833] Starting dynamic subtest: pipe-B-eDP-1
[130.503266] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.450s)
[130.512608] Starting dynamic subtest: pipe-C-eDP-1
[147.445841] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.393s)
[147.455044] Starting dynamic subtest: pipe-D-eDP-1
[164.407767] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.330s)
[164.410024] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.521s)
[165.564314] [014/133] (860s left) syncobj_basic (test-valid-cycle)
[165.628616] Starting subtest: test-valid-cycle
[165.630855] Subtest test-valid-cycle: SUCCESS (0.000s)
[165.732450] [015/133] (860s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[165.839527] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[165.841929] Starting dynamic subtest: pipe-A
[165.865017] Dynamic subtest pipe-A: SKIP (0.021s)
[165.873364] Starting dynamic subtest: pipe-B
[165.897273] Dynamic subtest pipe-B: SKIP (0.033s)
[165.905180] Starting dynamic subtest: pipe-C
[165.929119] Dynamic subtest pipe-C: SKIP (0.033s)
[165.936779] Starting dynamic subtest: pipe-D
[165.960132] Dynamic subtest pipe-D: SKIP (0.032s)
[165.964202] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.121s)
[166.057267] [016/133] (860s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[166.160653] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[170.319143] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.209s)
[171.439910] [017/133] (855s left) prime_mmap_coherency (read)
[171.505714] Starting subtest: read
[176.857052] Subtest read: SUCCESS (5.378s)
[176.982609] [018/133] (849s left) gem_fence_thrash (bo-write-verify-y)
[177.015496] Starting subtest: bo-write-verify-y
[177.026580] Subtest bo-write-verify-y: SKIP (0.014s)
[177.088959] [019/133] (849s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[177.132919] Starting subtest: single-wait-all-for-submit-available-submitted
[177.135191] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[177.227340] [020/133] (849s left) kms_cursor_crc (cursor-onscreen-32x10)
[177.390967] Starting subtest: cursor-onscreen-32x10
[177.440661] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[177.743381] [021/133] (849s left) gem_ctx_persistence (idempotent)
[177.803849] Starting subtest: idempotent
[177.806013] Subtest idempotent: SUCCESS (0.000s)
[177.910748] [022/133] (848s left) kms_invalid_mode (bad-hsync-start)
[177.992274] Starting subtest: bad-hsync-start
[177.994087] Starting dynamic subtest: pipe-A-eDP-1
[178.292622] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s)
[178.301981] Starting dynamic subtest: pipe-B-eDP-1
[178.303924] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[178.311566] Starting dynamic subtest: pipe-C-eDP-1
[178.313456] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[178.321422] Starting dynamic subtest: pipe-D-eDP-1
[178.323560] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[178.325782] Subtest bad-hsync-start: SUCCESS (0.308s)
[179.124571] [023/133] (847s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[179.226743] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[179.231317] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[179.326857] [024/133] (847s left) kms_atomic (test-only)
[179.432076] Starting subtest: test-only
[179.479187] Starting dynamic subtest: pipe-A-eDP-1
[182.017725] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.544s)
[182.019974] Subtest test-only: SUCCESS (2.594s)
[182.806859] [025/133] (844s left) kms_psr (fbc-pr-sprite-plane-move)
[182.896969] Starting subtest: fbc-pr-sprite-plane-move
[182.901150] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[182.998522] [026/133] (844s left) kms_flip (flip-vs-absolute-wf_vblank)
[183.096501] Starting subtest: flip-vs-absolute-wf_vblank
[183.098683] Starting dynamic subtest: A-eDP1
[192.049458] Dynamic subtest A-eDP1: SUCCESS (8.965s)
[192.060338] Starting dynamic subtest: B-eDP1
[200.981914] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[200.991878] Starting dynamic subtest: C-eDP1
[209.908836] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[209.917482] Starting dynamic subtest: D-eDP1
[218.844627] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[218.850061] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.760s)
[220.086147] [027/133] (807s left) gem_exec_schedule (pi-distinct-iova)
[220.263053] Starting subtest: pi-distinct-iova
[220.265386] Starting dynamic subtest: rcs0
[220.338537] Dynamic subtest rcs0: SUCCESS (0.078s)
[220.348090] Starting dynamic subtest: vcs0
[220.404842] Dynamic subtest vcs0: SUCCESS (0.065s)
[220.414690] Starting dynamic subtest: vcs1
[220.461551] Dynamic subtest vcs1: SUCCESS (0.056s)
[220.472115] Starting dynamic subtest: vecs0
[220.517773] Dynamic subtest vecs0: SUCCESS (0.055s)
[220.526929] Starting dynamic subtest: ccs0
[220.573978] Dynamic subtest ccs0: SUCCESS (0.056s)
[220.576734] Subtest pi-distinct-iova: SUCCESS (0.314s)
[221.954105] [028/133] (805s left) gem_mmap_offset (bad-extensions)
[222.009311] Starting subtest: bad-extensions
[222.011549] Subtest bad-extensions: SUCCESS (0.000s)
[222.114425] [029/133] (805s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[222.207041] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[222.211191] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[222.317018] [030/133] (804s left) kms_vblank (wait-forked)
[222.405740] Starting subtest: wait-forked
[222.407921] Starting dynamic subtest: pipe-A-eDP-1
[224.215139] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[224.228329] Starting dynamic subtest: pipe-D-eDP-1
[226.682531] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.466s)
[226.684943] Subtest wait-forked: SUCCESS (4.280s)
[227.550501] [031/133] (799s left) perf (invalid-oa-metric-set-id)
[227.685488] Starting subtest: invalid-oa-metric-set-id
[227.697319] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[227.738411] [032/133] (799s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[227.794186] Starting subtest: etime-single-wait-all-available-unsubmitted
[227.896542] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s)
[227.973413] [033/133] (799s left) sw_sync (sync_merge)
[228.012652] Starting subtest: sync_merge
[228.014823] Subtest sync_merge: SUCCESS (0.000s)
[228.072963] [034/133] (799s left) kms_lease (page-flip-implicit-plane)
[228.178659] Starting subtest: page-flip-implicit-plane
[228.180920] Starting dynamic subtest: pipe-A-eDP-1
[228.709294] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.525s)
[228.719853] Starting dynamic subtest: pipe-B-eDP-1
[229.895122] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.185s)
[229.904927] Starting dynamic subtest: pipe-C-eDP-1
[231.008753] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[231.017577] Starting dynamic subtest: pipe-D-eDP-1
[232.136963] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[232.138873] Subtest page-flip-implicit-plane: SUCCESS (3.957s)
[232.983981] [035/133] (794s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[233.084332] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[233.110500] Starting dynamic subtest: pipe-A-plane-0
[233.399376] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[233.408109] Starting dynamic subtest: pipe-A-plane-3
[233.632336] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[233.640857] Starting dynamic subtest: pipe-A-plane-5
[233.645225] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[234.751482] Starting dynamic subtest: pipe-B-plane-0
[235.043850] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[235.052332] Starting dynamic subtest: pipe-B-plane-3
[235.277846] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[235.290078] Starting dynamic subtest: pipe-B-plane-5
[235.294581] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[235.588475] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.504s)
[236.427844] [036/133] (791s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[236.533228] Starting subtest: 4-tiled-32bpp-rotate-90
[236.553133] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[236.667825] [037/133] (790s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[236.768820] Starting subtest: addfb25-yf-tiled-legacy
[236.770776] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[236.878297] [038/133] (790s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[236.977411] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[238.055643] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.079s)
[238.187674] [039/133] (789s left) gem_ctx_create (basic)
[238.246723] Starting subtest: basic
[238.248600] Subtest basic: SUCCESS (0.000s)
[238.426814] [040/133] (789s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[238.527310] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[238.529742] Starting dynamic subtest: pipe-A-eDP-1
[238.553229] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[238.568178] Starting dynamic subtest: pipe-B-eDP-1
[238.592356] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[238.601404] Starting dynamic subtest: pipe-C-eDP-1
[238.623283] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[238.631341] Starting dynamic subtest: pipe-D-eDP-1
[238.653671] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[238.657746] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[240.895700] [041/133] (786s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[240.986236] Starting subtest: 2x-absolute-wf_vblank-interruptible
[240.997950] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[241.077456] [042/133] (786s left) gem_exec_balancer (bonded-dual)
[241.139737] Starting subtest: bonded-dual
[241.144276] Subtest bonded-dual: SKIP (0.000s)
[241.433489] [043/133] (786s left) gem_eio (in-flight-contexts-10ms)
[241.673078] Starting subtest: in-flight-contexts-10ms
[252.855532] Subtest in-flight-contexts-10ms: SUCCESS (11.184s)
[253.022159] [044/133] (774s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[253.129519] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[253.133444] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[253.201656] [045/133] (774s left) gem_userptr_blits (unsync-overlap)
[253.269088] Subtest unsync-overlap: SKIP (0.000s)
[253.399343] [046/133] (774s left) kms_flip_event_leak (basic)
[253.491581] Starting subtest: basic
[253.493567] Starting dynamic subtest: pipe-A-eDP-1
[253.910594] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[253.920295] Starting dynamic subtest: pipe-B-eDP-1
[254.998842] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.088s)
[255.008089] Starting dynamic subtest: pipe-C-eDP-1
[256.103788] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[256.116588] Starting dynamic subtest: pipe-D-eDP-1
[257.241738] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[257.243699] Subtest basic: SUCCESS (3.752s)
[258.101625] [047/133] (769s left) i915_drm_fdinfo (most-busy-check-all)
[258.148301] Starting subtest: most-busy-check-all
[258.151962] Starting dynamic subtest: rcs0
[258.156515] Dynamic subtest rcs0: SKIP (0.003s)
[258.164800] Starting dynamic subtest: bcs0
[258.168947] Dynamic subtest bcs0: SKIP (0.000s)
[258.177228] Starting dynamic subtest: vcs0
[258.181401] Dynamic subtest vcs0: SKIP (0.000s)
[258.189550] Starting dynamic subtest: vcs1
[258.193851] Dynamic subtest vcs1: SKIP (0.001s)
[258.202429] Starting dynamic subtest: vecs0
[258.206686] Dynamic subtest vecs0: SKIP (0.000s)
[258.214941] Starting dynamic subtest: ccs0
[258.219153] Dynamic subtest ccs0: SKIP (0.000s)
[258.223393] Subtest most-busy-check-all: SKIP (0.009s)
[258.260577] [048/133] (769s left) gem_mmap (pf-nonblock)
[258.313341] Subtest pf-nonblock: SKIP (0.000s)
[258.379179] [049/133] (769s left) gem_exec_basic (basic)
[258.432730] Starting subtest: basic
[258.434857] Starting dynamic subtest: rcs0-smem
[258.437038] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[258.453972] Starting dynamic subtest: bcs0-smem
[258.456159] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[258.474720] Starting dynamic subtest: vcs0-smem
[258.476775] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[258.488848] Starting dynamic subtest: vcs1-smem
[258.490827] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[258.499468] Starting dynamic subtest: vecs0-smem
[258.501331] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[258.511187] Starting dynamic subtest: ccs0-smem
[258.513002] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[258.514820] Subtest basic: SUCCESS (0.014s)
[259.911686] [050/133] (768s left) kms_plane_cursor (overlay)
[260.006402] Starting subtest: overlay
[260.010626] Starting dynamic subtest: pipe-A-eDP-1-size-64
[262.581143] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.575s)
[262.643082] Starting dynamic subtest: pipe-A-eDP-1-size-128
[265.192296] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[265.252692] Starting dynamic subtest: pipe-A-eDP-1-size-256
[267.838746] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.594s)
[268.190240] Starting dynamic subtest: pipe-B-eDP-1-size-64
[271.474409] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.296s)
[271.534640] Starting dynamic subtest: pipe-B-eDP-1-size-128
[274.121059] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.593s)
[274.180353] Starting dynamic subtest: pipe-B-eDP-1-size-256
[276.812380] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.638s)
[277.161299] Starting dynamic subtest: pipe-C-eDP-1-size-64
[280.102579] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.952s)
[280.139911] Starting dynamic subtest: pipe-C-eDP-1-size-128
[282.336401] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[282.373950] Starting dynamic subtest: pipe-C-eDP-1-size-256
[284.547631] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s)
[284.876860] Starting dynamic subtest: pipe-D-eDP-1-size-64
[287.803621] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.937s)
[287.840284] Starting dynamic subtest: pipe-D-eDP-1-size-128
[290.047578] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[290.085483] Starting dynamic subtest: pipe-D-eDP-1-size-256
[292.270608] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.192s)
[292.594194] Subtest overlay: SUCCESS (32.581s)
[293.449280] [051/133] (734s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[293.558122] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[293.562391] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[293.663535] [052/133] (734s left) kms_pwrite_crc
[295.255818] [053/133] (732s left) kms_psr (psr-sprite-plane-move)
[295.363514] Starting subtest: psr-sprite-plane-move
[295.365867] Starting dynamic subtest: eDP-1
[297.097545] Dynamic subtest eDP-1: SUCCESS (1.734s)
[297.099906] Subtest psr-sprite-plane-move: SUCCESS (1.735s)
[297.929754] [054/133] (730s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[298.016167] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[298.020985] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[298.102686] [055/133] (730s left) dumb_buffer (invalid-bpp)
[298.153280] Starting subtest: invalid-bpp
[298.155509] Subtest invalid-bpp: SUCCESS (0.000s)
[298.244069] [056/133] (730s left) kms_cursor_crc (cursor-onscreen-64x21)
[298.435979] Starting subtest: cursor-onscreen-64x21
[298.485762] Subtest cursor-onscreen-64x21: SKIP (0.047s)
[298.723715] [057/133] (729s left) gem_lmem_swapping (random-engines)
[298.768547] Subtest random-engines: SKIP (0.000s)
[298.807456] [058/133] (729s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[298.908857] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[306.195661] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.291s)
[306.318177] [059/133] (722s left) gem_exec_params (rel-constants-invalid-ring)
[306.375329] Starting subtest: rel-constants-invalid-ring
[306.377575] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[306.473888] [060/133] (721s left) gen7_exec_parse (chained-batch)
[306.526618] Subtest chained-batch: SKIP (0.000s)
[306.582130] [061/133] (721s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[306.957793] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[307.764187] [062/133] (720s left) gem_exec_params (no-bsd)
[307.817797] Starting subtest: no-bsd
[307.822889] Subtest no-bsd: SUCCESS (0.002s)
[309.923268] [063/133] (718s left) perf_pmu (busy-check-all)
[309.960924] Starting subtest: busy-check-all
[309.963190] Starting dynamic subtest: rcs0
[310.514202] Dynamic subtest rcs0: SUCCESS (0.553s)
[310.526430] Starting dynamic subtest: bcs0
[311.067697] Dynamic subtest bcs0: SUCCESS (0.551s)
[311.079298] Starting dynamic subtest: vcs0
[312.861174] Dynamic subtest vcs0: SUCCESS (1.790s)
[312.872972] Starting dynamic subtest: vcs1
[314.845525] Dynamic subtest vcs1: SUCCESS (1.981s)
[314.856913] Starting dynamic subtest: vecs0
[316.828689] Dynamic subtest vecs0: SUCCESS (1.981s)
[316.839931] Starting dynamic subtest: ccs0
[317.385416] Dynamic subtest ccs0: SUCCESS (0.556s)
[317.388022] Subtest busy-check-all: SUCCESS (7.427s)
[317.488168] [064/133] (711s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[317.588003] Starting subtest: y-tiled-8bpp-rotate-180
[317.592361] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[317.687365] [065/133] (710s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[317.775631] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[318.432915] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[318.603898] [066/133] (710s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[318.702843] Starting subtest: fbcpsr-tiling-4
[325.824531] Subtest fbcpsr-tiling-4: SUCCESS (7.126s)
[325.963403] [067/133] (702s left) gem_ctx_isolation (clean)
[326.027231] Starting subtest: clean
[326.029437] Starting dynamic subtest: rcs0
[326.074765] Dynamic subtest rcs0: SUCCESS (0.047s)
[326.085757] Starting dynamic subtest: bcs0
[326.163968] Dynamic subtest bcs0: SUCCESS (0.088s)
[326.174079] Starting dynamic subtest: vcs0
[326.209682] Dynamic subtest vcs0: SUCCESS (0.045s)
[326.221234] Starting dynamic subtest: vcs1
[327.829796] Dynamic subtest vcs1: SUCCESS (1.619s)
[327.840320] Starting dynamic subtest: vecs0
[329.821087] Dynamic subtest vecs0: SUCCESS (1.990s)
[329.831355] Starting dynamic subtest: ccs0
[331.895614] Dynamic subtest ccs0: SUCCESS (2.075s)
[331.897987] Subtest clean: SUCCESS (5.870s)
[332.085946] [068/133] (696s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[332.176152] Starting subtest: fbc-psr-cursor-mmap-gtt
[332.178403] Starting dynamic subtest: eDP-1
[332.182430] Dynamic subtest eDP-1: SKIP (0.000s)
[332.186397] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[332.261350] [069/133] (696s left) gem_exec_params (invalid-bsd1-flag-on-render)
[332.338603] Starting subtest: invalid-bsd1-flag-on-render
[332.341052] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[332.439659] [070/133] (696s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[332.543394] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[332.547753] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[332.664562] [071/133] (696s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[332.756054] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[332.757838] Starting dynamic subtest: pipe-A-eDP-1
[332.777440] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[332.787961] Starting dynamic subtest: pipe-B-eDP-1
[332.807951] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[332.818885] Starting dynamic subtest: pipe-C-eDP-1
[332.838872] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[332.848088] Starting dynamic subtest: pipe-D-eDP-1
[332.868011] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[332.870199] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.086s)
[335.076012] [072/133] (693s left) i915_drm_fdinfo (virtual-busy-idle-all)
[335.123723] Starting subtest: virtual-busy-idle-all
[335.128126] Subtest virtual-busy-idle-all: SKIP (0.000s)
[335.196548] [073/133] (693s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[335.291156] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[335.295660] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[335.401193] [074/133] (693s left) kms_psr (pr-cursor-plane-move)
[335.497445] Starting subtest: pr-cursor-plane-move
[335.501406] Subtest pr-cursor-plane-move: SKIP (0.000s)
[335.575712] [075/133] (693s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[335.695721] Starting subtest: 2x-flip-vs-cursor-legacy
[335.700205] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[335.839645] [076/133] (693s left) kms_pm_backlight (fade)
[335.927463] Starting subtest: fade
[335.977098] Starting dynamic subtest: eDP-1
[338.647449] Dynamic subtest eDP-1: SUCCESS (2.668s)
[338.649717] Subtest fade: SUCCESS (2.720s)
[339.501065] [077/133] (689s left) gem_exec_whisper (basic-fds-priority)
[339.557837] Starting subtest: basic-fds-priority
[363.339503] Subtest basic-fds-priority: SUCCESS (23.782s)
[363.543027] [078/133] (665s left) kms_color_pipeline (plane-lut1d-lut1d)
[363.647323] Starting subtest: plane-lut1d-lut1d
[363.793063] Starting dynamic subtest: pipe-A-plane-0
[363.970552] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[363.981955] Starting dynamic subtest: pipe-A-plane-1
[364.137193] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[364.146952] Starting dynamic subtest: pipe-A-plane-2
[364.303599] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[365.544142] Starting dynamic subtest: pipe-B-plane-0
[365.736204] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[365.745934] Starting dynamic subtest: pipe-B-plane-1
[365.902925] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[365.912796] Starting dynamic subtest: pipe-B-plane-2
[366.069724] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[367.237623] Starting dynamic subtest: pipe-C-plane-0
[367.416124] Dynamic subtest pipe-C-plane-0: SUCCESS (0.188s)
[367.425398] Starting dynamic subtest: pipe-C-plane-1
[367.571878] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[367.587262] Starting dynamic subtest: pipe-C-plane-2
[367.749821] Dynamic subtest pipe-C-plane-2: SUCCESS (0.177s)
[368.973876] Starting dynamic subtest: pipe-D-plane-0
[369.121396] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[369.130936] Starting dynamic subtest: pipe-D-plane-1
[369.276903] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[369.286455] Starting dynamic subtest: pipe-D-plane-2
[369.443285] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[369.727325] Subtest plane-lut1d-lut1d: SUCCESS (6.084s)
[370.549762] [079/133] (658s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[370.654795] Starting subtest: fbc-rgb565-draw-mmap-cpu
[374.667828] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.018s)
[375.841626] [080/133] (653s left) kms_scaling_modes (scaling-mode-full)
[375.940719] Starting subtest: scaling-mode-full
[375.943033] Starting dynamic subtest: pipe-A-eDP-1
[376.038948] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.099s)
[376.050579] Starting dynamic subtest: pipe-B-eDP-1
[377.262455] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.222s)
[377.271832] Starting dynamic subtest: pipe-C-eDP-1
[378.378701] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[378.388428] Starting dynamic subtest: pipe-D-eDP-1
[379.524115] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.144s)
[379.526469] Subtest scaling-mode-full: SUCCESS (3.588s)
[380.681836] [081/133] (648s left) gem_workarounds (suspend-resume)
[380.756720] Starting subtest: suspend-resume
[397.299222] Subtest suspend-resume: SUCCESS (1.169s)
[397.433519] [082/133] (631s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[397.547352] Starting subtest: short-busy-flip-before-cursor-toggle
[397.551547] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[397.693967] [083/133] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[397.789404] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[397.793468] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[397.902214] [084/133] (631s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[397.991401] Starting subtest: fbc-rgb101010-draw-blt
[402.511282] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.583s)
[403.690370] [085/133] (625s left) gem_exec_params (sol-reset-not-gen7)
[403.768203] Starting subtest: sol-reset-not-gen7
[403.770442] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[403.899486] [086/133] (625s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[404.016338] Starting subtest: cursorB-vs-flipA-varying-size
[404.020693] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[404.163375] [087/133] (625s left) gem_exec_schedule (preempt-self)
[404.231879] Starting subtest: preempt-self
[404.234209] Starting dynamic subtest: rcs0
[404.243496] Dynamic subtest rcs0: SUCCESS (0.020s)
[404.254883] Starting dynamic subtest: bcs0
[404.264532] Dynamic subtest bcs0: SUCCESS (0.020s)
[404.273755] Starting dynamic subtest: vcs0
[404.286284] Dynamic subtest vcs0: SUCCESS (0.021s)
[404.298124] Starting dynamic subtest: vcs1
[404.305439] Dynamic subtest vcs1: SUCCESS (0.018s)
[404.317968] Starting dynamic subtest: vecs0
[404.322923] Dynamic subtest vecs0: SUCCESS (0.017s)
[404.331909] Starting dynamic subtest: ccs0
[404.340278] Dynamic subtest ccs0: SUCCESS (0.017s)
[404.342511] Subtest preempt-self: SUCCESS (0.118s)
[406.269980] [088/133] (623s left) gem_lmem_swapping (heavy-multi)
[406.309253] Subtest heavy-multi: SKIP (0.000s)
[406.357893] [089/133] (623s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[406.438459] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[406.442805] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[406.519143] [090/133] (623s left) gem_eio (create)
[406.758562] Starting subtest: create
[407.099625] Subtest create: SUCCESS (0.342s)
[407.237358] [091/133] (622s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[407.297659] Starting subtest: invalid-bsd1-flag-on-vebox
[407.299553] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[407.396122] [092/133] (622s left) kms_pipe_crc_basic (read-crc)
[407.474361] Starting subtest: read-crc
[407.475933] Starting dynamic subtest: pipe-A-eDP-1
[408.186806] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[408.197827] Starting dynamic subtest: pipe-B-eDP-1
[409.540630] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.359s)
[409.554224] Starting dynamic subtest: pipe-C-eDP-1
[410.923243] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.386s)
[410.933083] Starting dynamic subtest: pipe-D-eDP-1
[412.232789] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s)
[412.235220] Subtest read-crc: SUCCESS (4.779s)
[413.056439] [093/133] (616s left) kms_frontbuffer_tracking (basic)
[413.157703] Starting subtest: basic
[416.491871] Subtest basic: SUCCESS (3.346s)
[416.576551] [094/133] (613s left) gem_eio (wait-1us)
[416.818371] Starting subtest: wait-1us
[417.184926] Subtest wait-1us: SUCCESS (0.368s)
[417.333396] [095/133] (612s left) api_intel_bb (intel-bb-blit-y)
[417.385631] Starting subtest: intel-bb-blit-y
[420.857912] Subtest intel-bb-blit-y: SUCCESS (3.477s)
[420.963188] [096/133] (608s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[421.064361] Starting subtest: bad-rotation-90-y-tiled-ccs
[421.066625] Starting dynamic subtest: pipe-A-eDP-1
[421.089549] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[421.100633] Starting dynamic subtest: pipe-B-eDP-1
[421.121469] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[421.130297] Starting dynamic subtest: pipe-C-eDP-1
[421.150757] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[421.159370] Starting dynamic subtest: pipe-D-eDP-1
[421.181574] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[421.185856] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[423.303360] [097/133] (606s left) gem_madvise (dontneed-after-mmap)
[423.353875] Starting subtest: dontneed-after-mmap
[423.371649] Subtest dontneed-after-mmap: SUCCESS (0.017s)
[423.483930] [098/133] (606s left) gem_exec_params (rs-invalid)
[423.540216] Starting subtest: rs-invalid
[423.542626] Subtest rs-invalid: SUCCESS (0.001s)
[423.647054] [099/133] (606s left) gem_exec_parallel (contexts)
[423.708194] Starting subtest: contexts
[423.710867] Starting dynamic subtest: rcs0
[427.646779] Dynamic subtest rcs0: SUCCESS (3.944s)
[427.657228] Starting dynamic subtest: bcs0
[431.764279] Dynamic subtest bcs0: SUCCESS (4.118s)
[431.773766] Starting dynamic subtest: vcs0
[437.592719] Dynamic subtest vcs0: SUCCESS (5.825s)
[437.602085] Starting dynamic subtest: vcs1
[441.753947] Dynamic subtest vcs1: SUCCESS (4.158s)
[441.763439] Starting dynamic subtest: vecs0
[447.525209] Dynamic subtest vecs0: SUCCESS (5.770s)
[447.534814] Starting dynamic subtest: ccs0
[451.774247] Dynamic subtest ccs0: SUCCESS (4.248s)
[451.776946] Subtest contexts: SUCCESS (28.070s)
[451.979688] [100/133] (578s left) gem_userptr_blits (mmap-offset-banned)
[452.063212] Starting subtest: mmap-offset-banned
[452.065584] Starting dynamic subtest: wb
[452.067562] Dynamic subtest wb: SUCCESS (0.000s)
[452.079495] Starting dynamic subtest: wc
[452.081789] Dynamic subtest wc: SUCCESS (0.000s)
[452.091573] Starting dynamic subtest: uc
[452.093833] Dynamic subtest uc: SUCCESS (0.000s)
[452.096049] Subtest mmap-offset-banned: SUCCESS (0.003s)
[452.189258] [101/133] (577s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[452.276110] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[452.278449] Starting dynamic subtest: pipe-A-eDP-1
[452.304024] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[452.316240] Starting dynamic subtest: pipe-B-eDP-1
[452.340514] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[452.351729] Starting dynamic subtest: pipe-C-eDP-1
[452.376043] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[452.385610] Starting dynamic subtest: pipe-D-eDP-1
[452.411774] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[452.416036] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[454.583812] [102/133] (575s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[454.637335] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[454.641831] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[454.834195] [103/133] (575s left) perf (gen12-mi-rpc)
[454.921226] Starting subtest: gen12-mi-rpc
[454.923645] Starting dynamic subtest: rcs0
[454.945112] Dynamic subtest rcs0: SUCCESS (0.023s)
[454.947461] Subtest gen12-mi-rpc: SUCCESS (0.025s)
[454.998121] [104/133] (575s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[455.154955] Starting subtest: cursorA-vs-flipA-legacy
[466.274585] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.121s)
[467.103618] [105/133] (563s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[467.212641] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[467.216886] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[467.281853] [106/133] (563s left) kms_frontbuffer_tracking (psr-slowdraw)
[467.384372] Starting subtest: psr-slowdraw
[492.662451] Subtest psr-slowdraw: SUCCESS (25.289s)
[492.787813] [107/133] (537s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[492.897731] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[492.901998] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[492.999727] [108/133] (537s left) prime_busy (hang)
[493.053865] Starting subtest: hang
[493.056212] Starting dynamic subtest: rcs0
[518.727229] Dynamic subtest rcs0: SUCCESS (25.662s)
[518.736218] Starting dynamic subtest: bcs0
[525.878779] Dynamic subtest bcs0: SUCCESS (7.153s)
[525.890840] Starting dynamic subtest: vcs0
[532.856073] Dynamic subtest vcs0: SUCCESS (6.972s)
[532.867666] Starting dynamic subtest: vcs1
[539.890253] Dynamic subtest vcs1: SUCCESS (7.037s)
[539.899460] Starting dynamic subtest: vecs0
[546.866233] Dynamic subtest vecs0: SUCCESS (6.972s)
[546.877588] Starting dynamic subtest: ccs0
[560.700641] Dynamic subtest ccs0: SUCCESS (13.838s)
[560.703256] Subtest hang: SUCCESS (67.641s)
[560.817457] [109/133] (469s left) kms_psr (psr2-cursor-plane-move)
[560.919118] Starting subtest: psr2-cursor-plane-move
[560.921435] Starting dynamic subtest: eDP-1
[562.600684] Dynamic subtest eDP-1: SUCCESS (1.681s)
[562.602926] Subtest psr2-cursor-plane-move: SUCCESS (1.682s)
[563.392993] [110/133] (467s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[563.487586] Starting subtest: fbc-pr-cursor-mmap-cpu
[563.491727] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[563.559654] [111/133] (467s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[563.653691] Starting subtest: fbc-rgb565-draw-mmap-gtt
[563.658122] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[563.735715] [112/133] (466s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[563.852723] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[563.857321] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[564.000611] [113/133] (466s left) i915_suspend (forcewake)
[564.054655] Starting subtest: forcewake
[596.305255] Subtest forcewake: SUCCESS (2.250s)
[596.372420] [114/133] (434s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[596.507254] Starting subtest: cursor-vs-flip-atomic-transitions
[626.617576] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.248s)
[627.442208] [115/133] (403s left) kms_chamelium_color (ctm-green-to-red)
[627.540881] Subtest ctm-green-to-red: SKIP (0.000s)
[627.605642] [116/133] (403s left) gem_create (create-ext-cpu-access-big)
[627.781416] Starting subtest: create-ext-cpu-access-big
[627.785401] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[627.856878] [117/133] (403s left) syncobj_wait (multi-wait-all-submitted-signaled)
[627.903205] Starting subtest: multi-wait-all-submitted-signaled
[628.003900] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[628.085672] [118/133] (402s left) gem_busy (semaphore)
[628.288365] Subtest semaphore: SKIP (0.000s)
[628.521430] [119/133] (402s left) kms_pm_rpm (dpms-non-lpsp)
[630.368114] Starting subtest: dpms-non-lpsp
[630.373191] Subtest dpms-non-lpsp: SKIP (0.001s)
[630.787991] [120/133] (400s left) drm_read (empty-block)
[630.937135] Starting subtest: empty-block
[631.935248] Subtest empty-block: SUCCESS (1.000s)
[632.059485] [121/133] (398s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[632.115532] Starting subtest: invalid-single-wait-all-unsubmitted
[632.117846] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[632.213773] [122/133] (398s left) kms_cursor_crc (cursor-sliding-256x85)
[632.465848] Starting subtest: cursor-sliding-256x85
[632.516039] Subtest cursor-sliding-256x85: SKIP (0.045s)
[632.684431] [123/133] (398s left) syncobj_timeline (multi-wait-signaled)
[632.742362] Starting subtest: multi-wait-signaled
[632.744861] Subtest multi-wait-signaled: SUCCESS (0.001s)
[632.870382] [124/133] (398s left) syncobj_eventfd (binary-wait-before-signal)
[632.923018] Starting subtest: binary-wait-before-signal
[632.950901] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[633.027953] [125/133] (398s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[633.119670] Starting subtest: pr-primary-plane-update-sf-dmg-area
[633.123236] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[633.208917] [126/133] (398s left) kms_color (ctm-blue-to-red)
[633.308500] Starting subtest: ctm-blue-to-red
[633.310045] Starting dynamic subtest: pipe-A-eDP-1
[633.996514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s)
[634.006780] Starting dynamic subtest: pipe-B-eDP-1
[635.395332] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.397s)
[635.405370] Starting dynamic subtest: pipe-C-eDP-1
[636.761615] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[636.771560] Starting dynamic subtest: pipe-D-eDP-1
[638.101695] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[638.104153] Subtest ctm-blue-to-red: SUCCESS (4.794s)
[638.905007] [127/133] (392s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[639.012846] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[639.017242] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[639.115375] [128/133] (392s left) gem_userptr_blits (process-exit-busy)
[639.180759] Starting subtest: process-exit-busy
[639.189184] Subtest process-exit-busy: SUCCESS (0.011s)
[639.332803] [129/133] (392s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[639.428864] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[639.433305] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[639.517739] [130/133] (391s left) syncobj_wait (invalid-signal-illegal-handle)
[639.573538] Starting subtest: invalid-signal-illegal-handle
[639.575845] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[639.686824] [131/133] (391s left) kms_addfb_basic (addfb25-bad-modifier)
[639.773260] Starting subtest: addfb25-bad-modifier
[639.775546] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[639.871384] [132/133] (391s left) kms_dp_link_training (uhbr-mst)
[639.959514] Starting subtest: uhbr-mst
[639.966814] Subtest uhbr-mst: SKIP (0.000s)
[640.032930] [133/133] (391s left) gem_pxp (reject-modify-context-protection-on)
[640.159402] Starting subtest: reject-modify-context-protection-on
[640.161695] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[640.277871] Closing watchdogs
results: parsing output: 0/ for test: kms_hdr
results: parsing output: 1/ for test: gem_softpin
results: parsing output: 2/ for test: i915_pm_rpm
results: parsing output: 3/ for test: kms_atomic_transition
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: sysfs_timeslice_duration
results: parsing output: 6/ for test: prime_vgem
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: api_intel_allocator
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: syncobj_basic
results: parsing output: 14/ for test: kms_plane_scaling
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: prime_mmap_coherency
results: parsing output: 17/ for test: gem_fence_thrash
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: kms_invalid_mode
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_atomic
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: gem_mmap_offset
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: sw_sync
results: parsing output: 33/ for test: kms_lease
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_ctx_create
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: kms_plane
results: parsing output: 44/ for test: gem_userptr_blits
results: parsing output: 45/ for test: kms_flip_event_leak
results: parsing output: 46/ for test: i915_drm_fdinfo
results: parsing output: 47/ for test: gem_mmap
results: parsing output: 48/ for test: gem_exec_basic
results: parsing output: 49/ for test: kms_plane_cursor
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_pwrite_crc
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: dumb_buffer
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: gen7_exec_parse
results: parsing output: 60/ for test: kms_chamelium_hpd
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ctx_isolation
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: i915_drm_fdinfo
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_pm_backlight
results: parsing output: 76/ for test: gem_exec_whisper
results: parsing output: 77/ for test: kms_color_pipeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_scaling_modes
results: parsing output: 80/ for test: gem_workarounds
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: kms_flip_scaled_crc
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: gem_exec_params
results: parsing output: 91/ for test: kms_pipe_crc_basic
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_eio
results: parsing output: 94/ for test: api_intel_bb
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: gem_madvise
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: gem_exec_parallel
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: prime_busy
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: i915_suspend
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_chamelium_color
results: parsing output: 115/ for test: gem_create
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: gem_busy
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: drm_read
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: syncobj_eventfd
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: kms_color
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_addfb_basic
results: parsing output: 131/ for test: kms_dp_link_training
results: parsing output: 132/ for test: gem_pxp
Done.