[60.675351] Initializing watchdogs
[60.675397]   /dev/watchdog0
[60.689745] [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]
[60.694164] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.696607] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.700179] [001/133] (960s left) gem_basic (create-fd-close)
[60.794092] Starting subtest: create-fd-close
[60.798522] Subtest create-fd-close: SUCCESS (0.000s)
[60.912148] [002/133] (960s left) kms_invalid_mode (overflow-vrefresh)
[61.016058] Starting subtest: overflow-vrefresh
[61.018391] Starting dynamic subtest: pipe-A-eDP-1
[61.302414] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[61.310689] Starting dynamic subtest: pipe-B-eDP-1
[61.313047] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[61.319647] Starting dynamic subtest: pipe-C-eDP-1
[61.321911] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[61.328534] Starting dynamic subtest: pipe-D-eDP-1
[61.330391] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[61.332656] Subtest overflow-vrefresh: SUCCESS (0.298s)
[62.104126] [003/133] (959s left) api_intel_bb (full-batch)
[62.170051] Starting subtest: full-batch
[62.174541] Subtest full-batch: SUCCESS (0.006s)
[62.329814] [004/133] (958s left) syncobj_wait (invalid-signal-one-illegal-handle)
[62.399920] Starting subtest: invalid-signal-one-illegal-handle
[62.401979] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[62.523330] [005/133] (958s left) syncobj_basic (bad-handle-to-fd)
[62.581354] Starting subtest: bad-handle-to-fd
[62.583529] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[62.698577] [006/133] (958s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[62.788325] Starting subtest: primary-y-tiled-reflect-x-180
[62.872646] Subtest primary-y-tiled-reflect-x-180: SKIP (0.082s)
[62.984687] [007/133] (958s left) sw_sync (sync_merge_invalid)
[63.022232] Starting subtest: sync_merge_invalid
[63.044204] Subtest sync_merge_invalid: SUCCESS (0.024s)
[63.117564] [008/133] (958s left) syncobj_wait (invalid-wait-illegal-handle)
[63.171071] Starting subtest: invalid-wait-illegal-handle
[63.173028] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[63.308709] [009/133] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[63.410943] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[63.414804] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[63.524676] [010/133] (958s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[63.620200] Starting subtest: fbc-farfromfence-mmap-gtt
[63.623829] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[63.734676] [011/133] (957s left) gem_mmap_wc (bad-size)
[63.800973] Subtest bad-size: SKIP (0.000s)
[63.856661] [012/133] (957s left) gem_userptr_blits (forbidden-operations)
[63.930324] Starting subtest: forbidden-operations
[63.933896] Subtest forbidden-operations: SKIP (0.000s)
[64.090296] [013/133] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[64.185240] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[64.188774] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[64.305935] [014/133] (957s left) i915_hangman (engine-engine-hang)
[64.380317] Starting subtest: engine-engine-hang
[64.382305] Starting dynamic subtest: rcs0
[65.909817] Dynamic subtest rcs0: SUCCESS (1.533s)
[65.920574] Starting dynamic subtest: bcs0
[67.891505] Dynamic subtest bcs0: SUCCESS (1.986s)
[67.903054] Starting dynamic subtest: vcs0
[69.875010] Dynamic subtest vcs0: SUCCESS (1.987s)
[69.886322] Starting dynamic subtest: vcs1
[71.861471] Dynamic subtest vcs1: SUCCESS (1.988s)
[71.871211] Starting dynamic subtest: vecs0
[73.844089] Dynamic subtest vecs0: SUCCESS (1.985s)
[73.854533] Starting dynamic subtest: ccs0
[75.891653] Dynamic subtest ccs0: SUCCESS (2.048s)
[75.894586] Subtest engine-engine-hang: SUCCESS (11.533s)
[75.981450] [015/133] (945s left) gem_sync (basic-all)
[76.055071] Starting subtest: basic-all
[79.895868] Subtest basic-all: SUCCESS (3.851s)
[80.100857] [016/133] (941s left) kms_vblank (query-idle)
[80.193721] Starting subtest: query-idle
[80.196072] Starting dynamic subtest: pipe-A-eDP-1
[81.934503] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.740s)
[81.948383] Starting dynamic subtest: pipe-D-eDP-1
[84.401465] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.465s)
[84.403656] Subtest query-idle: SUCCESS (4.208s)
[85.235693] [017/133] (936s left) gem_exec_whisper (basic-queues)
[85.307947] Starting subtest: basic-queues
[90.925946] Subtest basic-queues: SUCCESS (5.618s)
[91.132388] [018/133] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[91.245657] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[91.250308] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[91.354850] [019/133] (930s left) kms_prop_blob (blob-prop-validate)
[91.412653] Starting subtest: blob-prop-validate
[91.414571] Subtest blob-prop-validate: SUCCESS (0.000s)
[91.533673] [020/133] (930s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[91.633503] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[91.635839] Starting dynamic subtest: A-eDP1
[100.567147] Dynamic subtest A-eDP1: SUCCESS (8.935s)
[100.576480] Starting dynamic subtest: B-eDP1
[109.490156] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[109.501522] Starting dynamic subtest: C-eDP1
[118.443694] Dynamic subtest C-eDP1: SUCCESS (8.907s)
[118.458019] Starting dynamic subtest: D-eDP1
[127.383263] Dynamic subtest D-eDP1: SUCCESS (8.937s)
[127.385682] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.712s)
[128.565455] [021/133] (893s left) kms_flip (absolute-wf_vblank)
[128.674391] Starting subtest: absolute-wf_vblank
[128.676778] Starting dynamic subtest: A-eDP1
[137.442140] Dynamic subtest A-eDP1: SUCCESS (8.736s)
[137.451648] Starting dynamic subtest: B-eDP1
[146.166674] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[146.175905] Starting dynamic subtest: C-eDP1
[154.905405] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[154.914642] Starting dynamic subtest: D-eDP1
[163.628463] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[163.630520] Subtest absolute-wf_vblank: SUCCESS (34.912s)
[164.793958] [022/133] (857s left) kms_flip (flip-vs-expired-vblank)
[164.904058] Starting subtest: flip-vs-expired-vblank
[164.906298] Starting dynamic subtest: A-eDP1
[173.629728] Dynamic subtest A-eDP1: SUCCESS (8.691s)
[173.639223] Starting dynamic subtest: B-eDP1
[182.270591] Dynamic subtest B-eDP1: SUCCESS (8.640s)
[182.280609] Starting dynamic subtest: C-eDP1
[190.998160] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[191.007744] Starting dynamic subtest: D-eDP1
[199.580302] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[199.582815] Subtest flip-vs-expired-vblank: SUCCESS (34.679s)
[200.766766] [023/133] (821s left) kms_big_fb (linear-8bpp-rotate-270)
[200.867389] Starting subtest: linear-8bpp-rotate-270
[200.888999] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[201.064815] [024/133] (821s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[201.175810] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[201.180153] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[201.280815] [025/133] (820s left) kms_dp_link_training (uhbr-mst)
[201.376885] Starting subtest: uhbr-mst
[201.385282] Subtest uhbr-mst: SKIP (0.000s)
[201.457968] [026/133] (820s left) perf_pmu (semaphore-wait)
[201.493458] Starting subtest: semaphore-wait
[201.495627] Starting dynamic subtest: rcs0
[202.008639] Dynamic subtest rcs0: SUCCESS (0.513s)
[202.019520] Starting dynamic subtest: bcs0
[202.521259] Dynamic subtest bcs0: SUCCESS (0.512s)
[202.530262] Starting dynamic subtest: vcs0
[203.035731] Dynamic subtest vcs0: SUCCESS (0.513s)
[203.044963] Starting dynamic subtest: vcs1
[203.548814] Dynamic subtest vcs1: SUCCESS (0.512s)
[203.557822] Starting dynamic subtest: vecs0
[204.061215] Dynamic subtest vecs0: SUCCESS (0.511s)
[204.071924] Starting dynamic subtest: ccs0
[204.576080] Dynamic subtest ccs0: SUCCESS (0.513s)
[204.578980] Subtest semaphore-wait: SUCCESS (3.082s)
[205.993725] [027/133] (816s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[206.111675] Starting subtest: yf-tiled-16bpp-rotate-180
[206.116265] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[206.211640] [028/133] (816s left) syncobj_timeline (reset-signaled)
[206.281147] Starting subtest: reset-signaled
[206.283527] Subtest reset-signaled: SUCCESS (0.000s)
[206.409532] [029/133] (815s left) i915_drm_fdinfo (busy-check-all)
[206.454612] Starting subtest: busy-check-all
[206.456772] Starting dynamic subtest: rcs0
[206.460879] Dynamic subtest rcs0: SKIP (0.004s)
[206.469596] Starting dynamic subtest: bcs0
[206.473668] Dynamic subtest bcs0: SKIP (0.000s)
[206.481441] Starting dynamic subtest: vcs0
[206.485826] Dynamic subtest vcs0: SKIP (0.001s)
[206.493333] Starting dynamic subtest: vcs1
[206.497415] Dynamic subtest vcs1: SKIP (0.001s)
[206.504543] Starting dynamic subtest: vecs0
[206.508655] Dynamic subtest vecs0: SKIP (0.001s)
[206.515618] Starting dynamic subtest: ccs0
[206.519750] Dynamic subtest ccs0: SKIP (0.001s)
[206.523837] Subtest busy-check-all: SKIP (0.010s)
[206.557497] [030/133] (815s left) fbdev (eof)
[206.599582] Starting subtest: eof
[206.601937] Subtest eof: SUCCESS (0.000s)
[206.679166] [031/133] (815s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-cpu)
[206.820287] Starting subtest: psr-abgr161616f-draw-mmap-cpu
[206.824801] Subtest psr-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[206.957765] [032/133] (815s left) gem_ctx_param (root-set)
[207.020983] Starting subtest: root-set
[207.025136] Subtest root-set: SUCCESS (0.003s)
[207.162680] [033/133] (815s left) vgem_basic (dmabuf-export)
[207.249589] Starting subtest: dmabuf-export
[207.279419] Subtest dmabuf-export: SUCCESS (0.031s)
[207.396504] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[207.399510] [034/133] (815s left) kms_psr (pr-sprite-plane-onoff)
[207.493483] Starting subtest: pr-sprite-plane-onoff
[207.497039] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[207.590849] [035/133] (814s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[207.691319] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[207.693364] Starting dynamic subtest: pipe-A-eDP-1
[207.713146] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[207.722808] Starting dynamic subtest: pipe-B-eDP-1
[207.740862] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[207.747783] Starting dynamic subtest: pipe-C-eDP-1
[207.765827] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[207.772677] Starting dynamic subtest: pipe-D-eDP-1
[207.791204] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[207.794987] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[210.016042] [036/133] (812s left) gem_exec_reloc (basic-gtt-cpu)
[210.075954] Subtest basic-gtt-cpu: SKIP (0.000s)
[210.162948] [037/133] (812s left) gem_exec_store (pages)
[210.230776] Starting subtest: pages
[210.233469] Starting dynamic subtest: rcs0
[210.346983] Dynamic subtest rcs0: SUCCESS (0.119s)
[210.356416] Starting dynamic subtest: bcs0
[210.430477] Dynamic subtest bcs0: SUCCESS (0.083s)
[210.440396] Starting dynamic subtest: vcs0
[210.509858] Dynamic subtest vcs0: SUCCESS (0.079s)
[210.519502] Starting dynamic subtest: vcs1
[210.581929] Dynamic subtest vcs1: SUCCESS (0.072s)
[210.591518] Starting dynamic subtest: vecs0
[210.654018] Dynamic subtest vecs0: SUCCESS (0.072s)
[210.663889] Starting dynamic subtest: ccs0
[210.726315] Dynamic subtest ccs0: SUCCESS (0.072s)
[210.728745] Subtest pages: SUCCESS (0.499s)
[210.920782] [038/133] (811s left) gen3_render_tiledy_blits
[211.051672] [039/133] (811s left) kms_vblank (accuracy-idle)
[211.149113] Starting subtest: accuracy-idle
[211.151416] Starting dynamic subtest: pipe-A-eDP-1
[212.921971] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.767s)
[212.935106] Starting dynamic subtest: pipe-D-eDP-1
[215.336294] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.416s)
[215.338529] Subtest accuracy-idle: SUCCESS (4.187s)
[216.183943] [040/133] (806s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[216.302220] Starting subtest: cursorA-vs-flipA-toggle
[227.438658] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.135s)
[228.312763] [041/133] (794s left) gem_exec_schedule (preempt-queue-contexts-chain)
[228.387176] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[228.686285] [042/133] (794s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[228.785113] Starting subtest: plane-downscale-factor-0-75-with-rotation
[228.787472] Starting dynamic subtest: pipe-A
[229.013049] Dynamic subtest pipe-A: SUCCESS (0.231s)
[229.022279] Starting dynamic subtest: pipe-B
[230.273541] Dynamic subtest pipe-B: SUCCESS (1.259s)
[230.283411] Starting dynamic subtest: pipe-C
[231.607294] Dynamic subtest pipe-C: SUCCESS (1.333s)
[231.615978] Starting dynamic subtest: pipe-D
[232.962639] Dynamic subtest pipe-D: SUCCESS (1.355s)
[232.964959] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.181s)
[234.126536] [043/133] (788s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[234.231164] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[238.483921] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.257s)
[239.635856] [044/133] (783s left) kms_pipe_crc_basic (nonblocking-crc)
[239.731313] Starting subtest: nonblocking-crc
[239.733480] Starting dynamic subtest: pipe-A-eDP-1
[240.515684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.781s)
[240.523639] Starting dynamic subtest: pipe-B-eDP-1
[241.946588] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.431s)
[241.961848] Starting dynamic subtest: pipe-C-eDP-1
[243.314451] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[243.323968] Starting dynamic subtest: pipe-D-eDP-1
[244.667538] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s)
[244.669864] Subtest nonblocking-crc: SUCCESS (4.936s)
[245.473569] [045/133] (777s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[245.574088] Starting subtest: fbc-psr-sprite-mmap-gtt
[245.576386] Starting dynamic subtest: eDP-1
[245.580733] Dynamic subtest eDP-1: SKIP (0.000s)
[245.585207] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[245.657346] [046/133] (777s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[245.706465] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[245.780985] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.017s)
[245.819423] [047/133] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[245.908592] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[245.912851] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[246.019219] [048/133] (777s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[246.120082] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[246.146813] Starting dynamic subtest: pipe-A-plane-0
[246.434919] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[246.442972] Starting dynamic subtest: pipe-A-plane-3
[246.668151] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[246.676223] Starting dynamic subtest: pipe-A-plane-5
[246.679569] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[247.754299] Starting dynamic subtest: pipe-B-plane-0
[248.047923] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[248.059071] Starting dynamic subtest: pipe-B-plane-3
[248.281048] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[248.289076] Starting dynamic subtest: pipe-B-plane-5
[248.293405] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[248.601099] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.481s)
[249.454308] [049/133] (773s left) gem_spin_batch (user-each)
[249.509799] Starting subtest: user-each
[252.866711] Subtest user-each: SUCCESS (3.357s)
[253.107791] [050/133] (770s left) kms_lease (implicit-plane-lease)
[253.208329] Starting subtest: implicit-plane-lease
[253.210839] Subtest implicit-plane-lease: SUCCESS (0.002s)
[253.366779] [051/133] (769s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[253.464386] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[253.468625] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[253.585304] [052/133] (769s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[253.695995] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[253.700039] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[253.828216] [053/133] (769s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[253.970765] Starting subtest: dp-mst-type-0-suspend-resume
[253.975108] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[254.123200] [054/133] (769s left) gem_ctx_param (invalid-param-set)
[254.181363] Starting subtest: invalid-param-set
[254.183268] Subtest invalid-param-set: SUCCESS (0.000s)
[254.265314] [055/133] (769s left) kms_cursor_crc (cursor-sliding-512x170)
[254.547960] Starting subtest: cursor-sliding-512x170
[254.551054] Subtest cursor-sliding-512x170: SKIP (0.001s)
[254.715415] [056/133] (768s left) syncobj_timeline (etime-single-wait-submitted)
[254.774192] Starting subtest: etime-single-wait-submitted
[254.881030] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[254.967440] [057/133] (768s left) kms_rotation_crc (sprite-rotation-90)
[255.071318] Starting subtest: sprite-rotation-90
[255.075639] Subtest sprite-rotation-90: SKIP (0.001s)
[255.154171] [058/133] (768s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[255.264790] Starting subtest: yf-tiled-64bpp-rotate-270
[255.269197] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[255.395079] [059/133] (768s left) syncobj_timeline (wait-all-for-submit-snapshot)
[255.454303] Starting subtest: wait-all-for-submit-snapshot
[255.535218] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[255.625064] [060/133] (767s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[255.743037] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[256.378557] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s)
[256.604744] [061/133] (766s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[256.699344] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[256.701661] Starting dynamic subtest: pipe-A-eDP-1
[256.724984] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[256.738556] Starting dynamic subtest: pipe-B-eDP-1
[256.759126] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[256.767088] Starting dynamic subtest: pipe-C-eDP-1
[256.787653] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[256.795589] Starting dynamic subtest: pipe-D-eDP-1
[256.817440] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[256.821499] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[258.935584] [062/133] (764s left) kms_async_flips (alternate-sync-async-flip)
[259.026061] Starting subtest: alternate-sync-async-flip
[259.397856] Starting dynamic subtest: pipe-A-eDP-1
[262.214248] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.817s)
[262.593507] Starting dynamic subtest: pipe-B-eDP-1
[265.338961] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.753s)
[265.727445] Starting dynamic subtest: pipe-C-eDP-1
[268.470031] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.749s)
[268.847620] Starting dynamic subtest: pipe-D-eDP-1
[271.604566] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.763s)
[271.606596] Subtest alternate-sync-async-flip: SUCCESS (12.583s)
[272.793474] [063/133] (750s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[272.898067] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[272.900286] Starting dynamic subtest: pipe-A-default-mode
[273.189841] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[273.194537] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.291s)
[274.013535] [064/133] (749s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[274.405244] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[275.219581] [065/133] (748s left) gem_exec_nop (basic-series)
[275.303258] Starting subtest: basic-series
[291.928492] Subtest basic-series: SUCCESS (16.629s)
[292.189812] [066/133] (731s left) api_intel_bb (add-remove-objects)
[292.241016] Starting subtest: add-remove-objects
[292.251827] Subtest add-remove-objects: SUCCESS (0.012s)
[292.401870] [067/133] (731s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[297.427618] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[297.429803] Starting dynamic subtest: pipe-A-eDP-1
[308.870455] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.439s)
[308.878524] Starting dynamic subtest: pipe-B-eDP-1
[320.312036] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.438s)
[320.314229] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.882s)
[321.181743] [068/133] (702s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[321.292642] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[321.296585] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[321.408060] [069/133] (702s left) kms_setmode (basic-clone-single-crtc)
[321.466605] Starting subtest: basic-clone-single-crtc
[321.473048] Subtest basic-clone-single-crtc: SKIP (0.000s)
[321.592376] [070/133] (702s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[326.655230] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[326.657957] Starting dynamic subtest: pipe-A-eDP-1
[327.445954] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s)
[327.454223] Starting dynamic subtest: pipe-B-eDP-1
[328.575261] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[328.579810] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.921s)
[329.760599] [071/133] (694s left) gem_ctx_param (invalid-set-ringsize)
[329.820211] Starting subtest: invalid-set-ringsize
[329.822843] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[329.917393] [072/133] (694s left) vgem_basic (second-client)
[329.969280] Starting subtest: second-client
[329.990594] Subtest second-client: SUCCESS (0.022s)
[330.072794] [073/133] (694s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[330.176559] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[330.180534] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[330.306112] [074/133] (693s left) gem_eio (context-create)
[330.556964] Starting subtest: context-create
[330.921105] Subtest context-create: SUCCESS (0.364s)
[331.097856] [075/133] (693s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[331.226339] Starting subtest: basic-flip-before-cursor-varying-size
[332.155078] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.926s)
[332.999935] [076/133] (691s left) syncobj_timeline (multi-wait-all-available-signaled)
[333.050559] Starting subtest: multi-wait-all-available-signaled
[333.052857] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[333.165527] [077/133] (691s left) gem_exec_fence (parallel)
[333.344600] Starting subtest: parallel
[333.347362] Starting dynamic subtest: rcs0
[335.494818] Dynamic subtest rcs0: SUCCESS (2.151s)
[335.504081] Starting dynamic subtest: bcs0
[337.644456] Dynamic subtest bcs0: SUCCESS (2.149s)
[337.654487] Starting dynamic subtest: vcs0
[339.796754] Dynamic subtest vcs0: SUCCESS (2.151s)
[339.806270] Starting dynamic subtest: vcs1
[341.949210] Dynamic subtest vcs1: SUCCESS (2.151s)
[341.960351] Starting dynamic subtest: vecs0
[344.103043] Dynamic subtest vecs0: SUCCESS (2.153s)
[344.112663] Starting dynamic subtest: ccs0
[346.256017] Dynamic subtest ccs0: SUCCESS (2.152s)
[346.258109] Subtest parallel: SUCCESS (12.912s)
[347.025350] [078/133] (677s left) kms_rotation_crc (multiplane-rotation)
[347.133935] Starting subtest: multiplane-rotation
[364.682292] Subtest multiplane-rotation: SUCCESS (17.550s)
[364.845015] [079/133] (659s left) kms_psr (fbc-pr-primary-page-flip)
[364.951443] Starting subtest: fbc-pr-primary-page-flip
[364.954986] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[365.033932] [080/133] (659s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[365.100847] Starting subtest: yf-tiled-to-vebox-x-tiled
[365.104470] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[365.293579] [081/133] (659s left) kms_cursor_crc (cursor-random-64x21)
[365.502493] Starting subtest: cursor-random-64x21
[365.552842] Subtest cursor-random-64x21: SKIP (0.044s)
[365.811752] [082/133] (658s left) gem_ctx_engines (none)
[365.881133] Starting subtest: none
[365.883253] Subtest none: SUCCESS (0.001s)
[366.078204] [083/133] (658s left) gem_userptr_blits (stress-mm-invalidate-close)
[366.148214] Starting subtest: stress-mm-invalidate-close
[368.297480] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[368.468533] [084/133] (656s left) gem_exec_schedule (noreorder)
[368.646616] Starting subtest: noreorder
[368.648463] Starting dynamic subtest: rcs0
[368.734049] Dynamic subtest rcs0: SUCCESS (0.090s)
[368.744534] Starting dynamic subtest: vcs0
[369.900739] Dynamic subtest vcs0: SUCCESS (1.163s)
[369.911861] Starting dynamic subtest: vcs1
[371.903916] Dynamic subtest vcs1: SUCCESS (2.000s)
[371.915033] Starting dynamic subtest: vecs0
[373.912490] Dynamic subtest vecs0: SUCCESS (2.006s)
[373.924068] Starting dynamic subtest: ccs0
[374.016840] Dynamic subtest ccs0: SUCCESS (0.104s)
[374.019556] Subtest noreorder: SUCCESS (5.374s)
[374.217733] [085/133] (650s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[374.323517] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[378.582954] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.263s)
[379.738464] [086/133] (644s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[379.869232] Starting subtest: cursorB-vs-flipB-atomic
[379.873555] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[380.046313] [087/133] (644s left) dumb_buffer (create-clear)
[380.093376] Starting subtest: create-clear
[414.077558] Subtest create-clear: SUCCESS (33.926s)
[414.139303] [088/133] (610s left) perf_pmu (busy-double-start)
[414.187468] Starting subtest: busy-double-start
[414.189441] Starting dynamic subtest: rcs0
[417.826941] Dynamic subtest rcs0: FAIL (3.573s)
[417.836774] Starting dynamic subtest: bcs0
[421.335730] Dynamic subtest bcs0: SUCCESS (3.576s)
[421.347338] Starting dynamic subtest: vcs0
[425.434664] Dynamic subtest vcs0: SUCCESS (4.097s)
[425.446121] Starting dynamic subtest: vcs1
[429.431907] Dynamic subtest vcs1: SUCCESS (3.995s)
[429.443788] Starting dynamic subtest: vecs0
[433.454317] Dynamic subtest vecs0: SUCCESS (4.020s)
[433.466023] Starting dynamic subtest: ccs0
[437.090802] Dynamic subtest ccs0: FAIL (3.565s)
[437.093131] Subtest busy-double-start: FAIL (22.837s)
[437.151369] [089/133] (587s left) kms_draw_crc (draw-method-render)
[437.262117] Starting subtest: draw-method-render
[437.264385] Starting dynamic subtest: xrgb8888-untiled
[437.505429] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[437.514214] Starting dynamic subtest: rgb565-untiled
[437.740115] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[437.749088] Starting dynamic subtest: xrgb2101010-untiled
[437.972359] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[437.981245] Starting dynamic subtest: xbgr16161616f-untiled
[438.217018] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[438.225995] Starting dynamic subtest: xrgb8888-xtiled
[438.350114] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[438.360614] Starting dynamic subtest: rgb565-xtiled
[438.472141] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[438.480920] Starting dynamic subtest: xrgb2101010-xtiled
[438.583133] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[438.591677] Starting dynamic subtest: xbgr16161616f-xtiled
[438.716330] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[438.725153] Starting dynamic subtest: xrgb8888-4tiled
[438.838670] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[438.847296] Starting dynamic subtest: rgb565-4tiled
[438.949966] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[438.958185] Starting dynamic subtest: xrgb2101010-4tiled
[439.072058] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[439.080809] Starting dynamic subtest: xbgr16161616f-4tiled
[439.205455] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[439.207343] Subtest draw-method-render: SUCCESS (1.945s)
[439.316972] [090/133] (585s left) kms_cursor_crc (cursor-offscreen-32x32)
[439.462324] Starting subtest: cursor-offscreen-32x32
[439.510842] Subtest cursor-offscreen-32x32: SKIP (0.043s)
[439.825110] [091/133] (585s left) gem_exec_balancer (hang)
[440.098987] Starting subtest: hang
[441.893490] Subtest hang: SUCCESS (1.794s)
[442.026963] [092/133] (582s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[442.132326] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[448.689632] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.561s)
[448.850577] [093/133] (576s left) gem_pxp (reject-modify-context-protection-off-2)
[448.966051] Starting subtest: reject-modify-context-protection-off-2
[448.968647] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[449.099387] [094/133] (575s left) gen9_exec_parse (basic-rejected-ctx-param)
[449.160174] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[449.250836] [095/133] (575s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[449.354195] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[449.356439] Starting dynamic subtest: pipe-A-default-mode
[449.647054] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[449.651986] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.292s)
[450.483857] [096/133] (574s left) gem_softpin (allocator-nopin-reserve)
[450.559767] Starting subtest: allocator-nopin-reserve
[450.652306] Subtest allocator-nopin-reserve: SUCCESS (0.092s)
[450.815866] [097/133] (574s left) kms_plane_multiple (2x-tiling-y)
[450.933195] Starting subtest: 2x-tiling-y
[450.937650] Subtest 2x-tiling-y: SKIP (0.000s)
[451.019553] [098/133] (574s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[451.125764] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[451.128063] Starting dynamic subtest: pipe-A-eDP-1
[451.150718] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[451.165782] Starting dynamic subtest: pipe-B-eDP-1
[451.187390] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[451.197645] Starting dynamic subtest: pipe-C-eDP-1
[451.218726] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[451.227253] Starting dynamic subtest: pipe-D-eDP-1
[451.250456] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[451.254966] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[453.363403] [099/133] (571s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[453.466644] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[453.470926] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[453.589623] [100/133] (571s left) gem_mmap_offset (bad-extensions)
[453.660056] Starting subtest: bad-extensions
[453.662283] Subtest bad-extensions: SUCCESS (0.000s)
[453.771559] [101/133] (571s left) kms_color (ctm-negative)
[453.873766] Starting subtest: ctm-negative
[453.876048] Starting dynamic subtest: pipe-A-eDP-1
[454.584253] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[454.593399] Starting dynamic subtest: pipe-B-eDP-1
[455.967315] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s)
[455.976057] Starting dynamic subtest: pipe-C-eDP-1
[457.337584] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[457.346688] Starting dynamic subtest: pipe-D-eDP-1
[458.659809] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[458.662259] Subtest ctm-negative: SUCCESS (4.788s)
[459.473683] [102/133] (565s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[459.538417] Starting subtest: saturated-hostile-nopreempt
[459.540665] Starting dynamic subtest: rcs0
[459.617787] Dynamic subtest rcs0: SKIP (0.079s)
[459.629358] Starting dynamic subtest: bcs0
[459.644616] Dynamic subtest bcs0: SKIP (0.026s)
[459.653286] Starting dynamic subtest: vcs0
[459.670603] Dynamic subtest vcs0: SKIP (0.024s)
[459.679146] Starting dynamic subtest: vcs1
[459.689399] Dynamic subtest vcs1: SKIP (0.017s)
[459.698195] Starting dynamic subtest: vecs0
[459.718490] Dynamic subtest vecs0: SKIP (0.028s)
[459.727163] Starting dynamic subtest: ccs0
[459.744683] Dynamic subtest ccs0: SKIP (0.023s)
[459.749375] Subtest saturated-hostile-nopreempt: SKIP (0.207s)
[459.841213] [103/133] (565s left) gem_exec_balancer (persistence)
[460.108053] Starting subtest: persistence
[460.988249] Subtest persistence: SUCCESS (0.880s)
[461.144105] [104/133] (564s left) kms_chamelium_edid (vga-edid-read)
[461.551228] Subtest vga-edid-read: SKIP (0.000s)
[462.383229] [105/133] (563s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[462.479202] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[462.481535] Starting dynamic subtest: pipe-A-eDP-1
[462.507792] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[462.518953] Starting dynamic subtest: pipe-B-eDP-1
[462.542611] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[462.552278] Starting dynamic subtest: pipe-C-eDP-1
[462.575720] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[462.583866] Starting dynamic subtest: pipe-D-eDP-1
[462.608117] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[462.612636] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[464.775015] [106/133] (560s left) kms_atomic (test-only)
[464.869602] Starting subtest: test-only
[464.919459] Starting dynamic subtest: pipe-A-eDP-1
[467.490699] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.574s)
[467.493057] Subtest test-only: SUCCESS (2.624s)
[468.362527] [107/133] (557s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[468.469432] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[468.473731] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[468.602413] [108/133] (556s left) kms_addfb_basic (clobberred-modifier)
[468.662614] Starting subtest: clobberred-modifier
[468.667132] Subtest clobberred-modifier: SKIP (0.000s)
[468.829911] [109/133] (556s left) gem_exec_reloc (basic-wc-noreloc)
[468.902927] Subtest basic-wc-noreloc: SKIP (0.000s)
[468.986903] [110/133] (556s left) gem_eio (wait-immediate)
[469.226292] Starting subtest: wait-immediate
[469.612665] Subtest wait-immediate: SUCCESS (0.386s)
[469.822987] [111/133] (555s left) kms_psr (fbc-psr2-primary-page-flip)
[469.929661] Starting subtest: fbc-psr2-primary-page-flip
[469.931550] Starting dynamic subtest: eDP-1
[469.935022] Dynamic subtest eDP-1: SKIP (0.000s)
[469.938454] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[470.013274] [112/133] (555s left) gem_userptr_blits (unsync-overlap)
[470.083838] Subtest unsync-overlap: SKIP (0.000s)
[470.234342] [113/133] (555s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[470.331637] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[470.333661] Starting dynamic subtest: pipe-A
[470.355882] Dynamic subtest pipe-A: SKIP (0.021s)
[470.364493] Starting dynamic subtest: pipe-B
[470.388894] Dynamic subtest pipe-B: SKIP (0.033s)
[470.397387] Starting dynamic subtest: pipe-C
[470.424806] Dynamic subtest pipe-C: SKIP (0.033s)
[470.433124] Starting dynamic subtest: pipe-D
[470.458198] Dynamic subtest pipe-D: SKIP (0.033s)
[470.461678] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.124s)
[470.581610] [114/133] (555s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[470.683047] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[470.686669] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[470.863294] [115/133] (555s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[470.969145] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[470.970944] Starting dynamic subtest: pipe-A-default-mode
[471.277050] Dynamic subtest pipe-A-default-mode: SKIP (0.304s)
[471.281769] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.306s)
[472.112775] [116/133] (553s left) gem_tiled_blits (basic)
[472.178625] Subtest basic: SKIP (0.000s)
[472.257419] [117/133] (553s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[472.364624] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[472.369098] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[472.494671] [118/133] (553s left) i915_pm_rps (basic-api)
[472.552134] Starting subtest: basic-api
[472.556229] Subtest basic-api: SKIP (0.001s)
[472.689506] [119/133] (553s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[472.792436] Starting subtest: y-tiled-32bpp-rotate-270
[472.796583] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[472.915385] [120/133] (553s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[473.010196] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[476.678446] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.671s)
[477.809874] [121/133] (548s left) syncobj_eventfd (timeline-wait-before-signal)
[477.878527] Starting subtest: timeline-wait-before-signal
[477.909712] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[477.997903] [122/133] (548s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[478.095694] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[485.550478] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.457s)
[485.710178] [123/133] (540s left) i915_query (query-regions-unallocated)
[485.769073] Starting subtest: query-regions-unallocated
[485.771217] Subtest query-regions-unallocated: SUCCESS (0.000s)
[485.890999] [124/133] (540s left) kms_psr (psr-dpms)
[486.002120] Starting subtest: psr-dpms
[486.004272] Starting dynamic subtest: eDP-1
[488.939256] Dynamic subtest eDP-1: SUCCESS (2.938s)
[488.941609] Subtest psr-dpms: SUCCESS (2.939s)
[489.807955] [125/133] (536s left) kms_pm_dc (dc5-psr)
[490.908049] Starting subtest: dc5-psr
[493.907206] Subtest dc5-psr: SUCCESS (3.000s)
[494.759419] [126/133] (531s left) gem_exec_fence (syncobj-unused-fence)
[495.199438] Starting subtest: syncobj-unused-fence
[495.204669] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[497.010369] [127/133] (529s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[497.114391] Starting subtest: fbcpsr-tiling-4
[504.186963] Subtest fbcpsr-tiling-4: SUCCESS (7.076s)
[504.356979] [128/133] (522s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[504.468389] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[504.470643] Starting dynamic subtest: pipe-A-eDP-1
[504.528193] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[504.541338] Starting dynamic subtest: pipe-B-eDP-1
[504.599846] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[504.610464] Starting dynamic subtest: pipe-C-eDP-1
[504.667575] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[504.677844] Starting dynamic subtest: pipe-D-eDP-1
[504.734957] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[504.739241] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[506.744643] [129/133] (519s left) gem_exec_flush (basic-uc-set-default)
[506.811698] Starting subtest: basic-uc-set-default
[512.294883] Subtest basic-uc-set-default: SUCCESS (5.457s)
[512.481279] [130/133] (514s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[512.593827] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[512.598161] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[512.720323] [131/133] (513s left) gem_mmap_gtt (cpuset-medium-copy)
[512.787735] Subtest cpuset-medium-copy: SKIP (0.000s)
[512.856684] [132/133] (513s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[512.955549] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[512.960114] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[513.082195] [133/133] (513s left) gem_softpin (softpin)
[513.147186] Starting subtest: softpin
[545.453117] Subtest softpin: SUCCESS (32.299s)
[545.615091] Closing watchdogs
results: parsing output: 0/ for test: gem_basic
results: parsing output: 1/ for test: kms_invalid_mode
results: parsing output: 2/ for test: api_intel_bb
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: syncobj_basic
results: parsing output: 5/ for test: kms_rotation_crc
results: parsing output: 6/ for test: sw_sync
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_mmap_wc
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: i915_hangman
results: parsing output: 14/ for test: gem_sync
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: gem_exec_whisper
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_prop_blob
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_dp_link_training
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: i915_drm_fdinfo
results: parsing output: 29/ for test: fbdev
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_ctx_param
results: parsing output: 32/ for test: vgem_basic
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: gem_exec_store
results: parsing output: 37/ for test: gen3_render_tiledy_blits
results: parsing output: 38/ for test: kms_vblank
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_pipe_crc_basic
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: sriov_basic
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: gem_spin_batch
results: parsing output: 49/ for test: kms_lease
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_content_protection
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_rotation_crc
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: gem_exec_nop
results: parsing output: 65/ for test: api_intel_bb
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_setmode
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: gem_ctx_param
results: parsing output: 71/ for test: vgem_basic
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_exec_fence
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: gem_ctx_engines
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: dumb_buffer
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: kms_draw_crc
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: gem_exec_balancer
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: gen9_exec_parse
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: kms_plane_multiple
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_mmap_offset
results: parsing output: 100/ for test: kms_color
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: kms_chamelium_edid
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_atomic
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: gem_tiled_blits
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: i915_pm_rps
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: i915_query
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_pm_dc
results: parsing output: 125/ for test: gem_exec_fence
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_exec_flush
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_mmap_gtt
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_softpin
Done.