[61.068379] Initializing watchdogs
[61.068463]   /dev/watchdog0
[61.086295] [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]
[61.090792] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.093259] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.096186] [001/133] (960s left) kms_draw_crc (draw-method-blt)
[61.194732] Starting subtest: draw-method-blt
[61.195644] Starting dynamic subtest: xrgb8888-untiled
[61.438516] Dynamic subtest xrgb8888-untiled: SUCCESS (0.243s)
[61.449174] Starting dynamic subtest: rgb565-untiled
[61.682149] Dynamic subtest rgb565-untiled: SUCCESS (0.243s)
[61.690150] Starting dynamic subtest: xrgb2101010-untiled
[61.904550] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[61.910600] Starting dynamic subtest: xbgr16161616f-untiled
[62.127749] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[62.133532] Starting dynamic subtest: xrgb8888-xtiled
[62.237569] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[62.243608] Starting dynamic subtest: rgb565-xtiled
[62.359842] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[62.365449] Starting dynamic subtest: xrgb2101010-xtiled
[62.470943] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[62.477882] Starting dynamic subtest: xbgr16161616f-xtiled
[62.582388] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[62.590591] Starting dynamic subtest: xrgb8888-4tiled
[62.693200] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.111s)
[62.699696] Starting dynamic subtest: rgb565-4tiled
[62.815695] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[62.825193] Starting dynamic subtest: xrgb2101010-4tiled
[62.926601] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[62.933452] Starting dynamic subtest: xbgr16161616f-4tiled
[63.026605] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.100s)
[63.027496] Subtest draw-method-blt: SUCCESS (1.833s)
[63.167470] [002/133] (958s left) prime_mmap (test_reprime)
[63.227053] Starting subtest: test_reprime
[63.227985] Starting dynamic subtest: test_reprime-smem
[63.258848] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[63.259865] Subtest test_reprime: SUCCESS (0.032s)
[63.359624] [003/133] (958s left) perf_pmu (busy)
[63.394447] Starting subtest: busy
[63.395482] Starting dynamic subtest: rcs0
[64.019322] Dynamic subtest rcs0: SUCCESS (0.624s)
[64.028185] Starting dynamic subtest: bcs0
[64.589540] Dynamic subtest bcs0: SUCCESS (0.569s)
[64.598064] Starting dynamic subtest: vcs0
[65.949813] Dynamic subtest vcs0: SUCCESS (1.349s)
[65.958490] Starting dynamic subtest: vcs1
[67.933242] Dynamic subtest vcs1: SUCCESS (1.982s)
[67.942457] Starting dynamic subtest: vecs0
[69.917026] Dynamic subtest vecs0: SUCCESS (1.984s)
[69.925172] Starting dynamic subtest: ccs0
[70.475078] Dynamic subtest ccs0: SUCCESS (0.566s)
[70.476134] Subtest busy: SUCCESS (7.081s)
[70.591591] [004/133] (951s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[70.694918] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[70.706635] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[70.832351] [005/133] (950s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[70.937137] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[70.938167] Starting dynamic subtest: pipe-A-eDP-1
[70.946985] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[70.956587] Starting dynamic subtest: pipe-B-eDP-1
[70.965651] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[70.973067] Starting dynamic subtest: pipe-C-eDP-1
[70.981064] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[70.986865] Starting dynamic subtest: pipe-D-eDP-1
[70.995323] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[70.997063] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[73.169054] [006/133] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[73.275350] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[77.578372] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.303s)
[78.749450] [007/133] (943s left) i915_pm_freq_mult (media-freq)
[78.815267] Starting subtest: media-freq
[78.816743] Starting dynamic subtest: gt0
[78.819124] Dynamic subtest gt0: SKIP (0.000s)
[78.831873] Starting dynamic subtest: gt1
[78.833986] Dynamic subtest gt1: SKIP (0.000s)
[78.836053] Subtest media-freq: SKIP (0.001s)
[78.908042] [008/133] (942s left) kms_vblank (ts-continuation-modeset-hang)
[79.003121] Starting subtest: ts-continuation-modeset-hang
[79.003970] Starting dynamic subtest: pipe-A-eDP-1
[106.657195] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.652s)
[106.668163] Starting dynamic subtest: pipe-D-eDP-1
[121.689107] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.026s)
[121.690081] Subtest ts-continuation-modeset-hang: SUCCESS (42.685s)
[122.569513] [009/133] (899s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[122.654980] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[122.655998] Starting dynamic subtest: pipe-A-eDP-1
[122.718853] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[122.725953] Starting dynamic subtest: pipe-B-eDP-1
[122.784142] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.065s)
[122.791065] Starting dynamic subtest: pipe-C-eDP-1
[122.848996] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.064s)
[122.855754] Starting dynamic subtest: pipe-D-eDP-1
[122.910813] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[122.911911] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.256s)
[125.148335] [010/133] (896s left) kms_psr (psr2-cursor-plane-move)
[125.238352] Starting subtest: psr2-cursor-plane-move
[125.239349] Starting dynamic subtest: eDP-1
[126.901617] Dynamic subtest eDP-1: SUCCESS (1.663s)
[126.902565] Subtest psr2-cursor-plane-move: SUCCESS (1.664s)
[127.697355] [011/133] (894s left) sysfs_heartbeat_interval (nopreempt)
[127.752281] Starting subtest: nopreempt
[127.753357] Starting dynamic subtest: vecs0
[136.950307] Dynamic subtest vecs0: SUCCESS (9.188s)
[136.959080] Starting dynamic subtest: ccs0
[140.986539] Dynamic subtest ccs0: SUCCESS (4.044s)
[140.995926] Starting dynamic subtest: vcs0
[149.934909] Dynamic subtest vcs0: SUCCESS (8.947s)
[149.944651] Starting dynamic subtest: bcs0
[153.974986] Dynamic subtest bcs0: SUCCESS (4.037s)
[153.983927] Starting dynamic subtest: rcs0
[158.104198] Dynamic subtest rcs0: SUCCESS (4.127s)
[158.113154] Starting dynamic subtest: vcs1
[167.920850] Dynamic subtest vcs1: SUCCESS (9.817s)
[167.921934] Subtest nopreempt: SUCCESS (40.168s)
[168.006300] [012/133] (853s left) kms_flip (nonexisting-fb-interruptible)
[168.114272] Starting subtest: nonexisting-fb-interruptible
[168.116513] Starting dynamic subtest: A-eDP1
[169.289220] Dynamic subtest A-eDP1: SUCCESS (1.173s)
[169.296879] Starting dynamic subtest: B-eDP1
[170.425769] Dynamic subtest B-eDP1: SUCCESS (1.136s)
[170.432882] Starting dynamic subtest: C-eDP1
[171.553761] Dynamic subtest C-eDP1: SUCCESS (1.127s)
[171.563971] Starting dynamic subtest: D-eDP1
[172.684225] Dynamic subtest D-eDP1: SUCCESS (1.130s)
[172.686447] Subtest nonexisting-fb-interruptible: SUCCESS (4.572s)
[173.961218] [013/133] (848s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[174.055342] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[174.056201] Starting dynamic subtest: pipe-A-eDP-1
[190.414484] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.676s)
[190.422880] Starting dynamic subtest: pipe-B-eDP-1
[208.377791] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.822s)
[208.392966] Starting dynamic subtest: pipe-C-eDP-1
[226.354121] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.726s)
[226.364592] Starting dynamic subtest: pipe-D-eDP-1
[244.340924] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.724s)
[244.341971] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.953s)
[250.646730] [014/133] (776s left) gem_basic (create-fd-close)
[250.715106] Starting subtest: create-fd-close
[250.718031] Subtest create-fd-close: SUCCESS (0.000s)
[250.825665] [015/133] (776s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[250.884513] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[250.886804] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[251.078542] [016/133] (776s left) gem_exec_whisper (basic-fds)
[251.138155] Starting subtest: basic-fds
[259.201861] Subtest basic-fds: SUCCESS (8.049s)
[259.383166] [017/133] (767s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[259.485454] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[259.487914] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[259.604278] [018/133] (767s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[259.694404] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[259.696561] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[259.782452] [019/133] (767s left) core_auth (many-magics)
[259.825934] Starting subtest: many-magics
[260.705200] Subtest many-magics: SUCCESS (0.881s)
[260.921290] [020/133] (766s left) kms_cursor_crc (cursor-offscreen-128x42)
[261.139489] Starting subtest: cursor-offscreen-128x42
[261.184135] Subtest cursor-offscreen-128x42: SKIP (0.042s)
[261.403363] [021/133] (765s left) perf (mi-rpc)
[261.524533] Starting subtest: mi-rpc
[261.526554] Subtest mi-rpc: SKIP (0.000s)
[261.554782] [022/133] (765s left) gem_exec_schedule (u-fairslice-all)
[261.614468] Starting subtest: u-fairslice-all
[263.679661] Subtest u-fairslice-all: SUCCESS (2.064s)
[263.986012] [023/133] (763s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[264.077479] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[264.079320] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[264.172221] [024/133] (763s left) kms_psr (psr-primary-mmap-cpu)
[264.263823] Starting subtest: psr-primary-mmap-cpu
[264.264941] Starting dynamic subtest: eDP-1
[265.990664] Dynamic subtest eDP-1: SUCCESS (1.726s)
[265.991986] Subtest psr-primary-mmap-cpu: SUCCESS (1.727s)
[266.860088] [025/133] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[266.959329] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[266.961072] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[267.074379] [026/133] (760s left) gem_exec_balancer (sliced)
[267.127910] Starting subtest: sliced
[267.130413] Subtest sliced: SKIP (0.000s)
[267.440342] [027/133] (760s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[267.536437] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[267.546638] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[267.665846] [028/133] (759s left) kms_atomic_interruptible (legacy-cursor)
[267.758648] Starting subtest: legacy-cursor
[267.759644] Starting dynamic subtest: pipe-A-eDP-1
[275.193463] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.430s)
[275.194987] Subtest legacy-cursor: SUCCESS (7.431s)
[276.039091] [029/133] (751s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[276.125497] Starting subtest: nonblocking-crc-frame-sequence
[276.126557] Starting dynamic subtest: pipe-A-eDP-1
[276.858983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s)
[276.868135] Starting dynamic subtest: pipe-B-eDP-1
[278.250942] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.390s)
[278.259461] Starting dynamic subtest: pipe-C-eDP-1
[279.650023] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[279.658144] Starting dynamic subtest: pipe-D-eDP-1
[281.086598] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.435s)
[281.087704] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.961s)
[281.969261] [030/133] (745s left) kms_psr (fbc-psr-sprite-blt)
[282.067769] Starting subtest: fbc-psr-sprite-blt
[282.068767] Starting dynamic subtest: eDP-1
[282.070583] Dynamic subtest eDP-1: SKIP (0.000s)
[282.072318] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[282.148274] [031/133] (745s left) gem_pxp (create-protected-buffer)
[282.278655] Starting subtest: create-protected-buffer
[282.279972] Subtest create-protected-buffer: SUCCESS (0.000s)
[282.418512] [032/133] (745s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[282.525315] Starting subtest: psr-rgb101010-draw-blt
[289.935562] Subtest psr-rgb101010-draw-blt: SUCCESS (7.411s)
[290.041524] [033/133] (737s left) dumb_buffer (invalid-bpp)
[290.099050] Starting subtest: invalid-bpp
[290.100612] Subtest invalid-bpp: SUCCESS (0.000s)
[290.211356] [034/133] (737s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[290.310101] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[290.311925] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[290.425053] [035/133] (737s left) kms_flip (plain-flip-ts-check)
[290.522514] Starting subtest: plain-flip-ts-check
[290.525460] Starting dynamic subtest: A-eDP1
[299.393106] Dynamic subtest A-eDP1: SUCCESS (8.844s)
[299.401932] Starting dynamic subtest: B-eDP1
[308.225374] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[308.236321] Starting dynamic subtest: C-eDP1
[317.058361] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[317.069400] Starting dynamic subtest: D-eDP1
[325.859418] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[325.861478] Subtest plain-flip-ts-check: SUCCESS (35.337s)
[327.040026] [036/133] (700s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[327.155377] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[327.157375] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[327.235987] [037/133] (700s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[327.301029] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[327.302463] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[327.418268] [038/133] (700s left) prime_mmap_coherency (ioctl-errors)
[327.485676] Starting subtest: ioctl-errors
[347.919970] Subtest ioctl-errors: SUCCESS (20.433s)
[348.077082] [039/133] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[348.224880] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[354.983035] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.759s)
[355.146477] [040/133] (672s left) kms_addfb_basic (basic-y-tiled-legacy)
[355.207455] Starting subtest: basic-y-tiled-legacy
[355.209996] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[355.356713] [041/133] (672s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[355.423639] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[355.424962] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[355.535760] [042/133] (672s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[355.622775] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[362.360491] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.739s)
[362.478505] [043/133] (665s left) syncobj_timeline (wait-all-for-submit-snapshot)
[362.528162] Starting subtest: wait-all-for-submit-snapshot
[362.610409] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[362.690364] [044/133] (665s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[362.796556] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[363.666501] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.870s)
[363.845502] [045/133] (664s left) kms_psr (psr2-cursor-blt)
[363.943782] Starting subtest: psr2-cursor-blt
[363.944976] Starting dynamic subtest: eDP-1
[365.641399] Dynamic subtest eDP-1: SUCCESS (1.698s)
[365.642379] Subtest psr2-cursor-blt: SUCCESS (1.699s)
[366.444769] [046/133] (661s left) kms_plane_cursor (primary)
[366.534801] Starting subtest: primary
[366.537508] Starting dynamic subtest: pipe-A-eDP-1-size-64
[369.086878] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.553s)
[369.113842] Starting dynamic subtest: pipe-A-eDP-1-size-128
[371.643589] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.538s)
[371.670407] Starting dynamic subtest: pipe-A-eDP-1-size-256
[374.199761] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[374.512338] Starting dynamic subtest: pipe-B-eDP-1-size-64
[377.815718] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.312s)
[377.844940] Starting dynamic subtest: pipe-B-eDP-1-size-128
[380.372417] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.538s)
[380.398454] Starting dynamic subtest: pipe-B-eDP-1-size-256
[382.940160] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.549s)
[383.260126] Starting dynamic subtest: pipe-C-eDP-1-size-64
[386.182843] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.931s)
[386.211166] Starting dynamic subtest: pipe-C-eDP-1-size-128
[388.404829] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[388.431968] Starting dynamic subtest: pipe-C-eDP-1-size-256
[390.615496] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[390.932826] Starting dynamic subtest: pipe-D-eDP-1-size-64
[393.795738] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.872s)
[393.823473] Starting dynamic subtest: pipe-D-eDP-1-size-128
[395.996198] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.180s)
[396.023826] Starting dynamic subtest: pipe-D-eDP-1-size-256
[398.206861] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[398.513421] Subtest primary: SUCCESS (31.977s)
[399.350306] [047/133] (628s left) gem_exec_balancer (full-late)
[399.424494] Starting subtest: full-late
[404.106853] Subtest full-late: SUCCESS (4.682s)
[404.396903] [048/133] (623s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[404.503568] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[404.505979] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[404.585732] [049/133] (623s left) kms_pm_rpm (fences-dpms)
[406.405401] Starting subtest: fences-dpms
[406.407573] Subtest fences-dpms: SKIP (0.000s)
[406.901644] [050/133] (621s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[407.278973] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[408.073295] [051/133] (620s left) kms_universal_plane (disable-primary-vs-flip)
[408.170155] Starting subtest: disable-primary-vs-flip
[408.171552] Starting dynamic subtest: pipe-A-eDP-1
[409.662823] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.491s)
[409.677616] Starting dynamic subtest: pipe-B-eDP-1
[411.811737] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.147s)
[411.826960] Starting dynamic subtest: pipe-C-eDP-1
[413.983469] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.171s)
[413.992654] Starting dynamic subtest: pipe-D-eDP-1
[416.157914] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.172s)
[416.159056] Subtest disable-primary-vs-flip: SUCCESS (7.987s)
[416.957204] [052/133] (611s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[417.047031] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[417.048104] Starting dynamic subtest: pipe-A-eDP-1
[428.049158] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.004s)
[428.058223] Starting dynamic subtest: pipe-B-eDP-1
[439.770002] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.718s)
[439.770911] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.725s)
[440.618271] [053/133] (587s left) i915_suspend (sysfs-reader)
[440.666797] Starting subtest: sysfs-reader
[459.188500] Subtest sysfs-reader: SUCCESS (3.707s)
[467.326942] [054/133] (569s left) prime_self_import (basic-with_fd_dup)
[467.376371] Starting subtest: basic-with_fd_dup
[467.396824] Subtest basic-with_fd_dup: SUCCESS (0.023s)
[467.513619] [055/133] (568s left) kms_color (invalid-ctm-matrix-sizes)
[467.613387] Starting subtest: invalid-ctm-matrix-sizes
[467.614373] Starting dynamic subtest: pipe-A
[467.615341] Dynamic subtest pipe-A: SUCCESS (0.002s)
[467.624719] Starting dynamic subtest: pipe-B
[467.625648] Dynamic subtest pipe-B: SUCCESS (0.003s)
[467.634319] Starting dynamic subtest: pipe-C
[467.635222] Dynamic subtest pipe-C: SUCCESS (0.003s)
[467.643890] Starting dynamic subtest: pipe-D
[467.644738] Dynamic subtest pipe-D: SUCCESS (0.004s)
[467.645524] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[467.707472] [056/133] (568s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[468.093889] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[468.872371] [057/133] (567s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[468.972514] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[475.727832] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.747s)
[475.897257] [058/133] (560s left) kms_panel_fitting (atomic-fastset)
[475.994282] Starting subtest: atomic-fastset
[475.995137] Starting dynamic subtest: pipe-A-eDP-1
[476.148150] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.153s)
[476.159169] Starting dynamic subtest: pipe-B-eDP-1
[477.407151] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.257s)
[477.418023] Starting dynamic subtest: pipe-C-eDP-1
[478.610057] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.201s)
[478.620573] Starting dynamic subtest: pipe-D-eDP-1
[479.736243] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[479.737149] Subtest atomic-fastset: SUCCESS (3.740s)
[480.994635] [059/133] (555s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[481.047304] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[481.048233] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[481.143787] [060/133] (555s left) gem_create (create-invalid-size)
[481.197281] Starting subtest: create-invalid-size
[481.198154] Subtest create-invalid-size: SUCCESS (0.000s)
[481.395581] [061/133] (555s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[481.656076] Starting subtest: cursor-rapid-movement-512x170
[481.657871] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[481.819956] [062/133] (554s left) vgem_basic (setversion)
[481.943571] Starting subtest: setversion
[481.945203] Subtest setversion: SUCCESS (0.000s)
[482.026781] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[482.028848] [063/133] (554s left) kms_psr (fbc-pr-sprite-plane-move)
[482.118316] Starting subtest: fbc-pr-sprite-plane-move
[482.119980] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[482.211358] [064/133] (554s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[482.311953] Starting subtest: plane-upscale-20x20-with-pixel-format
[482.312909] Starting dynamic subtest: pipe-A
[483.362027] Dynamic subtest pipe-A: SUCCESS (1.050s)
[483.374013] Starting dynamic subtest: pipe-B
[485.494162] Dynamic subtest pipe-B: SUCCESS (2.130s)
[485.503582] Starting dynamic subtest: pipe-C
[486.702721] Dynamic subtest pipe-C: SUCCESS (1.207s)
[486.711562] Starting dynamic subtest: pipe-D
[487.939351] Dynamic subtest pipe-D: SUCCESS (1.235s)
[487.940364] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.626s)
[489.159055] [065/133] (547s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[489.264242] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[496.792637] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.527s)
[496.970148] [066/133] (539s left) i915_drm_fdinfo (busy-check-all)
[497.008062] Starting subtest: busy-check-all
[497.008928] Starting dynamic subtest: rcs0
[497.013310] Dynamic subtest rcs0: SKIP (0.004s)
[497.022042] Starting dynamic subtest: bcs0
[497.023814] Dynamic subtest bcs0: SKIP (0.000s)
[497.032202] Starting dynamic subtest: vcs0
[497.033846] Dynamic subtest vcs0: SKIP (0.000s)
[497.042468] Starting dynamic subtest: vcs1
[497.044170] Dynamic subtest vcs1: SKIP (0.000s)
[497.052500] Starting dynamic subtest: vecs0
[497.054182] Dynamic subtest vecs0: SKIP (0.000s)
[497.062427] Starting dynamic subtest: ccs0
[497.064237] Dynamic subtest ccs0: SKIP (0.000s)
[497.065820] Subtest busy-check-all: SKIP (0.009s)
[497.099485] [067/133] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[497.204419] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[497.206182] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[497.311001] [068/133] (539s left) kms_plane (plane-position-covered)
[497.416214] Starting subtest: plane-position-covered
[497.985030] Starting dynamic subtest: pipe-A-plane-1
[499.293355] Dynamic subtest pipe-A-plane-1: SUCCESS (1.308s)
[499.304022] Starting dynamic subtest: pipe-A-plane-2
[500.564717] Dynamic subtest pipe-A-plane-2: SUCCESS (1.270s)
[500.573495] Starting dynamic subtest: pipe-A-plane-3
[501.798190] Dynamic subtest pipe-A-plane-3: SUCCESS (1.233s)
[501.807555] Starting dynamic subtest: pipe-A-plane-4
[503.036531] Dynamic subtest pipe-A-plane-4: SUCCESS (1.237s)
[503.045105] Starting dynamic subtest: pipe-A-plane-5
[503.061037] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[504.188949] Starting dynamic subtest: pipe-B-plane-1
[505.472214] Dynamic subtest pipe-B-plane-1: SUCCESS (1.291s)
[505.481196] Starting dynamic subtest: pipe-B-plane-2
[506.739402] Dynamic subtest pipe-B-plane-2: SUCCESS (1.267s)
[506.748297] Starting dynamic subtest: pipe-B-plane-3
[507.974059] Dynamic subtest pipe-B-plane-3: SUCCESS (1.234s)
[507.983108] Starting dynamic subtest: pipe-B-plane-4
[509.215861] Dynamic subtest pipe-B-plane-4: SUCCESS (1.242s)
[509.224774] Starting dynamic subtest: pipe-B-plane-5
[509.241761] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[509.242635] Subtest plane-position-covered: SUCCESS (11.827s)
[510.122312] [069/133] (526s left) kms_flip (2x-busy-flip)
[510.219553] Starting subtest: 2x-busy-flip
[510.231669] Subtest 2x-busy-flip: SKIP (0.011s)
[510.374320] [070/133] (526s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[510.489299] Starting subtest: verify-pxp-stale-buf-optout-execution
[511.548888] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.060s)
[511.695207] [071/133] (525s left) syncobj_eventfd (binary-wait-before-signal)
[511.754271] Starting subtest: binary-wait-before-signal
[511.784880] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[511.867792] [072/133] (525s left) gem_exercise_blt (fast-copy-emit)
[511.923239] Starting subtest: fast-copy-emit
[511.924215] Starting dynamic subtest: linear-smem-smem-emit
[511.944973] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[511.955919] Starting dynamic subtest: xmajor-smem-smem-emit
[511.961881] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[511.970310] Starting dynamic subtest: tile4-smem-smem-emit
[511.978934] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[511.987403] Starting dynamic subtest: tile64-smem-smem-emit
[511.995544] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[511.996472] Subtest fast-copy-emit: SUCCESS (0.073s)
[512.150115] [073/133] (524s left) gem_exec_schedule (noreorder-corked)
[512.336036] Starting subtest: noreorder-corked
[512.337037] Starting dynamic subtest: rcs0
[513.467467] Dynamic subtest rcs0: SUCCESS (1.140s)
[513.479311] Starting dynamic subtest: vcs0
[515.110605] Dynamic subtest vcs0: SUCCESS (1.632s)
[515.122060] Starting dynamic subtest: vcs1
[517.085480] Dynamic subtest vcs1: SUCCESS (1.972s)
[517.096699] Starting dynamic subtest: vecs0
[519.026377] Dynamic subtest vecs0: SUCCESS (1.938s)
[519.041911] Starting dynamic subtest: ccs0
[520.196459] Dynamic subtest ccs0: SUCCESS (1.177s)
[520.200525] Subtest noreorder-corked: SUCCESS (7.871s)
[520.393826] [074/133] (516s left) i915_fb_tiling (basic-x-tiling)
[520.445733] Subtest basic-x-tiling: SKIP (0.000s)
[520.512201] [075/133] (516s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[520.626352] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[525.044910] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.419s)
[526.193763] [076/133] (511s left) gem_workarounds (reset-fd)
[526.259211] Starting subtest: reset-fd
[526.407695] Subtest reset-fd: SUCCESS (0.148s)
[526.567113] [077/133] (510s left) kms_hdr (bpc-switch)
[526.664570] Starting subtest: bpc-switch
[527.749380] Starting dynamic subtest: pipe-A-eDP-1
[531.163073] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.414s)
[531.163904] Subtest bpc-switch: SUCCESS (4.500s)
[531.305613] [078/133] (505s left) gem_ctx_shared (q-promotion)
[531.366371] Starting subtest: Q-promotion
[531.367734] Starting dynamic subtest: rcs0
[531.476850] Dynamic subtest rcs0: SUCCESS (0.109s)
[531.495581] Starting dynamic subtest: vcs0
[531.561976] Dynamic subtest vcs0: SUCCESS (0.083s)
[531.578183] Starting dynamic subtest: vcs1
[531.647024] Dynamic subtest vcs1: SUCCESS (0.084s)
[531.666077] Starting dynamic subtest: vecs0
[531.726192] Dynamic subtest vecs0: SUCCESS (0.077s)
[531.742915] Starting dynamic subtest: ccs0
[531.813947] Dynamic subtest ccs0: SUCCESS (0.086s)
[531.815840] Subtest Q-promotion: SUCCESS (0.447s)
[533.171853] [079/133] (504s left) kms_lease (lease-invalid-plane)
[533.278657] Starting subtest: lease-invalid-plane
[533.279647] Starting dynamic subtest: pipe-A-eDP-1
[533.280612] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[533.294518] Starting dynamic subtest: pipe-B-eDP-1
[533.295597] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[533.306904] Starting dynamic subtest: pipe-C-eDP-1
[533.307889] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[533.316321] Starting dynamic subtest: pipe-D-eDP-1
[533.317258] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[533.318060] Subtest lease-invalid-plane: SUCCESS (0.004s)
[533.349946] [080/133] (504s left) perf (invalid-open-flags)
[533.443923] Starting subtest: invalid-open-flags
[533.445219] Subtest invalid-open-flags: SUCCESS (0.000s)
[533.486931] [081/133] (503s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[533.579184] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[533.579968] Starting dynamic subtest: pipe-A-eDP-1
[533.588360] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[533.597464] Starting dynamic subtest: pipe-B-eDP-1
[533.605977] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[533.614910] Starting dynamic subtest: pipe-C-eDP-1
[533.623192] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[533.631487] Starting dynamic subtest: pipe-D-eDP-1
[533.639874] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[533.641553] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[535.807534] [082/133] (501s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[535.904402] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[540.126032] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.223s)
[541.335197] [083/133] (496s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[541.433820] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[548.736939] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.303s)
[548.872253] [084/133] (488s left) gem_spin_batch (resubmit-all)
[548.925813] Starting subtest: resubmit-all
[548.926708] Starting dynamic subtest: rcs0
[548.940403] Dynamic subtest rcs0: SUCCESS (0.016s)
[548.953140] Starting dynamic subtest: bcs0
[548.954137] Dynamic subtest bcs0: SUCCESS (0.002s)
[548.962535] Starting dynamic subtest: vcs0
[548.963411] Dynamic subtest vcs0: SUCCESS (0.002s)
[548.972157] Starting dynamic subtest: vcs1
[548.973016] Dynamic subtest vcs1: SUCCESS (0.002s)
[548.981518] Starting dynamic subtest: vecs0
[548.982435] Dynamic subtest vecs0: SUCCESS (0.002s)
[548.990930] Starting dynamic subtest: ccs0
[548.991846] Dynamic subtest ccs0: SUCCESS (0.002s)
[548.992733] Subtest resubmit-all: SUCCESS (0.030s)
[550.056465] [085/133] (487s left) prime_vgem (basic-fence-flip)
[550.124490] Starting subtest: basic-fence-flip
[550.415141] Subtest basic-fence-flip: SUCCESS (0.290s)
[550.540291] [086/133] (487s left) perf_pmu (module-unload)
[550.610666] Starting subtest: module-unload
[559.032507] Subtest module-unload: FAIL (8.384s)
[559.055751] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[559.056492] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[559.058220] [087/133] (478s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[560.594624] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[560.596826] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[560.740342] [FACT kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[560.741668] [FACT kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)] new: kernel.kmod_is_loaded.i915: true
[560.744229] [088/133] (476s left) api_intel_bb (object-noreloc-keep-cache-simple)
[560.791136] Starting subtest: object-noreloc-keep-cache-simple
[560.799303] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.009s)
[560.953744] [089/133] (476s left) syncobj_wait (single-wait-submitted)
[561.004700] Starting subtest: single-wait-submitted
[561.110521] Subtest single-wait-submitted: SUCCESS (0.105s)
[561.196187] [090/133] (476s left) gem_readwrite (read-bad-handle)
[561.256628] Subtest read-bad-handle: SKIP (0.000s)
[561.322384] [091/133] (476s left) api_intel_allocator (standalone)
[561.387632] Starting subtest: standalone
[561.403717] Subtest standalone: SUCCESS (0.017s)
[561.559549] [092/133] (476s left) gem_userptr_blits (dmabuf-unsync)
[561.633141] Subtest dmabuf-unsync: SKIP (0.000s)
[561.767041] [093/133] (476s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[561.910796] Starting subtest: flip-vs-cursor-atomic-transitions
[569.565587] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.651s)
[570.406959] [094/133] (467s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[570.507427] Starting subtest: fbc-dirtyfb-ioctl
[570.509460] Starting dynamic subtest: A-eDP-1
[573.069935] Dynamic subtest A-eDP-1: SUCCESS (2.561s)
[573.070795] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.563s)
[573.872376] [095/133] (464s left) kms_async_flips (test-cursor-atomic)
[573.973378] Starting subtest: test-cursor-atomic
[573.975238] Subtest test-cursor-atomic: SKIP (0.000s)
[575.205316] [096/133] (462s left) kms_chamelium_color (ctm-green-to-red)
[575.306123] Subtest ctm-green-to-red: SKIP (0.000s)
[575.346132] [097/133] (462s left) gem_mmap_gtt (flink-race)
[575.404001] Subtest flink-race: SKIP (0.000s)
[575.469840] [098/133] (462s left) kms_content_protection (atomic-hdcp14)
[575.621465] Starting subtest: atomic-hdcp14
[575.623353] Subtest atomic-hdcp14: SKIP (0.000s)
[575.778948] [099/133] (462s left) gem_mmap_wc (write)
[575.841001] Subtest write: SKIP (0.000s)
[575.905709] [100/133] (462s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[575.959586] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[576.029709] [101/133] (462s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[576.147475] Starting subtest: cursorB-vs-flipB-varying-size
[576.149440] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[576.312463] [102/133] (461s left) kms_pm_rpm (package-g7)
[578.230739] Starting subtest: package-g7
[578.233373] Subtest package-g7: SKIP (0.000s)
[578.618731] [103/133] (459s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[578.717350] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[586.127390] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.410s)
[586.306975] [104/133] (451s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[586.414366] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[586.416066] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[586.534186] [105/133] (451s left) kms_psr (fbc-pr-primary-blt)
[586.616219] Starting subtest: fbc-pr-primary-blt
[586.617784] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[586.696002] [106/133] (451s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[586.805044] Starting subtest: fbc-modesetfrombusy
[590.676320] Subtest fbc-modesetfrombusy: SUCCESS (3.872s)
[591.863219] [107/133] (446s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[591.970856] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[596.505504] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.535s)
[597.665629] [108/133] (440s left) kms_big_fb (linear-16bpp-rotate-0)
[597.769068] Starting subtest: linear-16bpp-rotate-0
[599.091403] Subtest linear-16bpp-rotate-0: SUCCESS (1.322s)
[599.233732] [109/133] (439s left) gem_ctx_persistence (engines-hang)
[599.296319] Starting subtest: engines-hang
[599.297222] Starting dynamic subtest: rcs0
[599.450902] Dynamic subtest rcs0: SUCCESS (0.154s)
[599.463850] Starting dynamic subtest: bcs0
[599.557489] Dynamic subtest bcs0: SUCCESS (0.105s)
[599.569392] Starting dynamic subtest: vcs0
[599.662421] Dynamic subtest vcs0: SUCCESS (0.103s)
[599.674216] Starting dynamic subtest: vcs1
[599.772774] Dynamic subtest vcs1: SUCCESS (0.108s)
[599.785213] Starting dynamic subtest: vecs0
[599.885775] Dynamic subtest vecs0: SUCCESS (0.111s)
[599.898117] Starting dynamic subtest: ccs0
[599.986547] Dynamic subtest ccs0: SUCCESS (0.099s)
[599.987931] Subtest engines-hang: SUCCESS (0.691s)
[600.076004] [110/133] (438s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[600.158735] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[600.160378] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[600.285298] [111/133] (438s left) gem_exec_gttfill (multigpu-basic)
[600.471678] Starting subtest: multigpu-basic
[614.198794] Subtest multigpu-basic: SUCCESS (13.728s)
[614.269453] [112/133] (424s left) gem_exec_fence (submit3)
[614.508225] Starting subtest: submit3
[614.509971] Subtest submit3: SKIP (0.000s)
[616.139357] [113/133] (422s left) fbdev (read)
[616.176259] Starting subtest: read
[616.719453] Subtest read: SUCCESS (0.534s)
[616.770291] [114/133] (421s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[616.896429] Starting subtest: 4-tiled-16bpp-rotate-270
[616.916555] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.020s)
[617.057982] [115/133] (421s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[617.162710] Starting subtest: yf-tiled-8bpp-rotate-0
[617.164288] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[617.285586] [116/133] (421s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[617.385885] Starting subtest: x-tiled-32bpp-rotate-180
[618.776552] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.390s)
[618.919400] [117/133] (419s left) sriov_basic (enable-vfs-autoprobe-off)
[618.969449] Starting subtest: enable-vfs-autoprobe-off
[618.970426] Starting dynamic subtest: numvfs-1
[619.001115] Dynamic subtest numvfs-1: FAIL (0.016s)
[619.009046] Starting dynamic subtest: numvfs-2
[619.032737] Dynamic subtest numvfs-2: FAIL (0.004s)
[619.040606] Starting dynamic subtest: numvfs-3
[619.064163] Dynamic subtest numvfs-3: FAIL (0.003s)
[619.071885] Starting dynamic subtest: numvfs-4
[619.095254] Dynamic subtest numvfs-4: FAIL (0.004s)
[619.103231] Starting dynamic subtest: numvfs-5
[619.129878] Dynamic subtest numvfs-5: FAIL (0.004s)
[619.138353] Starting dynamic subtest: numvfs-6
[619.163267] Dynamic subtest numvfs-6: FAIL (0.004s)
[619.170982] Starting dynamic subtest: numvfs-7
[619.196302] Dynamic subtest numvfs-7: FAIL (0.004s)
[619.204154] Starting dynamic subtest: numvfs-random
[619.228864] Dynamic subtest numvfs-random: FAIL (0.004s)
[619.236730] Starting dynamic subtest: numvfs-all
[619.262151] Dynamic subtest numvfs-all: FAIL (0.004s)
[619.262896] Subtest enable-vfs-autoprobe-off: FAIL (0.052s)
[619.291761] [118/133] (419s left) kms_hdr (static-toggle)
[619.380973] Starting subtest: static-toggle
[619.383160] Subtest static-toggle: SKIP (0.000s)
[619.461758] [119/133] (419s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[619.551287] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[619.552026] Starting dynamic subtest: pipe-A-eDP-1
[619.558411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[619.566556] Starting dynamic subtest: pipe-B-eDP-1
[619.573031] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[619.581079] Starting dynamic subtest: pipe-C-eDP-1
[619.595635] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[619.603468] Starting dynamic subtest: pipe-D-eDP-1
[619.610223] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[619.610929] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[621.729811] [120/133] (417s left) kms_flip (2x-flip-vs-modeset)
[621.824024] Starting subtest: 2x-flip-vs-modeset
[621.834362] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[621.960278] [121/133] (416s left) gem_exec_reloc (basic-wc-gtt-active)
[622.024223] Subtest basic-wc-gtt-active: SKIP (0.000s)
[622.099628] [122/133] (416s left) gem_userptr_blits (mmap-offset-banned)
[622.165592] Starting subtest: mmap-offset-banned
[622.166427] Starting dynamic subtest: wb
[622.167392] Dynamic subtest wb: SUCCESS (0.000s)
[622.176243] Starting dynamic subtest: wc
[622.177047] Dynamic subtest wc: SUCCESS (0.000s)
[622.185527] Starting dynamic subtest: uc
[622.186332] Dynamic subtest uc: SUCCESS (0.000s)
[622.187057] Subtest mmap-offset-banned: SUCCESS (0.003s)
[622.326891] [123/133] (416s left) gem_ccs (suspend-resume)
[622.394190] Starting subtest: suspend-resume
[622.396115] Subtest suspend-resume: SKIP (0.000s)
[622.511600] [124/133] (416s left) gem_exec_schedule (smoketest-all)
[622.591878] Starting subtest: smoketest-all
[654.943542] Subtest smoketest-all: SUCCESS (32.321s)
[656.186411] [125/133] (382s left) gem_tiled_wb
[656.307047] [126/133] (382s left) gem_linear_blits (normal)
[656.490629] Starting subtest: normal
[660.976642] Subtest normal: SUCCESS (4.477s)
[661.124258] [127/133] (377s left) gen9_exec_parse (batch-without-end)
[661.225834] Subtest batch-without-end: SKIP (0.000s)
[661.314176] [128/133] (377s left) syncobj_wait (invalid-signal-zero-handles)
[661.370362] Starting subtest: invalid-signal-zero-handles
[661.371246] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[661.493835] [129/133] (377s left) gem_ctx_persistence (legacy-engines-persistence)
[661.552506] Starting subtest: legacy-engines-persistence
[661.553412] Starting dynamic subtest: render
[662.422619] Dynamic subtest render: SUCCESS (0.869s)
[662.436012] Starting dynamic subtest: bsd1
[663.238413] Dynamic subtest bsd1: SUCCESS (0.812s)
[663.250565] Starting dynamic subtest: bsd2
[663.970049] Dynamic subtest bsd2: SUCCESS (0.727s)
[663.980376] Starting dynamic subtest: blt
[664.767430] Dynamic subtest blt: SUCCESS (0.796s)
[664.779594] Starting dynamic subtest: vebox
[665.539378] Dynamic subtest vebox: SUCCESS (0.769s)
[665.542619] Subtest legacy-engines-persistence: SUCCESS (3.987s)
[665.627949] [130/133] (373s left) kms_cursor_crc (cursor-sliding-32x32)
[665.794317] Starting subtest: cursor-sliding-32x32
[665.839179] Subtest cursor-sliding-32x32: SKIP (0.043s)
[666.157093] [131/133] (373s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[666.251489] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[666.252932] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[666.387838] [132/133] (372s left) sw_sync (alloc_fence)
[666.421060] Starting subtest: alloc_fence
[666.421895] Subtest alloc_fence: SUCCESS (0.000s)
[666.486388] [133/133] (372s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[666.533417] Starting subtest: etime-multi-wait-available-unsubmitted
[666.637563] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s)
[666.718944] 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.