[100.207507] Initializing watchdogs
[100.207578]   /dev/watchdog0
[100.221272] [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]
[100.225469] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[100.227567] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[100.231101] [001/131] (960s left) fbdev (unaligned-read)
[100.304131] Starting subtest: unaligned-read
[100.318754] Subtest unaligned-read: SUCCESS (0.015s)
[100.392946] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[100.448667] Starting subtest: dirty-switch
[100.451110] Starting dynamic subtest: rcs0
[100.685513] Dynamic subtest rcs0: SUCCESS (0.237s)
[100.695849] Starting dynamic subtest: bcs0
[100.949469] Dynamic subtest bcs0: SUCCESS (0.263s)
[100.958803] Starting dynamic subtest: vcs0
[101.214463] Dynamic subtest vcs0: SUCCESS (0.266s)
[101.224054] Starting dynamic subtest: vcs1
[103.159996] Dynamic subtest vcs1: SUCCESS (1.945s)
[103.170030] Starting dynamic subtest: vecs0
[105.149292] Dynamic subtest vecs0: SUCCESS (1.989s)
[105.158929] Starting dynamic subtest: ccs0
[107.142702] Dynamic subtest ccs0: SUCCESS (1.993s)
[107.145212] Subtest dirty-switch: SUCCESS (6.694s)
[107.419303] [003/131] (953s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[107.525319] Starting subtest: psr-modesetfrombusy
[113.739279] Subtest psr-modesetfrombusy: SUCCESS (6.217s)
[113.905905] [004/131] (946s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[114.005180] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[114.007125] Starting dynamic subtest: pipe-A-default-mode
[116.760022] Dynamic subtest pipe-A-default-mode: SUCCESS (2.759s)
[116.762183] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.760s)
[117.638684] [005/131] (943s left) gem_exec_params (sol-reset-invalid)
[117.707741] Starting subtest: sol-reset-invalid
[117.712432] Subtest sol-reset-invalid: SUCCESS (0.003s)
[119.036387] [006/131] (941s left) gem_spin_batch (resubmit-new)
[119.092932] Starting subtest: resubmit-new
[119.095327] Starting dynamic subtest: rcs0
[119.101110] Dynamic subtest rcs0: SUCCESS (0.008s)
[119.109123] Starting dynamic subtest: bcs0
[119.111095] Dynamic subtest bcs0: SUCCESS (0.004s)
[119.122677] Starting dynamic subtest: vcs0
[119.125045] Dynamic subtest vcs0: SUCCESS (0.006s)
[119.133292] Starting dynamic subtest: vcs1
[119.135427] Dynamic subtest vcs1: SUCCESS (0.007s)
[119.142524] Starting dynamic subtest: vecs0
[119.144737] Dynamic subtest vecs0: SUCCESS (0.007s)
[119.151659] Starting dynamic subtest: ccs0
[119.153828] Dynamic subtest ccs0: SUCCESS (0.003s)
[119.156076] Subtest resubmit-new: SUCCESS (0.038s)
[120.917759] [007/131] (940s left) gem_exec_schedule (preempt-user)
[120.994225] Starting subtest: preempt-user
[120.996500] Starting dynamic subtest: rcs0
[121.020877] Dynamic subtest rcs0: SUCCESS (0.034s)
[121.031315] Starting dynamic subtest: bcs0
[121.057584] Dynamic subtest bcs0: SUCCESS (0.036s)
[121.066018] Starting dynamic subtest: vcs0
[121.080670] Dynamic subtest vcs0: SUCCESS (0.023s)
[121.088537] Starting dynamic subtest: vcs1
[121.104313] Dynamic subtest vcs1: SUCCESS (0.023s)
[121.111547] Starting dynamic subtest: vecs0
[121.126433] Dynamic subtest vecs0: SUCCESS (0.022s)
[121.137093] Starting dynamic subtest: ccs0
[121.157856] Dynamic subtest ccs0: SUCCESS (0.031s)
[121.160307] Subtest preempt-user: SUCCESS (0.171s)
[123.013821] [008/131] (937s left) sysfs_heartbeat_interval (nopreempt)
[123.074071] Starting subtest: nopreempt
[123.076310] Starting dynamic subtest: vecs0
[132.880699] Dynamic subtest vecs0: SUCCESS (9.806s)
[132.891360] Starting dynamic subtest: ccs0
[136.906936] Dynamic subtest ccs0: SUCCESS (4.025s)
[136.916540] Starting dynamic subtest: vcs0
[146.922874] Dynamic subtest vcs0: SUCCESS (10.013s)
[146.933074] Starting dynamic subtest: bcs0
[150.877898] Dynamic subtest bcs0: SUCCESS (3.955s)
[150.887555] Starting dynamic subtest: rcs0
[154.937759] Dynamic subtest rcs0: SUCCESS (4.060s)
[154.948552] Starting dynamic subtest: vcs1
[163.947790] Dynamic subtest vcs1: SUCCESS (9.008s)
[163.950330] Subtest nopreempt: SUCCESS (40.873s)
[164.046847] [009/131] (896s left) kms_invalid_mode (zero-hdisplay)
[164.144913] Starting subtest: zero-hdisplay
[164.147429] Starting dynamic subtest: pipe-A-eDP-1
[164.428590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[164.437886] Starting dynamic subtest: pipe-B-eDP-1
[164.440125] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[164.447307] Starting dynamic subtest: pipe-C-eDP-1
[164.449583] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[164.457077] Starting dynamic subtest: pipe-D-eDP-1
[164.459380] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[164.461811] Subtest zero-hdisplay: SUCCESS (0.289s)
[165.269829] [010/131] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[165.370061] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[165.374684] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[165.494355] [011/131] (895s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[165.594395] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[166.488519] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.896s)
[166.703855] [012/131] (894s left) kms_getfb (getfb-handle-zero)
[166.810123] Starting subtest: getfb-handle-zero
[166.812515] Subtest getfb-handle-zero: SUCCESS (0.000s)
[166.949491] [013/131] (894s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[167.022609] Starting subtest: yf-tiled-ccs-to-yf-tiled
[167.027224] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[167.225087] [014/131] (893s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[167.313187] Starting subtest: multiplane-rotation-cropping-bottom
[174.515015] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.204s)
[174.674823] [015/131] (886s left) gem_eio (wait-1us)
[174.903742] Starting subtest: wait-1us
[175.228805] Subtest wait-1us: SUCCESS (0.326s)
[175.411731] [016/131] (885s left) syncobj_wait (multi-wait-for-submit-signaled)
[175.473397] Starting subtest: multi-wait-for-submit-signaled
[175.475304] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[175.603720] [017/131] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[175.706196] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[175.708229] Starting dynamic subtest: pipe-A-default-mode
[176.005602] Dynamic subtest pipe-A-default-mode: SKIP (0.297s)
[176.010053] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.298s)
[176.909491] [018/131] (884s left) kms_plane_alpha_blend (alpha-7efc)
[177.009059] Starting subtest: alpha-7efc
[177.281248] Starting dynamic subtest: pipe-A-eDP-1
[177.880685] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s)
[177.910088] Starting dynamic subtest: pipe-D-eDP-1
[179.197308] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.291s)
[179.199648] Subtest alpha-7efc: SUCCESS (2.189s)
[180.069246] [019/131] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[180.182470] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[180.187020] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[180.320310] [020/131] (881s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[180.423208] Starting subtest: fbc-psr2-primary-mmap-cpu
[180.425491] Starting dynamic subtest: eDP-1
[180.429620] Dynamic subtest eDP-1: SKIP (0.000s)
[180.433759] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[180.525202] [021/131] (880s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[180.627345] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[180.636016] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[180.766418] [022/131] (880s left) gem_exec_whisper (basic-normal-all)
[180.845158] Starting subtest: basic-normal-all
[183.318303] Subtest basic-normal-all: SUCCESS (2.472s)
[183.523070] [023/131] (878s left) kms_big_fb (linear-16bpp-rotate-180)
[183.635656] Starting subtest: linear-16bpp-rotate-180
[185.061059] Subtest linear-16bpp-rotate-180: SUCCESS (1.425s)
[185.215981] [024/131] (876s left) kms_frontbuffer_tracking (psr-slowdraw)
[185.315055] Starting subtest: psr-slowdraw
[210.589247] Subtest psr-slowdraw: SUCCESS (25.275s)
[210.756280] [025/131] (850s left) vgem_basic (dmabuf-fence)
[210.865399] Starting subtest: dmabuf-fence
[210.867651] Subtest dmabuf-fence: SUCCESS (0.003s)
[210.943122] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[210.946512] [026/131] (850s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[211.011477] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[211.013892] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[211.151493] [027/131] (850s left) kms_psr (pr-primary-render)
[211.239097] Starting subtest: pr-primary-render
[211.243586] Subtest pr-primary-render: SKIP (0.000s)
[211.336734] [028/131] (850s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[211.432752] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[211.434615] Starting dynamic subtest: pipe-A-eDP-1
[211.453740] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[211.463745] Starting dynamic subtest: pipe-B-eDP-1
[211.480852] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[211.488552] Starting dynamic subtest: pipe-C-eDP-1
[211.506055] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[211.513362] Starting dynamic subtest: pipe-D-eDP-1
[211.531527] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[211.535076] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[213.660158] [029/131] (848s left) core_auth (getclient-master-drop)
[213.692520] Starting subtest: getclient-master-drop
[213.709839] Subtest getclient-master-drop: SUCCESS (0.020s)
[213.852116] [030/131] (847s left) kms_plane_scaling (planes-downscale-factor-0-5)
[213.957298] Starting subtest: planes-downscale-factor-0-5
[213.959629] Starting dynamic subtest: pipe-A
[213.977527] Dynamic subtest pipe-A: SKIP (0.017s)
[213.986894] Starting dynamic subtest: pipe-B
[214.012800] Dynamic subtest pipe-B: SKIP (0.034s)
[214.021673] Starting dynamic subtest: pipe-C
[214.046361] Dynamic subtest pipe-C: SKIP (0.034s)
[214.055036] Starting dynamic subtest: pipe-D
[214.077798] Dynamic subtest pipe-D: SKIP (0.030s)
[214.082218] Subtest planes-downscale-factor-0-5: SKIP (0.117s)
[214.220158] [031/131] (847s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[214.323036] Starting subtest: fb-8bpc-vs-panel-8bpc
[214.325318] Starting dynamic subtest: pipe-A-eDP-1
[215.728715] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.405s)
[215.731028] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.407s)
[216.616236] [032/131] (845s left) gem_partial_pwrite_pread (reads-snoop)
[216.682654] Subtest reads-snoop: SKIP (0.000s)
[216.764449] [033/131] (845s left) gem_eio (in-flight-contexts-immediate)
[216.996184] Starting subtest: in-flight-contexts-immediate
[230.944900] Subtest in-flight-contexts-immediate: SUCCESS (13.949s)
[231.134547] [034/131] (830s left) gen3_render_mixed_blits
[231.259364] [035/131] (830s left) kms_pm_rpm (pm-tiling)
[233.078901] Starting subtest: pm-tiling
[233.083971] Subtest pm-tiling: SKIP (0.000s)
[233.570108] [036/131] (828s left) i915_module_load (reload-no-display)
[233.604183] Starting subtest: reload-no-display
[238.235356] Subtest reload-no-display: SUCCESS (4.634s)
[238.263778] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[238.264504] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[238.267632] [037/131] (823s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[239.841118] Starting subtest: plane-upscale-20x20-with-rotation
[239.843432] Starting dynamic subtest: pipe-A
[240.087633] Dynamic subtest pipe-A: SUCCESS (0.248s)
[240.095752] Starting dynamic subtest: pipe-B
[241.441069] Dynamic subtest pipe-B: SUCCESS (1.351s)
[241.450973] Starting dynamic subtest: pipe-C
[242.761734] Dynamic subtest pipe-C: SUCCESS (1.319s)
[242.770301] Starting dynamic subtest: pipe-D
[244.098957] Dynamic subtest pipe-D: SUCCESS (1.336s)
[244.101185] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.260s)
[245.260830] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[245.261994] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[245.266026] [038/131] (816s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[245.391396] Starting subtest: 4-tiled-8bpp-rotate-180
[246.531754] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.140s)
[246.701705] [039/131] (815s left) kms_rotation_crc (primary-rotation-90)
[246.806354] Starting subtest: primary-rotation-90
[246.809970] Subtest primary-rotation-90: SKIP (0.001s)
[246.901291] [040/131] (815s left) kms_cursor_crc (cursor-onscreen-32x10)
[247.052850] Starting subtest: cursor-onscreen-32x10
[247.098450] Subtest cursor-onscreen-32x10: SKIP (0.040s)
[247.396649] [041/131] (814s left) kms_vblank (wait-idle)
[247.488331] Starting subtest: wait-idle
[247.489871] Starting dynamic subtest: pipe-A-eDP-1
[249.242442] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[249.256789] Starting dynamic subtest: pipe-D-eDP-1
[251.712024] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.467s)
[251.714183] Subtest wait-idle: SUCCESS (4.223s)
[252.560106] [042/131] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[252.660929] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[252.665210] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[252.795630] [043/131] (809s left) kms_flip (2x-flip-vs-dpms)
[252.885427] Starting subtest: 2x-flip-vs-dpms
[252.893689] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[253.011096] [044/131] (809s left) gem_exec_fence (syncobj-channel)
[253.557881] Starting subtest: syncobj-channel
[254.575240] Subtest syncobj-channel: SUCCESS (1.015s)
[255.062431] [045/131] (807s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[255.168174] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[255.170331] Starting dynamic subtest: pipe-A-eDP-1
[255.179193] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[255.190185] Starting dynamic subtest: pipe-B-eDP-1
[255.199634] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[255.210040] Starting dynamic subtest: pipe-C-eDP-1
[255.218387] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[255.225957] Starting dynamic subtest: pipe-D-eDP-1
[255.234252] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[255.238528] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[257.449974] [046/131] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[257.545240] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[264.833391] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.290s)
[264.980881] [047/131] (797s left) kms_flip (busy-flip)
[265.076088] Starting subtest: busy-flip
[265.078381] Starting dynamic subtest: A-eDP1
[266.758161] Dynamic subtest A-eDP1: SUCCESS (1.681s)
[266.766709] Starting dynamic subtest: B-eDP1
[268.400135] Dynamic subtest B-eDP1: SUCCESS (1.641s)
[268.410256] Starting dynamic subtest: C-eDP1
[270.020643] Dynamic subtest C-eDP1: SUCCESS (1.619s)
[270.028671] Starting dynamic subtest: D-eDP1
[271.651729] Dynamic subtest D-eDP1: SUCCESS (1.629s)
[271.657503] Subtest busy-flip: SUCCESS (6.581s)
[272.928267] [048/131] (789s left) prime_mmap (test_aperture_limit)
[272.980154] Starting subtest: test_aperture_limit
[272.982577] Starting dynamic subtest: test_aperture_limit-smem
[272.990586] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[272.994966] Subtest test_aperture_limit: SKIP (0.009s)
[273.129309] [049/131] (789s left) i915_pm_rpm (sysfs-read)
[275.054354] Starting subtest: sysfs-read
[276.210871] Subtest sysfs-read: SUCCESS (1.155s)
[276.605237] [050/131] (786s left) kms_big_fb (yf-tiled-addfb)
[276.719693] Starting subtest: yf-tiled-addfb
[276.724093] Subtest yf-tiled-addfb: SKIP (0.000s)
[276.836061] [051/131] (785s left) sriov_basic (enable-vfs-autoprobe-on)
[276.897233] Starting subtest: enable-vfs-autoprobe-on
[276.899544] Starting dynamic subtest: numvfs-1
[276.977297] Dynamic subtest numvfs-1: FAIL (0.028s)
[276.987435] Starting dynamic subtest: numvfs-2
[277.059067] Dynamic subtest numvfs-2: FAIL (0.005s)
[277.068894] Starting dynamic subtest: numvfs-3
[277.140874] Dynamic subtest numvfs-3: FAIL (0.004s)
[277.150086] Starting dynamic subtest: numvfs-4
[277.221831] Dynamic subtest numvfs-4: FAIL (0.003s)
[277.231694] Starting dynamic subtest: numvfs-5
[277.304492] Dynamic subtest numvfs-5: FAIL (0.004s)
[277.313894] Starting dynamic subtest: numvfs-6
[277.386451] Dynamic subtest numvfs-6: FAIL (0.004s)
[277.396183] Starting dynamic subtest: numvfs-7
[277.468629] Dynamic subtest numvfs-7: FAIL (0.003s)
[277.478150] Starting dynamic subtest: numvfs-random
[277.542930] Dynamic subtest numvfs-random: FAIL (0.004s)
[277.552022] Starting dynamic subtest: numvfs-all
[277.612555] Dynamic subtest numvfs-all: FAIL (0.505s)
[277.614244] Subtest enable-vfs-autoprobe-on: FAIL (0.568s)
[277.648960] [052/131] (785s left) gem_exec_whisper (basic-queues)
[277.719196] Starting subtest: basic-queues
[283.394980] Subtest basic-queues: SUCCESS (5.671s)
[283.602764] [053/131] (779s left) kms_flip (2x-dpms-vs-vblank-race)
[283.716611] Starting subtest: 2x-dpms-vs-vblank-race
[283.725120] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[283.868232] [054/131] (778s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[283.975355] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[284.348995] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[287.141610] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[287.150353] Starting dynamic subtest: pipe-A-eDP-1-4
[289.317434] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[289.328176] Starting dynamic subtest: pipe-A-eDP-1-4
[291.328103] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[291.339486] Starting dynamic subtest: pipe-A-eDP-1-x
[293.506423] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[293.887718] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[296.673741] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.796s)
[296.685213] Starting dynamic subtest: pipe-B-eDP-1-4
[298.848782] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s)
[298.859973] Starting dynamic subtest: pipe-B-eDP-1-4
[300.859197] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[300.872205] Starting dynamic subtest: pipe-B-eDP-1-x
[303.048978] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.187s)
[303.425524] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[306.202703] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.785s)
[306.214622] Starting dynamic subtest: pipe-C-eDP-1-4
[308.377762] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[308.386488] Starting dynamic subtest: pipe-C-eDP-1-4
[310.388153] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[310.396498] Starting dynamic subtest: pipe-C-eDP-1-x
[312.567936] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[312.926138] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[315.733829] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.813s)
[315.745744] Starting dynamic subtest: pipe-D-eDP-1-4
[317.908067] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[317.916846] Starting dynamic subtest: pipe-D-eDP-1-4
[319.919477] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[319.930642] Starting dynamic subtest: pipe-D-eDP-1-x
[322.086767] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.166s)
[322.089301] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.111s)
[323.344100] [055/131] (739s left) gem_mmap_gtt (basic-write-read-distinct)
[323.407166] Subtest basic-write-read-distinct: SKIP (0.000s)
[323.460192] [056/131] (739s left) gem_mmap_offset (oob-read)
[323.510420] Starting subtest: oob-read
[323.512617] Subtest oob-read: SUCCESS (0.000s)
[323.631133] [057/131] (739s left) kms_atomic (atomic-plane-damage)
[323.731453] Starting subtest: atomic-plane-damage
[323.779426] Starting dynamic subtest: pipe-A-eDP-1
[324.339652] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.561s)
[324.341569] Subtest atomic-plane-damage: SUCCESS (0.608s)
[325.162753] [058/131] (737s left) kms_atomic_transition (plane-all-transition-nonblocking)
[325.266062] Starting subtest: plane-all-transition-nonblocking
[325.268398] Starting dynamic subtest: pipe-A-eDP-1
[327.759694] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[328.071131] Starting dynamic subtest: pipe-B-eDP-1
[331.271578] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.208s)
[331.567523] Subtest plane-all-transition-nonblocking: SUCCESS (6.303s)
[332.420227] [059/131] (730s left) gem_exec_parallel (contexts)
[332.486406] Starting subtest: contexts
[332.488871] Starting dynamic subtest: rcs0
[335.303307] Dynamic subtest rcs0: SUCCESS (2.815s)
[335.315080] Starting dynamic subtest: bcs0
[338.904203] Dynamic subtest bcs0: SUCCESS (3.598s)
[338.913604] Starting dynamic subtest: vcs0
[343.241231] Dynamic subtest vcs0: SUCCESS (4.333s)
[343.253255] Starting dynamic subtest: vcs1
[347.332546] Dynamic subtest vcs1: SUCCESS (4.088s)
[347.343945] Starting dynamic subtest: vecs0
[351.391040] Dynamic subtest vecs0: SUCCESS (4.057s)
[351.400670] Starting dynamic subtest: ccs0
[355.270760] Dynamic subtest ccs0: SUCCESS (3.876s)
[355.273697] Subtest contexts: SUCCESS (22.784s)
[355.495892] [060/131] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[355.596551] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[362.330323] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.737s)
[362.499707] [061/131] (700s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[362.601598] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[362.605745] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[362.736703] [062/131] (700s left) kms_atomic_interruptible (legacy-pageflip)
[362.840442] Starting subtest: legacy-pageflip
[362.842641] Starting dynamic subtest: pipe-A-eDP-1
[370.259242] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.420s)
[370.261589] Subtest legacy-pageflip: SUCCESS (7.421s)
[371.097087] [063/131] (692s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[371.201521] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[371.205487] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[371.340027] [064/131] (691s left) kms_psr (psr2-sprite-mmap-cpu)
[371.441962] Starting subtest: psr2-sprite-mmap-cpu
[371.444125] Starting dynamic subtest: eDP-1
[373.197581] Dynamic subtest eDP-1: SUCCESS (1.755s)
[373.199887] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.756s)
[374.048454] [065/131] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[374.137469] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[381.245423] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.110s)
[381.439097] [066/131] (681s left) gem_exec_schedule (fairslice-all)
[381.511716] Starting subtest: fairslice-all
[383.561392] Subtest fairslice-all: SUCCESS (2.059s)
[384.921446] [067/131] (678s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[389.940414] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[389.942695] Starting dynamic subtest: pipe-A-eDP-1
[390.723427] Dynamic subtest pipe-A-eDP-1: SKIP (0.780s)
[390.732301] Starting dynamic subtest: pipe-B-eDP-1
[391.853334] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[391.857815] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.911s)
[393.064385] [068/131] (670s left) api_intel_allocator (two-level-inception)
[393.118812] Starting subtest: two-level-inception
[398.515203] Subtest two-level-inception: SUCCESS (5.397s)
[398.679075] [069/131] (664s left) i915_suspend (debugfs-reader)
[398.743755] Starting subtest: debugfs-reader
[416.399345] Subtest debugfs-reader: SUCCESS (8.063s)
[416.565816] [070/131] (647s left) kms_flip (plain-flip-fb-recreate-interruptible)
[416.695678] Starting subtest: plain-flip-fb-recreate-interruptible
[416.698055] Starting dynamic subtest: A-eDP1
[425.573616] Dynamic subtest A-eDP1: SUCCESS (8.871s)
[425.585289] Starting dynamic subtest: B-eDP1
[434.405993] Dynamic subtest B-eDP1: SUCCESS (8.827s)
[434.416229] Starting dynamic subtest: C-eDP1
[443.234161] Dynamic subtest C-eDP1: SUCCESS (8.825s)
[443.252513] Starting dynamic subtest: D-eDP1
[452.066982] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[452.071594] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.364s)
[453.268126] [071/131] (610s left) gem_vm_create (invalid-destroy)
[453.328620] Starting subtest: invalid-destroy
[453.331061] Subtest invalid-destroy: SUCCESS (0.002s)
[453.472597] [072/131] (610s left) gem_ccs (ctrl-surf-copy-new-ctx)
[453.533401] Starting subtest: ctrl-surf-copy-new-ctx
[453.537729] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[453.674771] [073/131] (610s left) syncobj_basic (bad-destroy-pad)
[453.739413] Starting subtest: bad-destroy-pad
[453.741308] Subtest bad-destroy-pad: SUCCESS (0.000s)
[453.875467] [074/131] (609s left) kms_plane_multiple (2x-tiling-y)
[453.965380] Starting subtest: 2x-tiling-y
[453.969690] Subtest 2x-tiling-y: SKIP (0.000s)
[454.062561] [075/131] (609s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[454.161313] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[454.163489] Starting dynamic subtest: pipe-A-eDP-1
[454.185061] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[454.197021] Starting dynamic subtest: pipe-B-eDP-1
[454.214804] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[454.224105] Starting dynamic subtest: pipe-C-eDP-1
[454.241774] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[454.251164] Starting dynamic subtest: pipe-D-eDP-1
[454.269695] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[454.273056] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[456.364509] [076/131] (607s left) kms_pm_rpm (modeset-lpsp)
[458.696517] Starting subtest: modeset-lpsp
[460.168820] Subtest modeset-lpsp: SUCCESS (1.476s)
[460.283644] [077/131] (603s left) kms_setmode (basic)
[460.343814] Starting subtest: basic
[460.681517] Starting dynamic subtest: pipe-A-eDP-1
[462.749800] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.063s)
[463.093053] Starting dynamic subtest: pipe-B-eDP-1
[465.184518] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.097s)
[465.488204] Subtest basic: SUCCESS (5.143s)
[466.342728] [078/131] (597s left) kms_psr (fbc-psr-suspend)
[466.437157] Starting subtest: fbc-psr-suspend
[466.439444] Starting dynamic subtest: eDP-1
[466.444069] Dynamic subtest eDP-1: SKIP (0.000s)
[466.448566] Subtest fbc-psr-suspend: SKIP (0.001s)
[466.535737] [079/131] (597s left) gem_ringfill (engines-basic)
[472.529975] Starting subtest: engines-basic
[472.532447] Starting dynamic subtest: rcs0
[472.598016] Dynamic subtest rcs0: SUCCESS (0.068s)
[472.610880] Starting dynamic subtest: bcs0
[472.644035] Dynamic subtest bcs0: SUCCESS (0.044s)
[472.655068] Starting dynamic subtest: vcs0
[472.688494] Dynamic subtest vcs0: SUCCESS (0.042s)
[472.699560] Starting dynamic subtest: vcs1
[472.731100] Dynamic subtest vcs1: SUCCESS (0.041s)
[472.741947] Starting dynamic subtest: vecs0
[472.775124] Dynamic subtest vecs0: SUCCESS (0.042s)
[472.785997] Starting dynamic subtest: ccs0
[472.820853] Dynamic subtest ccs0: SUCCESS (0.044s)
[472.823529] Subtest engines-basic: SUCCESS (0.293s)
[472.923025] [080/131] (591s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[472.989206] Starting subtest: invalid-bsd2-flag-on-vebox
[472.991547] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[473.113222] [081/131] (590s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[473.215818] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[473.217891] Starting dynamic subtest: pipe-A-eDP-1
[473.236469] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[473.246320] Starting dynamic subtest: pipe-B-eDP-1
[473.264947] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[473.274957] Starting dynamic subtest: pipe-C-eDP-1
[473.294915] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[473.306715] Starting dynamic subtest: pipe-D-eDP-1
[473.326318] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[473.328570] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s)
[475.591586] [082/131] (588s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[475.703379] Starting subtest: extended-pageflip-modeset-hang-oldfb
[475.705661] Starting dynamic subtest: pipe-A
[483.605349] Dynamic subtest pipe-A: SUCCESS (7.899s)
[483.615731] Starting dynamic subtest: pipe-D
[492.182856] Dynamic subtest pipe-D: SUCCESS (8.573s)
[492.185113] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.477s)
[493.067167] [083/131] (571s left) gem_ppgtt (shrink-vs-evict-any)
[493.121744] Starting subtest: shrink-vs-evict-any
[498.476565] Subtest shrink-vs-evict-any: SUCCESS (5.352s)
[498.587299] [084/131] (565s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[498.646413] Starting subtest: etime-single-wait-for-submit-unsubmitted
[498.755488] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[498.857132] [085/131] (565s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[498.913168] Starting subtest: multi-wait-all-for-submit-signaled
[498.915550] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[499.058355] [086/131] (565s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[499.121856] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[499.227207] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[499.335527] [087/131] (565s left) gem_exec_schedule (implicit-write-read)
[499.421462] Starting subtest: implicit-write-read
[499.423489] Starting dynamic subtest: rcs0
[499.588219] Dynamic subtest rcs0: SUCCESS (0.176s)
[499.601536] Starting dynamic subtest: vcs0
[499.715245] Dynamic subtest vcs0: SUCCESS (0.127s)
[499.727629] Starting dynamic subtest: vcs1
[499.819133] Dynamic subtest vcs1: SUCCESS (0.103s)
[499.834859] Starting dynamic subtest: vecs0
[499.927856] Dynamic subtest vecs0: SUCCESS (0.106s)
[499.940826] Starting dynamic subtest: ccs0
[500.043647] Dynamic subtest ccs0: SUCCESS (0.114s)
[500.046857] Subtest implicit-write-read: SUCCESS (0.632s)
[501.660858] [088/131] (562s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[501.763740] Starting subtest: fbcpsr-rgb565-draw-blt
[508.739539] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.977s)
[508.913470] [089/131] (555s left) gem_ctx_persistence (processes)
[508.982439] Starting subtest: processes
[510.485842] Subtest processes: SUCCESS (1.503s)
[510.637545] [090/131] (553s left) kms_cursor_crc (cursor-sliding-32x10)
[510.801790] Starting subtest: cursor-sliding-32x10
[510.843674] Subtest cursor-sliding-32x10: SKIP (0.040s)
[511.134395] [091/131] (553s left) kms_psr (fbc-pr-primary-render)
[511.224490] Starting subtest: fbc-pr-primary-render
[511.228875] Subtest fbc-pr-primary-render: SKIP (0.000s)
[511.325530] [092/131] (553s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[511.386869] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[511.452540] [093/131] (553s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[511.508161] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[511.510145] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[511.639817] [094/131] (553s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[511.751420] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[511.754846] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[511.879863] [095/131] (552s left) gem_exec_async (concurrent-writes)
[511.940330] Starting subtest: concurrent-writes
[511.942255] Starting dynamic subtest: rcs0
[511.954512] Dynamic subtest rcs0: SUCCESS (0.014s)
[511.964972] Starting dynamic subtest: bcs0
[511.966797] Dynamic subtest bcs0: SUCCESS (0.007s)
[511.976803] Starting dynamic subtest: vcs0
[511.978523] Dynamic subtest vcs0: SUCCESS (0.005s)
[511.988200] Starting dynamic subtest: vcs1
[511.989991] Dynamic subtest vcs1: SUCCESS (0.006s)
[511.998797] Starting dynamic subtest: vecs0
[512.000609] Dynamic subtest vecs0: SUCCESS (0.005s)
[512.009702] Starting dynamic subtest: ccs0
[512.011562] Dynamic subtest ccs0: SUCCESS (0.005s)
[512.013370] Subtest concurrent-writes: SUCCESS (0.046s)
[512.258289] [096/131] (552s left) gem_mmap_gtt (basic-small-bo-tiledx)
[512.317973] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[512.386900] [097/131] (552s left) dmabuf_sync_file (import-basic)
[512.430391] Starting subtest: import-basic
[512.434391] Subtest import-basic: SUCCESS (0.003s)
[512.510619] [098/131] (552s left) kms_feature_discovery (display)
[512.606607] Starting subtest: display
[512.608519] Subtest display: SUCCESS (0.000s)
[512.702400] [099/131] (552s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[512.802243] Starting subtest: x-tiled-64bpp-rotate-90
[512.821569] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[512.967493] [100/131] (551s left) perf_pmu (busy-no-semaphores)
[513.017282] Starting subtest: busy-no-semaphores
[513.019359] Starting dynamic subtest: rcs0
[513.585204] Dynamic subtest rcs0: SUCCESS (0.564s)
[513.606078] Starting dynamic subtest: bcs0
[514.137488] Dynamic subtest bcs0: SUCCESS (0.549s)
[514.150224] Starting dynamic subtest: vcs0
[514.688457] Dynamic subtest vcs0: SUCCESS (0.547s)
[514.700513] Starting dynamic subtest: vcs1
[516.047205] Dynamic subtest vcs1: SUCCESS (1.356s)
[516.060413] Starting dynamic subtest: vecs0
[518.039019] Dynamic subtest vecs0: SUCCESS (1.989s)
[518.052309] Starting dynamic subtest: ccs0
[519.953679] Dynamic subtest ccs0: SUCCESS (1.912s)
[519.956751] Subtest busy-no-semaphores: SUCCESS (6.936s)
[520.094562] [101/131] (544s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[520.210729] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[520.215033] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[520.343511] [102/131] (544s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[520.467379] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[520.471588] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[520.639556] [103/131] (544s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[521.031824] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[521.867527] [104/131] (543s left) kms_getfb (getfb-reject-nv12)
[521.976019] Starting subtest: getfb-reject-nv12
[521.978264] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[522.125053] [105/131] (542s left) i915_drm_fdinfo (context-close-stress)
[522.170146] Starting subtest: context-close-stress
[532.916115] Subtest context-close-stress: SUCCESS (10.744s)
[533.034296] [106/131] (532s left) perf_pmu (module-unload)
[533.285296] Starting subtest: module-unload
[541.447332] Subtest module-unload: FAIL (8.048s)
[541.480134] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[541.481289] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[541.484565] [107/131] (523s left) kms_chamelium_edid (dp-edid-read)
[543.315430] Subtest dp-edid-read: SKIP (0.000s)
[544.145833] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[544.147042] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[544.151005] [108/131] (521s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[549.113726] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[549.115861] Starting dynamic subtest: pipe-A-eDP-1
[549.930471] Dynamic subtest pipe-A-eDP-1: SKIP (0.815s)
[549.940708] Starting dynamic subtest: pipe-B-eDP-1
[551.069793] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s)
[551.074179] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.956s)
[552.279716] [109/131] (513s left) kms_vblank (query-busy)
[552.387365] Starting subtest: query-busy
[552.389196] Starting dynamic subtest: pipe-A-eDP-1
[554.259806] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[554.274754] Starting dynamic subtest: pipe-D-eDP-1
[556.826595] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.562s)
[556.828790] Subtest query-busy: SUCCESS (4.440s)
[557.649350] [110/131] (507s left) syncobj_timeline (wait-for-submit-complex)
[557.712798] Starting subtest: wait-for-submit-complex
[557.772823] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[557.875304] [111/131] (507s left) perf (invalid-create-userspace-config)
[558.017696] Starting subtest: invalid-create-userspace-config
[558.019908] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[558.061342] [112/131] (507s left) gem_exec_basic (basic)
[558.123943] Starting subtest: basic
[558.126232] Starting dynamic subtest: rcs0-smem
[558.128534] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[558.139980] Starting dynamic subtest: bcs0-smem
[558.142115] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[558.151038] Starting dynamic subtest: vcs0-smem
[558.153207] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[558.161568] Starting dynamic subtest: vcs1-smem
[558.163702] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[558.171966] Starting dynamic subtest: vecs0-smem
[558.174061] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[558.182327] Starting dynamic subtest: ccs0-smem
[558.184405] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[558.186432] Subtest basic: SUCCESS (0.014s)
[559.566566] [113/131] (505s left) kms_chamelium_color (ctm-0-25)
[559.665535] Subtest ctm-0-25: SKIP (0.000s)
[559.710261] [114/131] (505s left) gem_userptr_blits (process-exit-busy)
[559.769885] Starting subtest: process-exit-busy
[559.782847] Subtest process-exit-busy: SUCCESS (0.014s)
[559.955633] [115/131] (505s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[560.018969] Starting subtest: y-tiled-ccs-to-y-tiled
[560.023482] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[560.225556] [116/131] (505s left) gen7_exec_parse (bitmasks)
[560.286197] Subtest bitmasks: SKIP (0.000s)
[560.355809] [117/131] (505s left) gem_eio (wait-wedge-10ms)
[560.533953] Starting subtest: wait-wedge-10ms
[561.532755] Subtest wait-wedge-10ms: SUCCESS (0.998s)
[561.712861] [118/131] (503s left) kms_content_protection (atomic)
[561.856659] Starting subtest: atomic
[561.861226] Subtest atomic: SKIP (0.000s)
[562.025956] [119/131] (503s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[562.127205] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[562.129299] Starting dynamic subtest: pipe-A-default-mode
[562.414358] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[562.418740] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.286s)
[563.275668] [120/131] (502s left) gem_exec_params (invalid-flag)
[563.342017] Starting subtest: invalid-flag
[563.344358] Subtest invalid-flag: SUCCESS (0.000s)
[563.475104] [121/131] (502s left) kms_getfb (getfb-addfb-different-handles)
[563.583186] Starting subtest: getfb-addfb-different-handles
[563.585361] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[563.726496] [122/131] (502s left) gem_exec_flush (basic-uc-ro-default)
[563.800114] Starting subtest: basic-uc-ro-default
[569.255035] Subtest basic-uc-ro-default: SUCCESS (5.455s)
[569.469062] [123/131] (496s left) gem_sync (basic-each)
[569.545291] Starting subtest: basic-each
[572.047255] Subtest basic-each: SUCCESS (2.513s)
[572.260033] [124/131] (493s left) gem_exec_balancer (full)
[572.347986] Starting subtest: full
[577.380950] Subtest full: SUCCESS (5.032s)
[577.736995] [125/131] (488s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[577.868200] Starting subtest: y-tiled-8bpp-rotate-180
[577.872673] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[578.001081] [126/131] (488s left) sw_sync (sync_merge_invalid)
[578.035409] Starting subtest: sync_merge_invalid
[578.063291] Subtest sync_merge_invalid: SUCCESS (0.029s)
[578.152458] [127/131] (487s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[578.253379] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[582.670816] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.420s)
[583.859958] [128/131] (482s left) gem_lmem_swapping (parallel-random-verify-ccs)
[583.899836] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[583.947523] [129/131] (482s left) kms_lease (lease-unleased-connector)
[584.038995] Starting subtest: lease-unleased-connector
[584.041217] Starting dynamic subtest: pipe-A-eDP-1
[584.046091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[584.056375] Starting dynamic subtest: pipe-B-eDP-1
[584.058542] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[584.068522] Starting dynamic subtest: pipe-C-eDP-1
[584.070870] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[584.087241] Starting dynamic subtest: pipe-D-eDP-1
[584.089382] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[584.091467] Subtest lease-unleased-connector: SUCCESS (0.037s)
[584.215673] [130/131] (481s left) perf (enable-disable)
[584.320504] Starting subtest: enable-disable
[584.322929] Starting dynamic subtest: 0-rcs0
[586.563926] Dynamic subtest 0-rcs0: SUCCESS (2.241s)
[586.574101] Starting dynamic subtest: 1-vcs0
[591.003583] Dynamic subtest 1-vcs0: SUCCESS (4.438s)
[591.006314] Subtest enable-disable: SUCCESS (6.681s)
[591.042529] [131/131] (475s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[591.191663] Starting subtest: cursor-rapid-movement-32x32
[591.238500] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[591.545715] 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.