[57.707620] Initializing watchdogs
[57.707666]   /dev/watchdog0
[57.721763] [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.726953] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.729254] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.732570] [001/133] (960s left) perf_pmu (rc6-all-gts)
[57.797507] Starting subtest: rc6-all-gts
[64.223111] Subtest rc6-all-gts: SUCCESS (6.469s)
[65.064933] [002/133] (953s left) gem_exec_reloc (basic-write-cpu-noreloc)
[65.127032] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[65.195495] [003/133] (953s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[65.295039] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[69.617398] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.353s)
[70.757560] [004/133] (947s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[70.865109] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[70.867630] Starting dynamic subtest: pipe-A
[71.911098] Dynamic subtest pipe-A: SUCCESS (1.052s)
[71.918682] Starting dynamic subtest: pipe-B
[74.016439] Dynamic subtest pipe-B: SUCCESS (2.111s)
[74.024679] Starting dynamic subtest: pipe-C
[75.207265] Dynamic subtest pipe-C: SUCCESS (1.193s)
[75.215220] Starting dynamic subtest: pipe-D
[76.434636] Dynamic subtest pipe-D: SUCCESS (1.229s)
[76.437370] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.587s)
[77.642535] [005/133] (940s left) gem_exec_fence (submit3)
[77.831085] Starting subtest: submit3
[77.836641] Subtest submit3: SKIP (0.000s)
[79.371726] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[79.374901] [006/133] (939s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[79.470796] Starting subtest: multiplane-rotation-cropping-bottom
[96.865126] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.393s)
[96.979374] [007/133] (921s left) gem_ctx_param (root-set)
[97.042482] Starting subtest: root-set
[97.044522] Subtest root-set: SUCCESS (0.001s)
[97.133535] [008/133] (921s left) gem_create (create-valid-nonaligned)
[97.182779] Starting subtest: create-valid-nonaligned
[97.184378] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[97.382100] [009/133] (921s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[97.483180] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[97.487200] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[97.593631] [010/133] (921s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[97.651068] Starting subtest: etime-single-wait-all-available-unsubmitted
[97.752842] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s)
[97.841400] [011/133] (920s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[97.960938] Starting subtest: verify-pxp-key-change-after-suspend-resume
[105.265719] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.306s)
[105.371609] [012/133] (913s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[105.492199] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[106.171639] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s)
[106.335382] [013/133] (912s left) gem_eio (create-ext)
[106.560488] Starting subtest: create-ext
[106.884711] Subtest create-ext: SUCCESS (0.323s)
[107.032416] [014/133] (911s left) kms_rotation_crc (sprite-rotation-270)
[107.128070] Starting subtest: sprite-rotation-270
[107.131801] Subtest sprite-rotation-270: SKIP (0.002s)
[107.204872] [015/133] (911s left) kms_prime (d3hot)
[107.284534] Subtest D3hot: SKIP (0.000s)
[107.391858] [016/133] (911s left) kms_color (ctm-negative)
[107.481706] Starting subtest: ctm-negative
[107.483382] Starting dynamic subtest: pipe-A-eDP-1
[108.196229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[108.206276] Starting dynamic subtest: pipe-B-eDP-1
[109.655489] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.460s)
[109.665755] Starting dynamic subtest: pipe-C-eDP-1
[111.033737] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[111.044230] Starting dynamic subtest: pipe-D-eDP-1
[112.366929] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[112.368971] Subtest ctm-negative: SUCCESS (4.884s)
[113.184989] [017/133] (905s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[113.309022] Starting subtest: cursorA-vs-flipB-atomic
[113.313736] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[113.449964] [018/133] (905s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[113.510250] Starting subtest: y-tiled-ccs-to-y-tiled
[113.515087] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[113.709437] [019/133] (905s left) kms_big_fb (linear-64bpp-rotate-0)
[113.806406] Starting subtest: linear-64bpp-rotate-0
[115.407620] Subtest linear-64bpp-rotate-0: SUCCESS (1.601s)
[115.564550] [020/133] (903s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[117.504676] Starting subtest: dpms-mode-unset-non-lpsp
[118.668273] Subtest dpms-mode-unset-non-lpsp: SKIP (1.162s)
[119.053143] [021/133] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[119.154606] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[125.714030] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.563s)
[125.862578] [022/133] (893s left) gem_exercise_blt (fast-copy)
[125.930061] Starting subtest: fast-copy
[125.932392] Starting dynamic subtest: linear-smem-smem
[125.953298] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[125.965680] Starting dynamic subtest: xmajor-smem-smem
[125.971867] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[125.981563] Starting dynamic subtest: tile4-smem-smem
[126.002127] Dynamic subtest tile4-smem-smem: SUCCESS (0.030s)
[126.013956] Starting dynamic subtest: tile64-smem-smem
[126.031660] Dynamic subtest tile64-smem-smem: SUCCESS (0.027s)
[126.034141] Subtest fast-copy: SUCCESS (0.102s)
[126.148781] [023/133] (893s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[126.251547] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[126.255632] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[126.360381] [024/133] (892s left) gem_softpin (evict-active)
[126.415826] Starting subtest: evict-active
[126.421511] Subtest evict-active: SUCCESS (0.006s)
[126.531418] [025/133] (892s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[126.618815] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[133.540352] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.922s)
[133.691141] [026/133] (885s left) kms_vblank (invalid)
[133.790079] Starting subtest: invalid
[133.791886] Starting dynamic subtest: pipe-A-eDP-1
[134.190446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[134.192696] Subtest invalid: SUCCESS (0.402s)
[135.042117] [027/133] (884s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[135.156147] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[136.279891] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.124s)
[136.393485] [028/133] (883s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[136.493967] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[136.497719] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[136.575627] [029/133] (882s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[136.685741] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[136.687609] Starting dynamic subtest: pipe-A-eDP-1
[147.371821] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.690s)
[147.382313] Starting dynamic subtest: pipe-B-eDP-1
[158.760765] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.385s)
[158.762701] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.078s)
[159.605310] [030/133] (859s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[159.699063] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[159.703434] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[159.773748] [031/133] (859s left) kms_psr (pr-sprite-mmap-cpu)
[159.862490] Starting subtest: pr-sprite-mmap-cpu
[159.866905] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[159.939611] [032/133] (859s left) syncobj_timeline (multi-wait-all-available-signaled)
[159.990377] Starting subtest: multi-wait-all-available-signaled
[159.992332] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[160.085895] [033/133] (859s left) kms_content_protection (legacy-hdcp14)
[160.225310] Starting subtest: legacy-hdcp14
[160.229443] Subtest legacy-hdcp14: SKIP (0.000s)
[160.373981] [034/133] (859s left) kms_psr (psr2-sprite-plane-move)
[160.464221] Starting subtest: psr2-sprite-plane-move
[160.466483] Starting dynamic subtest: eDP-1
[162.222821] Dynamic subtest eDP-1: SUCCESS (1.758s)
[162.225113] Subtest psr2-sprite-plane-move: SUCCESS (1.759s)
[163.066090] [035/133] (856s left) api_intel_bb (intel-bb-blit-y)
[163.131424] Starting subtest: intel-bb-blit-y
[166.610377] Subtest intel-bb-blit-y: SUCCESS (3.479s)
[166.740220] [036/133] (852s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[166.836588] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[166.841101] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[166.943503] [037/133] (852s left) kms_cursor_crc (cursor-size-change)
[167.030501] Starting subtest: cursor-size-change
[167.032749] Starting dynamic subtest: pipe-A-eDP-1
[167.802104] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.772s)
[167.811737] Starting dynamic subtest: pipe-D-eDP-1
[169.210558] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.408s)
[169.212706] Subtest cursor-size-change: SUCCESS (2.183s)
[170.028841] [038/133] (849s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[170.129508] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[170.134250] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[170.216114] [039/133] (849s left) kms_flip (nonblocking-read)
[170.308391] Starting subtest: nonblocking-read
[170.310438] Subtest nonblocking-read: SUCCESS (0.000s)
[170.424703] [040/133] (849s left) sriov_basic (enable-vfs-bind-unbind-each)
[170.489923] Starting subtest: enable-vfs-bind-unbind-each
[170.492446] Starting dynamic subtest: numvfs-1
[170.567681] Dynamic subtest numvfs-1: FAIL (0.017s)
[170.578925] Starting dynamic subtest: numvfs-2
[170.652324] Dynamic subtest numvfs-2: FAIL (0.004s)
[170.663991] Starting dynamic subtest: numvfs-3
[170.736744] Dynamic subtest numvfs-3: FAIL (0.004s)
[170.747374] Starting dynamic subtest: numvfs-4
[170.820240] Dynamic subtest numvfs-4: FAIL (0.004s)
[170.831249] Starting dynamic subtest: numvfs-5
[170.905033] Dynamic subtest numvfs-5: FAIL (0.004s)
[170.915942] Starting dynamic subtest: numvfs-6
[170.986093] Dynamic subtest numvfs-6: FAIL (0.005s)
[170.998220] Starting dynamic subtest: numvfs-7
[171.058313] Dynamic subtest numvfs-7: FAIL (0.004s)
[171.068329] Starting dynamic subtest: numvfs-random
[171.127633] Dynamic subtest numvfs-random: FAIL (0.004s)
[171.129588] Subtest enable-vfs-bind-unbind-each: FAIL (0.051s)
[171.173580] [041/133] (848s left) kms_lease (lease-unleased-crtc)
[171.270392] Starting subtest: lease-unleased-crtc
[171.272400] Starting dynamic subtest: pipe-A-eDP-1
[171.566347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[171.576288] Starting dynamic subtest: pipe-B-eDP-1
[172.290347] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.723s)
[172.300880] Starting dynamic subtest: pipe-C-eDP-1
[172.303194] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[172.312826] Starting dynamic subtest: pipe-D-eDP-1
[172.314694] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[172.316617] Subtest lease-unleased-crtc: SUCCESS (1.031s)
[172.665042] [042/133] (847s left) gem_exec_capture (capture-recoverable)
[172.726159] Starting subtest: capture-recoverable
[172.728511] Subtest capture-recoverable: SUCCESS (0.003s)
[172.861979] [043/133] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[172.960675] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[172.965185] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[173.052148] [044/133] (847s left) gem_exec_flush (basic-wb-prw-default)
[173.107713] Starting subtest: basic-wb-prw-default
[178.592571] Subtest basic-wb-prw-default: SUCCESS (5.462s)
[178.771470] [045/133] (841s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[178.893386] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[178.898053] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[179.034562] [046/133] (841s left) i915_getparams_basic (basic-subslice-total)
[179.090982] Starting subtest: basic-subslice-total
[179.095064] Subtest basic-subslice-total: SUCCESS (0.000s)
[179.205185] [047/133] (840s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[179.252563] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[179.256831] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[179.436415] [048/133] (840s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[179.548550] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[188.998690] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.449s)
[189.797682] [049/133] (830s left) kms_psr (fbc-psr2-suspend)
[189.883675] Starting subtest: fbc-psr2-suspend
[189.885977] Starting dynamic subtest: eDP-1
[189.890039] Dynamic subtest eDP-1: SKIP (0.000s)
[189.894281] Subtest fbc-psr2-suspend: SKIP (0.001s)
[189.960809] [050/133] (830s left) gem_mmap_offset (close-race)
[190.009457] Starting subtest: close-race
[210.176390] Subtest close-race: SUCCESS (20.113s)
[210.246315] [051/133] (810s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[210.378810] Starting subtest: x-tiled-16bpp-rotate-270
[210.410371] Subtest x-tiled-16bpp-rotate-270: SKIP (0.029s)
[210.564515] [052/133] (809s left) gem_exec_balancer (parallel)
[210.821211] Starting subtest: parallel
[211.784496] Subtest parallel: SUCCESS (0.964s)
[212.329202] [053/133] (808s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[212.429890] Starting subtest: 2x-absolute-wf_vblank-interruptible
[212.444438] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.012s)
[212.538907] [054/133] (807s left) kms_flip (2x-nonexisting-fb)
[212.635128] Starting subtest: 2x-nonexisting-fb
[212.648357] Subtest 2x-nonexisting-fb: SKIP (0.012s)
[212.757446] [055/133] (807s left) gem_ccs (suspend-resume)
[212.825282] Starting subtest: suspend-resume
[212.829122] Subtest suspend-resume: SKIP (0.000s)
[212.929398] [056/133] (807s left) kms_getfb (getfb2-into-addfb2)
[213.027981] Starting subtest: getfb2-into-addfb2
[213.030369] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[213.131182] [057/133] (807s left) gen9_exec_parse (bb-start-out)
[213.199458] Subtest bb-start-out: SKIP (0.000s)
[213.278887] [058/133] (807s left) fbdev (read)
[213.316201] Starting subtest: read
[213.847398] Subtest read: SUCCESS (0.529s)
[213.912540] [059/133] (806s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[214.016403] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[214.020665] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[214.092786] [060/133] (806s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[214.217870] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[214.222455] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[214.367149] [061/133] (806s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[214.431677] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[214.495916] [062/133] (806s left) kms_cursor_edge_walk (256x256-top-edge)
[214.604755] Starting subtest: 256x256-top-edge
[214.607342] Starting dynamic subtest: pipe-A-eDP-1
[218.077207] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s)
[218.090535] Starting dynamic subtest: pipe-D-eDP-1
[221.197820] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[221.200234] Subtest 256x256-top-edge: SUCCESS (6.594s)
[222.005492] [063/133] (798s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[222.101855] Starting subtest: plane-downscale-factor-0-5-with-rotation
[222.104053] Starting dynamic subtest: pipe-A
[222.122685] Dynamic subtest pipe-A: SKIP (0.016s)
[222.133205] Starting dynamic subtest: pipe-B
[222.150294] Dynamic subtest pipe-B: SKIP (0.030s)
[222.160316] Starting dynamic subtest: pipe-C
[222.182041] Dynamic subtest pipe-C: SKIP (0.030s)
[222.192104] Starting dynamic subtest: pipe-D
[222.211823] Dynamic subtest pipe-D: SKIP (0.030s)
[222.215671] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.109s)
[222.335060] [064/133] (798s left) kms_psr (fbc-psr2-no-drrs)
[222.425926] Starting subtest: fbc-psr2-no-drrs
[222.428089] Starting dynamic subtest: eDP-1
[222.432040] Dynamic subtest eDP-1: SKIP (0.000s)
[222.436078] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[222.498622] [065/133] (798s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[222.560093] Starting subtest: stress-mm-invalidate-close-overlap
[224.707516] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[224.841715] [066/133] (796s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[224.943325] Starting subtest: psr-rgb101010-draw-render
[232.198134] Subtest psr-rgb101010-draw-render: SUCCESS (7.259s)
[232.310827] [067/133] (788s left) gem_exec_reloc (basic-write-wc)
[232.368058] Subtest basic-write-wc: SKIP (0.000s)
[232.437494] [068/133] (788s left) kms_vblank (ts-continuation-modeset-rpm)
[232.520966] Starting subtest: ts-continuation-modeset-rpm
[232.522806] Starting dynamic subtest: pipe-A-eDP-1
[235.018784] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[235.038185] Starting dynamic subtest: pipe-D-eDP-1
[237.270199] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.247s)
[237.272621] Subtest ts-continuation-modeset-rpm: SUCCESS (4.750s)
[238.163845] [069/133] (782s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[238.262952] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[238.267105] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[238.371248] [070/133] (782s left) gem_exec_params (cliprects-invalid)
[238.429600] Starting subtest: cliprects-invalid
[238.431979] Subtest cliprects-invalid: SUCCESS (0.000s)
[238.529556] [071/133] (782s left) sw_sync (timeline_closed)
[238.558904] Starting subtest: timeline_closed
[238.561294] Subtest timeline_closed: SUCCESS (0.000s)
[238.618181] [072/133] (782s left) kms_addfb_basic (clobberred-modifier)
[238.676329] Starting subtest: clobberred-modifier
[238.680585] Subtest clobberred-modifier: SKIP (0.000s)
[238.820512] [073/133] (782s left) gem_exec_reloc (basic-wc-gtt-active)
[238.873916] Subtest basic-wc-gtt-active: SKIP (0.000s)
[238.951674] [074/133] (782s left) gem_spin_batch (resubmit)
[239.022042] Starting subtest: resubmit
[239.024079] Starting dynamic subtest: rcs0
[239.029080] Dynamic subtest rcs0: SUCCESS (0.007s)
[239.040574] Starting dynamic subtest: bcs0
[239.042452] Dynamic subtest bcs0: SUCCESS (0.002s)
[239.052312] Starting dynamic subtest: vcs0
[239.053939] Dynamic subtest vcs0: SUCCESS (0.002s)
[239.063215] Starting dynamic subtest: vcs1
[239.064799] Dynamic subtest vcs1: SUCCESS (0.003s)
[239.074708] Starting dynamic subtest: vecs0
[239.076310] Dynamic subtest vecs0: SUCCESS (0.003s)
[239.085402] Starting dynamic subtest: ccs0
[239.087032] Dynamic subtest ccs0: SUCCESS (0.003s)
[239.088709] Subtest resubmit: SUCCESS (0.024s)
[239.280117] [075/133] (782s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[239.379625] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[239.383188] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[239.464804] [076/133] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[239.562658] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[239.565948] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[239.679379] [077/133] (781s left) gem_busy (close-race)
[239.747592] Starting subtest: close-race
[265.278467] Subtest close-race: SUCCESS (25.527s)
[265.644976] [078/133] (755s left) gem_ctx_isolation (dirty-switch)
[265.763527] Starting subtest: dirty-switch
[265.766061] Starting dynamic subtest: rcs0
[266.011090] Dynamic subtest rcs0: SUCCESS (0.247s)
[266.024821] Starting dynamic subtest: bcs0
[266.320258] Dynamic subtest bcs0: SUCCESS (0.308s)
[266.333276] Starting dynamic subtest: vcs0
[266.566112] Dynamic subtest vcs0: SUCCESS (0.245s)
[266.576232] Starting dynamic subtest: vcs1
[268.491549] Dynamic subtest vcs1: SUCCESS (1.924s)
[268.506484] Starting dynamic subtest: vecs0
[270.472081] Dynamic subtest vecs0: SUCCESS (1.979s)
[270.482958] Starting dynamic subtest: ccs0
[272.533051] Dynamic subtest ccs0: SUCCESS (2.060s)
[272.535425] Subtest dirty-switch: SUCCESS (6.769s)
[272.758455] [079/133] (748s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[272.872937] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[272.877267] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[272.977809] [080/133] (748s left) syncobj_wait (invalid-signal-zero-handles)
[273.047617] Starting subtest: invalid-signal-zero-handles
[273.050063] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[273.122881] [081/133] (748s left) gem_exec_schedule (fairslice-all)
[273.205985] Starting subtest: fairslice-all
[275.259673] Subtest fairslice-all: SUCCESS (2.059s)
[276.364881] [082/133] (745s left) kms_psr (fbc-pr-basic)
[276.456053] Starting subtest: fbc-pr-basic
[276.460266] Subtest fbc-pr-basic: SKIP (0.000s)
[276.534710] [083/133] (745s left) gem_mmap_gtt (basic-read)
[276.595454] Subtest basic-read: SKIP (0.000s)
[276.654512] [084/133] (745s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[276.757096] Starting subtest: y-tiled-8bpp-rotate-0
[276.761582] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[276.856474] [085/133] (745s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[277.242745] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[278.073429] [086/133] (743s left) i915_pm_rps (basic-api)
[278.133297] Starting subtest: basic-api
[278.137835] Subtest basic-api: SKIP (0.000s)
[278.246569] [087/133] (743s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[278.345154] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[278.356996] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[278.465692] [088/133] (743s left) drm_mm (drm_mm)
[278.507612] Starting subtest: drm_mm
[278.566766] Starting dynamic subtest: drm_test_mm_init
[278.663447] Dynamic subtest drm_test_mm_init: SUCCESS (0.095s)
[278.673955] Starting dynamic subtest: drm_test_mm_debug
[278.753445] Dynamic subtest drm_test_mm_debug: SUCCESS (0.090s)
[278.763707] Starting dynamic subtest: drm_test_mm_align32
[278.850123] Dynamic subtest drm_test_mm_align32: SUCCESS (0.096s)
[278.860524] Starting dynamic subtest: drm_test_mm_align64
[278.937439] Dynamic subtest drm_test_mm_align64: SUCCESS (0.087s)
[278.947396] Starting dynamic subtest: drm_test_mm_lowest
[279.017983] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.080s)
[279.027881] Starting dynamic subtest: drm_test_mm_highest
[279.111740] Dynamic subtest drm_test_mm_highest: SUCCESS (0.092s)
[279.113551] Subtest drm_mm: SUCCESS (0.602s)
[279.268306] [089/133] (742s left) kms_chamelium_edid (dp-mode-timings)
[279.657099] Subtest dp-mode-timings: SKIP (0.000s)
[280.502114] [090/133] (741s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[280.613295] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[284.354346] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.744s)
[285.551810] [091/133] (736s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[285.648798] Starting subtest: fbcpsr-modesetfrombusy
[291.784193] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.139s)
[291.913531] [092/133] (730s left) kms_vrr (max-min)
[292.005250] Starting subtest: max-min
[292.010377] Subtest max-min: SKIP (0.000s)
[292.092642] [093/133] (730s left) gem_pxp (create-regular-context-2)
[292.191011] Starting subtest: create-regular-context-2
[292.192964] Subtest create-regular-context-2: SUCCESS (0.002s)
[292.298241] [094/133] (729s left) kms_cursor_crc (cursor-offscreen-64x64)
[292.488407] Starting subtest: cursor-offscreen-64x64
[292.497121] Starting dynamic subtest: pipe-A-eDP-1
[294.475639] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.980s)
[294.507459] Starting dynamic subtest: pipe-D-eDP-1
[297.065241] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.568s)
[297.067556] Subtest cursor-offscreen-64x64: SUCCESS (4.577s)
[297.921282] [095/133] (724s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[298.017067] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[298.021645] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[298.094247] [096/133] (724s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[298.196252] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[298.198510] Starting dynamic subtest: pipe-A-eDP-1
[298.257289] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[298.270521] Starting dynamic subtest: pipe-B-eDP-1
[298.328357] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[298.342101] Starting dynamic subtest: pipe-C-eDP-1
[298.399816] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[298.411649] Starting dynamic subtest: pipe-D-eDP-1
[298.468448] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[298.472622] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[300.467845] [097/133] (721s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[300.565510] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[300.569663] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[300.662168] [098/133] (721s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[300.758805] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[300.761142] Starting dynamic subtest: pipe-A-eDP-1
[300.782107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[300.797858] Starting dynamic subtest: pipe-B-eDP-1
[300.816187] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[300.826629] Starting dynamic subtest: pipe-C-eDP-1
[300.845341] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[300.855218] Starting dynamic subtest: pipe-D-eDP-1
[300.874361] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[300.876294] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[303.023498] [099/133] (719s left) gem_reg_read (timestamp-monotonic)
[303.080947] Starting subtest: timestamp-monotonic
[307.559096] Subtest timestamp-monotonic: SUCCESS (4.428s)
[307.602191] [100/133] (714s left) gem_ctx_persistence (legacy-engines-hang)
[307.661315] Starting subtest: legacy-engines-hang
[307.663556] Starting dynamic subtest: render
[307.732620] Dynamic subtest render: SUCCESS (0.071s)
[307.748563] Starting dynamic subtest: bsd1
[307.842654] Dynamic subtest bsd1: SUCCESS (0.107s)
[307.858450] Starting dynamic subtest: bsd2
[307.944764] Dynamic subtest bsd2: SUCCESS (0.099s)
[307.960479] Starting dynamic subtest: blt
[308.043913] Dynamic subtest blt: SUCCESS (0.096s)
[308.059560] Starting dynamic subtest: vebox
[308.143829] Dynamic subtest vebox: SUCCESS (0.096s)
[308.146474] Subtest legacy-engines-hang: SUCCESS (0.485s)
[308.227915] [101/133] (714s left) gem_exec_schedule (reorder-wide)
[308.416739] Subtest reorder-wide: SKIP (0.000s)
[308.602434] [102/133] (714s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[308.759373] Starting subtest: cursor-rapid-movement-32x10
[308.805636] Subtest cursor-rapid-movement-32x10: SKIP (0.041s)
[309.085997] [103/133] (713s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[309.171098] Starting subtest: random-ccs-data-y-tiled-ccs
[309.173295] Starting dynamic subtest: pipe-A-eDP-1
[309.198480] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[309.209292] Starting dynamic subtest: pipe-B-eDP-1
[309.232829] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[309.242840] Starting dynamic subtest: pipe-C-eDP-1
[309.266744] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[309.276997] Starting dynamic subtest: pipe-D-eDP-1
[309.301074] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[309.305423] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[311.479717] [104/133] (711s left) kms_prop_blob (invalid-get-prop-any)
[311.541661] Starting subtest: invalid-get-prop-any
[311.543642] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[311.630155] [105/133] (711s left) syncobj_timeline (wait-all-snapshot)
[311.677270] Starting subtest: wait-all-snapshot
[311.757337] Subtest wait-all-snapshot: SUCCESS (0.081s)
[311.841320] [106/133] (710s left) gem_pread (snoop)
[311.914843] Subtest snoop: SKIP (0.000s)
[311.988301] [107/133] (710s left) kms_pipe_crc_basic (hang-read-crc)
[312.090092] Starting subtest: hang-read-crc
[312.092358] Starting dynamic subtest: pipe-A-eDP-1
[314.154809] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.066s)
[314.166010] Starting dynamic subtest: pipe-B-eDP-1
[316.999918] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.842s)
[317.011589] Starting dynamic subtest: pipe-C-eDP-1
[319.631369] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.629s)
[319.643631] Starting dynamic subtest: pipe-D-eDP-1
[322.295788] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.664s)
[322.298196] Subtest hang-read-crc: SUCCESS (10.205s)
[323.120826] [108/133] (699s left) api_intel_allocator (alloc-simple)
[323.186063] Starting subtest: alloc-simple
[323.188219] Subtest alloc-simple: SUCCESS (0.003s)
[323.306411] [109/133] (699s left) perf (low-oa-exponent-permissions)
[323.460861] Starting subtest: low-oa-exponent-permissions
[323.498399] Subtest low-oa-exponent-permissions: SUCCESS (0.038s)
[323.553728] [110/133] (699s left) kms_atomic (atomic-plane-damage)
[323.648279] Starting subtest: atomic-plane-damage
[323.699456] Starting dynamic subtest: pipe-A-eDP-1
[324.249459] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[324.251672] Subtest atomic-plane-damage: SUCCESS (0.599s)
[325.045502] [111/133] (697s left) sysfs_heartbeat_interval (mixed)
[325.108644] Starting subtest: mixed
[325.111103] Starting dynamic subtest: vecs0
[330.350222] Dynamic subtest vecs0: SUCCESS (5.240s)
[330.362831] Starting dynamic subtest: ccs0
[335.565600] Dynamic subtest ccs0: SUCCESS (5.214s)
[335.578859] Starting dynamic subtest: vcs0
[340.790304] Dynamic subtest vcs0: SUCCESS (5.223s)
[340.804245] Starting dynamic subtest: bcs0
[345.975669] Dynamic subtest bcs0: SUCCESS (5.183s)
[345.989066] Starting dynamic subtest: rcs0
[351.187287] Dynamic subtest rcs0: SUCCESS (5.196s)
[351.200413] Starting dynamic subtest: vcs1
[356.472083] Dynamic subtest vcs1: SUCCESS (5.296s)
[356.474502] Subtest mixed: SUCCESS (31.363s)
[356.554699] [112/133] (666s left) gem_readwrite (beyond-eob)
[356.611133] Subtest beyond-EOB: SKIP (0.000s)
[356.670987] [113/133] (666s left) kms_joiner (invalid-modeset-big-joiner)
[356.773100] Starting subtest: invalid-modeset-big-joiner
[356.777287] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[356.844283] [114/133] (666s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[356.901597] Starting subtest: multi-wait-available-unsubmitted-signaled
[356.903889] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[357.034865] [115/133] (666s left) gem_exec_schedule (preempt-engines)
[357.108671] Starting subtest: preempt-engines
[357.111083] Starting dynamic subtest: rcs0
[359.356049] Dynamic subtest rcs0: SUCCESS (2.247s)
[359.369884] Starting dynamic subtest: bcs0
[361.703454] Dynamic subtest bcs0: SUCCESS (2.291s)
[361.717416] Starting dynamic subtest: vcs0
[364.046872] Dynamic subtest vcs0: SUCCESS (2.343s)
[364.059221] Starting dynamic subtest: vcs1
[366.271350] Dynamic subtest vcs1: SUCCESS (2.273s)
[366.288344] Starting dynamic subtest: vecs0
[368.593913] Dynamic subtest vecs0: SUCCESS (2.271s)
[368.607536] Starting dynamic subtest: ccs0
[370.913382] Dynamic subtest ccs0: SUCCESS (2.315s)
[370.916639] Subtest preempt-engines: SUCCESS (13.752s)
[371.184065] [116/133] (652s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[371.277849] Starting subtest: addfb25-y-tiled-legacy
[371.279947] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[371.359040] [117/133] (651s left) gem_softpin (noreloc-s3)
[371.424213] Starting subtest: noreloc-S3
[392.032733] Subtest noreloc-S3: SUCCESS (5.392s)
[392.172922] [118/133] (631s left) gem_userptr_blits (stress-purge)
[392.246895] Starting subtest: stress-purge
[397.502330] Subtest stress-purge: SUCCESS (5.369s)
[397.628280] [119/133] (625s left) kms_addfb_basic (invalid-get-prop)
[397.722706] Starting subtest: invalid-get-prop
[397.724412] Subtest invalid-get-prop: SUCCESS (0.000s)
[397.867742] [120/133] (625s left) kms_feature_discovery (display-3x)
[397.954845] Starting subtest: display-3x
[397.958459] Subtest display-3x: SKIP (0.000s)
[398.036673] [121/133] (625s left) gem_exec_parallel (basic)
[398.091792] Starting subtest: basic
[398.093844] Starting dynamic subtest: rcs0
[399.486329] Dynamic subtest rcs0: SUCCESS (1.411s)
[399.497965] Starting dynamic subtest: bcs0
[400.943487] Dynamic subtest bcs0: SUCCESS (1.470s)
[400.957496] Starting dynamic subtest: vcs0
[402.630590] Dynamic subtest vcs0: SUCCESS (1.698s)
[402.642509] Starting dynamic subtest: vcs1
[404.600937] Dynamic subtest vcs1: SUCCESS (1.982s)
[404.615044] Starting dynamic subtest: vecs0
[406.586202] Dynamic subtest vecs0: SUCCESS (1.993s)
[406.600215] Starting dynamic subtest: ccs0
[408.080329] Dynamic subtest ccs0: SUCCESS (1.499s)
[408.082734] Subtest basic: SUCCESS (10.068s)
[408.272433] [122/133] (615s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[408.370340] Starting subtest: crc-primary-suspend-y-tiled-ccs
[408.372612] Starting dynamic subtest: pipe-A-eDP-1
[408.381628] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[408.393761] Starting dynamic subtest: pipe-B-eDP-1
[408.404382] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[408.415174] Starting dynamic subtest: pipe-C-eDP-1
[408.423636] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[408.434141] Starting dynamic subtest: pipe-D-eDP-1
[408.442754] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[408.446969] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[410.622934] [123/133] (612s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[410.744390] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[418.117928] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.392s)
[418.254800] [124/133] (605s left) i915_selftest (live)
[420.107336] Starting subtest: live
[420.110054] Starting dynamic subtest: sanitycheck
[424.512584] Dynamic subtest sanitycheck: SUCCESS (4.402s)
[424.523546] Starting dynamic subtest: uncore
[428.863585] Dynamic subtest uncore: SUCCESS (4.349s)
[428.874504] Starting dynamic subtest: workarounds
[431.995098] Dynamic subtest workarounds: SUCCESS (3.129s)
[432.008533] Starting dynamic subtest: gt_engines
[436.518097] Dynamic subtest gt_engines: SUCCESS (4.522s)
[436.530302] Starting dynamic subtest: gt_timelines
[452.082438] Dynamic subtest gt_timelines: SUCCESS (15.566s)
[452.093437] Starting dynamic subtest: gt_contexts
[454.846444] Dynamic subtest gt_contexts: SUCCESS (2.762s)
[454.862323] Starting dynamic subtest: gt_lrc
[459.260115] Dynamic subtest gt_lrc: SUCCESS (4.413s)
[459.270033] Starting dynamic subtest: gt_mocs
[463.653121] Dynamic subtest gt_mocs: SUCCESS (4.392s)
[463.664064] Starting dynamic subtest: gt_pm
[470.473196] Dynamic subtest gt_pm: SUCCESS (6.820s)
[470.483976] Starting dynamic subtest: gt_heartbeat
[474.804341] Dynamic subtest gt_heartbeat: SUCCESS (4.331s)
[474.814392] Starting dynamic subtest: gt_tlb
[484.206624] Dynamic subtest gt_tlb: SUCCESS (9.404s)
[484.220129] Starting dynamic subtest: requests
[497.651608] Dynamic subtest requests: SUCCESS (13.435s)
[497.662523] Starting dynamic subtest: migrate
[505.422491] Dynamic subtest migrate: SUCCESS (7.767s)
[505.433144] Starting dynamic subtest: active
[509.768501] Dynamic subtest active: SUCCESS (4.343s)
[509.779905] Starting dynamic subtest: objects
[514.519357] Dynamic subtest objects: SUCCESS (4.748s)
[514.530370] Starting dynamic subtest: mman
[519.557262] Dynamic subtest mman: SUCCESS (5.035s)
[519.568168] Starting dynamic subtest: dmabuf
[523.892332] Dynamic subtest dmabuf: SUCCESS (4.332s)
[523.903714] Starting dynamic subtest: vma
[528.288476] Dynamic subtest vma: SUCCESS (4.394s)
[528.300058] Starting dynamic subtest: coherency
[533.190227] Dynamic subtest coherency: SUCCESS (4.900s)
[533.200399] Starting dynamic subtest: gtt
[543.109896] Dynamic subtest gtt: SUCCESS (9.917s)
[543.120843] Starting dynamic subtest: gem
[551.319978] Dynamic subtest gem: SUCCESS (8.210s)
[551.330348] Starting dynamic subtest: evict
[556.881307] Dynamic subtest evict: SUCCESS (5.561s)
[556.892475] Starting dynamic subtest: hugepages
[565.838929] Dynamic subtest hugepages: SUCCESS (8.958s)
[565.849500] Starting dynamic subtest: gem_contexts
[594.865236] Dynamic subtest gem_contexts: SUCCESS (29.031s)
[594.874431] Starting dynamic subtest: client
[599.235326] Dynamic subtest client: SUCCESS (4.370s)
[599.246348] Starting dynamic subtest: gem_migrate
[603.570547] Dynamic subtest gem_migrate: SUCCESS (4.334s)
[603.581409] Starting dynamic subtest: reset
[607.961309] Dynamic subtest reset: SUCCESS (4.390s)
[607.970610] Starting dynamic subtest: memory_region
[612.356909] Dynamic subtest memory_region: SUCCESS (4.394s)
[612.369820] Starting dynamic subtest: hangcheck
[625.115950] Dynamic subtest hangcheck: SUCCESS (12.752s)
[625.129895] Starting dynamic subtest: execlists
[629.413183] Dynamic subtest execlists: SUCCESS (4.295s)
[629.424338] Starting dynamic subtest: ring_submission
[632.138321] Dynamic subtest ring_submission: SUCCESS (2.721s)
[632.149330] Starting dynamic subtest: perf
[636.541302] Dynamic subtest perf: SUCCESS (4.401s)
[636.552291] Starting dynamic subtest: slpc
[650.606253] Dynamic subtest slpc: SUCCESS (14.060s)
[650.617390] Starting dynamic subtest: guc
[654.540075] Dynamic subtest guc: SUCCESS (3.932s)
[654.549729] Starting dynamic subtest: guc_multi_lrc
[658.851715] Dynamic subtest guc_multi_lrc: SUCCESS (4.309s)
[658.862699] Starting dynamic subtest: guc_hang
[663.803628] Dynamic subtest guc_hang: SUCCESS (4.949s)
[663.814313] Starting dynamic subtest: late_gt_pm
[668.172073] Dynamic subtest late_gt_pm: SUCCESS (4.365s)
[668.175220] Subtest live: SUCCESS (248.062s)
[668.204885] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[668.205581] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[668.208982] [125/133] (355s left) prime_udl
[668.289081] [126/133] (355s left) syncobj_eventfd (binary-wait-signaled)
[669.940471] Starting subtest: binary-wait-signaled
[669.942788] Subtest binary-wait-signaled: SUCCESS (0.001s)
[670.018839] [FACT syncobj_eventfd (binary-wait-signaled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[670.020175] [FACT syncobj_eventfd (binary-wait-signaled)] new: kernel.kmod_is_loaded.i915: true
[670.023855] [127/133] (353s left) gem_exec_whisper (basic-fds)
[670.101333] Starting subtest: basic-fds
[676.031120] Subtest basic-fds: SUCCESS (5.928s)
[676.218539] [128/133] (347s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[676.325400] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[676.329562] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[676.397501] [129/133] (347s left) gem_exec_params (rel-constants-invalid)
[676.467597] Starting subtest: rel-constants-invalid
[676.469963] Subtest rel-constants-invalid: SUCCESS (0.000s)
[676.565952] [130/133] (347s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[676.652382] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[676.654884] Starting dynamic subtest: pipe-A-eDP-1
[676.674882] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[676.689831] Starting dynamic subtest: pipe-B-eDP-1
[676.709760] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[676.719400] Starting dynamic subtest: pipe-C-eDP-1
[676.738438] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[676.748118] Starting dynamic subtest: pipe-D-eDP-1
[676.767535] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[676.769752] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[678.949709] [131/133] (344s left) syncobj_wait (reset-during-wait-for-submit)
[679.008489] Starting subtest: reset-during-wait-for-submit
[679.111312] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[679.205931] [132/133] (344s left) i915_drm_fdinfo (virtual-busy-all)
[679.253617] Starting subtest: virtual-busy-all
[679.257979] Subtest virtual-busy-all: SKIP (0.000s)
[679.333915] [133/133] (344s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[679.458201] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[679.462382] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[679.578624] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_plane_scaling
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: kms_rotation_crc
results: parsing output: 6/ for test: gem_ctx_param
results: parsing output: 7/ for test: gem_create
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_eio
results: parsing output: 13/ for test: kms_rotation_crc
results: parsing output: 14/ for test: kms_prime
results: parsing output: 15/ for test: kms_color
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_pm_rpm
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exercise_blt
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_softpin
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_vblank
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_flip_scaled_crc
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_content_protection
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: api_intel_bb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: sriov_basic
results: parsing output: 40/ for test: kms_lease
results: parsing output: 41/ for test: gem_exec_capture
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_flush
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: i915_getparams_basic
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_mmap_offset
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: gem_ccs
results: parsing output: 55/ for test: kms_getfb
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: fbdev
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_cursor_edge_walk
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: sw_sync
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: gem_spin_batch
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_busy
results: parsing output: 77/ for test: gem_ctx_isolation
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_chamelium_hpd
results: parsing output: 85/ for test: i915_pm_rps
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: drm_mm
results: parsing output: 88/ for test: kms_chamelium_edid
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_vrr
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: gem_reg_read
results: parsing output: 99/ for test: gem_ctx_persistence
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_prop_blob
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_pread
results: parsing output: 106/ for test: kms_pipe_crc_basic
results: parsing output: 107/ for test: api_intel_allocator
results: parsing output: 108/ for test: perf
results: parsing output: 109/ for test: kms_atomic
results: parsing output: 110/ for test: sysfs_heartbeat_interval
results: parsing output: 111/ for test: gem_readwrite
results: parsing output: 112/ for test: kms_joiner
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: gem_softpin
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_addfb_basic
results: parsing output: 119/ for test: kms_feature_discovery
results: parsing output: 120/ for test: gem_exec_parallel
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: i915_selftest
results: parsing output: 124/ for test: prime_udl
results: parsing output: 125/ for test: syncobj_eventfd
results: parsing output: 126/ for test: gem_exec_whisper
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: gem_exec_params
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: i915_drm_fdinfo
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.