[57.147984] Initializing watchdogs
[57.148052]   /dev/watchdog0
[57.162150] [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]
[57.166559] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.168960] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.172345] [001/133] (960s left) i915_pm_rps (basic-api)
[57.260199] Starting subtest: basic-api
[57.264749] Subtest basic-api: SKIP (0.001s)
[57.380098] [002/133] (960s left) kms_invalid_mode (bad-hsync-end)
[57.479399] Starting subtest: bad-hsync-end
[57.481761] Starting dynamic subtest: pipe-A-eDP-1
[57.764474] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[57.771395] Starting dynamic subtest: pipe-B-eDP-1
[57.773409] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[57.779742] Starting dynamic subtest: pipe-C-eDP-1
[57.781736] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[57.788489] Starting dynamic subtest: pipe-D-eDP-1
[57.790794] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[57.793079] Subtest bad-hsync-end: SUCCESS (0.290s)
[58.649830] [003/133] (959s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[58.742963] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[58.745164] Starting dynamic subtest: pipe-A-eDP-1
[58.767089] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.775306] Starting dynamic subtest: pipe-B-eDP-1
[58.796383] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.803155] Starting dynamic subtest: pipe-C-eDP-1
[58.823777] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.830181] Starting dynamic subtest: pipe-D-eDP-1
[58.851218] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.855146] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[60.949130] [004/133] (956s left) kms_cursor_edge_walk (64x64-top-edge)
[61.046576] Starting subtest: 64x64-top-edge
[61.049046] Starting dynamic subtest: pipe-A-eDP-1
[64.529525] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s)
[64.540555] Starting dynamic subtest: pipe-D-eDP-1
[67.661096] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[67.665079] Subtest 64x64-top-edge: SUCCESS (6.581s)
[68.496795] [005/133] (949s left) kms_plane (plane-position-hole)
[68.592707] Starting subtest: plane-position-hole
[69.092750] Starting dynamic subtest: pipe-A-plane-1
[70.372337] Dynamic subtest pipe-A-plane-1: SUCCESS (1.277s)
[70.380077] Starting dynamic subtest: pipe-A-plane-2
[71.663569] Dynamic subtest pipe-A-plane-2: SUCCESS (1.288s)
[71.672554] Starting dynamic subtest: pipe-A-plane-3
[72.892245] Dynamic subtest pipe-A-plane-3: SUCCESS (1.226s)
[72.901057] Starting dynamic subtest: pipe-A-plane-4
[74.159374] Dynamic subtest pipe-A-plane-4: SUCCESS (1.265s)
[74.166495] Starting dynamic subtest: pipe-A-plane-5
[74.183747] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[75.291398] Starting dynamic subtest: pipe-B-plane-1
[76.572169] Dynamic subtest pipe-B-plane-1: SUCCESS (1.285s)
[76.580704] Starting dynamic subtest: pipe-B-plane-2
[77.862690] Dynamic subtest pipe-B-plane-2: SUCCESS (1.289s)
[77.872070] Starting dynamic subtest: pipe-B-plane-3
[79.207352] Dynamic subtest pipe-B-plane-3: SUCCESS (1.343s)
[79.214077] Starting dynamic subtest: pipe-B-plane-4
[80.568067] Dynamic subtest pipe-B-plane-4: SUCCESS (1.359s)
[80.576963] Starting dynamic subtest: pipe-B-plane-5
[80.592520] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[80.594511] Subtest plane-position-hole: SUCCESS (11.985s)
[81.433438] [006/133] (936s left) kms_prop_blob (basic)
[81.484987] Starting subtest: basic
[81.487231] Subtest basic: SUCCESS (0.000s)
[81.620968] [007/133] (936s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[81.768889] Starting subtest: dp-mst-lic-type-0-hdcp14
[81.773675] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[81.915062] [008/133] (936s left) dumb_buffer (create-clear)
[81.968845] Starting subtest: create-clear
[116.440316] Subtest create-clear: SUCCESS (34.454s)
[116.571181] [009/133] (901s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[116.685996] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[116.690161] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[116.810720] [010/133] (901s left) kms_addfb_basic (bad-pitch-63)
[116.866673] Starting subtest: bad-pitch-63
[116.868820] Subtest bad-pitch-63: SUCCESS (0.000s)
[117.018247] [011/133] (901s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[117.122907] Starting subtest: cursorA-vs-flipB-toggle
[117.127294] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[117.275609] [012/133] (900s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[117.355739] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[117.357626] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[117.477801] [013/133] (900s left) api_intel_bb (offset-control)
[117.539192] Starting subtest: offset-control
[117.544862] Subtest offset-control: SUCCESS (0.007s)
[117.693809] [014/133] (900s left) gem_wait (invalid-buf)
[117.748520] Starting subtest: invalid-buf
[117.750568] Subtest invalid-buf: SUCCESS (0.000s)
[117.999381] [015/133] (900s left) kms_flip (flip-vs-fences-interruptible)
[118.103965] Starting subtest: flip-vs-fences-interruptible
[118.108642] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[118.236600] [016/133] (899s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[118.333944] Starting subtest: primary-y-tiled-reflect-x-270
[118.338098] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[118.413978] [017/133] (899s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[118.506044] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[118.508319] Starting dynamic subtest: pipe-A-eDP-1
[118.565596] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[118.574483] Starting dynamic subtest: pipe-B-eDP-1
[118.630894] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[118.639762] Starting dynamic subtest: pipe-C-eDP-1
[118.698445] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[118.706475] Starting dynamic subtest: pipe-D-eDP-1
[118.764558] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[118.768955] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.015s)
[120.718596] [018/133] (897s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[120.820462] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[127.618076] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.799s)
[127.749484] [019/133] (890s left) syncobj_wait (invalid-reset-illegal-handle)
[127.800935] Starting subtest: invalid-reset-illegal-handle
[127.803059] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[127.894231] [020/133] (890s left) gem_lmem_swapping (massive-random)
[127.940743] Subtest massive-random: SKIP (0.000s)
[127.977774] [021/133] (890s left) syncobj_timeline (etime-multi-wait-all-submitted)
[128.048198] Starting subtest: etime-multi-wait-all-submitted
[128.156304] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s)
[128.238811] [022/133] (890s left) gem_userptr_blits (sync-unmap)
[128.300454] Starting subtest: sync-unmap
[128.315036] Subtest sync-unmap: SUCCESS (0.015s)
[128.452199] [023/133] (890s left) gem_pxp (create-protected-buffer)
[128.574725] Starting subtest: create-protected-buffer
[128.577158] Subtest create-protected-buffer: SUCCESS (0.000s)
[128.690151] [024/133] (889s left) prime_mmap (test_refcounting)
[128.752161] Starting subtest: test_refcounting
[128.754378] Starting dynamic subtest: test_refcounting-smem
[128.784889] Dynamic subtest test_refcounting-smem: SUCCESS (0.034s)
[128.787271] Subtest test_refcounting: SUCCESS (0.035s)
[128.909635] [025/133] (889s left) gem_exec_schedule (pi-shared-iova)
[129.091615] Starting subtest: pi-shared-iova
[129.093937] Starting dynamic subtest: rcs0
[129.159454] Dynamic subtest rcs0: SUCCESS (0.070s)
[129.169811] Starting dynamic subtest: vcs0
[129.207909] Dynamic subtest vcs0: SUCCESS (0.049s)
[129.216966] Starting dynamic subtest: vcs1
[129.254798] Dynamic subtest vcs1: SUCCESS (0.046s)
[129.262311] Starting dynamic subtest: vecs0
[129.302546] Dynamic subtest vecs0: SUCCESS (0.047s)
[129.311686] Starting dynamic subtest: ccs0
[129.354118] Dynamic subtest ccs0: SUCCESS (0.051s)
[129.356597] Subtest pi-shared-iova: SUCCESS (0.266s)
[131.011884] [026/133] (887s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[131.123235] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[132.321212] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.608s)
[132.357506] [027/133] (886s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[132.462332] Starting subtest: flip-primary-invalidate-overlay
[144.011076] Subtest flip-primary-invalidate-overlay: SUCCESS (11.549s)
[144.167032] [028/133] (874s left) kms_psr (fbc-psr-dpms)
[144.270414] Starting subtest: fbc-psr-dpms
[144.272442] Starting dynamic subtest: eDP-1
[144.275966] Dynamic subtest eDP-1: SKIP (0.000s)
[144.279557] Subtest fbc-psr-dpms: SKIP (0.001s)
[144.346185] [029/133] (874s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[144.448518] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[144.459187] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[144.544633] [030/133] (874s left) gem_softpin (evict-prime)
[144.599156] Starting subtest: evict-prime
[144.601249] Starting dynamic subtest: rcs0
[145.776775] Dynamic subtest rcs0: SUCCESS (1.177s)
[145.788586] Starting dynamic subtest: bcs0
[146.931500] Dynamic subtest bcs0: SUCCESS (1.153s)
[146.942100] Starting dynamic subtest: vcs0
[148.911924] Dynamic subtest vcs0: SUCCESS (1.978s)
[148.923045] Starting dynamic subtest: vcs1
[150.902629] Dynamic subtest vcs1: SUCCESS (1.989s)
[150.912069] Starting dynamic subtest: vecs0
[152.881649] Dynamic subtest vecs0: SUCCESS (1.976s)
[152.892234] Starting dynamic subtest: ccs0
[154.019064] Dynamic subtest ccs0: SUCCESS (1.138s)
[154.029732] Starting dynamic subtest: all
[155.892800] Dynamic subtest all: SUCCESS (1.871s)
[155.895664] Subtest evict-prime: SUCCESS (11.292s)
[155.981796] [031/133] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[156.083558] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[156.087988] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[156.204034] [032/133] (862s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[156.313704] Starting subtest: x-tiled-32bpp-rotate-0
[157.614538] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.302s)
[157.828019] [033/133] (861s left) kms_psr (psr2-sprite-plane-onoff)
[157.936393] Starting subtest: psr2-sprite-plane-onoff
[157.938894] Starting dynamic subtest: eDP-1
[159.671509] Dynamic subtest eDP-1: SUCCESS (1.734s)
[159.673791] Subtest psr2-sprite-plane-onoff: SUCCESS (1.735s)
[160.520265] [034/133] (858s left) kms_chamelium_frames (hdmi-aspect-ratio)
[160.907424] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[161.712814] [035/133] (857s left) gem_fence_thrash (bo-write-verify-none)
[161.748877] Starting subtest: bo-write-verify-none
[161.776167] Subtest bo-write-verify-none: SKIP (0.024s)
[161.841562] [036/133] (857s left) api_intel_bb (blit-noreloc-purge-cache)
[161.898851] Starting subtest: blit-noreloc-purge-cache
[161.906246] Subtest blit-noreloc-purge-cache: SUCCESS (0.009s)
[162.004306] [037/133] (856s left) gem_exec_reloc (basic-cpu-read-noreloc)
[162.072915] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[162.150884] [038/133] (856s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[162.255964] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[168.993931] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.740s)
[169.129856] [039/133] (849s left) gem_reg_read (timestamp-monotonic)
[169.187415] Starting subtest: timestamp-monotonic
[173.523428] Subtest timestamp-monotonic: SUCCESS (4.336s)
[173.603608] [040/133] (845s left) kms_color (degamma)
[173.717074] Starting subtest: degamma
[173.719314] Starting dynamic subtest: pipe-A-eDP-1
[174.427784] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[174.435065] Starting dynamic subtest: pipe-B-eDP-1
[175.861658] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.434s)
[175.870457] Starting dynamic subtest: pipe-C-eDP-1
[177.265892] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s)
[177.274088] Starting dynamic subtest: pipe-D-eDP-1
[178.604488] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[178.606438] Subtest degamma: SUCCESS (4.884s)
[179.424201] [041/133] (839s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[179.520118] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[179.522401] Starting dynamic subtest: pipe-A-default-mode
[180.674915] Dynamic subtest pipe-A-default-mode: SKIP (1.151s)
[180.679054] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.152s)
[180.840400] [042/133] (838s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[180.941396] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[187.451311] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.512s)
[187.576358] [043/133] (831s left) gem_exec_alignment (pi)
[187.642211] Starting subtest: pi
[237.758043] Subtest pi: SUCCESS (50.110s)
[238.746220] [044/133] (780s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[238.900515] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[238.904840] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[239.013039] [045/133] (780s left) gem_ctx_persistence (heartbeat-hostile)
[239.073140] Starting subtest: heartbeat-hostile
[239.077656] Subtest heartbeat-hostile: SKIP (0.000s)
[239.175561] [046/133] (780s left) perf_pmu (semaphore-wait)
[239.218585] Starting subtest: semaphore-wait
[239.220470] Starting dynamic subtest: rcs0
[239.731650] Dynamic subtest rcs0: SUCCESS (0.513s)
[239.743323] Starting dynamic subtest: bcs0
[240.245164] Dynamic subtest bcs0: SUCCESS (0.511s)
[240.255594] Starting dynamic subtest: vcs0
[240.759533] Dynamic subtest vcs0: SUCCESS (0.511s)
[240.769541] Starting dynamic subtest: vcs1
[241.270691] Dynamic subtest vcs1: SUCCESS (0.510s)
[241.279774] Starting dynamic subtest: vecs0
[241.782092] Dynamic subtest vecs0: SUCCESS (0.508s)
[241.793979] Starting dynamic subtest: ccs0
[242.297776] Dynamic subtest ccs0: SUCCESS (0.513s)
[242.300728] Subtest semaphore-wait: SUCCESS (3.080s)
[242.451819] [047/133] (776s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[242.546116] Starting subtest: fbc-pr-sprite-mmap-cpu
[242.550713] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[242.644833] [048/133] (776s left) kms_chamelium_color (ctm-0-25)
[242.728560] Subtest ctm-0-25: SKIP (0.000s)
[242.770822] [049/133] (776s left) gem_tiled_blits (normal)
[242.839227] Subtest normal: SKIP (0.000s)
[242.942084] [050/133] (776s left) gem_exec_fence (syncobj-timeline-unused-fence)
[243.529326] Starting subtest: syncobj-timeline-unused-fence
[243.531255] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[244.982939] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[244.986525] [051/133] (774s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[245.080560] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[245.084653] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[245.203806] [052/133] (774s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[245.311633] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[249.391239] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.083s)
[250.575229] [053/133] (769s left) kms_draw_crc (draw-method-mmap-gtt)
[250.674390] Starting subtest: draw-method-mmap-gtt
[250.678806] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[250.804121] [054/133] (768s left) i915_drm_fdinfo (virtual-busy)
[250.843240] Starting subtest: virtual-busy
[250.847234] Subtest virtual-busy: SKIP (0.000s)
[250.950085] [055/133] (768s left) sysfs_heartbeat_interval (invalid)
[251.016478] Starting subtest: invalid
[251.018611] Starting dynamic subtest: vecs0
[251.020871] Dynamic subtest vecs0: SUCCESS (0.000s)
[251.029311] Starting dynamic subtest: ccs0
[251.031077] Dynamic subtest ccs0: SUCCESS (0.000s)
[251.038760] Starting dynamic subtest: vcs0
[251.040783] Dynamic subtest vcs0: SUCCESS (0.000s)
[251.048361] Starting dynamic subtest: bcs0
[251.050471] Dynamic subtest bcs0: SUCCESS (0.000s)
[251.058051] Starting dynamic subtest: rcs0
[251.060130] Dynamic subtest rcs0: SUCCESS (0.000s)
[251.067616] Starting dynamic subtest: vcs1
[251.069794] Dynamic subtest vcs1: SUCCESS (0.000s)
[251.071879] Subtest invalid: SUCCESS (0.005s)
[251.159223] [056/133] (768s left) gen9_exec_parse (cmd-crossing-page)
[251.222121] Subtest cmd-crossing-page: SKIP (0.000s)
[251.302839] [057/133] (768s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[251.401234] Starting subtest: stress-xrgb8888-4tiled
[257.307906] Subtest stress-xrgb8888-4tiled: SUCCESS (5.906s)
[257.361421] [058/133] (762s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[257.747461] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[258.554246] [059/133] (761s left) kms_cursor_crc (cursor-onscreen-64x64)
[258.727077] Starting subtest: cursor-onscreen-64x64
[258.731884] Starting dynamic subtest: pipe-A-eDP-1
[260.831829] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s)
[260.858927] Starting dynamic subtest: pipe-D-eDP-1
[263.689769] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.835s)
[263.691645] Subtest cursor-onscreen-64x64: SUCCESS (4.959s)
[264.561434] [060/133] (755s left) i915_getparams_basic (basic-subslice-total)
[264.621524] Starting subtest: basic-subslice-total
[264.626088] Subtest basic-subslice-total: SUCCESS (0.000s)
[264.747480] [061/133] (755s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[264.810310] Starting subtest: invalid-multi-wait-unsubmitted
[264.812175] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[264.918402] [062/133] (755s left) gem_exec_fence (syncobj-export)
[265.362108] Starting subtest: syncobj-export
[265.366980] Subtest syncobj-export: SUCCESS (0.004s)
[267.011845] [063/133] (753s left) gem_exec_fence (basic-wait)
[267.187552] Starting subtest: basic-wait
[267.190076] Starting dynamic subtest: rcs0
[267.295716] Dynamic subtest rcs0: SUCCESS (0.108s)
[267.309839] Starting dynamic subtest: bcs0
[267.360920] Dynamic subtest bcs0: SUCCESS (0.063s)
[267.371438] Starting dynamic subtest: vcs0
[267.427268] Dynamic subtest vcs0: SUCCESS (0.064s)
[267.437656] Starting dynamic subtest: vcs1
[267.489792] Dynamic subtest vcs1: SUCCESS (0.061s)
[267.500441] Starting dynamic subtest: vecs0
[267.555861] Dynamic subtest vecs0: SUCCESS (0.064s)
[267.566133] Starting dynamic subtest: ccs0
[267.628132] Dynamic subtest ccs0: SUCCESS (0.070s)
[267.630632] Subtest basic-wait: SUCCESS (0.442s)
[268.963233] [064/133] (751s left) gem_partial_pwrite_pread (reads-uncached)
[269.029349] Subtest reads-uncached: SKIP (0.000s)
[269.121526] [065/133] (751s left) gem_media_fill (media-fill)
[269.183592] Subtest media-fill: SKIP (0.000s)
[269.295721] [066/133] (750s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[269.399206] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[269.401494] Starting dynamic subtest: A-eDP1
[272.987188] Dynamic subtest A-eDP1: SUCCESS (3.584s)
[272.995550] Starting dynamic subtest: B-eDP1
[276.171059] Dynamic subtest B-eDP1: SUCCESS (3.183s)
[276.184254] Starting dynamic subtest: C-eDP1
[279.265404] Dynamic subtest C-eDP1: SUCCESS (3.095s)
[279.277455] Starting dynamic subtest: D-eDP1
[282.360079] Dynamic subtest D-eDP1: SUCCESS (3.091s)
[282.362448] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.961s)
[283.173729] [067/133] (737s left) syncobj_wait (wait-any-complex)
[283.231636] Starting subtest: wait-any-complex
[283.291461] Subtest wait-any-complex: SUCCESS (0.061s)
[283.395380] [068/133] (736s left) kms_rotation_crc (primary-rotation-180)
[283.494034] Starting subtest: primary-rotation-180
[290.511017] Subtest primary-rotation-180: SUCCESS (7.019s)
[291.750650] [069/133] (728s left) gem_workarounds (suspend-resume-context)
[291.831596] Starting subtest: suspend-resume-context
[308.091547] Subtest suspend-resume-context: SUCCESS (1.338s)
[308.257378] [070/133] (712s left) gem_pxp (reject-modify-context-protection-off-3)
[308.379404] Starting subtest: reject-modify-context-protection-off-3
[308.381917] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[308.519557] [071/133] (711s left) kms_lease (lease-unleased-crtc)
[308.623058] Starting subtest: lease-unleased-crtc
[308.625459] Starting dynamic subtest: pipe-A-eDP-1
[309.026128] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.386s)
[309.036938] Starting dynamic subtest: pipe-B-eDP-1
[309.739508] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.681s)
[309.757087] Starting dynamic subtest: pipe-C-eDP-1
[309.759218] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[309.772655] Starting dynamic subtest: pipe-D-eDP-1
[309.774808] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[309.776899] Subtest lease-unleased-crtc: SUCCESS (1.083s)
[310.150398] [072/133] (710s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[310.276005] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[310.281053] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[310.410346] [073/133] (710s left) gem_exec_reloc (basic-gtt-wc)
[310.476530] Subtest basic-gtt-wc: SKIP (0.000s)
[310.559188] [074/133] (710s left) gem_exec_reloc (basic-cpu)
[310.640076] Subtest basic-cpu: SKIP (0.000s)
[310.720924] [075/133] (709s left) kms_atomic_interruptible (legacy-pageflip)
[310.818076] Starting subtest: legacy-pageflip
[310.820386] Starting dynamic subtest: pipe-A-eDP-1
[318.223865] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.249s)
[318.226393] Subtest legacy-pageflip: SUCCESS (7.251s)
[319.098220] [076/133] (701s left) kms_atomic_interruptible (universal-setplane-cursor)
[319.208070] Starting subtest: universal-setplane-cursor
[319.210367] Starting dynamic subtest: pipe-A-eDP-1
[326.611412] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.348s)
[326.613833] Subtest universal-setplane-cursor: SUCCESS (7.350s)
[327.413509] [077/133] (693s left) gem_mmap_gtt (hang-busy)
[327.482096] Subtest hang-busy: SKIP (0.000s)
[327.552369] [078/133] (693s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[327.659213] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[327.663422] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[327.793192] [079/133] (692s left) perf_pmu (module-unload)
[327.884627] Starting subtest: module-unload
[337.724994] Subtest module-unload: FAIL (9.704s)
[337.759958] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[337.760684] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[337.763908] [080/133] (683s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[339.398782] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[339.400996] Starting dynamic subtest: pipe-A-default-mode
[342.129534] Dynamic subtest pipe-A-default-mode: SUCCESS (2.730s)
[342.131935] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.732s)
[343.053135] [FACT kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[343.054348] [FACT kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)] new: kernel.kmod_is_loaded.i915: true
[343.058036] [081/133] (677s left) gem_exec_schedule (u-semaphore-resolve)
[343.147024] Starting subtest: u-semaphore-resolve
[343.181058] Subtest u-semaphore-resolve: SUCCESS (0.036s)
[343.548486] [082/133] (677s left) i915_selftest (live)
[347.562634] Starting subtest: live
[347.564817] Starting dynamic subtest: sanitycheck
[351.993758] Dynamic subtest sanitycheck: SUCCESS (4.432s)
[352.004141] Starting dynamic subtest: uncore
[354.787114] Dynamic subtest uncore: SUCCESS (2.790s)
[354.797521] Starting dynamic subtest: workarounds
[358.162215] Dynamic subtest workarounds: SUCCESS (3.372s)
[358.171792] Starting dynamic subtest: gt_engines
[361.412167] Dynamic subtest gt_engines: SUCCESS (3.245s)
[361.422377] Starting dynamic subtest: gt_timelines
[375.886243] Dynamic subtest gt_timelines: SUCCESS (14.465s)
[375.896369] Starting dynamic subtest: gt_contexts
[380.358952] Dynamic subtest gt_contexts: SUCCESS (4.469s)
[380.369015] Starting dynamic subtest: gt_lrc
[386.636761] Dynamic subtest gt_lrc: SUCCESS (6.272s)
[386.646930] Starting dynamic subtest: gt_mocs
[389.679469] Dynamic subtest gt_mocs: SUCCESS (3.039s)
[389.689976] Starting dynamic subtest: gt_pm
[396.619669] Dynamic subtest gt_pm: SUCCESS (6.935s)
[396.629696] Starting dynamic subtest: gt_heartbeat
[401.140912] Dynamic subtest gt_heartbeat: SUCCESS (4.517s)
[401.151394] Starting dynamic subtest: gt_tlb
[411.129097] Dynamic subtest gt_tlb: SUCCESS (9.987s)
[411.139170] Starting dynamic subtest: requests
[425.076880] Dynamic subtest requests: SUCCESS (13.948s)
[425.087107] Starting dynamic subtest: migrate
[431.361004] Dynamic subtest migrate: SUCCESS (6.283s)
[431.371341] Starting dynamic subtest: active
[435.828671] Dynamic subtest active: SUCCESS (4.464s)
[435.839340] Starting dynamic subtest: objects
[440.747138] Dynamic subtest objects: SUCCESS (4.916s)
[440.757778] Starting dynamic subtest: mman
[445.673911] Dynamic subtest mman: SUCCESS (4.924s)
[445.683616] Starting dynamic subtest: dmabuf
[450.194612] Dynamic subtest dmabuf: SUCCESS (4.518s)
[450.204918] Starting dynamic subtest: vma
[454.720039] Dynamic subtest vma: SUCCESS (4.522s)
[454.736094] Starting dynamic subtest: coherency
[458.286275] Dynamic subtest coherency: SUCCESS (3.563s)
[458.294664] Starting dynamic subtest: gtt
[470.480028] Dynamic subtest gtt: SUCCESS (12.188s)
[470.490556] Starting dynamic subtest: gem
[478.621479] Dynamic subtest gem: SUCCESS (8.138s)
[478.631621] Starting dynamic subtest: evict
[482.738274] Dynamic subtest evict: SUCCESS (4.113s)
[482.748632] Starting dynamic subtest: hugepages
[494.306206] Dynamic subtest hugepages: SUCCESS (11.562s)
[494.320844] Starting dynamic subtest: gem_contexts
[522.044205] Dynamic subtest gem_contexts: SUCCESS (27.727s)
[522.054982] Starting dynamic subtest: client
[524.865842] Dynamic subtest client: SUCCESS (2.818s)
[524.876349] Starting dynamic subtest: gem_migrate
[529.293898] Dynamic subtest gem_migrate: SUCCESS (4.425s)
[529.304024] Starting dynamic subtest: reset
[532.236987] Dynamic subtest reset: SUCCESS (2.940s)
[532.247570] Starting dynamic subtest: memory_region
[536.711047] Dynamic subtest memory_region: SUCCESS (4.474s)
[536.727309] Starting dynamic subtest: hangcheck
[551.019311] Dynamic subtest hangcheck: SUCCESS (14.310s)
[551.029654] Starting dynamic subtest: execlists
[555.488109] Dynamic subtest execlists: SUCCESS (4.467s)
[555.498506] Starting dynamic subtest: ring_submission
[559.957749] Dynamic subtest ring_submission: SUCCESS (4.468s)
[559.967955] Starting dynamic subtest: perf
[564.447139] Dynamic subtest perf: SUCCESS (4.487s)
[564.457606] Starting dynamic subtest: slpc
[578.956639] Dynamic subtest slpc: SUCCESS (14.509s)
[578.966796] Starting dynamic subtest: guc
[583.093142] Dynamic subtest guc: SUCCESS (4.135s)
[583.103689] Starting dynamic subtest: guc_multi_lrc
[587.576106] Dynamic subtest guc_multi_lrc: SUCCESS (4.481s)
[587.586763] Starting dynamic subtest: guc_hang
[592.762970] Dynamic subtest guc_hang: SUCCESS (5.169s)
[592.772487] Starting dynamic subtest: late_gt_pm
[597.236672] Dynamic subtest late_gt_pm: SUCCESS (4.488s)
[597.239560] Subtest live: SUCCESS (249.640s)
[597.268952] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[597.269772] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[597.272940] [083/133] (423s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[598.841866] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[602.612898] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.774s)
[603.801409] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[603.802572] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[603.806226] [084/133] (417s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[603.902949] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[612.872505] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.972s)
[613.038407] [085/133] (407s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[613.098211] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[613.102561] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[613.296209] [086/133] (407s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[613.419122] Starting subtest: flip-vs-cursor-busy-crc-legacy
[614.345570] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.925s)
[615.318017] [087/133] (405s left) kms_pm_rpm (fences)
[617.246283] Starting subtest: fences
[617.251357] Subtest fences: SKIP (0.000s)
[617.634679] [088/133] (403s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[617.730561] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[617.735023] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[617.851373] [089/133] (403s left) dumb_buffer (map-valid)
[617.904298] Starting subtest: map-valid
[617.906549] Subtest map-valid: SUCCESS (0.000s)
[618.029962] [090/133] (403s left) gem_exec_suspend (basic-s0)
[618.108556] Starting subtest: basic-S0
[618.110907] Starting dynamic subtest: smem
[637.976724] Dynamic subtest smem: SUCCESS (6.693s)
[637.979441] Subtest basic-S0: SUCCESS (6.696s)
[638.176517] [091/133] (383s left) gem_render_copy_redux (normal)
[638.252475] Starting subtest: normal
[638.502986] Subtest normal: SUCCESS (0.250s)
[638.665134] [092/133] (382s left) kms_psr (pr-sprite-plane-move)
[638.765279] Starting subtest: pr-sprite-plane-move
[638.769628] Subtest pr-sprite-plane-move: SKIP (0.000s)
[638.862611] [093/133] (382s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[638.966880] Starting subtest: fbcpsr-tiling-y
[638.971269] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[639.090577] [094/133] (382s left) gem_ctx_exec (basic-invalid-context)
[639.159364] Starting subtest: basic-invalid-context
[639.163682] Subtest basic-invalid-context: SUCCESS (0.005s)
[639.329137] [095/133] (382s left) sw_sync (sync_merge_same)
[639.363637] Starting subtest: sync_merge_same
[639.365685] Subtest sync_merge_same: SUCCESS (0.000s)
[639.446427] [096/133] (382s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[639.535687] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[639.537550] Starting dynamic subtest: pipe-A
[639.557667] Dynamic subtest pipe-A: SKIP (0.017s)
[639.569297] Starting dynamic subtest: pipe-B
[639.606258] Dynamic subtest pipe-B: SKIP (0.050s)
[639.615524] Starting dynamic subtest: pipe-C
[639.644233] Dynamic subtest pipe-C: SKIP (0.036s)
[639.653231] Starting dynamic subtest: pipe-D
[639.677448] Dynamic subtest pipe-D: SKIP (0.033s)
[639.680857] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.140s)
[639.797442] [097/133] (381s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[639.894164] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[639.896231] Starting dynamic subtest: pipe-A-eDP-1
[640.739258] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[640.748818] Starting dynamic subtest: pipe-B-eDP-1
[642.372832] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.568s)
[642.383501] Starting dynamic subtest: pipe-C-eDP-1
[643.892774] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.471s)
[643.903566] Starting dynamic subtest: pipe-D-eDP-1
[645.477329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.542s)
[645.479604] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.416s)
[646.669761] [098/133] (374s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[646.730379] Starting subtest: invalid-single-wait-all-unsubmitted
[646.732577] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[646.862723] [099/133] (374s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[646.970315] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[647.617545] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[647.822577] [100/133] (373s left) gem_ctx_freq (sysfs)
[647.881157] Starting subtest: sysfs
[647.883508] Starting dynamic subtest: gt0
[653.409802] Dynamic subtest gt0: SUCCESS (5.459s)
[653.422609] Starting dynamic subtest: gt1
[694.999478] Dynamic subtest gt1: SUCCESS (41.510s)
[695.002487] Subtest sysfs: SUCCESS (46.974s)
[695.150971] [101/133] (326s left) perf (gen12-group-concurrent-oa-buffer-read)
[695.293008] Starting subtest: gen12-group-concurrent-oa-buffer-read
[705.334043] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.035s)
[705.381968] [102/133] (316s left) kms_cursor_legacy (forked-bo)
[705.501306] Starting subtest: forked-bo
[705.503279] Starting dynamic subtest: pipe-A
[710.956472] Dynamic subtest pipe-A: SUCCESS (5.451s)
[710.969714] Starting dynamic subtest: pipe-B
[716.434325] Dynamic subtest pipe-B: SUCCESS (5.472s)
[716.446462] Starting dynamic subtest: pipe-C
[721.964977] Dynamic subtest pipe-C: SUCCESS (5.527s)
[721.975670] Starting dynamic subtest: pipe-D
[727.472626] Dynamic subtest pipe-D: SUCCESS (5.501s)
[727.485384] Starting dynamic subtest: all-pipes
[732.973336] Dynamic subtest all-pipes: SUCCESS (5.486s)
[732.975818] Subtest forked-bo: SUCCESS (27.448s)
[733.119999] [103/133] (288s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[733.215341] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[736.930433] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.717s)
[738.139811] [104/133] (283s left) kms_vblank (query-forked-busy)
[738.235800] Starting subtest: query-forked-busy
[738.238150] Starting dynamic subtest: pipe-A-eDP-1
[740.112889] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[740.129582] Starting dynamic subtest: pipe-D-eDP-1
[742.652914] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s)
[742.655236] Subtest query-forked-busy: SUCCESS (4.421s)
[743.467344] [105/133] (278s left) gem_eio (execbuf)
[743.667781] Starting subtest: execbuf
[743.957547] Subtest execbuf: SUCCESS (0.289s)
[744.151768] [106/133] (277s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[744.254526] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[744.265737] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[744.411458] [107/133] (277s left) syncobj_basic (bad-destroy)
[744.470896] Starting subtest: bad-destroy
[744.472864] Subtest bad-destroy: SUCCESS (0.000s)
[744.599334] [108/133] (277s left) gem_exec_balancer (bonded-true-hang)
[744.843705] Starting subtest: bonded-true-hang
[744.849044] Subtest bonded-true-hang: SKIP (0.000s)
[744.969623] [109/133] (277s left) kms_pwrite_crc
[746.613068] [110/133] (275s left) kms_cursor_crc (cursor-random-32x32)
[746.759573] Starting subtest: cursor-random-32x32
[746.805173] Subtest cursor-random-32x32: SKIP (0.038s)
[747.121375] [111/133] (275s left) kms_async_flips (async-flip-hang)
[747.215000] Starting subtest: async-flip-hang
[747.595701] Starting dynamic subtest: pipe-A-eDP-1
[762.489231] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.893s)
[762.860225] Starting dynamic subtest: pipe-B-eDP-1
[778.485144] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.628s)
[778.852980] Starting dynamic subtest: pipe-C-eDP-1
[794.480184] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.631s)
[794.856619] Starting dynamic subtest: pipe-D-eDP-1
[810.484772] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.632s)
[810.487379] Subtest async-flip-hang: SUCCESS (63.264s)
[811.658153] [112/133] (210s left) gem_userptr_blits (probe)
[811.723178] Starting subtest: probe
[811.794429] Subtest probe: SUCCESS (0.071s)
[811.947135] [113/133] (210s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[812.038621] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[812.051478] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[812.123641] [114/133] (210s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[812.193983] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[812.300457] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[812.387279] [115/133] (209s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[812.488960] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[819.489934] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.002s)
[819.652005] [116/133] (202s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[819.749137] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[819.751405] Starting dynamic subtest: pipe-A-eDP-1
[830.723856] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.977s)
[830.735504] Starting dynamic subtest: pipe-B-eDP-1
[842.473490] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.743s)
[842.475826] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.724s)
[843.335547] [117/133] (179s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[843.405952] Starting subtest: multi-wait-available-submitted-signaled
[843.408309] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[843.534992] [118/133] (178s left) kms_selftest (drm_cmdline_parser)
[843.570181] Starting subtest: drm_cmdline_parser
[843.616914] Starting dynamic subtest: drm_test_cmdline_force_d_only
[843.766723] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.148s)
[843.777377] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[843.861488] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.094s)
[843.871150] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[844.020874] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.158s)
[844.030113] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[844.165152] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.143s)
[844.174712] Starting dynamic subtest: drm_test_cmdline_force_e_only
[844.304571] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.139s)
[844.314565] Starting dynamic subtest: drm_test_cmdline_res
[844.454317] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.148s)
[844.465202] Starting dynamic subtest: drm_test_cmdline_res_vesa
[844.592702] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.139s)
[844.601458] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[844.744145] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.150s)
[844.754162] Starting dynamic subtest: drm_test_cmdline_res_rblank
[844.866657] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.122s)
[844.876025] Starting dynamic subtest: drm_test_cmdline_res_bpp
[844.993316] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.126s)
[845.002340] Starting dynamic subtest: drm_test_cmdline_res_refresh
[845.088480] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.095s)
[845.097644] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[845.229192] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.139s)
[845.238649] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[845.367641] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.138s)
[845.376708] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[845.519261] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.150s)
[845.528585] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[845.654016] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.134s)
[845.663451] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[845.779324] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.125s)
[845.788530] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[845.930558] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.150s)
[845.940355] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[846.069680] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.138s)
[846.079475] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[846.199483] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.129s)
[846.208771] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[846.342249] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.142s)
[846.352472] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[846.481137] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.138s)
[846.490353] Starting dynamic subtest: drm_test_cmdline_name
[846.617591] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.135s)
[846.628319] Starting dynamic subtest: drm_test_cmdline_name_bpp
[846.744295] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.127s)
[846.754485] Starting dynamic subtest: drm_test_cmdline_name_option
[846.831525] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.087s)
[846.841826] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[846.925478] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.093s)
[846.935470] Starting dynamic subtest: drm_test_cmdline_rotate_0
[847.045190] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.118s)
[847.056198] Starting dynamic subtest: drm_test_cmdline_rotate_90
[847.163506] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.118s)
[847.174228] Starting dynamic subtest: drm_test_cmdline_rotate_180
[847.284177] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.119s)
[847.293299] Starting dynamic subtest: drm_test_cmdline_rotate_270
[847.395542] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.112s)
[847.404859] Starting dynamic subtest: drm_test_cmdline_hmirror
[847.507479] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.111s)
[847.518087] Starting dynamic subtest: drm_test_cmdline_vmirror
[847.652285] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.142s)
[847.663328] Starting dynamic subtest: drm_test_cmdline_margin_options
[847.762423] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.109s)
[847.779588] Starting dynamic subtest: drm_test_cmdline_multiple_options
[847.884880] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.121s)
[847.896103] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[848.002556] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.116s)
[848.013154] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[848.126265] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.125s)
[848.136033] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[848.250793] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.123s)
[848.259804] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[848.408787] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.155s)
[848.425140] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[848.569731] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.162s)
[848.581117] Starting dynamic subtest: drm_test_cmdline_invalid
[848.715303] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.148s)
[848.726490] Starting dynamic subtest: drm_test_cmdline_tv_options
[848.884673] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.165s)
[848.886942] Subtest drm_cmdline_parser: SUCCESS (5.312s)
[849.117966] [119/133] (173s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[849.224094] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[849.228521] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[849.333041] [120/133] (173s left) gem_render_copy (x-tiled)
[849.402463] Starting subtest: x-tiled
[849.404316] Starting dynamic subtest: smem
[849.439483] Dynamic subtest smem: SUCCESS (0.039s)
[849.441863] Subtest x-tiled: SUCCESS (0.040s)
[849.699821] [121/133] (172s left) kms_prop_blob (blob-prop-core)
[849.751455] Starting subtest: blob-prop-core
[849.753419] Subtest blob-prop-core: SUCCESS (0.000s)
[849.877642] [122/133] (172s left) vgem_basic (second-client)
[849.926064] Starting subtest: second-client
[849.948268] Subtest second-client: SUCCESS (0.022s)
[850.018347] [123/133] (172s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[850.088857] Starting subtest: single-wait-all-for-submit-available-submitted
[850.091246] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[850.205970] [124/133] (172s left) syncobj_timeline (invalid-query-zero-handles)
[850.262631] Starting subtest: invalid-query-zero-handles
[850.264846] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[850.373220] [125/133] (172s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[850.473853] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[850.477728] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[850.581868] [126/133] (172s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[850.682750] Starting subtest: fbc-pr-cursor-mmap-cpu
[850.686249] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[850.765257] [127/133] (172s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[850.865877] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[850.869505] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[850.989552] [128/133] (171s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[851.087808] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[851.089600] Starting dynamic subtest: pipe-A-eDP-1
[851.107985] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[851.118762] Starting dynamic subtest: pipe-B-eDP-1
[851.136200] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[851.145572] Starting dynamic subtest: pipe-C-eDP-1
[851.163365] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[851.174213] Starting dynamic subtest: pipe-D-eDP-1
[851.192450] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[851.195913] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[853.314217] [129/133] (169s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[853.423089] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[853.427510] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[853.528344] [130/133] (169s left) kms_async_flips (test-time-stamp-atomic)
[853.631041] Starting subtest: test-time-stamp-atomic
[854.013764] Starting dynamic subtest: pipe-A-eDP-1
[854.816059] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.800s)
[855.181189] Starting dynamic subtest: pipe-B-eDP-1
[855.946250] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.770s)
[856.313980] Starting dynamic subtest: pipe-C-eDP-1
[857.081388] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.772s)
[857.445145] Starting dynamic subtest: pipe-D-eDP-1
[858.215248] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.776s)
[858.217724] Subtest test-time-stamp-atomic: SUCCESS (4.583s)
[859.372497] [131/133] (163s left) gem_partial_pwrite_pread (writes-after-reads)
[859.426658] Subtest writes-after-reads: SKIP (0.000s)
[859.511625] [132/133] (163s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[859.609105] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[860.568068] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.957s)
[860.710933] [133/133] (162s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[860.801695] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[860.812862] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[860.936496] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rps
results: parsing output: 1/ for test: kms_invalid_mode
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_cursor_edge_walk
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: kms_prop_blob
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: dumb_buffer
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_addfb_basic
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: api_intel_bb
results: parsing output: 13/ for test: gem_wait
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_rotation_crc
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: gem_lmem_swapping
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: gem_pxp
results: parsing output: 23/ for test: prime_mmap
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_psr_stress_test
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: gem_softpin
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_chamelium_frames
results: parsing output: 34/ for test: gem_fence_thrash
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_reg_read
results: parsing output: 39/ for test: kms_color
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_exec_alignment
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_ctx_persistence
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_chamelium_color
results: parsing output: 48/ for test: gem_tiled_blits
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_draw_crc
results: parsing output: 53/ for test: i915_drm_fdinfo
results: parsing output: 54/ for test: sysfs_heartbeat_interval
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: kms_pipe_stress
results: parsing output: 57/ for test: kms_chamelium_hpd
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: i915_getparams_basic
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: gem_partial_pwrite_pread
results: parsing output: 64/ for test: gem_media_fill
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: kms_rotation_crc
results: parsing output: 68/ for test: gem_workarounds
results: parsing output: 69/ for test: gem_pxp
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_atomic_interruptible
results: parsing output: 75/ for test: kms_atomic_interruptible
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: i915_selftest
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_render_copy
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_pm_rpm
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: dumb_buffer
results: parsing output: 89/ for test: gem_exec_suspend
results: parsing output: 90/ for test: gem_render_copy_redux
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_ctx_exec
results: parsing output: 94/ for test: sw_sync
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_ctx_freq
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_vblank
results: parsing output: 104/ for test: gem_eio
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: syncobj_basic
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: kms_pwrite_crc
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: gem_userptr_blits
results: parsing output: 112/ for test: kms_plane
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_selftest
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: kms_prop_blob
results: parsing output: 121/ for test: vgem_basic
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_async_flips
results: parsing output: 130/ for test: gem_partial_pwrite_pread
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_flip
Done.