[57.023518] Initializing watchdogs
[57.023563]   /dev/watchdog0
[57.037712] [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.041985] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.044151] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.047298] [001/131] (960s left) fbdev (unaligned-read)
[57.107666] Starting subtest: unaligned-read
[57.121826] Subtest unaligned-read: SUCCESS (0.014s)
[57.205218] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[57.273677] Starting subtest: dirty-switch
[57.275987] Starting dynamic subtest: rcs0
[57.489551] Dynamic subtest rcs0: SUCCESS (0.216s)
[57.499671] Starting dynamic subtest: bcs0
[57.755632] Dynamic subtest bcs0: SUCCESS (0.265s)
[57.765255] Starting dynamic subtest: vcs0
[58.012095] Dynamic subtest vcs0: SUCCESS (0.257s)
[58.022511] Starting dynamic subtest: vcs1
[59.126906] Dynamic subtest vcs1: SUCCESS (1.114s)
[59.135220] Starting dynamic subtest: vecs0
[61.097533] Dynamic subtest vecs0: SUCCESS (1.970s)
[61.104692] Starting dynamic subtest: ccs0
[63.168859] Dynamic subtest ccs0: SUCCESS (2.071s)
[63.171345] Subtest dirty-switch: SUCCESS (5.895s)
[63.439010] [003/131] (954s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[63.550778] Starting subtest: psr-modesetfrombusy
[69.754829] Subtest psr-modesetfrombusy: SUCCESS (6.210s)
[69.901644] [004/131] (947s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[70.011978] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[70.014071] Starting dynamic subtest: pipe-A-default-mode
[72.746560] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[72.748827] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.735s)
[73.634549] [005/131] (944s left) gem_exec_params (sol-reset-invalid)
[73.700467] Starting subtest: sol-reset-invalid
[73.702896] Subtest sol-reset-invalid: SUCCESS (0.002s)
[75.017931] [006/131] (942s left) gem_spin_batch (resubmit-new)
[75.070955] Starting subtest: resubmit-new
[75.073040] Starting dynamic subtest: rcs0
[75.077551] Dynamic subtest rcs0: SUCCESS (0.008s)
[75.086540] Starting dynamic subtest: bcs0
[75.088907] Dynamic subtest bcs0: SUCCESS (0.004s)
[75.096676] Starting dynamic subtest: vcs0
[75.099061] Dynamic subtest vcs0: SUCCESS (0.006s)
[75.106644] Starting dynamic subtest: vcs1
[75.108954] Dynamic subtest vcs1: SUCCESS (0.004s)
[75.115865] Starting dynamic subtest: vecs0
[75.118584] Dynamic subtest vecs0: SUCCESS (0.005s)
[75.127923] Starting dynamic subtest: ccs0
[75.130227] Dynamic subtest ccs0: SUCCESS (0.004s)
[75.132521] Subtest resubmit-new: SUCCESS (0.033s)
[76.956430] [007/131] (940s left) gem_exec_schedule (preempt-user)
[77.038723] Starting subtest: preempt-user
[77.040720] Starting dynamic subtest: rcs0
[77.070771] Dynamic subtest rcs0: SUCCESS (0.037s)
[77.081595] Starting dynamic subtest: bcs0
[77.100549] Dynamic subtest bcs0: SUCCESS (0.030s)
[77.108135] Starting dynamic subtest: vcs0
[77.126527] Dynamic subtest vcs0: SUCCESS (0.026s)
[77.134108] Starting dynamic subtest: vcs1
[77.150184] Dynamic subtest vcs1: SUCCESS (0.023s)
[77.157309] Starting dynamic subtest: vecs0
[77.175997] Dynamic subtest vecs0: SUCCESS (0.025s)
[77.184904] Starting dynamic subtest: ccs0
[77.206059] Dynamic subtest ccs0: SUCCESS (0.030s)
[77.208362] Subtest preempt-user: SUCCESS (0.173s)
[79.059776] [008/131] (938s left) sysfs_heartbeat_interval (nopreempt)
[79.119731] Starting subtest: nopreempt
[79.122265] Starting dynamic subtest: vecs0
[88.941244] Dynamic subtest vecs0: SUCCESS (9.817s)
[88.951964] Starting dynamic subtest: ccs0
[92.943047] Dynamic subtest ccs0: SUCCESS (4.002s)
[92.950717] Starting dynamic subtest: vcs0
[102.959954] Dynamic subtest vcs0: SUCCESS (10.015s)
[102.971268] Starting dynamic subtest: bcs0
[106.977666] Dynamic subtest bcs0: SUCCESS (4.019s)
[106.987945] Starting dynamic subtest: rcs0
[111.035044] Dynamic subtest rcs0: SUCCESS (4.056s)
[111.043770] Starting dynamic subtest: vcs1
[120.933817] Dynamic subtest vcs1: SUCCESS (9.895s)
[120.936459] Subtest nopreempt: SUCCESS (41.811s)
[121.025953] [009/131] (896s left) kms_invalid_mode (zero-hdisplay)
[121.124152] Starting subtest: zero-hdisplay
[121.126495] Starting dynamic subtest: pipe-A-eDP-1
[121.423881] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[121.433224] Starting dynamic subtest: pipe-B-eDP-1
[121.435383] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[121.442708] Starting dynamic subtest: pipe-C-eDP-1
[121.445063] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[121.452439] Starting dynamic subtest: pipe-D-eDP-1
[121.454717] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[121.456903] Subtest zero-hdisplay: SUCCESS (0.305s)
[122.272457] [010/131] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[122.368823] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[122.373435] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[122.502755] [011/131] (895s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[122.611265] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[123.493657] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.884s)
[123.674278] [012/131] (894s left) kms_getfb (getfb-handle-zero)
[123.770294] Starting subtest: getfb-handle-zero
[123.772593] Subtest getfb-handle-zero: SUCCESS (0.000s)
[123.893336] [013/131] (894s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[123.966834] Starting subtest: yf-tiled-ccs-to-yf-tiled
[123.971493] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[124.179440] [014/131] (893s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[124.295072] Starting subtest: multiplane-rotation-cropping-bottom
[131.609424] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.315s)
[131.760018] [015/131] (886s left) gem_eio (wait-1us)
[131.987642] Starting subtest: wait-1us
[132.313581] Subtest wait-1us: SUCCESS (0.326s)
[132.488628] [016/131] (885s left) syncobj_wait (multi-wait-for-submit-signaled)
[132.558858] Starting subtest: multi-wait-for-submit-signaled
[132.560791] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[132.688248] [017/131] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[132.788464] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[132.790384] Starting dynamic subtest: pipe-A-default-mode
[133.077264] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[133.081938] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.287s)
[133.899694] [018/131] (884s left) kms_plane_alpha_blend (alpha-7efc)
[133.989265] Starting subtest: alpha-7efc
[134.286382] Starting dynamic subtest: pipe-A-eDP-1
[134.881192] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.592s)
[134.911983] Starting dynamic subtest: pipe-D-eDP-1
[136.196253] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.290s)
[136.198580] Subtest alpha-7efc: SUCCESS (2.208s)
[137.063816] [019/131] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[137.171375] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[137.175519] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[137.304328] [020/131] (880s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[137.404201] Starting subtest: fbc-psr2-primary-mmap-cpu
[137.406424] Starting dynamic subtest: eDP-1
[137.410904] Dynamic subtest eDP-1: SKIP (0.000s)
[137.415417] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[137.497338] [021/131] (880s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[137.597524] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[137.605694] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[137.709295] [022/131] (880s left) gem_exec_whisper (basic-normal-all)
[137.779835] Starting subtest: basic-normal-all
[140.226687] Subtest basic-normal-all: SUCCESS (2.444s)
[140.433130] [023/131] (877s left) kms_big_fb (linear-16bpp-rotate-180)
[140.559504] Starting subtest: linear-16bpp-rotate-180
[141.983760] Subtest linear-16bpp-rotate-180: SUCCESS (1.423s)
[142.137205] [024/131] (876s left) kms_frontbuffer_tracking (psr-slowdraw)
[142.246191] Starting subtest: psr-slowdraw
[167.411013] Subtest psr-slowdraw: SUCCESS (25.164s)
[167.567188] [025/131] (850s left) vgem_basic (dmabuf-fence)
[167.675665] Starting subtest: dmabuf-fence
[167.677902] Subtest dmabuf-fence: SUCCESS (0.001s)
[167.750060] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[167.753062] [026/131] (850s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[167.815581] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[167.817868] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[167.956094] [027/131] (850s left) kms_psr (pr-primary-render)
[168.050191] Starting subtest: pr-primary-render
[168.054673] Subtest pr-primary-render: SKIP (0.000s)
[168.147975] [028/131] (850s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[168.241457] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[168.243351] Starting dynamic subtest: pipe-A-eDP-1
[168.262390] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[168.272641] Starting dynamic subtest: pipe-B-eDP-1
[168.290484] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[168.298816] Starting dynamic subtest: pipe-C-eDP-1
[168.316832] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[168.325121] Starting dynamic subtest: pipe-D-eDP-1
[168.343655] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[168.347034] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[170.460743] [029/131] (848s left) core_auth (getclient-master-drop)
[170.499109] Starting subtest: getclient-master-drop
[170.524782] Subtest getclient-master-drop: SUCCESS (0.025s)
[170.665144] [030/131] (848s left) kms_plane_scaling (planes-downscale-factor-0-5)
[170.764056] Starting subtest: planes-downscale-factor-0-5
[170.766353] Starting dynamic subtest: pipe-A
[170.784956] Dynamic subtest pipe-A: SKIP (0.017s)
[170.795080] Starting dynamic subtest: pipe-B
[170.820461] Dynamic subtest pipe-B: SKIP (0.034s)
[170.829828] Starting dynamic subtest: pipe-C
[170.854155] Dynamic subtest pipe-C: SKIP (0.034s)
[170.863414] Starting dynamic subtest: pipe-D
[170.883568] Dynamic subtest pipe-D: SKIP (0.030s)
[170.887980] Subtest planes-downscale-factor-0-5: SKIP (0.117s)
[171.000387] [031/131] (847s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[171.086416] Starting subtest: fb-8bpc-vs-panel-8bpc
[171.088795] Starting dynamic subtest: pipe-A-eDP-1
[172.491719] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.402s)
[172.494111] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.403s)
[173.318778] [032/131] (845s left) gem_partial_pwrite_pread (reads-snoop)
[173.374197] Subtest reads-snoop: SKIP (0.000s)
[173.460955] [033/131] (845s left) gem_eio (in-flight-contexts-immediate)
[173.702605] Starting subtest: in-flight-contexts-immediate
[184.935838] Subtest in-flight-contexts-immediate: SUCCESS (11.232s)
[185.127992] [034/131] (833s left) gen3_render_mixed_blits
[185.267506] [035/131] (833s left) kms_pm_rpm (pm-tiling)
[187.093627] Starting subtest: pm-tiling
[187.098463] Subtest pm-tiling: SKIP (0.000s)
[187.541018] [036/131] (831s left) i915_module_load (reload-no-display)
[187.583173] Starting subtest: reload-no-display
[193.805066] Subtest reload-no-display: SUCCESS (6.223s)
[193.832516] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[193.833218] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[193.836120] [037/131] (825s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[195.416773] Starting subtest: plane-upscale-20x20-with-rotation
[195.418963] Starting dynamic subtest: pipe-A
[195.662037] Dynamic subtest pipe-A: SUCCESS (0.247s)
[195.669465] Starting dynamic subtest: pipe-B
[196.974978] Dynamic subtest pipe-B: SUCCESS (1.312s)
[196.982190] Starting dynamic subtest: pipe-C
[198.306581] Dynamic subtest pipe-C: SUCCESS (1.331s)
[198.314771] Starting dynamic subtest: pipe-D
[199.632239] Dynamic subtest pipe-D: SUCCESS (1.325s)
[199.634543] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.218s)
[200.791695] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[200.793214] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[200.797094] [038/131] (818s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[200.918354] Starting subtest: 4-tiled-8bpp-rotate-180
[202.091108] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.174s)
[202.269167] [039/131] (816s left) kms_rotation_crc (primary-rotation-90)
[202.367063] Starting subtest: primary-rotation-90
[202.370879] Subtest primary-rotation-90: SKIP (0.001s)
[202.464489] [040/131] (816s left) kms_cursor_crc (cursor-onscreen-32x10)
[202.615559] Starting subtest: cursor-onscreen-32x10
[202.661873] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[202.957018] [041/131] (816s left) kms_vblank (wait-idle)
[203.055335] Starting subtest: wait-idle
[203.056916] Starting dynamic subtest: pipe-A-eDP-1
[204.823091] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.768s)
[204.837065] Starting dynamic subtest: pipe-D-eDP-1
[207.260107] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.433s)
[207.262368] Subtest wait-idle: SUCCESS (4.205s)
[208.113732] [042/131] (811s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[208.213654] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[208.217800] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[208.353918] [043/131] (810s left) kms_flip (2x-flip-vs-dpms)
[208.453236] Starting subtest: 2x-flip-vs-dpms
[208.463877] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[208.595715] [044/131] (810s left) gem_exec_fence (syncobj-channel)
[209.033800] Starting subtest: syncobj-channel
[210.053836] Subtest syncobj-channel: SUCCESS (1.017s)
[211.032294] [045/131] (808s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[211.127286] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[211.129665] Starting dynamic subtest: pipe-A-eDP-1
[211.139317] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[211.147880] Starting dynamic subtest: pipe-B-eDP-1
[211.157105] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[211.164692] Starting dynamic subtest: pipe-C-eDP-1
[211.175483] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[211.183022] Starting dynamic subtest: pipe-D-eDP-1
[211.191916] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[211.196348] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[213.460960] [046/131] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[213.567103] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[220.798459] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.234s)
[220.954199] [047/131] (798s left) kms_flip (busy-flip)
[221.057194] Starting subtest: busy-flip
[221.059419] Starting dynamic subtest: A-eDP1
[222.778116] Dynamic subtest A-eDP1: SUCCESS (1.721s)
[222.790261] Starting dynamic subtest: B-eDP1
[224.506571] Dynamic subtest B-eDP1: SUCCESS (1.727s)
[224.517152] Starting dynamic subtest: C-eDP1
[226.132435] Dynamic subtest C-eDP1: SUCCESS (1.624s)
[226.142243] Starting dynamic subtest: D-eDP1
[227.765165] Dynamic subtest D-eDP1: SUCCESS (1.632s)
[227.767575] Subtest busy-flip: SUCCESS (6.713s)
[229.045282] [048/131] (790s left) prime_mmap (test_aperture_limit)
[229.102516] Starting subtest: test_aperture_limit
[229.104826] Starting dynamic subtest: test_aperture_limit-smem
[229.112083] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[229.116348] Subtest test_aperture_limit: SKIP (0.008s)
[229.249641] [049/131] (790s left) i915_pm_rpm (sysfs-read)
[231.076782] Starting subtest: sysfs-read
[232.234631] Subtest sysfs-read: SUCCESS (1.154s)
[232.623192] [050/131] (786s left) kms_big_fb (yf-tiled-addfb)
[232.726689] Starting subtest: yf-tiled-addfb
[232.731234] Subtest yf-tiled-addfb: SKIP (0.000s)
[232.869025] [051/131] (786s left) sriov_basic (enable-vfs-autoprobe-on)
[232.933047] Starting subtest: enable-vfs-autoprobe-on
[232.934984] Starting dynamic subtest: numvfs-1
[233.015150] Dynamic subtest numvfs-1: FAIL (0.029s)
[233.024631] Starting dynamic subtest: numvfs-2
[233.096765] Dynamic subtest numvfs-2: FAIL (0.003s)
[233.106394] Starting dynamic subtest: numvfs-3
[233.179558] Dynamic subtest numvfs-3: FAIL (0.003s)
[233.188877] Starting dynamic subtest: numvfs-4
[233.262173] Dynamic subtest numvfs-4: FAIL (0.003s)
[233.271314] Starting dynamic subtest: numvfs-5
[233.342962] Dynamic subtest numvfs-5: FAIL (0.003s)
[233.351378] Starting dynamic subtest: numvfs-6
[233.423764] Dynamic subtest numvfs-6: FAIL (0.003s)
[233.433431] Starting dynamic subtest: numvfs-7
[233.505121] Dynamic subtest numvfs-7: FAIL (0.003s)
[233.514273] Starting dynamic subtest: numvfs-random
[233.574362] Dynamic subtest numvfs-random: FAIL (0.003s)
[233.582785] Starting dynamic subtest: numvfs-all
[233.641434] Dynamic subtest numvfs-all: FAIL (0.503s)
[233.643349] Subtest enable-vfs-autoprobe-on: FAIL (0.562s)
[233.678392] [052/131] (785s left) gem_exec_whisper (basic-queues)
[233.752422] Starting subtest: basic-queues
[240.885992] Subtest basic-queues: SUCCESS (7.129s)
[241.094716] [053/131] (778s left) kms_flip (2x-dpms-vs-vblank-race)
[241.199152] Starting subtest: 2x-dpms-vs-vblank-race
[241.212670] Subtest 2x-dpms-vs-vblank-race: SKIP (0.013s)
[241.314732] [054/131] (778s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[241.409107] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[241.780921] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[244.570243] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[244.580653] Starting dynamic subtest: pipe-A-eDP-1-4
[246.755994] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s)
[246.767101] Starting dynamic subtest: pipe-A-eDP-1-4
[248.766455] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[248.777996] Starting dynamic subtest: pipe-A-eDP-1-x
[250.945563] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[251.331083] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[254.093287] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.774s)
[254.104462] Starting dynamic subtest: pipe-B-eDP-1-4
[256.302258] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.208s)
[256.312892] Starting dynamic subtest: pipe-B-eDP-1-4
[258.312398] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[258.321685] Starting dynamic subtest: pipe-B-eDP-1-x
[260.491179] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s)
[260.853136] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[263.612387] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.766s)
[263.623686] Starting dynamic subtest: pipe-C-eDP-1-4
[265.787498] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[265.798675] Starting dynamic subtest: pipe-C-eDP-1-4
[267.797967] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[267.809096] Starting dynamic subtest: pipe-C-eDP-1-x
[269.976067] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[270.339194] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[273.140888] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[273.152754] Starting dynamic subtest: pipe-D-eDP-1-4
[275.315714] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[275.324092] Starting dynamic subtest: pipe-D-eDP-1-4
[277.326450] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[277.337218] Starting dynamic subtest: pipe-D-eDP-1-x
[279.505113] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[279.507779] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.096s)
[280.749536] [055/131] (738s left) gem_mmap_gtt (basic-write-read-distinct)
[280.816501] Subtest basic-write-read-distinct: SKIP (0.000s)
[280.880467] [056/131] (738s left) gem_mmap_offset (oob-read)
[280.935324] Starting subtest: oob-read
[280.937482] Subtest oob-read: SUCCESS (0.000s)
[281.056235] [057/131] (738s left) kms_atomic (atomic-plane-damage)
[281.151067] Starting subtest: atomic-plane-damage
[281.230431] Starting dynamic subtest: pipe-A-eDP-1
[281.802786] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s)
[281.804698] Subtest atomic-plane-damage: SUCCESS (0.651s)
[282.688433] [058/131] (737s left) kms_atomic_transition (plane-all-transition-nonblocking)
[282.788169] Starting subtest: plane-all-transition-nonblocking
[282.790445] Starting dynamic subtest: pipe-A-eDP-1
[285.281226] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[285.593438] Starting dynamic subtest: pipe-B-eDP-1
[288.797461] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.217s)
[289.110431] Subtest plane-all-transition-nonblocking: SUCCESS (6.323s)
[289.958884] [059/131] (729s left) gem_exec_parallel (contexts)
[290.039869] Starting subtest: contexts
[290.042094] Starting dynamic subtest: rcs0
[292.841529] Dynamic subtest rcs0: SUCCESS (2.802s)
[292.850799] Starting dynamic subtest: bcs0
[296.333369] Dynamic subtest bcs0: SUCCESS (3.489s)
[296.345068] Starting dynamic subtest: vcs0
[300.381028] Dynamic subtest vcs0: SUCCESS (4.045s)
[300.390252] Starting dynamic subtest: vcs1
[304.346303] Dynamic subtest vcs1: SUCCESS (3.964s)
[304.357882] Starting dynamic subtest: vecs0
[308.411257] Dynamic subtest vecs0: SUCCESS (4.063s)
[308.423469] Starting dynamic subtest: ccs0
[311.887704] Dynamic subtest ccs0: SUCCESS (3.475s)
[311.890495] Subtest contexts: SUCCESS (21.849s)
[312.099348] [060/131] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[312.210783] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[318.980735] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.771s)
[319.159516] [061/131] (700s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[319.265372] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[319.269272] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[319.375570] [062/131] (700s left) kms_atomic_interruptible (legacy-pageflip)
[319.480952] Starting subtest: legacy-pageflip
[319.483087] Starting dynamic subtest: pipe-A-eDP-1
[326.880685] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.397s)
[326.882825] Subtest legacy-pageflip: SUCCESS (7.399s)
[327.731841] [063/131] (692s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[327.833212] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[327.837388] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[327.955927] [064/131] (692s left) kms_psr (psr2-sprite-mmap-cpu)
[328.043960] Starting subtest: psr2-sprite-mmap-cpu
[328.046180] Starting dynamic subtest: eDP-1
[329.789755] Dynamic subtest eDP-1: SUCCESS (1.744s)
[329.792127] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.745s)
[330.685270] [065/131] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[330.784369] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[337.873389] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.091s)
[338.058520] [066/131] (682s left) gem_exec_schedule (fairslice-all)
[338.137116] Starting subtest: fairslice-all
[340.185723] Subtest fairslice-all: SUCCESS (2.053s)
[342.026362] [067/131] (678s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[346.921024] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[346.923338] Starting dynamic subtest: pipe-A-eDP-1
[347.726883] Dynamic subtest pipe-A-eDP-1: SKIP (0.800s)
[347.736757] Starting dynamic subtest: pipe-B-eDP-1
[348.858719] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[348.863077] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.934s)
[350.088778] [068/131] (670s left) api_intel_allocator (two-level-inception)
[350.148289] Starting subtest: two-level-inception
[355.545131] Subtest two-level-inception: SUCCESS (5.398s)
[355.694528] [069/131] (664s left) i915_suspend (debugfs-reader)
[355.747829] Starting subtest: debugfs-reader
[373.539377] Subtest debugfs-reader: SUCCESS (8.066s)
[373.718354] [070/131] (646s left) kms_flip (plain-flip-fb-recreate-interruptible)
[373.831581] Starting subtest: plain-flip-fb-recreate-interruptible
[373.834014] Starting dynamic subtest: A-eDP1
[382.717740] Dynamic subtest A-eDP1: SUCCESS (8.879s)
[382.728982] Starting dynamic subtest: B-eDP1
[391.554452] Dynamic subtest B-eDP1: SUCCESS (8.832s)
[391.565083] Starting dynamic subtest: C-eDP1
[400.371006] Dynamic subtest C-eDP1: SUCCESS (8.813s)
[400.382917] Starting dynamic subtest: D-eDP1
[409.197371] Dynamic subtest D-eDP1: SUCCESS (8.823s)
[409.201775] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.357s)
[410.405270] [071/131] (610s left) gem_vm_create (invalid-destroy)
[410.488372] Starting subtest: invalid-destroy
[410.490447] Subtest invalid-destroy: SUCCESS (0.004s)
[410.629172] [072/131] (609s left) gem_ccs (ctrl-surf-copy-new-ctx)
[410.697387] Starting subtest: ctrl-surf-copy-new-ctx
[410.702390] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[410.825917] [073/131] (609s left) syncobj_basic (bad-destroy-pad)
[410.881337] Starting subtest: bad-destroy-pad
[410.883613] Subtest bad-destroy-pad: SUCCESS (0.000s)
[411.010170] [074/131] (609s left) kms_plane_multiple (2x-tiling-y)
[411.101775] Starting subtest: 2x-tiling-y
[411.105985] Subtest 2x-tiling-y: SKIP (0.000s)
[411.196297] [075/131] (609s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[411.284931] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[411.287307] Starting dynamic subtest: pipe-A-eDP-1
[411.317258] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[411.328212] Starting dynamic subtest: pipe-B-eDP-1
[411.345693] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[411.354141] Starting dynamic subtest: pipe-C-eDP-1
[411.371606] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[411.380616] Starting dynamic subtest: pipe-D-eDP-1
[411.397902] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[411.401266] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[413.478273] [076/131] (607s left) kms_pm_rpm (modeset-lpsp)
[415.803260] Starting subtest: modeset-lpsp
[417.277102] Subtest modeset-lpsp: SUCCESS (1.473s)
[417.376122] [077/131] (603s left) kms_setmode (basic)
[417.445317] Starting subtest: basic
[417.763312] Starting dynamic subtest: pipe-A-eDP-1
[419.848817] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.081s)
[420.191580] Starting dynamic subtest: pipe-B-eDP-1
[422.272244] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.085s)
[422.577124] Subtest basic: SUCCESS (5.130s)
[423.436412] [078/131] (597s left) kms_psr (fbc-psr-suspend)
[423.542069] Starting subtest: fbc-psr-suspend
[423.544356] Starting dynamic subtest: eDP-1
[423.548752] Dynamic subtest eDP-1: SKIP (0.000s)
[423.553152] Subtest fbc-psr-suspend: SKIP (0.001s)
[423.641448] [079/131] (597s left) gem_ringfill (engines-basic)
[429.653342] Starting subtest: engines-basic
[429.655962] Starting dynamic subtest: rcs0
[429.719794] Dynamic subtest rcs0: SUCCESS (0.067s)
[429.732742] Starting dynamic subtest: bcs0
[429.763767] Dynamic subtest bcs0: SUCCESS (0.042s)
[429.775816] Starting dynamic subtest: vcs0
[429.806822] Dynamic subtest vcs0: SUCCESS (0.041s)
[429.819197] Starting dynamic subtest: vcs1
[429.848932] Dynamic subtest vcs1: SUCCESS (0.041s)
[429.859578] Starting dynamic subtest: vecs0
[429.891649] Dynamic subtest vecs0: SUCCESS (0.041s)
[429.902742] Starting dynamic subtest: ccs0
[429.936839] Dynamic subtest ccs0: SUCCESS (0.043s)
[429.939685] Subtest engines-basic: SUCCESS (0.286s)
[430.057251] [080/131] (590s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[430.109538] Starting subtest: invalid-bsd2-flag-on-vebox
[430.111833] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[430.242015] [081/131] (590s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[430.346947] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[430.349140] Starting dynamic subtest: pipe-A-eDP-1
[430.368597] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[430.379946] Starting dynamic subtest: pipe-B-eDP-1
[430.398818] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[430.408995] Starting dynamic subtest: pipe-C-eDP-1
[430.427849] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[430.437542] Starting dynamic subtest: pipe-D-eDP-1
[430.456948] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[430.459445] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s)
[432.618727] [082/131] (588s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[432.742065] Starting subtest: extended-pageflip-modeset-hang-oldfb
[432.743957] Starting dynamic subtest: pipe-A
[440.649274] Dynamic subtest pipe-A: SUCCESS (7.905s)
[440.659573] Starting dynamic subtest: pipe-D
[449.292819] Dynamic subtest pipe-D: SUCCESS (8.641s)
[449.295300] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.551s)
[450.176793] [083/131] (570s left) gem_ppgtt (shrink-vs-evict-any)
[450.242378] Starting subtest: shrink-vs-evict-any
[455.598675] Subtest shrink-vs-evict-any: SUCCESS (5.355s)
[455.721006] [084/131] (565s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[455.780728] Starting subtest: etime-single-wait-for-submit-unsubmitted
[455.886260] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[455.988725] [085/131] (565s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[456.052985] Starting subtest: multi-wait-all-for-submit-signaled
[456.055167] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[456.194140] [086/131] (564s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[456.254301] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[456.359051] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[456.475960] [087/131] (564s left) gem_exec_schedule (implicit-write-read)
[456.571459] Starting subtest: implicit-write-read
[456.573836] Starting dynamic subtest: rcs0
[456.745488] Dynamic subtest rcs0: SUCCESS (0.184s)
[456.759783] Starting dynamic subtest: vcs0
[456.886488] Dynamic subtest vcs0: SUCCESS (0.141s)
[456.899703] Starting dynamic subtest: vcs1
[456.993894] Dynamic subtest vcs1: SUCCESS (0.106s)
[457.006889] Starting dynamic subtest: vecs0
[457.098200] Dynamic subtest vecs0: SUCCESS (0.104s)
[457.107587] Starting dynamic subtest: ccs0
[457.234118] Dynamic subtest ccs0: SUCCESS (0.135s)
[457.236775] Subtest implicit-write-read: SUCCESS (0.674s)
[458.791659] [088/131] (562s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[458.893412] Starting subtest: fbcpsr-rgb565-draw-blt
[465.850015] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.958s)
[466.007830] [089/131] (555s left) gem_ctx_persistence (processes)
[466.075082] Starting subtest: processes
[467.595407] Subtest processes: SUCCESS (1.523s)
[467.697961] [090/131] (553s left) kms_cursor_crc (cursor-sliding-32x10)
[467.847060] Starting subtest: cursor-sliding-32x10
[467.891885] Subtest cursor-sliding-32x10: SKIP (0.040s)
[468.181210] [091/131] (553s left) kms_psr (fbc-pr-primary-render)
[468.273998] Starting subtest: fbc-pr-primary-render
[468.278039] Subtest fbc-pr-primary-render: SKIP (0.000s)
[468.371677] [092/131] (553s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[468.436709] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[468.508540] [093/131] (552s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[468.558359] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[468.560605] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[468.673181] [094/131] (552s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[468.775245] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[468.778888] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[468.899099] [095/131] (552s left) gem_exec_async (concurrent-writes)
[468.965763] Starting subtest: concurrent-writes
[468.967641] Starting dynamic subtest: rcs0
[468.984418] Dynamic subtest rcs0: SUCCESS (0.021s)
[468.999935] Starting dynamic subtest: bcs0
[469.001615] Dynamic subtest bcs0: SUCCESS (0.006s)
[469.014761] Starting dynamic subtest: vcs0
[469.016892] Dynamic subtest vcs0: SUCCESS (0.004s)
[469.028903] Starting dynamic subtest: vcs1
[469.030759] Dynamic subtest vcs1: SUCCESS (0.006s)
[469.039507] Starting dynamic subtest: vecs0
[469.041065] Dynamic subtest vecs0: SUCCESS (0.006s)
[469.049682] Starting dynamic subtest: ccs0
[469.051231] Dynamic subtest ccs0: SUCCESS (0.005s)
[469.052823] Subtest concurrent-writes: SUCCESS (0.053s)
[469.281655] [096/131] (552s left) gem_mmap_gtt (basic-small-bo-tiledx)
[469.345116] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[469.406496] [097/131] (552s left) dmabuf_sync_file (import-basic)
[469.448979] Starting subtest: import-basic
[469.450992] Subtest import-basic: SUCCESS (0.001s)
[469.530860] [098/131] (552s left) kms_feature_discovery (display)
[469.620659] Starting subtest: display
[469.622571] Subtest display: SUCCESS (0.000s)
[469.746067] [099/131] (551s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[469.853805] Starting subtest: x-tiled-64bpp-rotate-90
[469.873179] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[470.025753] [100/131] (551s left) perf_pmu (busy-no-semaphores)
[470.061444] Starting subtest: busy-no-semaphores
[470.063425] Starting dynamic subtest: rcs0
[470.622878] Dynamic subtest rcs0: SUCCESS (0.559s)
[470.635170] Starting dynamic subtest: bcs0
[471.172252] Dynamic subtest bcs0: SUCCESS (0.547s)
[471.185525] Starting dynamic subtest: vcs0
[471.727858] Dynamic subtest vcs0: SUCCESS (0.553s)
[471.739225] Starting dynamic subtest: vcs1
[473.110090] Dynamic subtest vcs1: SUCCESS (1.379s)
[473.123554] Starting dynamic subtest: vecs0
[475.157730] Dynamic subtest vecs0: SUCCESS (2.044s)
[475.171147] Starting dynamic subtest: ccs0
[477.141593] Dynamic subtest ccs0: SUCCESS (1.981s)
[477.144598] Subtest busy-no-semaphores: SUCCESS (7.081s)
[477.284733] [101/131] (544s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[477.397768] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[477.401669] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[477.538436] [102/131] (544s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[477.666371] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[477.670895] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[477.842465] [103/131] (544s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[478.232826] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[479.084217] [104/131] (542s left) kms_getfb (getfb-reject-nv12)
[479.187005] Starting subtest: getfb-reject-nv12
[479.189287] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[479.327728] [105/131] (542s left) i915_drm_fdinfo (context-close-stress)
[479.368078] Starting subtest: context-close-stress
[490.111948] Subtest context-close-stress: SUCCESS (10.742s)
[490.236880] [106/131] (531s left) perf_pmu (module-unload)
[490.468543] Starting subtest: module-unload
[498.957121] Subtest module-unload: FAIL (8.379s)
[498.988936] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[498.989667] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[498.992779] [107/131] (523s left) kms_chamelium_edid (dp-edid-read)
[500.779225] Subtest dp-edid-read: SKIP (0.000s)
[501.604815] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[501.605965] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[501.609329] [108/131] (520s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[506.598993] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[506.601411] Starting dynamic subtest: pipe-A-eDP-1
[507.404286] Dynamic subtest pipe-A-eDP-1: SKIP (0.803s)
[507.414037] Starting dynamic subtest: pipe-B-eDP-1
[508.540222] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[508.544406] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.941s)
[509.746156] [109/131] (512s left) kms_vblank (query-busy)
[509.846271] Starting subtest: query-busy
[509.848230] Starting dynamic subtest: pipe-A-eDP-1
[511.721740] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[511.735682] Starting dynamic subtest: pipe-D-eDP-1
[514.281480] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s)
[514.283757] Subtest query-busy: SUCCESS (4.437s)
[515.097723] [110/131] (507s left) syncobj_timeline (wait-for-submit-complex)
[515.151996] Starting subtest: wait-for-submit-complex
[515.212378] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[515.311038] [111/131] (506s left) perf (invalid-create-userspace-config)
[515.458295] Starting subtest: invalid-create-userspace-config
[515.460519] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[515.507172] [112/131] (506s left) gem_exec_basic (basic)
[515.568546] Starting subtest: basic
[515.570755] Starting dynamic subtest: rcs0-smem
[515.572595] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[515.582534] Starting dynamic subtest: bcs0-smem
[515.584615] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[515.593029] Starting dynamic subtest: vcs0-smem
[515.595096] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[515.603143] Starting dynamic subtest: vcs1-smem
[515.605307] Dynamic subtest vcs1-smem: SUCCESS (0.004s)
[515.613512] Starting dynamic subtest: vecs0-smem
[515.615592] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[515.623728] Starting dynamic subtest: ccs0-smem
[515.625873] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[515.627968] Subtest basic: SUCCESS (0.020s)
[517.714071] [113/131] (504s left) kms_chamelium_color (ctm-0-25)
[517.806809] Subtest ctm-0-25: SKIP (0.000s)
[517.848227] [114/131] (504s left) gem_userptr_blits (process-exit-busy)
[517.912487] Starting subtest: process-exit-busy
[517.922052] Subtest process-exit-busy: SUCCESS (0.012s)
[518.069453] [115/131] (504s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[518.135079] Starting subtest: y-tiled-ccs-to-y-tiled
[518.139577] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[518.341697] [116/131] (504s left) gen7_exec_parse (bitmasks)
[518.396127] Subtest bitmasks: SKIP (0.000s)
[518.469618] [117/131] (503s left) gem_eio (wait-wedge-10ms)
[518.652684] Starting subtest: wait-wedge-10ms
[519.676003] Subtest wait-wedge-10ms: SUCCESS (1.023s)
[519.836865] [118/131] (502s left) kms_content_protection (atomic)
[519.973882] Starting subtest: atomic
[519.978406] Subtest atomic: SKIP (0.000s)
[520.140756] [119/131] (502s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[520.232651] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[520.234761] Starting dynamic subtest: pipe-A-default-mode
[520.540565] Dynamic subtest pipe-A-default-mode: SKIP (0.305s)
[520.545106] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.306s)
[521.432742] [120/131] (501s left) gem_exec_params (invalid-flag)
[521.501317] Starting subtest: invalid-flag
[521.503702] Subtest invalid-flag: SUCCESS (0.000s)
[521.648099] [121/131] (500s left) kms_getfb (getfb-addfb-different-handles)
[521.751975] Starting subtest: getfb-addfb-different-handles
[521.754228] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[521.893318] [122/131] (500s left) gem_exec_flush (basic-uc-ro-default)
[521.966353] Starting subtest: basic-uc-ro-default
[527.421379] Subtest basic-uc-ro-default: SUCCESS (5.455s)
[527.641695] [123/131] (495s left) gem_sync (basic-each)
[527.718665] Starting subtest: basic-each
[530.228044] Subtest basic-each: SUCCESS (2.520s)
[530.436861] [124/131] (492s left) gem_exec_balancer (full)
[530.509668] Starting subtest: full
[535.466565] Subtest full: SUCCESS (4.957s)
[535.831920] [125/131] (486s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[535.938630] Starting subtest: y-tiled-8bpp-rotate-180
[535.942831] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[536.078170] [126/131] (486s left) sw_sync (sync_merge_invalid)
[536.119884] Starting subtest: sync_merge_invalid
[536.144131] Subtest sync_merge_invalid: SUCCESS (0.026s)
[536.236486] [127/131] (486s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[536.340710] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[540.700113] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.363s)
[541.919292] [128/131] (480s left) gem_lmem_swapping (parallel-random-verify-ccs)
[541.962216] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[542.002041] [129/131] (480s left) kms_lease (lease-unleased-connector)
[542.097191] Starting subtest: lease-unleased-connector
[542.099425] Starting dynamic subtest: pipe-A-eDP-1
[542.107190] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[542.117544] Starting dynamic subtest: pipe-B-eDP-1
[542.119496] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[542.140095] Starting dynamic subtest: pipe-C-eDP-1
[542.142536] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[542.163180] Starting dynamic subtest: pipe-D-eDP-1
[542.165381] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[542.167603] Subtest lease-unleased-connector: SUCCESS (0.039s)
[542.273231] [130/131] (480s left) perf (enable-disable)
[542.379966] Starting subtest: enable-disable
[542.382473] Starting dynamic subtest: 0-rcs0
[544.652111] Dynamic subtest 0-rcs0: SUCCESS (2.270s)
[544.662522] Starting dynamic subtest: 1-vecs0
[549.109218] Dynamic subtest 1-vecs0: SUCCESS (4.456s)
[549.111787] Subtest enable-disable: SUCCESS (6.727s)
[549.159731] [131/131] (473s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[549.311733] Starting subtest: cursor-rapid-movement-32x32
[549.358919] Subtest cursor-rapid-movement-32x32: SKIP (0.041s)
[549.678782] Closing watchdogs
results: parsing output: 0/ for test: fbdev
results: parsing output: 1/ for test: gem_ctx_isolation
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: gem_spin_batch
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: sysfs_heartbeat_interval
results: parsing output: 8/ for test: kms_invalid_mode
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_getfb
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: kms_rotation_crc
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_plane_alpha_blend
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: vgem_basic
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: core_auth
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: kms_dither
results: parsing output: 31/ for test: gem_partial_pwrite_pread
results: parsing output: 32/ for test: gem_eio
results: parsing output: 33/ for test: gen3_render_mixed_blits
results: parsing output: 34/ for test: kms_pm_rpm
results: parsing output: 35/ for test: i915_module_load
results: parsing output: 36/ for test: kms_plane_scaling
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_rotation_crc
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: kms_vblank
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: sriov_basic
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: gem_mmap_offset
results: parsing output: 56/ for test: kms_atomic
results: parsing output: 57/ for test: kms_atomic_transition
results: parsing output: 58/ for test: gem_exec_parallel
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_atomic_interruptible
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: i915_suspend
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gem_vm_create
results: parsing output: 71/ for test: gem_ccs
results: parsing output: 72/ for test: syncobj_basic
results: parsing output: 73/ for test: kms_plane_multiple
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_pm_rpm
results: parsing output: 76/ for test: kms_setmode
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: gem_ringfill
results: parsing output: 79/ for test: gem_exec_params
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_busy
results: parsing output: 82/ for test: gem_ppgtt
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_async
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: dmabuf_sync_file
results: parsing output: 97/ for test: kms_feature_discovery
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_chamelium_hpd
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: kms_chamelium_edid
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: gem_exec_basic
results: parsing output: 112/ for test: kms_chamelium_color
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: gem_render_copy
results: parsing output: 115/ for test: gen7_exec_parse
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_content_protection
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: kms_getfb
results: parsing output: 121/ for test: gem_exec_flush
results: parsing output: 122/ for test: gem_sync
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: sw_sync
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_lmem_swapping
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: kms_cursor_crc
Done.