[56.356026] Initializing watchdogs
[56.356083]   /dev/watchdog0
[56.369246] [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]
[56.373538] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.375765] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.379130] [001/133] (960s left) kms_draw_crc (draw-method-blt)
[56.505795] Starting subtest: draw-method-blt
[56.508045] Starting dynamic subtest: xrgb8888-untiled
[56.736939] Dynamic subtest xrgb8888-untiled: SUCCESS (0.234s)
[56.745064] Starting dynamic subtest: rgb565-untiled
[56.936073] Dynamic subtest rgb565-untiled: SUCCESS (0.200s)
[56.943666] Starting dynamic subtest: xrgb2101010-untiled
[57.178875] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.244s)
[57.185197] Starting dynamic subtest: xbgr16161616f-untiled
[57.388763] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[57.395192] Starting dynamic subtest: xrgb8888-xtiled
[57.499695] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[57.506101] Starting dynamic subtest: rgb565-xtiled
[57.610318] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[57.618055] Starting dynamic subtest: xrgb2101010-xtiled
[57.709868] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.100s)
[57.720293] Starting dynamic subtest: xbgr16161616f-xtiled
[57.809538] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.100s)
[57.816748] Starting dynamic subtest: xrgb8888-4tiled
[57.920588] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.111s)
[57.928142] Starting dynamic subtest: rgb565-4tiled
[58.041701] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[58.049171] Starting dynamic subtest: xrgb2101010-4tiled
[58.152366] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[58.160111] Starting dynamic subtest: xbgr16161616f-4tiled
[58.251923] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.100s)
[58.254072] Subtest draw-method-blt: SUCCESS (1.756s)
[58.400497] [002/133] (958s left) prime_mmap (test_reprime)
[58.461556] Starting subtest: test_reprime
[58.463501] Starting dynamic subtest: test_reprime-smem
[58.494716] Dynamic subtest test_reprime-smem: SUCCESS (0.033s)
[58.496923] Subtest test_reprime: SUCCESS (0.033s)
[58.591297] [003/133] (958s left) perf_pmu (busy)
[58.628384] Starting subtest: busy
[58.630465] Starting dynamic subtest: rcs0
[59.246474] Dynamic subtest rcs0: SUCCESS (0.619s)
[59.256772] Starting dynamic subtest: bcs0
[59.821717] Dynamic subtest bcs0: SUCCESS (0.576s)
[59.831974] Starting dynamic subtest: vcs0
[61.908966] Dynamic subtest vcs0: SUCCESS (2.091s)
[61.917223] Starting dynamic subtest: vcs1
[63.894758] Dynamic subtest vcs1: SUCCESS (1.988s)
[63.905218] Starting dynamic subtest: vecs0
[65.944254] Dynamic subtest vecs0: SUCCESS (2.052s)
[65.954903] Starting dynamic subtest: ccs0
[66.510842] Dynamic subtest ccs0: SUCCESS (0.568s)
[66.513356] Subtest busy: SUCCESS (7.902s)
[66.657818] [004/133] (950s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[66.813946] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[66.826561] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[67.083032] [005/133] (950s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[67.460590] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[67.463337] Starting dynamic subtest: pipe-A-eDP-1
[67.488096] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[67.497615] Starting dynamic subtest: pipe-B-eDP-1
[67.518437] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[67.525513] Starting dynamic subtest: pipe-C-eDP-1
[67.547643] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[67.554727] Starting dynamic subtest: pipe-D-eDP-1
[67.577210] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[67.581692] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[69.709057] [006/133] (947s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[69.815874] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[73.827562] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.019s)
[75.003894] [007/133] (942s left) i915_pm_freq_mult (media-freq)
[75.061075] Starting subtest: media-freq
[75.063460] Starting dynamic subtest: gt0
[75.068273] Dynamic subtest gt0: SKIP (0.000s)
[75.077755] Starting dynamic subtest: gt1
[75.081792] Dynamic subtest gt1: SKIP (0.000s)
[75.085781] Subtest media-freq: SKIP (0.001s)
[75.189978] [008/133] (942s left) kms_vblank (ts-continuation-modeset-hang)
[75.290910] Starting subtest: ts-continuation-modeset-hang
[75.292814] Starting dynamic subtest: pipe-A-eDP-1
[101.653072] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.358s)
[101.666787] Starting dynamic subtest: pipe-D-eDP-1
[126.668903] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.014s)
[126.671038] Subtest ts-continuation-modeset-hang: SUCCESS (51.376s)
[127.549849] [009/133] (889s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[127.645393] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[127.647720] Starting dynamic subtest: pipe-A-eDP-1
[127.701655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.058s)
[127.711461] Starting dynamic subtest: pipe-B-eDP-1
[127.765621] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.063s)
[127.773515] Starting dynamic subtest: pipe-C-eDP-1
[127.828501] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[127.836855] Starting dynamic subtest: pipe-D-eDP-1
[127.889112] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.059s)
[127.891323] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.246s)
[130.087845] [010/133] (887s left) kms_psr (psr2-cursor-plane-move)
[130.180222] Starting subtest: psr2-cursor-plane-move
[130.182455] Starting dynamic subtest: eDP-1
[131.860602] Dynamic subtest eDP-1: SUCCESS (1.679s)
[131.863064] Subtest psr2-cursor-plane-move: SUCCESS (1.680s)
[132.660238] [011/133] (884s left) sysfs_heartbeat_interval (nopreempt)
[132.715297] Starting subtest: nopreempt
[132.717249] Starting dynamic subtest: vecs0
[141.938550] Dynamic subtest vecs0: SUCCESS (9.220s)
[141.948743] Starting dynamic subtest: ccs0
[145.832937] Dynamic subtest ccs0: SUCCESS (3.897s)
[145.843877] Starting dynamic subtest: vcs0
[155.944081] Dynamic subtest vcs0: SUCCESS (10.110s)
[155.955082] Starting dynamic subtest: bcs0
[159.917334] Dynamic subtest bcs0: SUCCESS (3.972s)
[159.927937] Starting dynamic subtest: rcs0
[163.916738] Dynamic subtest rcs0: SUCCESS (3.997s)
[163.930435] Starting dynamic subtest: vcs1
[172.903840] Dynamic subtest vcs1: SUCCESS (8.984s)
[172.906365] Subtest nopreempt: SUCCESS (40.187s)
[172.988276] [012/133] (844s left) kms_flip (nonexisting-fb-interruptible)
[173.088066] Starting subtest: nonexisting-fb-interruptible
[173.090368] Starting dynamic subtest: A-eDP1
[174.244654] Dynamic subtest A-eDP1: SUCCESS (1.156s)
[174.255131] Starting dynamic subtest: B-eDP1
[175.375615] Dynamic subtest B-eDP1: SUCCESS (1.130s)
[175.385973] Starting dynamic subtest: C-eDP1
[176.502248] Dynamic subtest C-eDP1: SUCCESS (1.126s)
[176.511369] Starting dynamic subtest: D-eDP1
[177.634592] Dynamic subtest D-eDP1: SUCCESS (1.131s)
[177.637025] Subtest nonexisting-fb-interruptible: SUCCESS (4.549s)
[178.929276] [013/133] (838s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[179.050757] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[179.052626] Starting dynamic subtest: pipe-A-eDP-1
[196.048224] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.576s)
[196.058335] Starting dynamic subtest: pipe-B-eDP-1
[213.028548] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.486s)
[213.038934] Starting dynamic subtest: pipe-C-eDP-1
[229.946913] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.369s)
[229.957447] Starting dynamic subtest: pipe-D-eDP-1
[246.970742] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.361s)
[246.972987] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.798s)
[248.186992] [014/133] (769s left) gem_basic (create-fd-close)
[248.267862] Starting subtest: create-fd-close
[248.272403] Subtest create-fd-close: SUCCESS (0.000s)
[248.407741] [015/133] (769s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[248.465672] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[248.469824] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[248.664009] [016/133] (768s left) gem_exec_whisper (basic-fds)
[248.722877] Starting subtest: basic-fds
[256.095668] Subtest basic-fds: SUCCESS (7.452s)
[256.290100] [017/133] (761s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[256.391361] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[256.395636] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[256.493349] [018/133] (761s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[256.593717] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[256.598323] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[256.671869] [019/133] (761s left) core_auth (many-magics)
[256.730695] Starting subtest: many-magics
[257.664105] Subtest many-magics: SUCCESS (0.941s)
[257.862395] [020/133] (759s left) kms_cursor_crc (cursor-offscreen-128x42)
[258.129854] Starting subtest: cursor-offscreen-128x42
[258.178353] Subtest cursor-offscreen-128x42: SKIP (0.043s)
[258.404354] [021/133] (759s left) perf (mi-rpc)
[258.533456] Starting subtest: mi-rpc
[258.537351] Subtest mi-rpc: SKIP (0.000s)
[258.573939] [022/133] (759s left) gem_exec_schedule (u-fairslice-all)
[258.650246] Starting subtest: u-fairslice-all
[260.701916] Subtest u-fairslice-all: SUCCESS (2.064s)
[262.288262] [023/133] (755s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[262.393299] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[262.397791] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[262.504419] [024/133] (755s left) kms_psr (psr-primary-mmap-cpu)
[262.601227] Starting subtest: psr-primary-mmap-cpu
[262.603562] Starting dynamic subtest: eDP-1
[264.354991] Dynamic subtest eDP-1: SUCCESS (1.760s)
[264.357240] Subtest psr-primary-mmap-cpu: SUCCESS (1.761s)
[265.226991] [025/133] (752s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[265.325467] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[265.329914] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[265.452193] [026/133] (752s left) gem_exec_balancer (sliced)
[265.522001] Starting subtest: sliced
[265.526397] Subtest sliced: SKIP (0.000s)
[265.845735] [027/133] (752s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[265.939281] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[265.948668] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.012s)
[266.080071] [028/133] (752s left) kms_atomic_interruptible (legacy-cursor)
[266.182782] Starting subtest: legacy-cursor
[266.185050] Starting dynamic subtest: pipe-A-eDP-1
[273.618865] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.445s)
[273.620735] Subtest legacy-cursor: SUCCESS (7.447s)
[274.464946] [029/133] (743s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[274.569469] Starting subtest: nonblocking-crc-frame-sequence
[274.571886] Starting dynamic subtest: pipe-A-eDP-1
[275.306276] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[275.317545] Starting dynamic subtest: pipe-B-eDP-1
[276.662039] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.355s)
[276.672399] Starting dynamic subtest: pipe-C-eDP-1
[278.067185] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.403s)
[278.081445] Starting dynamic subtest: pipe-D-eDP-1
[279.391954] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[279.394294] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.824s)
[280.213248] [030/133] (737s left) kms_psr (fbc-psr-sprite-blt)
[280.314176] Starting subtest: fbc-psr-sprite-blt
[280.316189] Starting dynamic subtest: eDP-1
[280.320489] Dynamic subtest eDP-1: SKIP (0.000s)
[280.324864] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[280.395526] [031/133] (737s left) gem_pxp (create-protected-buffer)
[280.524660] Starting subtest: create-protected-buffer
[280.526691] Subtest create-protected-buffer: SUCCESS (0.000s)
[280.638379] [032/133] (737s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[280.733579] Starting subtest: psr-rgb101010-draw-blt
[287.950681] Subtest psr-rgb101010-draw-blt: SUCCESS (7.218s)
[288.089014] [033/133] (730s left) dumb_buffer (invalid-bpp)
[288.139530] Starting subtest: invalid-bpp
[288.141426] Subtest invalid-bpp: SUCCESS (0.000s)
[288.258923] [034/133] (730s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[288.357203] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[288.361311] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[288.468835] [035/133] (729s left) kms_flip (plain-flip-ts-check)
[288.570699] Starting subtest: plain-flip-ts-check
[288.572958] Starting dynamic subtest: A-eDP1
[297.424832] Dynamic subtest A-eDP1: SUCCESS (8.853s)
[297.434396] Starting dynamic subtest: B-eDP1
[306.266308] Dynamic subtest B-eDP1: SUCCESS (8.840s)
[306.278524] Starting dynamic subtest: C-eDP1
[315.086513] Dynamic subtest C-eDP1: SUCCESS (8.820s)
[315.101563] Starting dynamic subtest: D-eDP1
[323.928015] Dynamic subtest D-eDP1: SUCCESS (8.842s)
[323.930449] Subtest plain-flip-ts-check: SUCCESS (35.367s)
[325.127000] [036/133] (693s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[325.225712] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[325.230217] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[325.307579] [037/133] (693s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[325.375403] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[325.377826] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[325.498666] [038/133] (693s left) prime_mmap_coherency (ioctl-errors)
[325.562229] Starting subtest: ioctl-errors
[339.348202] Subtest ioctl-errors: SUCCESS (13.793s)
[339.541990] [039/133] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[339.685724] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[346.513518] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.829s)
[346.683007] [040/133] (671s left) kms_addfb_basic (basic-y-tiled-legacy)
[346.743225] Starting subtest: basic-y-tiled-legacy
[346.747505] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[346.893365] [041/133] (671s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[346.954888] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[346.957294] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[347.083643] [042/133] (671s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[347.188451] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[353.860755] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.672s)
[354.021739] [043/133] (664s left) syncobj_timeline (wait-all-for-submit-snapshot)
[354.082056] Starting subtest: wait-all-for-submit-snapshot
[354.164469] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[354.237986] [044/133] (664s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[354.347785] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[355.172164] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.825s)
[355.366642] [045/133] (663s left) kms_psr (psr2-cursor-blt)
[355.461646] Starting subtest: psr2-cursor-blt
[355.463930] Starting dynamic subtest: eDP-1
[357.138984] Dynamic subtest eDP-1: SUCCESS (1.676s)
[357.141029] Subtest psr2-cursor-blt: SUCCESS (1.677s)
[357.940395] [046/133] (660s left) kms_plane_cursor (primary)
[358.036852] Starting subtest: primary
[358.041403] Starting dynamic subtest: pipe-A-eDP-1-size-64
[360.599158] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.562s)
[360.624906] Starting dynamic subtest: pipe-A-eDP-1-size-128
[363.157345] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.539s)
[363.182811] Starting dynamic subtest: pipe-A-eDP-1-size-256
[365.757675] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.582s)
[366.079641] Starting dynamic subtest: pipe-B-eDP-1-size-64
[369.344485] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.274s)
[369.370240] Starting dynamic subtest: pipe-B-eDP-1-size-128
[371.889371] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.527s)
[371.917815] Starting dynamic subtest: pipe-B-eDP-1-size-256
[374.491730] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[374.807201] Starting dynamic subtest: pipe-C-eDP-1-size-64
[377.647999] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.851s)
[377.675358] Starting dynamic subtest: pipe-C-eDP-1-size-128
[379.870054] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.202s)
[379.897356] Starting dynamic subtest: pipe-C-eDP-1-size-256
[382.102827] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s)
[382.422812] Starting dynamic subtest: pipe-D-eDP-1-size-64
[385.392708] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.983s)
[385.423638] Starting dynamic subtest: pipe-D-eDP-1-size-128
[387.626018] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.213s)
[387.654048] Starting dynamic subtest: pipe-D-eDP-1-size-256
[389.825914] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[390.132984] Subtest primary: SUCCESS (32.094s)
[390.969971] [047/133] (627s left) gem_exec_balancer (full-late)
[391.054250] Starting subtest: full-late
[395.974950] Subtest full-late: SUCCESS (4.921s)
[396.342224] [048/133] (622s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[396.456330] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[396.460519] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[396.539024] [049/133] (622s left) kms_pm_rpm (fences-dpms)
[398.360958] Starting subtest: fences-dpms
[398.366791] Subtest fences-dpms: SKIP (0.000s)
[398.805754] [050/133] (620s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[399.180819] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[399.987216] [051/133] (619s left) kms_universal_plane (disable-primary-vs-flip)
[400.074852] Starting subtest: disable-primary-vs-flip
[400.077270] Starting dynamic subtest: pipe-A-eDP-1
[401.574590] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.497s)
[401.585369] Starting dynamic subtest: pipe-B-eDP-1
[403.780225] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.204s)
[403.791582] Starting dynamic subtest: pipe-C-eDP-1
[406.014569] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.233s)
[406.025754] Starting dynamic subtest: pipe-D-eDP-1
[408.176328] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.161s)
[408.178308] Subtest disable-primary-vs-flip: SUCCESS (8.101s)
[409.003254] [052/133] (610s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[409.109888] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[409.112251] Starting dynamic subtest: pipe-A-eDP-1
[420.080673] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.979s)
[420.091222] Starting dynamic subtest: pipe-B-eDP-1
[431.780150] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.698s)
[431.782457] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.680s)
[432.639865] [053/133] (586s left) i915_suspend (sysfs-reader)
[432.697395] Starting subtest: sysfs-reader
[450.999845] Subtest sysfs-reader: SUCCESS (3.329s)
[451.073726] [054/133] (568s left) prime_self_import (basic-with_fd_dup)
[451.122045] Starting subtest: basic-with_fd_dup
[451.157211] Subtest basic-with_fd_dup: SUCCESS (0.035s)
[451.270894] [055/133] (567s left) kms_color (invalid-ctm-matrix-sizes)
[451.360648] Starting subtest: invalid-ctm-matrix-sizes
[451.362542] Starting dynamic subtest: pipe-A
[451.364321] Dynamic subtest pipe-A: SUCCESS (0.002s)
[451.373902] Starting dynamic subtest: pipe-B
[451.375821] Dynamic subtest pipe-B: SUCCESS (0.003s)
[451.384621] Starting dynamic subtest: pipe-C
[451.386497] Dynamic subtest pipe-C: SUCCESS (0.003s)
[451.395375] Starting dynamic subtest: pipe-D
[451.397286] Dynamic subtest pipe-D: SUCCESS (0.004s)
[451.399071] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s)
[451.465891] [056/133] (567s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[451.852367] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[452.639290] [057/133] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[452.742214] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[459.488882] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.818s)
[459.658445] [058/133] (559s left) kms_panel_fitting (atomic-fastset)
[459.758230] Starting subtest: atomic-fastset
[459.760511] Starting dynamic subtest: pipe-A-eDP-1
[459.894694] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[459.907081] Starting dynamic subtest: pipe-B-eDP-1
[461.086333] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.197s)
[461.098914] Starting dynamic subtest: pipe-C-eDP-1
[462.264223] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.182s)
[462.279488] Starting dynamic subtest: pipe-D-eDP-1
[463.402335] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[463.404670] Subtest atomic-fastset: SUCCESS (3.664s)
[464.653137] [059/133] (554s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[464.721819] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[464.724273] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[464.851800] [060/133] (554s left) gem_create (create-invalid-size)
[464.913967] Starting subtest: create-invalid-size
[464.916179] Subtest create-invalid-size: SUCCESS (0.000s)
[465.106085] [061/133] (554s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[465.396124] Starting subtest: cursor-rapid-movement-512x170
[465.400400] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[465.584230] [062/133] (553s left) vgem_basic (setversion)
[465.687508] Starting subtest: setversion
[465.692037] Subtest setversion: SUCCESS (0.000s)
[465.766989] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[465.770683] [063/133] (553s left) kms_psr (fbc-pr-sprite-plane-move)
[465.855147] Starting subtest: fbc-pr-sprite-plane-move
[465.859107] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[465.939350] [064/133] (553s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[466.044836] Starting subtest: plane-upscale-20x20-with-pixel-format
[466.047045] Starting dynamic subtest: pipe-A
[467.090986] Dynamic subtest pipe-A: SUCCESS (1.050s)
[467.102027] Starting dynamic subtest: pipe-B
[469.233367] Dynamic subtest pipe-B: SUCCESS (2.147s)
[469.242892] Starting dynamic subtest: pipe-C
[470.430181] Dynamic subtest pipe-C: SUCCESS (1.198s)
[470.447521] Starting dynamic subtest: pipe-D
[471.655806] Dynamic subtest pipe-D: SUCCESS (1.226s)
[471.658172] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.625s)
[472.866013] [065/133] (546s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[472.955676] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[480.193201] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.248s)
[480.341646] [066/133] (539s left) i915_drm_fdinfo (busy-check-all)
[480.384111] Starting subtest: busy-check-all
[480.386398] Starting dynamic subtest: rcs0
[480.390989] Dynamic subtest rcs0: SKIP (0.004s)
[480.402980] Starting dynamic subtest: bcs0
[480.407319] Dynamic subtest bcs0: SKIP (0.000s)
[480.416913] Starting dynamic subtest: vcs0
[480.421361] Dynamic subtest vcs0: SKIP (0.001s)
[480.431428] Starting dynamic subtest: vcs1
[480.435889] Dynamic subtest vcs1: SKIP (0.001s)
[480.447209] Starting dynamic subtest: vecs0
[480.451364] Dynamic subtest vecs0: SKIP (0.000s)
[480.460879] Starting dynamic subtest: ccs0
[480.465165] Dynamic subtest ccs0: SKIP (0.000s)
[480.469302] Subtest busy-check-all: SKIP (0.012s)
[480.509922] [067/133] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[480.610729] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[480.615008] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[480.744230] [068/133] (539s left) kms_plane (plane-position-covered)
[480.834269] Starting subtest: plane-position-covered
[481.334710] Starting dynamic subtest: pipe-A-plane-1
[482.648045] Dynamic subtest pipe-A-plane-1: SUCCESS (1.314s)
[482.668754] Starting dynamic subtest: pipe-A-plane-2
[483.865058] Dynamic subtest pipe-A-plane-2: SUCCESS (1.214s)
[483.875070] Starting dynamic subtest: pipe-A-plane-3
[485.098808] Dynamic subtest pipe-A-plane-3: SUCCESS (1.232s)
[485.109067] Starting dynamic subtest: pipe-A-plane-4
[486.332938] Dynamic subtest pipe-A-plane-4: SUCCESS (1.233s)
[486.343822] Starting dynamic subtest: pipe-A-plane-5
[486.362105] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[487.503561] Starting dynamic subtest: pipe-B-plane-1
[488.823804] Dynamic subtest pipe-B-plane-1: SUCCESS (1.328s)
[488.834969] Starting dynamic subtest: pipe-B-plane-2
[490.148757] Dynamic subtest pipe-B-plane-2: SUCCESS (1.322s)
[490.161658] Starting dynamic subtest: pipe-B-plane-3
[491.345366] Dynamic subtest pipe-B-plane-3: SUCCESS (1.197s)
[491.355900] Starting dynamic subtest: pipe-B-plane-4
[492.603227] Dynamic subtest pipe-B-plane-4: SUCCESS (1.257s)
[492.614236] Starting dynamic subtest: pipe-B-plane-5
[492.629157] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[492.631698] Subtest plane-position-covered: SUCCESS (11.793s)
[493.511600] [069/133] (526s left) kms_flip (2x-busy-flip)
[493.615909] Starting subtest: 2x-busy-flip
[493.626992] Subtest 2x-busy-flip: SKIP (0.010s)
[493.762273] [070/133] (526s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[493.872549] Starting subtest: verify-pxp-stale-buf-optout-execution
[494.931798] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.059s)
[495.084312] [071/133] (524s left) syncobj_eventfd (binary-wait-before-signal)
[495.141941] Starting subtest: binary-wait-before-signal
[495.172907] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[495.272592] [072/133] (524s left) gem_exercise_blt (fast-copy-emit)
[495.332275] Starting subtest: fast-copy-emit
[495.334547] Starting dynamic subtest: linear-smem-smem-emit
[495.353086] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[495.364504] Starting dynamic subtest: xmajor-smem-smem-emit
[495.369856] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[495.380559] Starting dynamic subtest: tile4-smem-smem-emit
[495.386268] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s)
[495.396392] Starting dynamic subtest: tile64-smem-smem-emit
[495.402507] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[495.404728] Subtest fast-copy-emit: SUCCESS (0.071s)
[495.551914] [073/133] (524s left) gem_exec_schedule (noreorder-corked)
[495.725874] Starting subtest: noreorder-corked
[495.728354] Starting dynamic subtest: rcs0
[496.871211] Dynamic subtest rcs0: SUCCESS (1.145s)
[496.884644] Starting dynamic subtest: vcs0
[498.160604] Dynamic subtest vcs0: SUCCESS (1.286s)
[498.174220] Starting dynamic subtest: vcs1
[500.091919] Dynamic subtest vcs1: SUCCESS (1.929s)
[500.104942] Starting dynamic subtest: vecs0
[502.173556] Dynamic subtest vecs0: SUCCESS (2.080s)
[502.187178] Starting dynamic subtest: ccs0
[503.342112] Dynamic subtest ccs0: SUCCESS (1.167s)
[503.344990] Subtest noreorder-corked: SUCCESS (7.618s)
[503.542321] [074/133] (516s left) i915_fb_tiling (basic-x-tiling)
[503.598613] Subtest basic-x-tiling: SKIP (0.000s)
[503.670104] [075/133] (516s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[503.768986] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[508.253647] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.488s)
[509.406658] [076/133] (510s left) gem_workarounds (reset-fd)
[509.468186] Starting subtest: reset-fd
[509.612689] Subtest reset-fd: SUCCESS (0.145s)
[509.774361] [077/133] (510s left) kms_hdr (bpc-switch)
[509.894407] Starting subtest: bpc-switch
[510.950798] Starting dynamic subtest: pipe-A-eDP-1
[514.374194] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.427s)
[514.376500] Subtest bpc-switch: SUCCESS (4.484s)
[514.511290] [078/133] (505s left) gem_ctx_shared (q-promotion)
[514.575671] Starting subtest: Q-promotion
[514.578017] Starting dynamic subtest: rcs0
[514.678234] Dynamic subtest rcs0: SUCCESS (0.104s)
[514.697539] Starting dynamic subtest: vcs0
[514.764742] Dynamic subtest vcs0: SUCCESS (0.086s)
[514.782350] Starting dynamic subtest: vcs1
[514.841577] Dynamic subtest vcs1: SUCCESS (0.075s)
[514.859243] Starting dynamic subtest: vecs0
[514.921992] Dynamic subtest vecs0: SUCCESS (0.079s)
[514.939088] Starting dynamic subtest: ccs0
[515.014031] Dynamic subtest ccs0: SUCCESS (0.092s)
[515.016365] Subtest Q-promotion: SUCCESS (0.442s)
[516.231936] [079/133] (503s left) kms_lease (lease-invalid-plane)
[516.336698] Starting subtest: lease-invalid-plane
[516.339059] Starting dynamic subtest: pipe-A-eDP-1
[516.341363] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[516.352989] Starting dynamic subtest: pipe-B-eDP-1
[516.355294] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[516.366758] Starting dynamic subtest: pipe-C-eDP-1
[516.368592] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[516.377925] Starting dynamic subtest: pipe-D-eDP-1
[516.379769] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[516.381705] Subtest lease-invalid-plane: SUCCESS (0.004s)
[516.433048] [080/133] (503s left) perf (invalid-open-flags)
[516.532108] Starting subtest: invalid-open-flags
[516.534558] Subtest invalid-open-flags: SUCCESS (0.000s)
[516.577012] [081/133] (503s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[516.663239] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[516.665421] Starting dynamic subtest: pipe-A-eDP-1
[516.687972] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[516.700485] Starting dynamic subtest: pipe-B-eDP-1
[516.722327] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[516.732360] Starting dynamic subtest: pipe-C-eDP-1
[516.754623] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[516.766553] Starting dynamic subtest: pipe-D-eDP-1
[516.789576] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[516.794192] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[519.011379] [082/133] (501s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[519.122552] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[523.237826] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.119s)
[524.429273] [083/133] (495s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[524.532572] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[531.881338] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.353s)
[532.061436] [084/133] (488s left) gem_spin_batch (resubmit-all)
[532.128874] Starting subtest: resubmit-all
[532.131394] Starting dynamic subtest: rcs0
[532.138867] Dynamic subtest rcs0: SUCCESS (0.010s)
[532.153993] Starting dynamic subtest: bcs0
[532.156908] Dynamic subtest bcs0: SUCCESS (0.002s)
[532.166802] Starting dynamic subtest: vcs0
[532.169172] Dynamic subtest vcs0: SUCCESS (0.002s)
[532.178819] Starting dynamic subtest: vcs1
[532.181168] Dynamic subtest vcs1: SUCCESS (0.002s)
[532.191159] Starting dynamic subtest: vecs0
[532.193576] Dynamic subtest vecs0: SUCCESS (0.002s)
[532.203325] Starting dynamic subtest: ccs0
[532.205698] Dynamic subtest ccs0: SUCCESS (0.003s)
[532.207996] Subtest resubmit-all: SUCCESS (0.024s)
[534.212761] [085/133] (486s left) prime_vgem (basic-fence-flip)
[534.295744] Starting subtest: basic-fence-flip
[534.582841] Subtest basic-fence-flip: SUCCESS (0.288s)
[534.724185] [086/133] (485s left) perf_pmu (module-unload)
[534.801981] Starting subtest: module-unload
[543.259754] Subtest module-unload: FAIL (8.361s)
[543.289617] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[543.290326] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[543.293270] [087/133] (477s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[544.884876] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[544.889392] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[544.971406] [FACT kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[544.972591] [FACT kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)] new: kernel.kmod_is_loaded.i915: true
[544.976466] [088/133] (475s left) api_intel_bb (object-noreloc-keep-cache-simple)
[545.049034] Starting subtest: object-noreloc-keep-cache-simple
[545.054890] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.009s)
[545.157865] [089/133] (475s left) syncobj_wait (single-wait-submitted)
[545.218191] Starting subtest: single-wait-submitted
[545.322448] Subtest single-wait-submitted: SUCCESS (0.103s)
[545.412500] [090/133] (475s left) gem_readwrite (read-bad-handle)
[545.475474] Subtest read-bad-handle: SKIP (0.000s)
[545.540559] [091/133] (475s left) api_intel_allocator (standalone)
[545.607937] Starting subtest: standalone
[545.622431] Subtest standalone: SUCCESS (0.017s)
[545.784116] [092/133] (474s left) gem_userptr_blits (dmabuf-unsync)
[545.862215] Subtest dmabuf-unsync: SKIP (0.000s)
[546.022564] [093/133] (474s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[546.134761] Starting subtest: flip-vs-cursor-atomic-transitions
[553.737636] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.599s)
[554.549416] [094/133] (466s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[554.661257] Starting subtest: fbc-dirtyfb-ioctl
[554.663580] Starting dynamic subtest: A-eDP-1
[557.525648] Dynamic subtest A-eDP-1: SUCCESS (2.862s)
[557.527563] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.864s)
[558.339837] [095/133] (462s left) kms_async_flips (test-cursor-atomic)
[558.449147] Starting subtest: test-cursor-atomic
[558.453182] Subtest test-cursor-atomic: SKIP (0.000s)
[559.670019] [096/133] (461s left) kms_chamelium_color (ctm-green-to-red)
[559.769853] Subtest ctm-green-to-red: SKIP (0.000s)
[559.835122] [097/133] (461s left) gem_mmap_gtt (flink-race)
[559.896009] Subtest flink-race: SKIP (0.000s)
[559.966017] [098/133] (461s left) kms_content_protection (atomic-hdcp14)
[560.118449] Starting subtest: atomic-hdcp14
[560.122996] Subtest atomic-hdcp14: SKIP (0.000s)
[560.271233] [099/133] (460s left) gem_mmap_wc (write)
[560.338957] Subtest write: SKIP (0.000s)
[560.417715] [100/133] (460s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[560.478068] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[560.543460] [101/133] (460s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[560.671551] Starting subtest: cursorB-vs-flipB-varying-size
[560.675207] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[560.825417] [102/133] (460s left) kms_pm_rpm (package-g7)
[562.381148] Starting subtest: package-g7
[562.386777] Subtest package-g7: SKIP (0.000s)
[563.126115] [103/133] (458s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[563.257593] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[570.546460] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.290s)
[570.705161] [104/133] (450s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[570.803350] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[570.807640] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[570.902962] [105/133] (450s left) kms_psr (fbc-pr-primary-blt)
[571.002883] Starting subtest: fbc-pr-primary-blt
[571.007203] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[571.103814] [106/133] (450s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[571.201735] Starting subtest: fbc-modesetfrombusy
[574.990233] Subtest fbc-modesetfrombusy: SUCCESS (3.793s)
[576.184640] [107/133] (445s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[576.296122] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[580.741922] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.450s)
[581.899416] [108/133] (439s left) kms_big_fb (linear-16bpp-rotate-0)
[581.994971] Starting subtest: linear-16bpp-rotate-0
[583.274606] Subtest linear-16bpp-rotate-0: SUCCESS (1.279s)
[583.405539] [109/133] (438s left) gem_ctx_persistence (engines-hang)
[583.461342] Starting subtest: engines-hang
[583.463404] Starting dynamic subtest: rcs0
[583.562650] Dynamic subtest rcs0: SUCCESS (0.101s)
[583.574043] Starting dynamic subtest: bcs0
[583.697622] Dynamic subtest bcs0: SUCCESS (0.133s)
[583.710394] Starting dynamic subtest: vcs0
[583.777526] Dynamic subtest vcs0: SUCCESS (0.078s)
[583.788566] Starting dynamic subtest: vcs1
[583.885456] Dynamic subtest vcs1: SUCCESS (0.106s)
[583.896757] Starting dynamic subtest: vecs0
[583.984383] Dynamic subtest vecs0: SUCCESS (0.097s)
[583.995541] Starting dynamic subtest: ccs0
[584.121697] Dynamic subtest ccs0: SUCCESS (0.135s)
[584.123964] Subtest engines-hang: SUCCESS (0.661s)
[584.242025] [110/133] (437s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[584.335113] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[584.338511] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[584.460051] [111/133] (437s left) gem_exec_gttfill (multigpu-basic)
[584.646811] Starting subtest: multigpu-basic
[602.238154] Subtest multigpu-basic: SUCCESS (17.595s)
[602.345683] [112/133] (419s left) gem_exec_fence (submit3)
[602.561819] Starting subtest: submit3
[602.566208] Subtest submit3: SKIP (0.000s)
[604.245728] [113/133] (417s left) fbdev (read)
[604.294887] Starting subtest: read
[604.824115] Subtest read: SUCCESS (0.527s)
[604.900924] [114/133] (416s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[605.025863] Starting subtest: 4-tiled-16bpp-rotate-270
[605.048277] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.022s)
[605.207022] [115/133] (416s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[605.317119] Starting subtest: yf-tiled-8bpp-rotate-0
[605.321669] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[605.428175] [116/133] (416s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[605.533405] Starting subtest: x-tiled-32bpp-rotate-180
[607.035315] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.501s)
[607.186772] [117/133] (414s left) sriov_basic (enable-vfs-autoprobe-off)
[607.254295] Starting subtest: enable-vfs-autoprobe-off
[607.256542] Starting dynamic subtest: numvfs-1
[607.324904] Dynamic subtest numvfs-1: FAIL (0.026s)
[607.335630] Starting dynamic subtest: numvfs-2
[607.396124] Dynamic subtest numvfs-2: FAIL (0.004s)
[607.407169] Starting dynamic subtest: numvfs-3
[607.465950] Dynamic subtest numvfs-3: FAIL (0.003s)
[607.475862] Starting dynamic subtest: numvfs-4
[607.534849] Dynamic subtest numvfs-4: FAIL (0.003s)
[607.545630] Starting dynamic subtest: numvfs-5
[607.604074] Dynamic subtest numvfs-5: FAIL (0.003s)
[607.613922] Starting dynamic subtest: numvfs-6
[607.673058] Dynamic subtest numvfs-6: FAIL (0.004s)
[607.683488] Starting dynamic subtest: numvfs-7
[607.743860] Dynamic subtest numvfs-7: FAIL (0.003s)
[607.752819] Starting dynamic subtest: numvfs-random
[607.811489] Dynamic subtest numvfs-random: FAIL (0.003s)
[607.821778] Starting dynamic subtest: numvfs-all
[607.881746] Dynamic subtest numvfs-all: FAIL (0.004s)
[607.883608] Subtest enable-vfs-autoprobe-off: FAIL (0.488s)
[607.919479] [118/133] (413s left) kms_hdr (static-toggle)
[608.021364] Starting subtest: static-toggle
[608.026617] Subtest static-toggle: SKIP (0.000s)
[608.105704] [119/133] (413s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[608.198677] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[608.200544] Starting dynamic subtest: pipe-A-eDP-1
[608.217869] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[608.228894] Starting dynamic subtest: pipe-B-eDP-1
[608.245266] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[608.254169] Starting dynamic subtest: pipe-C-eDP-1
[608.269587] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[608.278470] Starting dynamic subtest: pipe-D-eDP-1
[608.294631] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[608.296297] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[610.551889] [120/133] (411s left) kms_flip (2x-flip-vs-modeset)
[610.647343] Starting subtest: 2x-flip-vs-modeset
[610.656011] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[610.752034] [121/133] (411s left) gem_exec_reloc (basic-wc-gtt-active)
[610.829460] Subtest basic-wc-gtt-active: SKIP (0.000s)
[610.913573] [122/133] (411s left) gem_userptr_blits (mmap-offset-banned)
[610.986731] Starting subtest: mmap-offset-banned
[610.989120] Starting dynamic subtest: wb
[610.991511] Dynamic subtest wb: SUCCESS (0.000s)
[611.001907] Starting dynamic subtest: wc
[611.003813] Dynamic subtest wc: SUCCESS (0.000s)
[611.013206] Starting dynamic subtest: uc
[611.015060] Dynamic subtest uc: SUCCESS (0.000s)
[611.017078] Subtest mmap-offset-banned: SUCCESS (0.002s)
[611.158955] [123/133] (410s left) gem_ccs (suspend-resume)
[611.226783] Starting subtest: suspend-resume
[611.231375] Subtest suspend-resume: SKIP (0.000s)
[611.353143] [124/133] (410s left) gem_exec_schedule (smoketest-all)
[611.438043] Starting subtest: smoketest-all
[643.808940] Subtest smoketest-all: SUCCESS (32.330s)
[645.281469] [125/133] (376s left) gem_tiled_wb
[645.413479] [126/133] (376s left) gem_linear_blits (normal)
[645.629489] Starting subtest: normal
[650.573699] Subtest normal: SUCCESS (4.945s)
[650.882443] [127/133] (371s left) gen9_exec_parse (batch-without-end)
[650.983957] Subtest batch-without-end: SKIP (0.000s)
[651.068302] [128/133] (371s left) syncobj_wait (invalid-signal-zero-handles)
[651.130949] Starting subtest: invalid-signal-zero-handles
[651.133216] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[651.254429] [129/133] (371s left) gem_ctx_persistence (legacy-engines-persistence)
[651.327834] Starting subtest: legacy-engines-persistence
[651.330620] Starting dynamic subtest: render
[652.211454] Dynamic subtest render: SUCCESS (0.883s)
[652.227752] Starting dynamic subtest: bsd1
[653.021937] Dynamic subtest bsd1: SUCCESS (0.806s)
[653.037738] Starting dynamic subtest: bsd2
[653.798830] Dynamic subtest bsd2: SUCCESS (0.774s)
[653.815447] Starting dynamic subtest: blt
[654.607105] Dynamic subtest blt: SUCCESS (0.805s)
[654.622566] Starting dynamic subtest: vebox
[655.370177] Dynamic subtest vebox: SUCCESS (0.760s)
[655.373062] Subtest legacy-engines-persistence: SUCCESS (4.044s)
[655.461209] [130/133] (366s left) kms_cursor_crc (cursor-sliding-32x32)
[655.620308] Starting subtest: cursor-sliding-32x32
[655.663394] Subtest cursor-sliding-32x32: SKIP (0.039s)
[655.940820] [131/133] (366s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[656.037735] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[656.041763] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[656.180627] [132/133] (366s left) sw_sync (alloc_fence)
[656.210077] Starting subtest: alloc_fence
[656.212366] Subtest alloc_fence: SUCCESS (0.000s)
[656.271457] [133/133] (366s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[656.326257] Starting subtest: etime-multi-wait-available-unsubmitted
[656.433654] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s)
[656.506804] Closing watchdogs
results: parsing output: 0/ for test: kms_draw_crc
results: parsing output: 1/ for test: prime_mmap
results: parsing output: 2/ for test: perf_pmu
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: i915_pm_freq_mult
results: parsing output: 7/ for test: kms_vblank
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: sysfs_heartbeat_interval
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_basic
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: gem_exec_whisper
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: core_auth
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: gem_exec_schedule
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_atomic_interruptible
results: parsing output: 28/ for test: kms_pipe_crc_basic
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_pxp
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: dumb_buffer
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: prime_mmap_coherency
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_plane_cursor
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: kms_flip_scaled_crc
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: kms_chamelium_edid
results: parsing output: 50/ for test: kms_universal_plane
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: i915_suspend
results: parsing output: 53/ for test: prime_self_import
results: parsing output: 54/ for test: kms_color
results: parsing output: 55/ for test: kms_chamelium_hpd
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_panel_fitting
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_create
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: vgem_basic
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: gem_pxp
results: parsing output: 70/ for test: syncobj_eventfd
results: parsing output: 71/ for test: gem_exercise_blt
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: i915_fb_tiling
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_workarounds
results: parsing output: 76/ for test: kms_hdr
results: parsing output: 77/ for test: gem_ctx_shared
results: parsing output: 78/ for test: kms_lease
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_spin_batch
results: parsing output: 84/ for test: prime_vgem
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: api_intel_bb
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: gem_readwrite
results: parsing output: 90/ for test: api_intel_allocator
results: parsing output: 91/ for test: gem_userptr_blits
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_dirtyfb
results: parsing output: 94/ for test: kms_async_flips
results: parsing output: 95/ for test: kms_chamelium_color
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_content_protection
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_ctx_persistence
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_gttfill
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: fbdev
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: sriov_basic
results: parsing output: 117/ for test: kms_hdr
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_userptr_blits
results: parsing output: 122/ for test: gem_ccs
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: gem_tiled_wb
results: parsing output: 125/ for test: gem_linear_blits
results: parsing output: 126/ for test: gen9_exec_parse
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: sw_sync
results: parsing output: 132/ for test: syncobj_timeline
Done.