[53.000131] Initializing watchdogs
[53.000265]   /dev/watchdog0
[53.015597] [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]
[53.020060] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[53.022254] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[53.025595] [001/131] (960s left) fbdev (unaligned-read)
[53.095776] Starting subtest: unaligned-read
[53.110741] Subtest unaligned-read: SUCCESS (0.015s)
[53.189518] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[53.257294] Starting subtest: dirty-switch
[53.259402] Starting dynamic subtest: rcs0
[53.482470] Dynamic subtest rcs0: SUCCESS (0.228s)
[53.490617] Starting dynamic subtest: bcs0
[53.743703] Dynamic subtest bcs0: SUCCESS (0.261s)
[53.753805] Starting dynamic subtest: vcs0
[53.996728] Dynamic subtest vcs0: SUCCESS (0.253s)
[54.006056] Starting dynamic subtest: vcs1
[55.163850] Dynamic subtest vcs1: SUCCESS (1.166s)
[55.173614] Starting dynamic subtest: vecs0
[57.140671] Dynamic subtest vecs0: SUCCESS (1.977s)
[57.148020] Starting dynamic subtest: ccs0
[59.139317] Dynamic subtest ccs0: SUCCESS (1.998s)
[59.141598] Subtest dirty-switch: SUCCESS (5.886s)
[59.415204] [003/131] (954s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[59.524150] Starting subtest: psr-modesetfrombusy
[65.695537] Subtest psr-modesetfrombusy: SUCCESS (6.175s)
[65.883093] [004/131] (947s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[65.982238] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[65.984270] Starting dynamic subtest: pipe-A-default-mode
[68.707152] Dynamic subtest pipe-A-default-mode: SUCCESS (2.725s)
[68.709592] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.726s)
[69.598033] [005/131] (944s left) gem_exec_params (sol-reset-invalid)
[69.661160] Starting subtest: sol-reset-invalid
[69.663579] Subtest sol-reset-invalid: SUCCESS (0.002s)
[71.056883] [006/131] (942s left) gem_spin_batch (resubmit-new)
[71.120124] Starting subtest: resubmit-new
[71.122457] Starting dynamic subtest: rcs0
[71.129982] Dynamic subtest rcs0: SUCCESS (0.010s)
[71.138310] Starting dynamic subtest: bcs0
[71.140634] Dynamic subtest bcs0: SUCCESS (0.004s)
[71.148709] Starting dynamic subtest: vcs0
[71.151077] Dynamic subtest vcs0: SUCCESS (0.004s)
[71.158751] Starting dynamic subtest: vcs1
[71.161084] Dynamic subtest vcs1: SUCCESS (0.004s)
[71.168254] Starting dynamic subtest: vecs0
[71.170478] Dynamic subtest vecs0: SUCCESS (0.004s)
[71.177782] Starting dynamic subtest: ccs0
[71.179899] Dynamic subtest ccs0: SUCCESS (0.004s)
[71.182078] Subtest resubmit-new: SUCCESS (0.031s)
[73.006531] [007/131] (940s left) gem_exec_schedule (preempt-user)
[73.087955] Starting subtest: preempt-user
[73.090042] Starting dynamic subtest: rcs0
[73.117372] Dynamic subtest rcs0: SUCCESS (0.036s)
[73.127437] Starting dynamic subtest: bcs0
[73.147282] Dynamic subtest bcs0: SUCCESS (0.030s)
[73.155197] Starting dynamic subtest: vcs0
[73.171084] Dynamic subtest vcs0: SUCCESS (0.023s)
[73.178331] Starting dynamic subtest: vcs1
[73.196096] Dynamic subtest vcs1: SUCCESS (0.025s)
[73.203500] Starting dynamic subtest: vecs0
[73.218788] Dynamic subtest vecs0: SUCCESS (0.022s)
[73.226131] Starting dynamic subtest: ccs0
[73.249950] Dynamic subtest ccs0: SUCCESS (0.031s)
[73.252352] Subtest preempt-user: SUCCESS (0.169s)
[75.021806] [008/131] (938s left) sysfs_heartbeat_interval (nopreempt)
[75.086646] Starting subtest: nopreempt
[75.088948] Starting dynamic subtest: vecs0
[84.910216] Dynamic subtest vecs0: SUCCESS (9.820s)
[84.920367] Starting dynamic subtest: ccs0
[88.996948] Dynamic subtest ccs0: SUCCESS (4.087s)
[89.006732] Starting dynamic subtest: vcs0
[98.919343] Dynamic subtest vcs0: SUCCESS (9.919s)
[98.929973] Starting dynamic subtest: bcs0
[102.961062] Dynamic subtest bcs0: SUCCESS (4.043s)
[102.971943] Starting dynamic subtest: rcs0
[107.086759] Dynamic subtest rcs0: SUCCESS (4.125s)
[107.097785] Starting dynamic subtest: vcs1
[116.913199] Dynamic subtest vcs1: SUCCESS (9.825s)
[116.916017] Subtest nopreempt: SUCCESS (41.825s)
[117.011170] [009/131] (896s left) kms_invalid_mode (zero-hdisplay)
[117.123166] Starting subtest: zero-hdisplay
[117.125305] Starting dynamic subtest: pipe-A-eDP-1
[117.408813] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[117.417496] Starting dynamic subtest: pipe-B-eDP-1
[117.419367] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[117.426592] Starting dynamic subtest: pipe-C-eDP-1
[117.428478] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[117.436085] Starting dynamic subtest: pipe-D-eDP-1
[117.438241] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[117.440407] Subtest zero-hdisplay: SUCCESS (0.291s)
[118.230985] [010/131] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[118.333549] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[118.337818] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[118.447420] [011/131] (895s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[118.551408] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[119.419833] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.870s)
[119.640599] [012/131] (894s left) kms_getfb (getfb-handle-zero)
[119.733735] Starting subtest: getfb-handle-zero
[119.735644] Subtest getfb-handle-zero: SUCCESS (0.000s)
[119.845415] [013/131] (894s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[119.915027] Starting subtest: yf-tiled-ccs-to-yf-tiled
[119.920129] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[120.127257] [014/131] (893s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[120.216040] Starting subtest: multiplane-rotation-cropping-bottom
[127.529303] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.315s)
[127.691573] [015/131] (886s left) gem_eio (wait-1us)
[127.933018] Starting subtest: wait-1us
[128.273269] Subtest wait-1us: SUCCESS (0.341s)
[128.461266] [016/131] (885s left) syncobj_wait (multi-wait-for-submit-signaled)
[128.508507] Starting subtest: multi-wait-for-submit-signaled
[128.510462] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[128.616733] [017/131] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[128.716995] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[128.718911] Starting dynamic subtest: pipe-A-default-mode
[129.010483] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[129.015125] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.293s)
[129.865804] [018/131] (884s left) kms_plane_alpha_blend (alpha-7efc)
[129.966189] Starting subtest: alpha-7efc
[130.250762] Starting dynamic subtest: pipe-A-eDP-1
[130.861258] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s)
[130.895852] Starting dynamic subtest: pipe-D-eDP-1
[132.164124] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.275s)
[132.166451] Subtest alpha-7efc: SUCCESS (2.198s)
[133.042555] [019/131] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[133.132068] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[133.136594] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[133.266471] [020/131] (881s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[133.370130] Starting subtest: fbc-psr2-primary-mmap-cpu
[133.372406] Starting dynamic subtest: eDP-1
[133.376577] Dynamic subtest eDP-1: SKIP (0.000s)
[133.380736] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[133.468212] [021/131] (880s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[133.564582] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[133.576992] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.013s)
[133.678788] [022/131] (880s left) gem_exec_whisper (basic-normal-all)
[133.749909] Starting subtest: basic-normal-all
[136.149507] Subtest basic-normal-all: SUCCESS (2.400s)
[136.355234] [023/131] (878s left) kms_big_fb (linear-16bpp-rotate-180)
[136.465869] Starting subtest: linear-16bpp-rotate-180
[137.877959] Subtest linear-16bpp-rotate-180: SUCCESS (1.412s)
[138.057039] [024/131] (876s left) kms_frontbuffer_tracking (psr-slowdraw)
[138.164027] Starting subtest: psr-slowdraw
[163.359136] Subtest psr-slowdraw: SUCCESS (25.194s)
[163.491115] [025/131] (851s left) vgem_basic (dmabuf-fence)
[163.591147] Starting subtest: dmabuf-fence
[163.593273] Subtest dmabuf-fence: SUCCESS (0.001s)
[163.669608] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[163.672701] [026/131] (850s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[163.724703] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[163.726838] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[163.854789] [027/131] (850s left) kms_psr (pr-primary-render)
[163.954908] Starting subtest: pr-primary-render
[163.959159] Subtest pr-primary-render: SKIP (0.000s)
[164.052981] [028/131] (850s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[164.150382] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[164.152377] Starting dynamic subtest: pipe-A-eDP-1
[164.171225] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[164.181256] Starting dynamic subtest: pipe-B-eDP-1
[164.198817] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[164.207144] Starting dynamic subtest: pipe-C-eDP-1
[164.224808] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[164.233046] Starting dynamic subtest: pipe-D-eDP-1
[164.251652] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[164.255261] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[166.361270] [029/131] (848s left) core_auth (getclient-master-drop)
[166.406079] Starting subtest: getclient-master-drop
[166.430497] Subtest getclient-master-drop: SUCCESS (0.027s)
[166.565248] [030/131] (848s left) kms_plane_scaling (planes-downscale-factor-0-5)
[166.659565] Starting subtest: planes-downscale-factor-0-5
[166.661685] Starting dynamic subtest: pipe-A
[166.682851] Dynamic subtest pipe-A: SKIP (0.018s)
[166.691948] Starting dynamic subtest: pipe-B
[166.720744] Dynamic subtest pipe-B: SKIP (0.037s)
[166.729608] Starting dynamic subtest: pipe-C
[166.756431] Dynamic subtest pipe-C: SKIP (0.036s)
[166.766746] Starting dynamic subtest: pipe-D
[166.789952] Dynamic subtest pipe-D: SKIP (0.032s)
[166.794251] Subtest planes-downscale-factor-0-5: SKIP (0.125s)
[166.916725] [031/131] (847s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[167.006543] Starting subtest: fb-8bpc-vs-panel-8bpc
[167.008675] Starting dynamic subtest: pipe-A-eDP-1
[168.425369] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.418s)
[168.427740] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.419s)
[169.319290] [032/131] (845s left) gem_partial_pwrite_pread (reads-snoop)
[169.374214] Subtest reads-snoop: SKIP (0.000s)
[169.460389] [033/131] (845s left) gem_eio (in-flight-contexts-immediate)
[169.701011] Starting subtest: in-flight-contexts-immediate
[180.897958] Subtest in-flight-contexts-immediate: SUCCESS (11.196s)
[181.097716] [034/131] (833s left) gen3_render_mixed_blits
[181.239718] [035/131] (833s left) kms_pm_rpm (pm-tiling)
[183.077996] Starting subtest: pm-tiling
[183.082810] Subtest pm-tiling: SKIP (0.000s)
[183.557412] [036/131] (831s left) i915_module_load (reload-no-display)
[183.591984] Starting subtest: reload-no-display
[188.163990] Subtest reload-no-display: SUCCESS (4.570s)
[188.190646] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[188.191398] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[188.194484] [037/131] (826s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[189.815724] Starting subtest: plane-upscale-20x20-with-rotation
[189.817954] Starting dynamic subtest: pipe-A
[190.048623] Dynamic subtest pipe-A: SUCCESS (0.246s)
[190.057235] Starting dynamic subtest: pipe-B
[191.304667] Dynamic subtest pipe-B: SUCCESS (1.254s)
[191.316561] Starting dynamic subtest: pipe-C
[192.633636] Dynamic subtest pipe-C: SUCCESS (1.327s)
[192.641316] Starting dynamic subtest: pipe-D
[193.969100] Dynamic subtest pipe-D: SUCCESS (1.333s)
[193.971485] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.167s)
[195.137523] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[195.138793] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[195.142469] [038/131] (819s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[195.253104] Starting subtest: 4-tiled-8bpp-rotate-180
[196.460101] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.207s)
[196.595451] [039/131] (818s left) kms_rotation_crc (primary-rotation-90)
[196.689958] Starting subtest: primary-rotation-90
[196.693478] Subtest primary-rotation-90: SKIP (0.001s)
[196.785917] [040/131] (818s left) kms_cursor_crc (cursor-onscreen-32x10)
[196.938076] Starting subtest: cursor-onscreen-32x10
[196.983359] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[197.267229] [041/131] (817s left) kms_vblank (wait-idle)
[197.357140] Starting subtest: wait-idle
[197.358617] Starting dynamic subtest: pipe-A-eDP-1
[199.109472] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[199.125311] Starting dynamic subtest: pipe-D-eDP-1
[201.592720] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.481s)
[201.595190] Subtest wait-idle: SUCCESS (4.237s)
[202.438966] [042/131] (812s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[202.547702] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[202.551852] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[202.684912] [043/131] (812s left) kms_flip (2x-flip-vs-dpms)
[202.787856] Starting subtest: 2x-flip-vs-dpms
[202.797818] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[202.945180] [044/131] (812s left) gem_exec_fence (syncobj-channel)
[203.372654] Starting subtest: syncobj-channel
[204.392089] Subtest syncobj-channel: SUCCESS (1.018s)
[205.025198] [045/131] (810s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[205.140490] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[205.142730] Starting dynamic subtest: pipe-A-eDP-1
[205.152024] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[205.162364] Starting dynamic subtest: pipe-B-eDP-1
[205.172625] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[205.183535] Starting dynamic subtest: pipe-C-eDP-1
[205.192421] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[205.200252] Starting dynamic subtest: pipe-D-eDP-1
[205.208878] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[205.213095] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[207.493256] [046/131] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[207.607794] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[214.848537] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.242s)
[215.019613] [047/131] (800s left) kms_flip (busy-flip)
[215.113273] Starting subtest: busy-flip
[215.115606] Starting dynamic subtest: A-eDP1
[216.806058] Dynamic subtest A-eDP1: SUCCESS (1.694s)
[216.816771] Starting dynamic subtest: B-eDP1
[218.439640] Dynamic subtest B-eDP1: SUCCESS (1.632s)
[218.450115] Starting dynamic subtest: C-eDP1
[220.070647] Dynamic subtest C-eDP1: SUCCESS (1.629s)
[220.079965] Starting dynamic subtest: D-eDP1
[221.703016] Dynamic subtest D-eDP1: SUCCESS (1.632s)
[221.705414] Subtest busy-flip: SUCCESS (6.596s)
[222.993349] [048/131] (792s left) prime_mmap (test_aperture_limit)
[223.063605] Starting subtest: test_aperture_limit
[223.066056] Starting dynamic subtest: test_aperture_limit-smem
[223.074026] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[223.078641] Subtest test_aperture_limit: SKIP (0.009s)
[223.201295] [049/131] (792s left) i915_pm_rpm (sysfs-read)
[225.035189] Starting subtest: sysfs-read
[226.193101] Subtest sysfs-read: SUCCESS (1.154s)
[226.583473] [050/131] (788s left) kms_big_fb (yf-tiled-addfb)
[226.694909] Starting subtest: yf-tiled-addfb
[226.699506] Subtest yf-tiled-addfb: SKIP (0.000s)
[226.822949] [051/131] (788s left) sriov_basic (enable-vfs-autoprobe-on)
[226.880762] Starting subtest: enable-vfs-autoprobe-on
[226.883128] Starting dynamic subtest: numvfs-1
[226.961829] Dynamic subtest numvfs-1: FAIL (0.029s)
[226.971685] Starting dynamic subtest: numvfs-2
[227.045058] Dynamic subtest numvfs-2: FAIL (0.004s)
[227.055713] Starting dynamic subtest: numvfs-3
[227.130717] Dynamic subtest numvfs-3: FAIL (0.003s)
[227.139950] Starting dynamic subtest: numvfs-4
[227.212852] Dynamic subtest numvfs-4: FAIL (0.004s)
[227.222350] Starting dynamic subtest: numvfs-5
[227.295900] Dynamic subtest numvfs-5: FAIL (0.004s)
[227.305868] Starting dynamic subtest: numvfs-6
[227.379504] Dynamic subtest numvfs-6: FAIL (0.004s)
[227.388923] Starting dynamic subtest: numvfs-7
[227.462599] Dynamic subtest numvfs-7: FAIL (0.003s)
[227.471559] Starting dynamic subtest: numvfs-random
[227.532791] Dynamic subtest numvfs-random: FAIL (0.004s)
[227.541937] Starting dynamic subtest: numvfs-all
[227.602260] Dynamic subtest numvfs-all: FAIL (0.514s)
[227.603981] Subtest enable-vfs-autoprobe-on: FAIL (0.575s)
[227.640592] [052/131] (787s left) gem_exec_whisper (basic-queues)
[227.706930] Starting subtest: basic-queues
[234.870732] Subtest basic-queues: SUCCESS (7.159s)
[235.078472] [053/131] (780s left) kms_flip (2x-dpms-vs-vblank-race)
[235.180254] Starting subtest: 2x-dpms-vs-vblank-race
[235.191957] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[235.296662] [054/131] (780s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[235.397659] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[235.782042] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[238.532279] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.750s)
[238.545931] Starting dynamic subtest: pipe-A-eDP-1-4
[240.707456] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[240.718198] Starting dynamic subtest: pipe-A-eDP-1-4
[242.717802] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[242.729071] Starting dynamic subtest: pipe-A-eDP-1-x
[244.896642] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[245.262862] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[248.062150] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.806s)
[248.073175] Starting dynamic subtest: pipe-B-eDP-1-4
[250.270499] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.208s)
[250.279479] Starting dynamic subtest: pipe-B-eDP-1-4
[252.280751] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[252.291469] Starting dynamic subtest: pipe-B-eDP-1-x
[254.471503] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[254.834322] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[257.600547] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.771s)
[257.610327] Starting dynamic subtest: pipe-C-eDP-1-4
[259.786407] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[259.797837] Starting dynamic subtest: pipe-C-eDP-1-4
[261.797470] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[261.808832] Starting dynamic subtest: pipe-C-eDP-1-x
[263.975816] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[264.336195] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[267.122721] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[267.137235] Starting dynamic subtest: pipe-D-eDP-1-4
[269.320313] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.197s)
[269.334313] Starting dynamic subtest: pipe-D-eDP-1-4
[271.330426] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[271.341753] Starting dynamic subtest: pipe-D-eDP-1-x
[273.509509] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[273.512264] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.111s)
[274.734011] [055/131] (740s left) gem_mmap_gtt (basic-write-read-distinct)
[274.793677] Subtest basic-write-read-distinct: SKIP (0.000s)
[274.853625] [056/131] (740s left) gem_mmap_offset (oob-read)
[274.914697] Starting subtest: oob-read
[274.916994] Subtest oob-read: SUCCESS (0.000s)
[275.035450] [057/131] (740s left) kms_atomic (atomic-plane-damage)
[275.131668] Starting subtest: atomic-plane-damage
[275.179679] Starting dynamic subtest: pipe-A-eDP-1
[275.765341] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[275.767629] Subtest atomic-plane-damage: SUCCESS (0.637s)
[276.656440] [058/131] (739s left) kms_atomic_transition (plane-all-transition-nonblocking)
[276.744888] Starting subtest: plane-all-transition-nonblocking
[276.747194] Starting dynamic subtest: pipe-A-eDP-1
[279.238080] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[279.561453] Starting dynamic subtest: pipe-B-eDP-1
[282.772652] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.220s)
[283.093149] Subtest plane-all-transition-nonblocking: SUCCESS (6.349s)
[283.938228] [059/131] (731s left) gem_exec_parallel (contexts)
[284.000707] Starting subtest: contexts
[284.002998] Starting dynamic subtest: rcs0
[287.061251] Dynamic subtest rcs0: SUCCESS (3.061s)
[287.071133] Starting dynamic subtest: bcs0
[290.424781] Dynamic subtest bcs0: SUCCESS (3.360s)
[290.433511] Starting dynamic subtest: vcs0
[294.453192] Dynamic subtest vcs0: SUCCESS (4.026s)
[294.462223] Starting dynamic subtest: vcs1
[298.541903] Dynamic subtest vcs1: SUCCESS (4.086s)
[298.553297] Starting dynamic subtest: vecs0
[302.356547] Dynamic subtest vecs0: SUCCESS (3.810s)
[302.370792] Starting dynamic subtest: ccs0
[305.690332] Dynamic subtest ccs0: SUCCESS (3.331s)
[305.692633] Subtest contexts: SUCCESS (21.690s)
[305.901858] [060/131] (710s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[306.007865] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[312.777350] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.772s)
[312.974455] [061/131] (703s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[313.079975] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[313.084061] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[313.215882] [062/131] (702s left) kms_atomic_interruptible (legacy-pageflip)
[313.306323] Starting subtest: legacy-pageflip
[313.308594] Starting dynamic subtest: pipe-A-eDP-1
[320.771664] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.464s)
[320.774043] Subtest legacy-pageflip: SUCCESS (7.466s)
[321.629407] [063/131] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[321.732031] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[321.736258] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[321.858337] [064/131] (694s left) kms_psr (psr2-sprite-mmap-cpu)
[321.949690] Starting subtest: psr2-sprite-mmap-cpu
[321.951930] Starting dynamic subtest: eDP-1
[323.716073] Dynamic subtest eDP-1: SUCCESS (1.764s)
[323.718339] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.765s)
[324.617545] [065/131] (691s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[324.720135] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[331.833299] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.115s)
[332.025330] [066/131] (684s left) gem_exec_schedule (fairslice-all)
[332.107358] Starting subtest: fairslice-all
[334.155963] Subtest fairslice-all: SUCCESS (2.053s)
[334.953465] [067/131] (681s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[340.023492] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[340.025761] Starting dynamic subtest: pipe-A-eDP-1
[340.813791] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s)
[340.822978] Starting dynamic subtest: pipe-B-eDP-1
[341.944068] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[341.948096] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.920s)
[343.141964] [068/131] (673s left) api_intel_allocator (two-level-inception)
[343.203595] Starting subtest: two-level-inception
[348.601394] Subtest two-level-inception: SUCCESS (5.398s)
[348.766569] [069/131] (667s left) i915_suspend (debugfs-reader)
[348.847781] Starting subtest: debugfs-reader
[367.783938] Subtest debugfs-reader: SUCCESS (9.214s)
[372.881736] [070/131] (648s left) kms_flip (plain-flip-fb-recreate-interruptible)
[373.005267] Starting subtest: plain-flip-fb-recreate-interruptible
[373.007542] Starting dynamic subtest: A-eDP1
[381.850002] Dynamic subtest A-eDP1: SUCCESS (8.836s)
[381.861511] Starting dynamic subtest: B-eDP1
[390.690392] Dynamic subtest B-eDP1: SUCCESS (8.836s)
[390.701711] Starting dynamic subtest: C-eDP1
[399.511688] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[399.523133] Starting dynamic subtest: D-eDP1
[408.343718] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[408.348132] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.328s)
[409.548704] [071/131] (611s left) gem_vm_create (invalid-destroy)
[409.606002] Starting subtest: invalid-destroy
[409.608503] Subtest invalid-destroy: SUCCESS (0.002s)
[409.744754] [072/131] (611s left) gem_ccs (ctrl-surf-copy-new-ctx)
[409.799494] Starting subtest: ctrl-surf-copy-new-ctx
[409.803893] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[409.945051] [073/131] (611s left) syncobj_basic (bad-destroy-pad)
[410.005184] Starting subtest: bad-destroy-pad
[410.007130] Subtest bad-destroy-pad: SUCCESS (0.000s)
[410.130331] [074/131] (611s left) kms_plane_multiple (2x-tiling-y)
[410.222004] Starting subtest: 2x-tiling-y
[410.226485] Subtest 2x-tiling-y: SKIP (0.000s)
[410.321298] [075/131] (611s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[410.426290] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[410.428524] Starting dynamic subtest: pipe-A-eDP-1
[410.451492] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[410.463313] Starting dynamic subtest: pipe-B-eDP-1
[410.481263] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[410.490953] Starting dynamic subtest: pipe-C-eDP-1
[410.508881] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[410.518138] Starting dynamic subtest: pipe-D-eDP-1
[410.536759] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[410.540135] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[412.620102] [076/131] (609s left) kms_pm_rpm (modeset-lpsp)
[414.741508] Starting subtest: modeset-lpsp
[416.223133] Subtest modeset-lpsp: SUCCESS (1.481s)
[416.326614] [077/131] (605s left) kms_setmode (basic)
[416.384572] Starting subtest: basic
[416.703081] Starting dynamic subtest: pipe-A-eDP-1
[418.802949] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.095s)
[419.145865] Starting dynamic subtest: pipe-B-eDP-1
[421.234655] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.094s)
[421.554373] Subtest basic: SUCCESS (5.167s)
[422.409510] [078/131] (599s left) kms_psr (fbc-psr-suspend)
[422.522343] Starting subtest: fbc-psr-suspend
[422.524594] Starting dynamic subtest: eDP-1
[422.528923] Dynamic subtest eDP-1: SKIP (0.000s)
[422.533280] Subtest fbc-psr-suspend: SKIP (0.001s)
[422.621411] [079/131] (599s left) gem_ringfill (engines-basic)
[428.628434] Starting subtest: engines-basic
[428.630937] Starting dynamic subtest: rcs0
[428.694029] Dynamic subtest rcs0: SUCCESS (0.066s)
[428.706450] Starting dynamic subtest: bcs0
[428.742056] Dynamic subtest bcs0: SUCCESS (0.045s)
[428.752763] Starting dynamic subtest: vcs0
[428.784901] Dynamic subtest vcs0: SUCCESS (0.041s)
[428.794847] Starting dynamic subtest: vcs1
[428.827995] Dynamic subtest vcs1: SUCCESS (0.041s)
[428.838719] Starting dynamic subtest: vecs0
[428.872017] Dynamic subtest vecs0: SUCCESS (0.042s)
[428.882573] Starting dynamic subtest: ccs0
[428.917982] Dynamic subtest ccs0: SUCCESS (0.044s)
[428.920296] Subtest engines-basic: SUCCESS (0.292s)
[429.020989] [080/131] (592s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[429.096003] Starting subtest: invalid-bsd2-flag-on-vebox
[429.098278] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[429.218322] [081/131] (592s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[429.311117] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[429.313396] Starting dynamic subtest: pipe-A-eDP-1
[429.332754] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[429.342934] Starting dynamic subtest: pipe-B-eDP-1
[429.362728] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[429.373190] Starting dynamic subtest: pipe-C-eDP-1
[429.393656] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[429.405644] Starting dynamic subtest: pipe-D-eDP-1
[429.425974] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[429.428296] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.088s)
[431.678737] [082/131] (590s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[431.782717] Starting subtest: extended-pageflip-modeset-hang-oldfb
[431.784789] Starting dynamic subtest: pipe-A
[439.681690] Dynamic subtest pipe-A: SUCCESS (7.897s)
[439.692301] Starting dynamic subtest: pipe-D
[448.271885] Dynamic subtest pipe-D: SUCCESS (8.586s)
[448.274056] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.488s)
[449.142941] [083/131] (572s left) gem_ppgtt (shrink-vs-evict-any)
[449.205562] Starting subtest: shrink-vs-evict-any
[455.617377] Subtest shrink-vs-evict-any: SUCCESS (6.392s)
[455.728997] [084/131] (566s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[455.781956] Starting subtest: etime-single-wait-for-submit-unsubmitted
[455.884802] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[455.992043] [085/131] (566s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[456.047768] Starting subtest: multi-wait-all-for-submit-signaled
[456.050018] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[456.177311] [086/131] (565s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[456.240621] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[456.348715] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[456.458552] [087/131] (565s left) gem_exec_schedule (implicit-write-read)
[456.541372] Starting subtest: implicit-write-read
[456.543827] Starting dynamic subtest: rcs0
[456.712762] Dynamic subtest rcs0: SUCCESS (0.183s)
[456.726359] Starting dynamic subtest: vcs0
[456.838017] Dynamic subtest vcs0: SUCCESS (0.125s)
[456.848020] Starting dynamic subtest: vcs1
[456.946110] Dynamic subtest vcs1: SUCCESS (0.106s)
[456.958881] Starting dynamic subtest: vecs0
[457.048847] Dynamic subtest vecs0: SUCCESS (0.102s)
[457.062180] Starting dynamic subtest: ccs0
[457.172137] Dynamic subtest ccs0: SUCCESS (0.121s)
[457.175168] Subtest implicit-write-read: SUCCESS (0.642s)
[457.760437] [088/131] (564s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[457.876556] Starting subtest: fbcpsr-rgb565-draw-blt
[464.968301] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.092s)
[465.130721] [089/131] (557s left) gem_ctx_persistence (processes)
[465.189526] Starting subtest: processes
[466.605688] Subtest processes: SUCCESS (1.415s)
[466.708821] [090/131] (555s left) kms_cursor_crc (cursor-sliding-32x10)
[466.855043] Starting subtest: cursor-sliding-32x10
[466.904593] Subtest cursor-sliding-32x10: SKIP (0.044s)
[467.205098] [091/131] (555s left) kms_psr (fbc-pr-primary-render)
[467.300130] Starting subtest: fbc-pr-primary-render
[467.304322] Subtest fbc-pr-primary-render: SKIP (0.000s)
[467.399273] [092/131] (554s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[467.469678] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[467.554588] [093/131] (554s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[467.604874] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[467.606739] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[467.743018] [094/131] (554s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[467.834027] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[467.837337] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[467.969177] [095/131] (554s left) gem_exec_async (concurrent-writes)
[468.035325] Starting subtest: concurrent-writes
[468.037046] Starting dynamic subtest: rcs0
[468.047423] Dynamic subtest rcs0: SUCCESS (0.014s)
[468.060988] Starting dynamic subtest: bcs0
[468.062860] Dynamic subtest bcs0: SUCCESS (0.006s)
[468.072812] Starting dynamic subtest: vcs0
[468.074720] Dynamic subtest vcs0: SUCCESS (0.005s)
[468.084549] Starting dynamic subtest: vcs1
[468.086152] Dynamic subtest vcs1: SUCCESS (0.005s)
[468.095464] Starting dynamic subtest: vecs0
[468.096988] Dynamic subtest vecs0: SUCCESS (0.006s)
[468.106267] Starting dynamic subtest: ccs0
[468.107783] Dynamic subtest ccs0: SUCCESS (0.005s)
[468.109301] Subtest concurrent-writes: SUCCESS (0.044s)
[468.363829] [096/131] (554s left) gem_mmap_gtt (basic-small-bo-tiledx)
[468.419030] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[468.481904] [097/131] (554s left) dmabuf_sync_file (import-basic)
[468.525065] Starting subtest: import-basic
[468.527257] Subtest import-basic: SUCCESS (0.001s)
[468.608411] [098/131] (554s left) kms_feature_discovery (display)
[468.704374] Starting subtest: display
[468.706308] Subtest display: SUCCESS (0.000s)
[468.801998] [099/131] (553s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[468.897176] Starting subtest: x-tiled-64bpp-rotate-90
[468.917634] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[469.058665] [100/131] (553s left) perf_pmu (busy-no-semaphores)
[469.098298] Starting subtest: busy-no-semaphores
[469.100116] Starting dynamic subtest: rcs0
[469.644521] Dynamic subtest rcs0: SUCCESS (0.544s)
[469.656226] Starting dynamic subtest: bcs0
[470.193851] Dynamic subtest bcs0: SUCCESS (0.546s)
[470.205286] Starting dynamic subtest: vcs0
[470.745458] Dynamic subtest vcs0: SUCCESS (0.549s)
[470.757779] Starting dynamic subtest: vcs1
[472.149276] Dynamic subtest vcs1: SUCCESS (1.401s)
[472.161287] Starting dynamic subtest: vecs0
[474.132866] Dynamic subtest vecs0: SUCCESS (1.982s)
[474.146772] Starting dynamic subtest: ccs0
[476.182221] Dynamic subtest ccs0: SUCCESS (2.047s)
[476.185150] Subtest busy-no-semaphores: SUCCESS (7.086s)
[476.325436] [101/131] (546s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[476.431494] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[476.435849] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[476.564806] [102/131] (546s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[476.703829] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[476.708277] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[476.873056] [103/131] (545s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[477.259114] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[478.071721] [104/131] (544s left) kms_getfb (getfb-reject-nv12)
[478.169026] Starting subtest: getfb-reject-nv12
[478.171288] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[478.299465] [105/131] (544s left) i915_drm_fdinfo (context-close-stress)
[478.343436] Starting subtest: context-close-stress
[489.085898] Subtest context-close-stress: SUCCESS (10.743s)
[489.188152] [106/131] (533s left) perf_pmu (module-unload)
[489.413986] Starting subtest: module-unload
[499.055849] Subtest module-unload: FAIL (9.538s)
[499.088474] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[499.089158] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[499.092181] [107/131] (523s left) kms_chamelium_edid (dp-edid-read)
[500.898003] Subtest dp-edid-read: SKIP (0.000s)
[501.729630] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[501.730848] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[501.734546] [108/131] (521s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[506.706526] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[506.708909] Starting dynamic subtest: pipe-A-eDP-1
[507.514315] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s)
[507.524004] Starting dynamic subtest: pipe-B-eDP-1
[508.647686] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[508.652035] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.938s)
[509.870677] [109/131] (513s left) kms_vblank (query-busy)
[509.968066] Starting subtest: query-busy
[509.970289] Starting dynamic subtest: pipe-A-eDP-1
[511.852520] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[511.867060] Starting dynamic subtest: pipe-D-eDP-1
[514.411844] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.554s)
[514.414104] Subtest query-busy: SUCCESS (4.443s)
[515.231746] [110/131] (507s left) syncobj_timeline (wait-for-submit-complex)
[515.290678] Starting subtest: wait-for-submit-complex
[515.351624] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[515.455595] [111/131] (507s left) perf (invalid-create-userspace-config)
[515.606818] Starting subtest: invalid-create-userspace-config
[515.608706] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[515.653720] [112/131] (507s left) gem_exec_basic (basic)
[515.718901] Starting subtest: basic
[515.721218] Starting dynamic subtest: rcs0-smem
[515.723525] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[515.734388] Starting dynamic subtest: bcs0-smem
[515.736634] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[515.745340] Starting dynamic subtest: vcs0-smem
[515.747368] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[515.755887] Starting dynamic subtest: vcs1-smem
[515.757967] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[515.766605] Starting dynamic subtest: vecs0-smem
[515.768780] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[515.777416] Starting dynamic subtest: ccs0-smem
[515.779612] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[515.781813] Subtest basic: SUCCESS (0.016s)
[517.646258] [113/131] (505s left) kms_chamelium_color (ctm-0-25)
[517.752480] Subtest ctm-0-25: SKIP (0.000s)
[517.812170] [114/131] (505s left) gem_userptr_blits (process-exit-busy)
[517.893974] Starting subtest: process-exit-busy
[517.905270] Subtest process-exit-busy: SUCCESS (0.012s)
[518.079914] [115/131] (505s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[518.144049] Starting subtest: y-tiled-ccs-to-y-tiled
[518.148670] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[518.351999] [116/131] (505s left) gen7_exec_parse (bitmasks)
[518.423556] Subtest bitmasks: SKIP (0.000s)
[518.516421] [117/131] (504s left) gem_eio (wait-wedge-10ms)
[518.711576] Starting subtest: wait-wedge-10ms
[520.717786] Subtest wait-wedge-10ms: SUCCESS (2.008s)
[520.909267] [118/131] (502s left) kms_content_protection (atomic)
[521.062925] Starting subtest: atomic
[521.067583] Subtest atomic: SKIP (0.000s)
[521.243111] [119/131] (502s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[521.335732] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[521.338028] Starting dynamic subtest: pipe-A-default-mode
[521.625843] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[521.630264] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.287s)
[522.461715] [120/131] (501s left) gem_exec_params (invalid-flag)
[522.523955] Starting subtest: invalid-flag
[522.526281] Subtest invalid-flag: SUCCESS (0.000s)
[522.669421] [121/131] (500s left) kms_getfb (getfb-addfb-different-handles)
[522.763638] Starting subtest: getfb-addfb-different-handles
[522.765778] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[522.892154] [122/131] (500s left) gem_exec_flush (basic-uc-ro-default)
[522.960828] Starting subtest: basic-uc-ro-default
[528.411449] Subtest basic-uc-ro-default: SUCCESS (5.451s)
[528.623946] [123/131] (495s left) gem_sync (basic-each)
[528.701866] Starting subtest: basic-each
[531.171523] Subtest basic-each: SUCCESS (2.480s)
[531.383580] [124/131] (492s left) gem_exec_balancer (full)
[531.456038] Starting subtest: full
[536.493681] Subtest full: SUCCESS (5.037s)
[536.872911] [125/131] (486s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[536.986678] Starting subtest: y-tiled-8bpp-rotate-180
[536.991037] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[537.143053] [126/131] (486s left) sw_sync (sync_merge_invalid)
[537.179775] Starting subtest: sync_merge_invalid
[537.211557] Subtest sync_merge_invalid: SUCCESS (0.031s)
[537.303827] [127/131] (486s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[537.416143] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[541.855151] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.443s)
[543.074576] [128/131] (480s left) gem_lmem_swapping (parallel-random-verify-ccs)
[543.121935] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[543.168648] [129/131] (480s left) kms_lease (lease-unleased-connector)
[543.263154] Starting subtest: lease-unleased-connector
[543.265499] Starting dynamic subtest: pipe-A-eDP-1
[543.267796] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[543.279130] Starting dynamic subtest: pipe-B-eDP-1
[543.281367] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[543.291513] Starting dynamic subtest: pipe-C-eDP-1
[543.293690] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[543.303356] Starting dynamic subtest: pipe-D-eDP-1
[543.305457] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[543.307578] Subtest lease-unleased-connector: SUCCESS (0.035s)
[543.429474] [130/131] (480s left) perf (enable-disable)
[543.534817] Starting subtest: enable-disable
[543.537430] Starting dynamic subtest: 0-rcs0
[545.844099] Dynamic subtest 0-rcs0: SUCCESS (2.309s)
[545.856699] Starting dynamic subtest: 1-vcs0
[550.331548] Dynamic subtest 1-vcs0: SUCCESS (4.485s)
[550.334192] Subtest enable-disable: SUCCESS (6.796s)
[550.380851] [131/131] (473s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[550.534279] Starting subtest: cursor-rapid-movement-32x32
[550.593674] Subtest cursor-rapid-movement-32x32: SKIP (0.053s)
[550.902957] 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.