[57.803556] Initializing watchdogs
[57.803627]   /dev/watchdog0
[57.819095] [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.823238] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.825343] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.828605] [001/128] (960s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[58.004050] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[64.280360] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (6.331s)
[64.411182] [002/128] (953s left) kms_flip (wf_vblank-ts-check)
[64.510240] Starting subtest: wf_vblank-ts-check
[64.512460] Starting dynamic subtest: A-eDP1
[76.905524] Dynamic subtest A-eDP1: FAIL (11.993s)
[76.913659] Starting dynamic subtest: B-eDP1
[85.390309] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[85.399057] Starting dynamic subtest: C-eDP1
[94.309520] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[94.317316] Starting dynamic subtest: D-eDP1
[103.228909] Dynamic subtest D-eDP1: SUCCESS (8.918s)
[103.233736] Subtest wf_vblank-ts-check: FAIL (38.755s)
[104.440107] [003/128] (913s left) syncobj_eventfd (invalid-bad-flags)
[104.504325] Starting subtest: invalid-bad-flags
[104.506684] Subtest invalid-bad-flags: SUCCESS (0.000s)
[104.591274] [004/128] (913s left) gem_ctx_create (basic-files)
[104.658416] Starting subtest: basic-files
[106.669551] Subtest basic-files: SUCCESS (2.011s)
[107.991223] [005/128] (910s left) gem_eio (wait-wedge-immediate)
[108.236473] Starting subtest: wait-wedge-immediate
[110.022945] Subtest wait-wedge-immediate: SUCCESS (1.786s)
[110.177333] [006/128] (908s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[110.282853] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[110.285148] Starting dynamic subtest: pipe-A-default-mode
[110.571990] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[110.576802] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.285s)
[111.361361] [007/128] (907s left) kms_vblank (query-busy-hang)
[111.460321] Starting subtest: query-busy-hang
[111.462775] Starting dynamic subtest: pipe-A-eDP-1
[113.347940] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[113.362103] Starting dynamic subtest: pipe-D-eDP-1
[115.915890] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.566s)
[115.918754] Subtest query-busy-hang: SUCCESS (4.453s)
[116.706161] [008/128] (901s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[116.823491] Starting subtest: fbc-indfb-scaledprimary
[120.917448] Subtest fbc-indfb-scaledprimary: SUCCESS (4.097s)
[121.067685] [009/128] (897s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[121.135331] Starting subtest: single-wait-for-submit-unsubmitted
[121.238908] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[121.305850] [010/128] (897s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[121.416917] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[123.953892] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.543s)
[124.071676] [011/128] (894s left) gem_mmap_gtt (big-bo-tiledy)
[124.120865] Subtest big-bo-tiledY: SKIP (0.000s)
[124.170611] [012/128] (894s left) gem_ctx_engines (execute-allforone)
[124.229534] Starting subtest: execute-allforone
[124.241045] Subtest execute-allforone: SUCCESS (0.012s)
[125.981737] [013/128] (892s left) gem_exec_fence (syncobj-timeline-unused-fence)
[126.551671] Starting subtest: syncobj-timeline-unused-fence
[126.562409] Subtest syncobj-timeline-unused-fence: SUCCESS (0.011s)
[128.010867] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[128.014027] [014/128] (890s left) gem_exec_reloc (basic-range)
[128.081063] Subtest basic-range: SKIP (0.000s)
[128.156651] [015/128] (890s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[128.555363] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[129.370344] [016/128] (889s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[129.467058] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[129.471820] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[130.604077] [017/128] (888s left) kms_flip (2x-flip-vs-modeset)
[130.708903] Starting subtest: 2x-flip-vs-modeset
[130.720380] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[130.839740] [018/128] (887s left) drm_fdinfo (memory-info-resident)
[130.879530] Starting subtest: memory-info-resident
[130.881868] Starting dynamic subtest: smem0
[133.994407] Dynamic subtest smem0: SUCCESS (3.116s)
[133.996979] Subtest memory-info-resident: SUCCESS (3.116s)
[134.060142] [019/128] (884s left) kms_async_flips (alternate-sync-async-flip-atomic)
[134.158646] Starting subtest: alternate-sync-async-flip-atomic
[134.521542] Starting dynamic subtest: pipe-A-eDP-1
[137.293093] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.773s)
[137.672176] Starting dynamic subtest: pipe-B-eDP-1
[140.421989] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.759s)
[140.786239] Starting dynamic subtest: pipe-C-eDP-1
[143.544842] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[143.908855] Starting dynamic subtest: pipe-D-eDP-1
[146.668830] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[146.671652] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.510s)
[147.836702] [020/128] (871s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[147.935079] Starting subtest: crc-primary-basic-yf-tiled-ccs
[147.937413] Starting dynamic subtest: pipe-A-eDP-1
[147.959753] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[147.969106] Starting dynamic subtest: pipe-B-eDP-1
[147.989479] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.996048] Starting dynamic subtest: pipe-C-eDP-1
[148.017206] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[148.025131] Starting dynamic subtest: pipe-D-eDP-1
[148.046598] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[148.050988] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.004s)
[150.096236] [021/128] (868s left) sw_sync (alloc_timeline)
[150.133564] Starting subtest: alloc_timeline
[150.135922] Subtest alloc_timeline: SUCCESS (0.000s)
[150.187599] [022/128] (868s left) kms_plane_lowres (tiling-4)
[150.284998] Starting subtest: tiling-4
[150.287300] Starting dynamic subtest: pipe-A-eDP-1
[150.291731] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[150.577372] Starting dynamic subtest: pipe-B-eDP-1
[150.582084] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[150.589175] Starting dynamic subtest: pipe-C-eDP-1
[150.593825] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[150.600922] Starting dynamic subtest: pipe-D-eDP-1
[150.605056] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[150.609207] Subtest tiling-4: SKIP (0.289s)
[151.417709] [023/128] (867s left) kms_getfb (getfb2-handle-closed)
[151.480461] Starting subtest: getfb2-handle-closed
[151.482554] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[151.582474] [024/128] (867s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[151.686994] Starting subtest: plane-downscale-factor-0-75-with-rotation
[151.689350] Starting dynamic subtest: pipe-A
[152.026600] Dynamic subtest pipe-A: SUCCESS (0.340s)
[152.035514] Starting dynamic subtest: pipe-B
[153.393390] Dynamic subtest pipe-B: SUCCESS (1.366s)
[153.409669] Starting dynamic subtest: pipe-C
[154.822593] Dynamic subtest pipe-C: SUCCESS (1.429s)
[154.831458] Starting dynamic subtest: pipe-D
[156.248514] Dynamic subtest pipe-D: SUCCESS (1.425s)
[156.250987] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.561s)
[157.418623] [025/128] (861s left) gem_exec_reloc (basic-concurrent16)
[157.488768] Subtest basic-concurrent16: SKIP (0.000s)
[157.562484] [026/128] (861s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[162.572791] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[162.575245] Starting dynamic subtest: pipe-A-eDP-1
[179.750053] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.175s)
[179.758224] Starting dynamic subtest: pipe-B-eDP-1
[196.888491] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.133s)
[196.891203] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.311s)
[197.667954] [027/128] (821s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[197.776059] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[197.779836] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[197.860786] [028/128] (821s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[197.967546] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[201.559221] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (3.597s)
[201.654952] [029/128] (817s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[201.752688] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[201.756232] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[201.854142] [030/128] (817s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[201.956751] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[201.958653] Starting dynamic subtest: pipe-A-eDP-1
[202.734890] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.768s)
[202.743860] Starting dynamic subtest: pipe-B-eDP-1
[204.533448] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.797s)
[204.542051] Starting dynamic subtest: pipe-C-eDP-1
[206.373574] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.839s)
[206.381779] Starting dynamic subtest: pipe-D-eDP-1
[208.202009] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.828s)
[208.204181] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.236s)
[209.293787] [031/128] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[209.403561] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[209.407850] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[209.503128] [032/128] (809s left) kms_psr (pr-primary-page-flip)
[209.603306] Starting subtest: pr-primary-page-flip
[209.607322] Subtest pr-primary-page-flip: SKIP (0.000s)
[209.668950] [033/128] (809s left) kms_addfb_basic (basic-x-tiled-legacy)
[209.726485] Starting subtest: basic-x-tiled-legacy
[209.730761] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[209.868850] [034/128] (809s left) kms_addfb_basic (invalid-set-prop)
[209.925012] Starting subtest: invalid-set-prop
[209.926855] Subtest invalid-set-prop: SUCCESS (0.000s)
[210.081781] [035/128] (809s left) gem_ctx_param (invalid-set-ringsize)
[210.145870] Starting subtest: invalid-set-ringsize
[210.148195] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[210.219725] [036/128] (809s left) kms_chamelium_edid (dp-edid-resolution-list)
[210.617128] Subtest dp-edid-resolution-list: SKIP (0.000s)
[211.390770] [037/128] (808s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[211.526653] Starting subtest: 2x-long-flip-vs-cursor-legacy
[211.531251] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[211.656424] [038/128] (807s left) kms_pm_dc (dc6-psr)
[212.769966] Starting subtest: dc6-psr
[219.971531] Subtest dc6-psr: FAIL (6.607s)
[220.003499] [039/128] (799s left) kms_big_fb (linear-8bpp-rotate-90)
[220.120264] Starting subtest: linear-8bpp-rotate-90
[220.140780] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[220.262239] [040/128] (799s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[220.359797] Starting subtest: fbc-psr-cursor-mmap-gtt
[220.362043] Starting dynamic subtest: eDP-1
[220.366382] Dynamic subtest eDP-1: SKIP (0.000s)
[220.370817] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[220.423892] [041/128] (799s left) kms_tiled_display (basic-test-pattern)
[220.540344] Subtest basic-test-pattern: SKIP (0.000s)
[220.577618] [042/128] (799s left) syncobj_wait (wait-all-interrupted)
[220.641377] Starting subtest: wait-all-interrupted
[220.742734] Subtest wait-all-interrupted: SUCCESS (0.101s)
[220.816053] [043/128] (798s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[220.924952] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[220.928476] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[221.035152] [044/128] (798s left) kms_color (ctm-max)
[221.129706] Starting subtest: ctm-max
[221.131600] Starting dynamic subtest: pipe-A-eDP-1
[221.814612] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s)
[221.822363] Starting dynamic subtest: pipe-B-eDP-1
[223.178634] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.361s)
[223.187207] Starting dynamic subtest: pipe-C-eDP-1
[224.464038] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.284s)
[224.472065] Starting dynamic subtest: pipe-D-eDP-1
[225.792081] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[225.794199] Subtest ctm-max: SUCCESS (4.658s)
[226.617502] [045/128] (793s left) syncobj_basic (bad-pad-fd-to-handle)
[226.679592] Starting subtest: bad-pad-fd-to-handle
[226.681893] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[226.785894] [046/128] (792s left) gen7_exec_parse (basic-offset)
[226.857631] Subtest basic-offset: SKIP (0.000s)
[226.932931] [047/128] (792s left) kms_invalid_mode (overflow-vrefresh)
[227.034176] Starting subtest: overflow-vrefresh
[227.036480] Starting dynamic subtest: pipe-A-eDP-1
[227.315545] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[227.323918] Starting dynamic subtest: pipe-B-eDP-1
[227.326186] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[227.333200] Starting dynamic subtest: pipe-C-eDP-1
[227.335471] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[227.342581] Starting dynamic subtest: pipe-D-eDP-1
[227.344581] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[227.346558] Subtest overflow-vrefresh: SUCCESS (0.287s)
[228.143108] [048/128] (791s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[228.194173] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[228.196387] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[228.295955] [049/128] (791s left) syncobj_timeline (wait-any-interrupted)
[228.352542] Starting subtest: wait-any-interrupted
[228.454844] Subtest wait-any-interrupted: SUCCESS (0.102s)
[228.526438] [050/128] (791s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[228.579553] Starting subtest: multi-wait-for-submit-submitted-signaled
[228.581833] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[228.687581] [051/128] (791s left) kms_psr (psr-dpms)
[228.791311] Starting subtest: psr-dpms
[228.793610] Starting dynamic subtest: eDP-1
[231.770967] Dynamic subtest eDP-1: SUCCESS (2.978s)
[231.773357] Subtest psr-dpms: SUCCESS (2.979s)
[232.615906] [052/128] (787s left) api_intel_allocator (default-alignment)
[232.677486] Starting subtest: default-alignment
[232.682642] Subtest default-alignment: SUCCESS (0.004s)
[232.806601] [053/128] (787s left) kms_vrr (seamless-rr-switch-vrr)
[232.911814] Starting subtest: seamless-rr-switch-vrr
[232.918424] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[232.976868] [054/128] (787s left) kms_lease (lease-uevent)
[233.086079] Starting subtest: lease-uevent
[234.100874] Subtest lease-uevent: SUCCESS (1.013s)
[234.172541] [055/128] (785s left) gem_spin_batch (resubmit-all)
[234.237943] Starting subtest: resubmit-all
[234.240450] Starting dynamic subtest: rcs0
[234.250093] Dynamic subtest rcs0: SUCCESS (0.012s)
[234.258342] Starting dynamic subtest: bcs0
[234.260665] Dynamic subtest bcs0: SUCCESS (0.002s)
[234.267925] Starting dynamic subtest: vcs0
[234.269899] Dynamic subtest vcs0: SUCCESS (0.002s)
[234.276574] Starting dynamic subtest: vcs1
[234.278576] Dynamic subtest vcs1: SUCCESS (0.003s)
[234.285378] Starting dynamic subtest: vecs0
[234.287383] Dynamic subtest vecs0: SUCCESS (0.001s)
[234.294192] Starting dynamic subtest: ccs0
[234.296116] Dynamic subtest ccs0: SUCCESS (0.002s)
[234.298062] Subtest resubmit-all: SUCCESS (0.025s)
[235.981882] [056/128] (784s left) kms_cursor_legacy (torture-bo)
[236.121419] Starting subtest: torture-bo
[236.123596] Starting dynamic subtest: pipe-A
[242.549945] Dynamic subtest pipe-A: SUCCESS (6.426s)
[242.559875] Starting dynamic subtest: pipe-B
[249.360874] Dynamic subtest pipe-B: SUCCESS (6.809s)
[249.369450] Starting dynamic subtest: pipe-C
[255.963330] Dynamic subtest pipe-C: SUCCESS (6.600s)
[255.972643] Starting dynamic subtest: pipe-D
[262.253552] Dynamic subtest pipe-D: SUCCESS (6.288s)
[262.263697] Starting dynamic subtest: all-pipes
[268.306201] Dynamic subtest all-pipes: SUCCESS (6.051s)
[268.308311] Subtest torture-bo: SUCCESS (32.183s)
[268.444999] [057/128] (751s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[268.555519] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[268.560055] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[268.658366] [058/128] (751s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[268.761849] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[268.766032] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[268.869139] [059/128] (751s left) kms_plane (plane-position-covered)
[268.970826] Starting subtest: plane-position-covered
[269.485369] Starting dynamic subtest: pipe-A-plane-1
[270.752261] Dynamic subtest pipe-A-plane-1: SUCCESS (1.266s)
[270.760508] Starting dynamic subtest: pipe-A-plane-2
[271.997158] Dynamic subtest pipe-A-plane-2: SUCCESS (1.245s)
[272.005499] Starting dynamic subtest: pipe-A-plane-3
[273.204072] Dynamic subtest pipe-A-plane-3: SUCCESS (1.205s)
[273.212362] Starting dynamic subtest: pipe-A-plane-4
[274.427994] Dynamic subtest pipe-A-plane-4: SUCCESS (1.222s)
[274.434945] Starting dynamic subtest: pipe-A-plane-5
[274.468107] Dynamic subtest pipe-A-plane-5: SUCCESS (0.040s)
[275.573678] Starting dynamic subtest: pipe-B-plane-1
[276.807683] Dynamic subtest pipe-B-plane-1: SUCCESS (1.240s)
[276.815839] Starting dynamic subtest: pipe-B-plane-2
[278.107479] Dynamic subtest pipe-B-plane-2: SUCCESS (1.297s)
[278.115929] Starting dynamic subtest: pipe-B-plane-3
[279.336187] Dynamic subtest pipe-B-plane-3: SUCCESS (1.229s)
[279.344043] Starting dynamic subtest: pipe-B-plane-4
[280.576213] Dynamic subtest pipe-B-plane-4: SUCCESS (1.240s)
[280.584178] Starting dynamic subtest: pipe-B-plane-5
[280.620788] Dynamic subtest pipe-B-plane-5: SUCCESS (0.043s)
[280.622631] Subtest plane-position-covered: SUCCESS (11.647s)
[281.367673] [060/128] (738s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[281.463834] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[281.466199] Starting dynamic subtest: pipe-A-eDP-1
[281.486749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[281.496315] Starting dynamic subtest: pipe-B-eDP-1
[281.516050] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[281.523856] Starting dynamic subtest: pipe-C-eDP-1
[281.543731] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[281.551464] Starting dynamic subtest: pipe-D-eDP-1
[281.571178] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[281.573373] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[283.621511] [061/128] (736s left) gem_mmap_gtt (basic-write-read-distinct)
[283.670526] Subtest basic-write-read-distinct: SKIP (0.000s)
[283.723403] [062/128] (736s left) i915_pm_rps (thresholds-idle)
[283.787204] Starting subtest: thresholds-idle
[283.791816] Subtest thresholds-idle: SKIP (0.000s)
[283.858825] [063/128] (736s left) i915_pm_freq_api (freq-reset)
[283.920848] Starting subtest: freq-reset
[283.923201] Starting dynamic subtest: gt0
[284.115527] Dynamic subtest gt0: SUCCESS (0.192s)
[284.123537] Starting dynamic subtest: gt1
[284.288229] Dynamic subtest gt1: SUCCESS (0.171s)
[284.290997] Subtest freq-reset: SUCCESS (0.366s)
[284.355019] [064/128] (736s left) perf_pmu (busy-idle-check-all)
[284.396479] Starting subtest: busy-idle-check-all
[284.398422] Starting dynamic subtest: rcs0
[285.070717] Dynamic subtest rcs0: SUCCESS (0.677s)
[285.081293] Starting dynamic subtest: bcs0
[285.723686] Dynamic subtest bcs0: SUCCESS (0.651s)
[285.735955] Starting dynamic subtest: vcs0
[286.956382] Dynamic subtest vcs0: SUCCESS (1.229s)
[286.967107] Starting dynamic subtest: vcs1
[288.939429] Dynamic subtest vcs1: SUCCESS (1.980s)
[288.950107] Starting dynamic subtest: vecs0
[290.923537] Dynamic subtest vecs0: SUCCESS (1.982s)
[290.934315] Starting dynamic subtest: ccs0
[291.580910] Dynamic subtest ccs0: SUCCESS (0.657s)
[291.583684] Subtest busy-idle-check-all: SUCCESS (7.187s)
[291.671943] [065/128] (728s left) kms_rotation_crc (bad-tiling)
[291.772777] Starting subtest: bad-tiling
[291.777242] Subtest bad-tiling: SKIP (0.001s)
[291.843055] [066/128] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[291.945359] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[291.949827] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[292.052892] [067/128] (728s left) kms_content_protection (atomic)
[292.232888] Starting subtest: atomic
[295.574926] Subtest atomic: SKIP (3.340s)
[296.738854] [068/128] (723s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[296.836553] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[296.840872] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[296.920629] [069/128] (723s left) gem_exec_reloc (basic-write-read-noreloc)
[296.983245] Subtest basic-write-read-noreloc: SKIP (0.000s)
[297.057783] [070/128] (723s left) gem_exec_schedule (preempt-queue-chain)
[297.135662] Subtest preempt-queue-chain: SKIP (0.000s)
[297.414760] [071/128] (723s left) gem_exec_reloc (basic-write-read-active)
[297.481643] Subtest basic-write-read-active: SKIP (0.000s)
[297.546834] [072/128] (723s left) gem_exec_fence (long-history)
[297.973074] Starting subtest: long-history
[305.650578] Subtest long-history: SUCCESS (7.678s)
[306.116723] [073/128] (714s left) kms_cursor_crc (cursor-random-64x64)
[306.270383] Starting subtest: cursor-random-64x64
[306.275175] Starting dynamic subtest: pipe-A-eDP-1
[309.924783] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.650s)
[309.953761] Starting dynamic subtest: pipe-D-eDP-1
[314.220681] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.271s)
[314.222729] Subtest cursor-random-64x64: SUCCESS (7.947s)
[315.082826] [074/128] (705s left) api_intel_bb (object-noreloc-keep-cache-simple)
[315.139983] Starting subtest: object-noreloc-keep-cache-simple
[315.142215] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[315.265278] [075/128] (705s left) i915_query (query-topology-matches-eu-total)
[315.324749] Starting subtest: query-topology-matches-eu-total
[315.327159] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[315.420617] [076/128] (705s left) gem_exec_schedule (u-fairslice-all)
[315.489169] Starting subtest: u-fairslice-all
[317.545889] Subtest u-fairslice-all: SUCCESS (2.060s)
[317.834424] [077/128] (702s left) sw_sync (sync_busy_fork)
[317.874650] Starting subtest: sync_busy_fork
[318.888396] Subtest sync_busy_fork: SUCCESS (1.014s)
[318.946626] [078/128] (701s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[323.934078] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[323.936863] Starting dynamic subtest: pipe-A-eDP-1
[324.736887] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s)
[324.745360] Starting dynamic subtest: pipe-B-eDP-1
[325.858681] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[325.862984] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.922s)
[327.039414] [079/128] (693s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[327.143699] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[332.052126] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.911s)
[332.159651] [080/128] (688s left) gen3_render_tiledy_blits
[332.267875] [081/128] (688s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[332.320095] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[332.322382] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[332.423756] [082/128] (688s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[332.536631] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[332.540816] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[332.635863] [083/128] (688s left) gem_exec_create (madvise)
[332.695836] Starting subtest: madvise
[332.698177] Starting dynamic subtest: smem
[353.014382] Dynamic subtest smem: SUCCESS (20.295s)
[353.016550] Subtest madvise: SUCCESS (20.295s)
[353.698010] [084/128] (667s left) gem_exec_create (forked)
[353.776678] Starting subtest: forked
[353.779169] Starting dynamic subtest: smem
[375.916657] Dynamic subtest smem: SUCCESS (22.137s)
[375.919727] Subtest forked: SUCCESS (22.138s)
[376.097447] [085/128] (645s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[376.197429] Starting subtest: yf-tiled-64bpp-rotate-0
[376.201479] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[376.302071] [086/128] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[376.409547] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[376.413953] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[376.527102] [087/128] (644s left) gem_ccs (block-copy-uncompressed)
[376.589522] Starting subtest: block-copy-uncompressed
[376.591851] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[376.612861] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s)
[376.623152] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[376.631073] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[376.638857] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[376.648875] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[376.656472] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[376.667019] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[376.669350] Subtest block-copy-uncompressed: SUCCESS (0.078s)
[376.801298] [088/128] (644s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[376.911924] Starting subtest: fbc-pr-sprite-mmap-cpu
[376.916378] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[376.976881] [089/128] (644s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[377.090063] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[377.093435] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[377.198611] [090/128] (644s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[377.304845] Starting subtest: 4-tiled-64bpp-rotate-0
[379.599473] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (2.294s)
[379.841965] [091/128] (641s left) kms_flip (2x-flip-vs-suspend)
[379.949231] Starting subtest: 2x-flip-vs-suspend
[379.960714] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[380.037639] [092/128] (641s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[380.102740] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[380.168760] [093/128] (641s left) gem_flink_race (flink_close)
[380.203716] Starting subtest: flink_close
[385.305353] Subtest flink_close: SUCCESS (5.104s)
[385.376172] [094/128] (636s left) gen9_exec_parse (allowed-single)
[385.446649] Subtest allowed-single: SKIP (0.000s)
[385.537811] [095/128] (635s left) prime_busy (after-wait)
[385.601419] Starting subtest: after-wait
[385.607459] Starting dynamic subtest: rcs0
[385.636752] Dynamic subtest rcs0: SUCCESS (0.030s)
[385.646437] Starting dynamic subtest: bcs0
[385.715512] Dynamic subtest bcs0: SUCCESS (0.078s)
[385.725561] Starting dynamic subtest: vcs0
[385.757342] Dynamic subtest vcs0: SUCCESS (0.041s)
[385.768209] Starting dynamic subtest: vcs1
[385.799200] Dynamic subtest vcs1: SUCCESS (0.042s)
[385.808915] Starting dynamic subtest: vecs0
[385.840913] Dynamic subtest vecs0: SUCCESS (0.041s)
[385.849385] Starting dynamic subtest: ccs0
[385.882625] Dynamic subtest ccs0: SUCCESS (0.041s)
[385.992056] Subtest after-wait: SUCCESS (0.389s)
[386.066845] [096/128] (635s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[386.139136] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[386.143731] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[386.321832] [097/128] (635s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[386.388478] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[386.449864] [098/128] (635s left) gem_workarounds (reset)
[386.522451] Starting subtest: reset
[386.726346] Subtest reset: SUCCESS (0.204s)
[386.867856] [099/128] (634s left) gem_exec_balancer (individual)
[386.938619] Starting subtest: individual
[388.933587] Subtest individual: SUCCESS (1.993s)
[389.187870] [100/128] (632s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[389.307466] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[390.164652] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.859s)
[390.344843] [101/128] (631s left) gem_ctx_persistence (legacy-engines-cleanup)
[390.415324] Starting subtest: legacy-engines-cleanup
[390.417616] Starting dynamic subtest: render
[390.491702] Dynamic subtest render: SUCCESS (0.075s)
[390.502527] Starting dynamic subtest: bsd1
[390.596717] Dynamic subtest bsd1: SUCCESS (0.104s)
[390.607604] Starting dynamic subtest: bsd2
[390.662890] Dynamic subtest bsd2: SUCCESS (0.064s)
[390.673100] Starting dynamic subtest: blt
[390.722707] Dynamic subtest blt: SUCCESS (0.058s)
[390.733469] Starting dynamic subtest: vebox
[390.786717] Dynamic subtest vebox: SUCCESS (0.061s)
[390.789401] Subtest legacy-engines-cleanup: SUCCESS (0.372s)
[390.861142] [102/128] (630s left) kms_force_connector_basic (force-edid)
[390.944640] Starting subtest: force-edid
[391.278919] Subtest force-edid: SUCCESS (0.335s)
[391.420633] [103/128] (630s left) gem_exec_whisper (basic-contexts-forked-all)
[391.494484] Starting subtest: basic-contexts-forked-all
[412.110892] Subtest basic-contexts-forked-all: SUCCESS (20.611s)
[412.286407] [104/128] (609s left) gem_lmem_evict (dontneed-evict-race)
[412.342144] Subtest dontneed-evict-race: SKIP (0.000s)
[412.381405] [105/128] (609s left) kms_psr (pr-primary-render)
[412.486034] Starting subtest: pr-primary-render
[412.490386] Subtest pr-primary-render: SKIP (0.000s)
[412.554395] [106/128] (609s left) api_intel_bb (full-batch)
[412.617749] Starting subtest: full-batch
[412.620930] Subtest full-batch: SUCCESS (0.006s)
[412.712014] [107/128] (609s left) gem_exec_reloc (basic-gtt-active)
[412.783356] Subtest basic-gtt-active: SKIP (0.000s)
[412.845865] [108/128] (609s left) kms_flip (flip-vs-expired-vblank-interruptible)
[412.955433] Starting subtest: flip-vs-expired-vblank-interruptible
[412.960251] Starting dynamic subtest: A-eDP1
[421.685354] Dynamic subtest A-eDP1: SUCCESS (8.726s)
[421.695124] Starting dynamic subtest: B-eDP1
[430.386084] Dynamic subtest B-eDP1: SUCCESS (8.699s)
[430.396393] Starting dynamic subtest: C-eDP1
[439.074297] Dynamic subtest C-eDP1: SUCCESS (8.687s)
[439.082962] Starting dynamic subtest: D-eDP1
[447.774399] Dynamic subtest D-eDP1: SUCCESS (8.698s)
[447.776784] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.819s)
[449.004667] [109/128] (572s left) dmabuf_sync_file (export-basic)
[449.051019] Starting subtest: export-basic
[449.053162] Subtest export-basic: SUCCESS (0.001s)
[449.106657] [110/128] (572s left) gem_userptr_blits (sync-unmap)
[449.170731] Starting subtest: sync-unmap
[449.184921] Subtest sync-unmap: SUCCESS (0.013s)
[449.304469] [111/128] (572s left) syncobj_timeline (32bits-limit)
[449.361192] Starting subtest: 32bits-limit
[449.363506] Subtest 32bits-limit: SUCCESS (0.001s)
[449.464580] [112/128] (572s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[449.528010] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[449.532448] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[449.706465] [113/128] (572s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[449.806755] Starting subtest: x-tiled-8bpp-rotate-90
[449.827094] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[449.945397] [114/128] (572s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[450.042436] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[450.046638] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[450.139602] [115/128] (572s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[450.192803] Starting subtest: single-wait-all-for-submit-available-submitted
[450.195096] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[450.305483] [116/128] (571s left) gem_mmap (pf-nonblock)
[450.351603] Subtest pf-nonblock: SKIP (0.000s)
[450.413983] [117/128] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[450.518585] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[454.839849] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.325s)
[454.959875] [118/128] (567s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[455.072594] Starting subtest: psr-rgb565-draw-render
[460.012181] Subtest psr-rgb565-draw-render: SUCCESS (4.943s)
[460.164338] [119/128] (562s left) kms_cursor_crc (cursor-sliding-512x512)
[460.423907] Starting subtest: cursor-sliding-512x512
[460.428905] Subtest cursor-sliding-512x512: SKIP (0.001s)
[460.589803] [120/128] (561s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[460.687144] Starting subtest: bad-rotation-90-yf-tiled-ccs
[460.689491] Starting dynamic subtest: pipe-A-eDP-1
[460.711815] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[460.720547] Starting dynamic subtest: pipe-B-eDP-1
[460.741194] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[460.749097] Starting dynamic subtest: pipe-C-eDP-1
[460.770362] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[460.778142] Starting dynamic subtest: pipe-D-eDP-1
[460.801098] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[460.805460] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[462.903507] [121/128] (559s left) kms_pm_dc (dc3co-vpb-simulation)
[464.007055] Starting subtest: dc3co-vpb-simulation
[473.353647] Subtest dc3co-vpb-simulation: SKIP (9.343s)
[473.479832] [122/128] (548s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[473.577414] Starting subtest: psr-dirtyfb-ioctl
[473.579802] Starting dynamic subtest: A-eDP-1
[475.423182] Dynamic subtest A-eDP-1: SUCCESS (1.843s)
[475.425533] Subtest psr-dirtyfb-ioctl: SUCCESS (1.844s)
[476.202367] [123/128] (546s left) gem_pxp (reject-modify-context-protection-off-1)
[476.333070] Starting subtest: reject-modify-context-protection-off-1
[476.335726] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[476.449378] [124/128] (546s left) perf (polling)
[476.563584] Starting subtest: polling
[476.565581] Starting dynamic subtest: 0-rcs0
[486.596676] Dynamic subtest 0-rcs0: SUCCESS (10.032s)
[486.605081] Starting dynamic subtest: 1-vecs0
[496.616067] Dynamic subtest 1-vecs0: SUCCESS (10.018s)
[496.618920] Subtest polling: SUCCESS (20.052s)
[496.659510] [125/128] (525s left) gem_exec_reloc (basic-write-gtt-noreloc)
[496.722493] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[496.794485] [126/128] (525s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[496.900346] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[497.007072] [127/128] (525s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[497.112122] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[502.376725] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.267s)
[502.507144] [128/128] (520s left) gem_mmap_wc (read-write)
[502.575118] Subtest read-write: SKIP (0.000s)
[502.624675] Closing watchdogs
Done.