[114.406433] Initializing watchdogs
[114.406480]   /dev/watchdog0
[114.420869] [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]
[114.425216] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[114.427555] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[114.430888] [001/134] (960s left) kms_getfb (getfb-handle-valid)
[114.558780] Starting subtest: getfb-handle-valid
[114.561066] Subtest getfb-handle-valid: SUCCESS (0.000s)
[114.670220] [002/134] (960s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[114.765386] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[114.769894] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[114.843918] [003/134] (960s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[114.943619] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[114.945934] Starting dynamic subtest: pipe-A
[115.031578] Dynamic subtest pipe-A: SUCCESS (0.090s)
[115.038707] Starting dynamic subtest: pipe-B
[116.161892] Dynamic subtest pipe-B: SUCCESS (1.129s)
[116.174576] Starting dynamic subtest: pipe-C
[117.273534] Dynamic subtest pipe-C: SUCCESS (1.111s)
[117.281480] Starting dynamic subtest: pipe-D
[118.416131] Dynamic subtest pipe-D: SUCCESS (1.142s)
[118.418504] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.474s)
[119.627168] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[119.731259] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[119.735286] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[119.843183] [005/134] (955s left) kms_chamelium_hpd (hdmi-hpd)
[120.247145] Subtest hdmi-hpd: SKIP (0.000s)
[121.014546] [006/134] (954s left) kms_async_flips (invalid-async-flip-atomic)
[121.098193] Starting subtest: invalid-async-flip-atomic
[121.472960] Starting dynamic subtest: pipe-A-eDP-1
[122.264756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s)
[122.621441] Starting dynamic subtest: pipe-B-eDP-1
[123.402487] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s)
[123.759272] Starting dynamic subtest: pipe-C-eDP-1
[124.518959] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[124.877706] Starting dynamic subtest: pipe-D-eDP-1
[125.652895] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.781s)
[125.655415] Subtest invalid-async-flip-atomic: SUCCESS (4.557s)
[126.805879] [007/134] (948s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[126.905242] Starting subtest: fbc-psr2-sprite-mmap-cpu
[126.907184] Starting dynamic subtest: eDP-1
[126.911271] Dynamic subtest eDP-1: SKIP (0.000s)
[126.915413] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[127.000897] [008/134] (948s left) gem_lmem_swapping (heavy-random)
[127.048800] Subtest heavy-random: SKIP (0.000s)
[127.092919] [009/134] (948s left) gem_basic (create-fd-close)
[127.156638] Starting subtest: create-fd-close
[127.160970] Subtest create-fd-close: SUCCESS (0.000s)
[127.275108] [010/134] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[127.374076] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[127.378413] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[127.473119] [011/134] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[127.574640] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[127.578636] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[127.679120] [012/134] (947s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[127.778541] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[127.782132] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[127.924211] [013/134] (947s left) kms_vblank (crtc-id)
[128.022140] Starting subtest: crtc-id
[128.023855] Starting dynamic subtest: pipe-A-eDP-1
[128.474465] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.452s)
[128.487877] Starting dynamic subtest: pipe-D-eDP-1
[129.634555] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.157s)
[129.636425] Subtest crtc-id: SUCCESS (1.612s)
[130.479741] [014/134] (944s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[130.577332] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[130.589271] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[130.669674] [015/134] (944s left) kms_psr (pr-sprite-mmap-gtt)
[130.768186] Starting subtest: pr-sprite-mmap-gtt
[130.772363] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[130.864641] [016/134] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[130.964891] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[130.969061] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[131.068702] [017/134] (944s left) i915_drm_fdinfo (virtual-busy-idle-all)
[131.108527] Starting subtest: virtual-busy-idle-all
[131.113116] Subtest virtual-busy-idle-all: SKIP (0.000s)
[131.184560] [018/134] (944s left) gem_eio (wait-wedge-1us)
[131.342750] Starting subtest: wait-wedge-1us
[132.923732] Subtest wait-wedge-1us: SUCCESS (1.579s)
[133.089811] [019/134] (942s left) kms_plane_cursor (viewport)
[133.188764] Starting subtest: viewport
[133.193382] Starting dynamic subtest: pipe-A-eDP-1-size-64
[135.765503] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.578s)
[135.827129] Starting dynamic subtest: pipe-A-eDP-1-size-128
[138.388206] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s)
[138.447160] Starting dynamic subtest: pipe-A-eDP-1-size-256
[141.012715] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.571s)
[141.360588] Starting dynamic subtest: pipe-B-eDP-1-size-64
[144.655867] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.304s)
[144.714084] Starting dynamic subtest: pipe-B-eDP-1-size-128
[147.357048] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.649s)
[147.415142] Starting dynamic subtest: pipe-B-eDP-1-size-256
[149.946709] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.538s)
[150.293520] Starting dynamic subtest: pipe-C-eDP-1-size-64
[153.244421] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.960s)
[153.281362] Starting dynamic subtest: pipe-C-eDP-1-size-128
[155.500433] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.225s)
[155.536872] Starting dynamic subtest: pipe-C-eDP-1-size-256
[157.722423] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[158.054114] Starting dynamic subtest: pipe-D-eDP-1-size-64
[160.937694] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.892s)
[160.974526] Starting dynamic subtest: pipe-D-eDP-1-size-128
[163.193457] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.225s)
[163.231439] Starting dynamic subtest: pipe-D-eDP-1-size-256
[165.492930] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.269s)
[165.812552] Subtest viewport: SUCCESS (32.623s)
[166.705427] [020/134] (908s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[166.797867] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[166.800116] Starting dynamic subtest: pipe-A-eDP-1
[166.857064] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[166.865934] Starting dynamic subtest: pipe-B-eDP-1
[166.924261] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[166.932557] Starting dynamic subtest: pipe-C-eDP-1
[166.986899] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[166.994257] Starting dynamic subtest: pipe-D-eDP-1
[167.049466] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[167.053762] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[169.071057] [021/134] (906s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[169.182352] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[169.186397] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[169.300845] [022/134] (906s left) gem_softpin (safe-alignment)
[169.364650] Starting subtest: safe-alignment
[169.389842] Subtest safe-alignment: SUCCESS (0.026s)
[170.953922] [023/134] (904s left) sysfs_heartbeat_interval (precise)
[171.009232] Starting subtest: precise
[171.011693] Starting dynamic subtest: vecs0
[178.916184] Dynamic subtest vecs0: SUCCESS (7.906s)
[178.927050] Starting dynamic subtest: ccs0
[180.153820] Dynamic subtest ccs0: SUCCESS (1.236s)
[180.164320] Starting dynamic subtest: vcs0
[187.948945] Dynamic subtest vcs0: SUCCESS (7.790s)
[187.959715] Starting dynamic subtest: bcs0
[189.175864] Dynamic subtest bcs0: SUCCESS (1.226s)
[189.185981] Starting dynamic subtest: rcs0
[191.889677] Dynamic subtest rcs0: SUCCESS (2.712s)
[191.899595] Starting dynamic subtest: vcs1
[199.908266] Dynamic subtest vcs1: SUCCESS (8.017s)
[199.910718] Subtest precise: SUCCESS (28.899s)
[199.996855] [024/134] (875s left) gem_mmap_wc (close)
[200.055214] Subtest close: SKIP (0.000s)
[200.120735] [025/134] (875s left) gem_exec_balancer (parallel-keep-in-fence)
[200.474024] Starting subtest: parallel-keep-in-fence
[201.557645] Subtest parallel-keep-in-fence: SUCCESS (1.087s)
[201.693589] [026/134] (874s left) kms_invalid_mode (bad-hsync-end)
[201.801104] Starting subtest: bad-hsync-end
[201.803345] Starting dynamic subtest: pipe-A-eDP-1
[202.085235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[202.093289] Starting dynamic subtest: pipe-B-eDP-1
[202.095497] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[202.102953] Starting dynamic subtest: pipe-C-eDP-1
[202.105202] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[202.112931] Starting dynamic subtest: pipe-D-eDP-1
[202.114901] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[202.116815] Subtest bad-hsync-end: SUCCESS (0.291s)
[202.891166] [027/134] (873s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[202.995520] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[203.730676] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.737s)
[203.935560] [028/134] (872s left) syncobj_timeline (invalid-signal-illegal-handle)
[203.994069] Starting subtest: invalid-signal-illegal-handle
[203.996321] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[204.124088] [029/134] (871s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[204.224278] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[204.228775] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[205.337918] [030/134] (870s left) syncobj_timeline (device-signal-unordered)
[205.400760] Starting subtest: device-signal-unordered
[205.403149] Subtest device-signal-unordered: SUCCESS (0.001s)
[205.531389] [031/134] (870s left) kms_getfb (getfb-reject-nv12)
[205.649076] Starting subtest: getfb-reject-nv12
[205.651428] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[205.799133] [032/134] (870s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[205.896473] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[213.030798] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.136s)
[213.173145] [033/134] (862s left) syncobj_basic (bad-flags-fd-to-handle)
[213.237580] Starting subtest: bad-flags-fd-to-handle
[213.239843] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[213.350257] [034/134] (862s left) kms_psr (psr2-primary-mmap-gtt)
[213.445271] Starting subtest: psr2-primary-mmap-gtt
[213.447593] Starting dynamic subtest: eDP-1
[214.851939] Dynamic subtest eDP-1: SKIP (1.403s)
[214.857207] Subtest psr2-primary-mmap-gtt: SKIP (1.405s)
[215.015556] [035/134] (861s left) gem_partial_pwrite_pread (reads-snoop)
[215.085283] Subtest reads-snoop: SKIP (0.000s)
[215.155898] [036/134] (861s left) i915_drm_fdinfo (memory-info-shared)
[215.193963] Starting subtest: memory-info-shared
[215.196255] Starting dynamic subtest: smem0
[215.242055] Dynamic subtest smem0: SUCCESS (0.051s)
[215.244247] Subtest memory-info-shared: SUCCESS (0.052s)
[215.322064] [037/134] (860s left) gen9_exec_parse (allowed-all)
[215.397526] Subtest allowed-all: SKIP (0.000s)
[215.483343] [038/134] (860s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[220.462596] Starting subtest: pr-cursor-plane-move-continuous-sf
[220.466946] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[221.316671] [039/134] (855s left) gen7_exec_parse (basic-allocation)
[221.395633] Subtest basic-allocation: SKIP (0.000s)
[221.479768] [040/134] (854s left) gem_bad_reloc (negative-reloc-lut)
[221.547140] Subtest negative-reloc-lut: SKIP (0.000s)
[221.626099] [041/134] (854s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[221.715220] Starting subtest: compare-crc-sanitycheck-nv12
[221.717135] Starting dynamic subtest: pipe-A-eDP-1
[222.419974] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s)
[222.428662] Starting dynamic subtest: pipe-B-eDP-1
[223.684714] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.267s)
[223.695560] Starting dynamic subtest: pipe-C-eDP-1
[224.963715] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.278s)
[224.972327] Starting dynamic subtest: pipe-D-eDP-1
[226.204872] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[226.207234] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.491s)
[227.033153] [042/134] (849s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[227.141936] Starting subtest: x-tiled-32bpp-rotate-270
[227.160859] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[227.321263] [043/134] (849s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[227.419550] Starting subtest: primary-y-tiled-reflect-x-180
[227.479954] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[227.591812] [044/134] (848s left) gem_render_copy (yf-tiled)
[227.664405] Starting subtest: yf-tiled
[227.668585] Subtest yf-tiled: SKIP (0.000s)
[227.855589] [045/134] (848s left) sw_sync (sync_multi_consumer)
[227.899785] Starting subtest: sync_multi_consumer
[228.325734] Subtest sync_multi_consumer: SUCCESS (0.427s)
[228.407405] [046/134] (848s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[228.517075] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[228.521385] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[228.618423] [047/134] (848s left) kms_flip (flip-vs-suspend)
[228.715310] Starting subtest: flip-vs-suspend
[228.717600] Starting dynamic subtest: A-eDP1
[278.191384] Dynamic subtest A-eDP1: SUCCESS (4.691s)
[278.206294] Starting dynamic subtest: B-eDP1
[327.187262] Dynamic subtest B-eDP1: SUCCESS (4.475s)
[327.201087] Starting dynamic subtest: C-eDP1
[376.171475] Dynamic subtest C-eDP1: SUCCESS (4.489s)
[376.185096] Starting dynamic subtest: D-eDP1
[425.174536] Dynamic subtest D-eDP1: SUCCESS (4.550s)
[425.176834] Subtest flip-vs-suspend: SUCCESS (18.214s)
[426.352641] [048/134] (650s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[426.467316] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[426.471323] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[426.579346] [049/134] (650s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[426.671959] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[426.676280] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[426.795018] [050/134] (650s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[426.891939] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[426.894194] Starting dynamic subtest: pipe-A-eDP-1
[426.914352] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[426.925800] Starting dynamic subtest: pipe-B-eDP-1
[426.944840] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[426.953610] Starting dynamic subtest: pipe-C-eDP-1
[426.971709] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[426.979395] Starting dynamic subtest: pipe-D-eDP-1
[426.997455] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[426.999295] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[429.174027] [051/134] (647s left) gem_readwrite (read-write)
[429.229883] Subtest read-write: SKIP (0.000s)
[429.292126] [052/134] (647s left) kms_cursor_crc (cursor-offscreen-256x256)
[429.525459] Starting subtest: cursor-offscreen-256x256
[429.530296] Starting dynamic subtest: pipe-A-eDP-1
[431.490799] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.979s)
[431.524177] Starting dynamic subtest: pipe-D-eDP-1
[434.071840] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.571s)
[434.073996] Subtest cursor-offscreen-256x256: SUCCESS (4.582s)
[434.917081] [053/134] (641s left) kms_sequence (get-idle)
[435.021840] Starting subtest: get-idle
[435.024105] Starting dynamic subtest: pipe-A-eDP-1
[436.818533] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.804s)
[436.830245] Starting dynamic subtest: pipe-B-eDP-1
[439.259686] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.451s)
[439.273417] Starting dynamic subtest: pipe-C-eDP-1
[441.691296] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.437s)
[441.704720] Starting dynamic subtest: pipe-D-eDP-1
[444.109843] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.420s)
[444.112284] Subtest get-idle: SUCCESS (9.120s)
[444.938686] [054/134] (632s left) kms_color (ctm-red-to-blue)
[445.026090] Starting subtest: ctm-red-to-blue
[445.028044] Starting dynamic subtest: pipe-A-eDP-1
[445.740169] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[445.749095] Starting dynamic subtest: pipe-B-eDP-1
[447.107067] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.368s)
[447.116212] Starting dynamic subtest: pipe-C-eDP-1
[448.489843] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[448.500801] Starting dynamic subtest: pipe-D-eDP-1
[449.809285] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[449.811958] Subtest ctm-red-to-blue: SUCCESS (4.792s)
[450.620331] [055/134] (626s left) sw_sync (sync_merge_invalid)
[450.656923] Starting subtest: sync_merge_invalid
[450.678812] Subtest sync_merge_invalid: SUCCESS (0.022s)
[450.760889] [056/134] (626s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[450.806521] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[450.869652] [057/134] (626s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[450.930823] Starting subtest: invalid-multi-wait-unsubmitted
[450.933240] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[451.051371] [058/134] (626s left) kms_pm_rpm (fences)
[452.586846] Starting subtest: fences
[452.591675] Subtest fences: SKIP (0.000s)
[453.354528] [059/134] (623s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[453.435438] Starting subtest: rel-constants-invalid-rel-gen5
[453.437549] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[453.564301] [060/134] (623s left) kms_psr (fbc-psr-no-drrs)
[453.647499] Starting subtest: fbc-psr-no-drrs
[453.649783] Starting dynamic subtest: eDP-1
[453.653852] Dynamic subtest eDP-1: SKIP (0.000s)
[453.657889] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[453.730470] [061/134] (623s left) kms_frontbuffer_tracking (fbc-tiling-4)
[453.824918] Starting subtest: fbc-tiling-4
[458.105219] Subtest fbc-tiling-4: SUCCESS (4.284s)
[459.242463] [062/134] (618s left) gem_eio (wait-immediate)
[459.479653] Starting subtest: wait-immediate
[459.876188] Subtest wait-immediate: SUCCESS (0.396s)
[460.038806] [063/134] (617s left) gem_sync (basic-store-all)
[460.108239] Starting subtest: basic-store-all
[464.502284] Subtest basic-store-all: SUCCESS (4.401s)
[464.711373] [064/134] (612s left) gem_exec_gttfill (all-engines)
[464.786358] Starting subtest: all-engines
[488.567184] Subtest all-engines: SUCCESS (23.778s)
[488.761150] [065/134] (588s left) kms_cdclk (plane-scaling)
[488.918661] Starting subtest: plane-scaling
[488.920956] Starting dynamic subtest: pipe-A-eDP-1
[489.217818] Dynamic subtest pipe-A-eDP-1: SKIP (0.297s)
[489.227835] Starting dynamic subtest: pipe-B-eDP-1
[489.232448] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[489.241457] Starting dynamic subtest: pipe-C-eDP-1
[489.246117] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[489.255126] Starting dynamic subtest: pipe-D-eDP-1
[489.259677] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[489.264190] Subtest plane-scaling: SKIP (0.305s)
[490.070752] [066/134] (587s left) kms_flip (nonblocking-read)
[490.188313] Starting subtest: nonblocking-read
[490.190802] Subtest nonblocking-read: SUCCESS (0.000s)
[490.327360] [067/134] (587s left) kms_dsc (dsc-with-output-formats)
[490.438963] Starting subtest: dsc-with-output-formats
[490.460371] Subtest dsc-with-output-formats: SKIP (0.000s)
[490.523262] [068/134] (586s left) gem_mmap_gtt (big-bo-tiledy)
[490.585702] Subtest big-bo-tiledY: SKIP (0.000s)
[490.649209] [069/134] (586s left) gem_exec_alignment (pi)
[490.721567] Starting subtest: pi
[540.647351] Subtest pi: SUCCESS (49.925s)
[541.681880] [070/134] (535s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[541.840923] Starting subtest: 4-tiled-8bpp-rotate-270
[541.860851] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.019s)
[542.010807] [071/134] (535s left) api_intel_allocator (reopen)
[542.059283] Starting subtest: reopen
[542.061588] Subtest reopen: SUCCESS (0.003s)
[542.189178] [072/134] (535s left) kms_psr (psr-primary-render)
[542.278641] Starting subtest: psr-primary-render
[542.280877] Starting dynamic subtest: eDP-1
[544.045995] Dynamic subtest eDP-1: SUCCESS (1.766s)
[544.048296] Subtest psr-primary-render: SUCCESS (1.767s)
[544.941123] [073/134] (532s left) gem_pxp (create-regular-context-1)
[545.070274] Starting subtest: create-regular-context-1
[545.072717] Subtest create-regular-context-1: SUCCESS (0.002s)
[545.217985] [074/134] (532s left) kms_big_fb (linear-8bpp-rotate-90)
[545.332198] Starting subtest: linear-8bpp-rotate-90
[545.352803] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[545.500270] [075/134] (532s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[545.607868] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[545.610153] Starting dynamic subtest: pipe-A-eDP-1
[578.422125] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.937s)
[578.431566] Starting dynamic subtest: pipe-B-eDP-1
[611.351668] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.708s)
[611.361421] Starting dynamic subtest: pipe-C-eDP-1
[644.355180] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.719s)
[644.365943] Starting dynamic subtest: pipe-D-eDP-1
[677.333280] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.715s)
[677.335617] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.085s)
[678.553173] [076/134] (399s left) kms_psr (fbc-pr-primary-blt)
[678.647443] Starting subtest: fbc-pr-primary-blt
[678.651582] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[678.732031] [077/134] (399s left) gem_ccs (suspend-resume)
[678.791998] Starting subtest: suspend-resume
[678.796307] Subtest suspend-resume: SKIP (0.000s)
[678.915300] [078/134] (398s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[679.015802] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[679.019897] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[679.147742] [079/134] (398s left) kms_vrr (seamless-rr-switch-vrr)
[679.241018] Starting subtest: seamless-rr-switch-vrr
[679.247372] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[679.329134] [080/134] (398s left) kms_addfb_basic (bad-pitch-65536)
[679.383620] Starting subtest: bad-pitch-65536
[679.385904] Subtest bad-pitch-65536: SUCCESS (0.000s)
[679.537261] [081/134] (398s left) gem_exec_schedule (noreorder)
[679.728447] Starting subtest: noreorder
[679.730872] Starting dynamic subtest: rcs0
[679.816823] Dynamic subtest rcs0: SUCCESS (0.088s)
[679.828445] Starting dynamic subtest: vcs0
[681.184553] Dynamic subtest vcs0: SUCCESS (1.380s)
[681.200663] Starting dynamic subtest: vcs1
[683.097329] Dynamic subtest vcs1: SUCCESS (1.928s)
[683.111058] Starting dynamic subtest: vecs0
[685.152014] Dynamic subtest vecs0: SUCCESS (2.065s)
[685.164130] Starting dynamic subtest: ccs0
[685.238425] Dynamic subtest ccs0: SUCCESS (0.086s)
[685.241308] Subtest noreorder: SUCCESS (5.560s)
[685.433458] [082/134] (392s left) gem_ctx_param (invalid-get-engines)
[685.502294] Starting subtest: invalid-get-engines
[685.504598] Subtest invalid-get-engines: SUCCESS (0.001s)
[685.627171] [083/134] (392s left) gem_exec_whisper (basic-fds)
[685.698351] Starting subtest: basic-fds
[692.788889] Subtest basic-fds: SUCCESS (7.119s)
[692.981793] [084/134] (385s left) core_setmaster (master-drop-set-user)
[693.068539] Starting subtest: master-drop-set-user
[693.082736] Subtest master-drop-set-user: SUCCESS (0.013s)
[693.121320] [085/134] (385s left) gem_mmap_wc (set-cache-level)
[693.164946] Subtest set-cache-level: SKIP (0.000s)
[693.239701] [086/134] (385s left) kms_async_flips (alternate-sync-async-flip)
[693.345455] Starting subtest: alternate-sync-async-flip
[693.717913] Starting dynamic subtest: pipe-A-eDP-1
[696.529157] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.819s)
[696.909457] Starting dynamic subtest: pipe-B-eDP-1
[699.656927] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s)
[700.023278] Starting dynamic subtest: pipe-C-eDP-1
[702.776295] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[703.152507] Starting dynamic subtest: pipe-D-eDP-1
[705.898288] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.757s)
[705.900364] Subtest alternate-sync-async-flip: SUCCESS (12.575s)
[707.086599] [087/134] (371s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[707.191549] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[711.423862] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.238s)
[712.580377] [088/134] (365s left) api_intel_bb (reset-bb)
[712.644162] Starting subtest: reset-bb
[712.646512] Subtest reset-bb: SUCCESS (0.004s)
[712.793622] [089/134] (365s left) kms_vrr (flip-suspend)
[712.901542] Starting subtest: flip-suspend
[712.907677] Subtest flip-suspend: SKIP (0.000s)
[712.987172] [090/134] (365s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[717.929575] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[717.934043] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.003s)
[718.789004] [091/134] (359s left) kms_plane_multiple (tiling-yf)
[718.888594] Starting subtest: tiling-yf
[718.892613] Subtest tiling-yf: SKIP (0.000s)
[718.985821] [092/134] (359s left) gem_tiled_partial_pwrite_pread (reads)
[719.058748] Subtest reads: SKIP (0.000s)
[719.124086] [093/134] (359s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[719.222544] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[723.339887] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.122s)
[724.481582] [094/134] (354s left) gem_exec_schedule (timeslicing)
[724.550050] Starting subtest: timeslicing
[724.552461] Starting dynamic subtest: rcs0
[724.561277] Dynamic subtest rcs0: SUCCESS (0.022s)
[724.572901] Starting dynamic subtest: bcs0
[724.581932] Dynamic subtest bcs0: SUCCESS (0.020s)
[724.591335] Starting dynamic subtest: vcs0
[724.602906] Dynamic subtest vcs0: SUCCESS (0.020s)
[724.612169] Starting dynamic subtest: vcs1
[724.622686] Dynamic subtest vcs1: SUCCESS (0.019s)
[724.632041] Starting dynamic subtest: vecs0
[724.643876] Dynamic subtest vecs0: SUCCESS (0.021s)
[724.653324] Starting dynamic subtest: ccs0
[724.666632] Dynamic subtest ccs0: SUCCESS (0.022s)
[724.668876] Subtest timeslicing: SUCCESS (0.128s)
[726.204801] [095/134] (352s left) gem_tiled_blits (interruptible)
[726.278019] Subtest interruptible: SKIP (0.000s)
[726.375310] [096/134] (352s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[726.480988] Starting subtest: y-tiled-64bpp-rotate-270
[726.485302] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[726.586807] [097/134] (352s left) i915_query (hwconfig_table)
[726.636934] Starting subtest: hwconfig_table
[726.930299] Subtest hwconfig_table: SUCCESS (0.001s)
[726.968403] [098/134] (351s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[727.083622] Starting subtest: basic-flip-after-cursor-legacy
[727.998210] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.914s)
[728.803452] [099/134] (349s left) sw_sync (sync_busy_fork)
[728.842432] Starting subtest: sync_busy_fork
[729.851617] Subtest sync_busy_fork: SUCCESS (1.011s)
[729.927186] [100/134] (348s left) kms_content_protection (atomic-dpms)
[730.088519] Starting subtest: atomic-dpms
[730.092839] Subtest atomic-dpms: SKIP (0.000s)
[730.262073] [101/134] (348s left) perf (stress-open-close)
[730.421046] Starting subtest: stress-open-close
[730.423255] Starting dynamic subtest: 0-rcs0
[732.586150] Dynamic subtest 0-rcs0: SUCCESS (2.168s)
[732.595600] Starting dynamic subtest: 1-vcs0
[734.745931] Dynamic subtest 1-vcs0: SUCCESS (2.160s)
[734.747791] Subtest stress-open-close: SUCCESS (4.329s)
[734.797409] [102/134] (344s left) gem_mmap_gtt (zero-extend)
[734.865456] Subtest zero-extend: SKIP (0.000s)
[734.943344] [103/134] (344s left) sw_sync (sync_multi_timeline_wait)
[734.982549] Starting subtest: sync_multi_timeline_wait
[734.984474] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[735.058672] [104/134] (343s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[735.114627] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[735.118460] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[735.320741] [105/134] (343s left) gem_tiled_fence_blits (normal)
[735.385019] Subtest normal: SKIP (0.000s)
[735.470980] [106/134] (343s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[735.531156] Starting subtest: wait-all-for-submit-delayed-submit
[735.634785] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[735.737462] [107/134] (343s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[735.842919] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[735.847323] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[735.970895] [108/134] (343s left) gen3_render_tiledx_blits
[736.110054] [109/134] (343s left) syncobj_timeline (multi-wait-signaled)
[736.166056] Starting subtest: multi-wait-signaled
[736.168367] Subtest multi-wait-signaled: SUCCESS (0.000s)
[736.298189] [110/134] (342s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[736.469270] Starting subtest: cursor-rapid-movement-32x10
[736.534967] Subtest cursor-rapid-movement-32x10: SKIP (0.060s)
[736.821485] [111/134] (342s left) gem_ctx_persistence (legacy-engines-mixed-process)
[736.891582] Starting subtest: legacy-engines-mixed-process
[736.893127] Starting dynamic subtest: render
[738.124145] Dynamic subtest render: SUCCESS (1.234s)
[738.135299] Starting dynamic subtest: bsd1
[740.117294] Dynamic subtest bsd1: SUCCESS (1.992s)
[740.129495] Starting dynamic subtest: bsd2
[742.109299] Dynamic subtest bsd2: SUCCESS (1.990s)
[742.121650] Starting dynamic subtest: blt
[744.142242] Dynamic subtest blt: SUCCESS (2.032s)
[744.154087] Starting dynamic subtest: vebox
[746.139040] Dynamic subtest vebox: SUCCESS (1.997s)
[746.141475] Subtest legacy-engines-mixed-process: SUCCESS (9.255s)
[746.246426] [112/134] (333s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[746.312520] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[746.382386] [113/134] (332s left) kms_pm_rpm (package-g7)
[748.310383] Starting subtest: package-g7
[748.315673] Subtest package-g7: SKIP (0.000s)
[748.701377] [114/134] (330s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[748.807035] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[748.811334] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[748.946753] [115/134] (330s left) kms_flip (2x-flip-vs-modeset)
[749.043226] Starting subtest: 2x-flip-vs-modeset
[749.053072] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[749.184509] [116/134] (330s left) gem_exec_flush (basic-uc-rw-default)
[749.249300] Starting subtest: basic-uc-rw-default
[754.697104] Subtest basic-uc-rw-default: SUCCESS (5.451s)
[754.906881] [117/134] (324s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[755.009760] Starting subtest: fbcpsr-2p-rte
[755.013981] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[755.145202] [118/134] (324s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[755.209715] Starting subtest: map-fixed-invalidate-overlap
[755.214225] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[755.357567] [119/134] (324s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[755.449968] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[755.452127] Starting dynamic subtest: pipe-A
[755.572135] Dynamic subtest pipe-A: SKIP (0.118s)
[755.582066] Starting dynamic subtest: pipe-B
[756.733623] Dynamic subtest pipe-B: SKIP (1.161s)
[756.745788] Starting dynamic subtest: pipe-C
[757.875386] Dynamic subtest pipe-C: SUCCESS (1.147s)
[757.886143] Starting dynamic subtest: pipe-D
[759.097143] Dynamic subtest pipe-D: SUCCESS (1.222s)
[759.099521] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.651s)
[760.315336] [120/134] (319s left) kms_cursor_edge_walk (128x128-left-edge)
[760.415586] Starting subtest: 128x128-left-edge
[760.417841] Starting dynamic subtest: pipe-A-eDP-1
[763.861867] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.447s)
[763.872163] Starting dynamic subtest: pipe-D-eDP-1
[766.983349] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[766.985602] Subtest 128x128-left-edge: SUCCESS (6.572s)
[767.793373] [121/134] (311s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[767.900198] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[767.904671] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[768.038954] [122/134] (311s left) gem_exec_balancer (parallel-balancer)
[768.296447] Starting subtest: parallel-balancer
[769.171308] Subtest parallel-balancer: SUCCESS (0.876s)
[769.293235] [123/134] (310s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[769.389110] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[777.138843] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.742s)
[777.254101] [124/134] (302s left) kms_chamelium_edid (dp-mode-timings)
[777.651038] Subtest dp-mode-timings: SKIP (0.000s)
[778.469758] [125/134] (301s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[780.300790] Starting subtest: gem-execbuf-stress-pc8
[780.342786] Subtest gem-execbuf-stress-pc8: SKIP (0.041s)
[780.738504] [126/134] (299s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[780.849854] Starting subtest: psr-dirtyfb-ioctl
[780.852281] Starting dynamic subtest: A-eDP-1
[784.835484] Dynamic subtest A-eDP-1: SUCCESS (3.978s)
[784.837620] Subtest psr-dirtyfb-ioctl: SUCCESS (3.979s)
[785.781824] [127/134] (294s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[785.876502] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[785.880607] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[785.981244] [128/134] (294s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[786.078356] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[786.105459] Starting dynamic subtest: pipe-A-plane-0
[786.539253] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[786.551886] Starting dynamic subtest: pipe-A-plane-3
[786.794322] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[786.803955] Starting dynamic subtest: pipe-A-plane-5
[786.807804] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[787.901550] Starting dynamic subtest: pipe-B-plane-0
[788.327094] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[788.337422] Starting dynamic subtest: pipe-B-plane-3
[788.582536] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[788.592662] Starting dynamic subtest: pipe-B-plane-5
[788.597015] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[788.892546] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.810s)
[789.783566] [129/134] (290s left) gem_bad_reloc (negative-reloc-bltcopy)
[789.845930] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[789.930946] [130/134] (290s left) gem_exec_fence (submit)
[790.100569] Starting subtest: submit
[790.105109] Subtest submit: SKIP (0.000s)
[792.259098] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[792.262932] [131/134] (287s left) perf_pmu (frequency)
[792.309128] Starting subtest: frequency
[792.315042] Starting dynamic subtest: gt0
[794.455469] Dynamic subtest gt0: SUCCESS (2.135s)
[794.467601] Starting dynamic subtest: idle-gt0
[794.997949] Dynamic subtest idle-gt0: SUCCESS (0.542s)
[795.011357] Starting dynamic subtest: gt1
[799.199463] Dynamic subtest gt1: SUCCESS (4.194s)
[799.209859] Starting dynamic subtest: idle-gt1
[799.704597] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[799.707289] Subtest frequency: SUCCESS (7.393s)
[799.834720] [132/134] (280s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[799.936147] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[807.391080] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.455s)
[807.584481] [133/134] (272s left) perf_pmu (enable-race)
[807.623353] Starting subtest: enable-race
[807.625644] Starting dynamic subtest: rcs0
[820.411616] Dynamic subtest rcs0: SUCCESS (12.787s)
[820.421806] Starting dynamic subtest: bcs0
[833.153242] Dynamic subtest bcs0: SUCCESS (12.741s)
[833.163830] Starting dynamic subtest: vcs0
[849.162839] Dynamic subtest vcs0: SUCCESS (16.001s)
[849.175462] Starting dynamic subtest: vcs1
[865.104628] Dynamic subtest vcs1: SUCCESS (15.931s)
[865.117670] Starting dynamic subtest: vecs0
[881.162342] Dynamic subtest vecs0: SUCCESS (16.059s)
[881.173619] Starting dynamic subtest: ccs0
[893.937409] Dynamic subtest ccs0: SUCCESS (12.773s)
[893.939811] Subtest enable-race: SUCCESS (86.304s)
[894.071497] [134/134] (186s left) gem_caching (read-writes)
[894.146061] Subtest read-writes: SKIP (0.000s)
[894.222777] Closing watchdogs
results: parsing output: 0/ for test: kms_getfb
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_chamelium_hpd
results: parsing output: 5/ for test: kms_async_flips
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: gem_lmem_swapping
results: parsing output: 8/ for test: gem_basic
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_vblank
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: i915_drm_fdinfo
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: kms_plane_cursor
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_softpin
results: parsing output: 22/ for test: sysfs_heartbeat_interval
results: parsing output: 23/ for test: gem_mmap_wc
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: kms_invalid_mode
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_getfb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: syncobj_basic
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_partial_pwrite_pread
results: parsing output: 35/ for test: i915_drm_fdinfo
results: parsing output: 36/ for test: gen9_exec_parse
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: gen7_exec_parse
results: parsing output: 39/ for test: gem_bad_reloc
results: parsing output: 40/ for test: kms_pipe_crc_basic
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_rotation_crc
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: sw_sync
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: gem_readwrite
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: kms_color
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_eio
results: parsing output: 62/ for test: gem_sync
results: parsing output: 63/ for test: gem_exec_gttfill
results: parsing output: 64/ for test: kms_cdclk
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_dsc
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: gem_exec_alignment
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: api_intel_allocator
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_pxp
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_ccs
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_vrr
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: gem_ctx_param
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: core_setmaster
results: parsing output: 84/ for test: gem_mmap_wc
results: parsing output: 85/ for test: kms_async_flips
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: api_intel_bb
results: parsing output: 88/ for test: kms_vrr
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_plane_multiple
results: parsing output: 91/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: gem_tiled_blits
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: i915_query
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: sw_sync
results: parsing output: 99/ for test: kms_content_protection
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: sw_sync
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: gem_tiled_fence_blits
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gen3_render_tiledx_blits
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_exec_flush
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: kms_cursor_edge_walk
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_exec_balancer
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_chamelium_edid
results: parsing output: 124/ for test: i915_pm_rpm
results: parsing output: 125/ for test: kms_dirtyfb
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: gem_bad_reloc
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: perf_pmu
results: parsing output: 133/ for test: gem_caching
Done.