[56.929200] Initializing watchdogs
[56.929341]   /dev/watchdog0
[56.944271] [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]
[56.948439] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.950567] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.954045] [001/131] (960s left) fbdev (unaligned-read)
[57.023801] Starting subtest: unaligned-read
[57.038694] Subtest unaligned-read: SUCCESS (0.015s)
[57.112776] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[57.178467] Starting subtest: dirty-switch
[57.180846] Starting dynamic subtest: rcs0
[57.433882] Dynamic subtest rcs0: SUCCESS (0.255s)
[57.443640] Starting dynamic subtest: bcs0
[57.722731] Dynamic subtest bcs0: SUCCESS (0.289s)
[57.733486] Starting dynamic subtest: vcs0
[57.947931] Dynamic subtest vcs0: SUCCESS (0.225s)
[57.956672] Starting dynamic subtest: vcs1
[59.124887] Dynamic subtest vcs1: SUCCESS (1.176s)
[59.134535] Starting dynamic subtest: vecs0
[61.105109] Dynamic subtest vecs0: SUCCESS (1.979s)
[61.114660] Starting dynamic subtest: ccs0
[63.151527] Dynamic subtest ccs0: SUCCESS (2.046s)
[63.154183] Subtest dirty-switch: SUCCESS (5.972s)
[63.424728] [003/131] (954s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[63.539448] Starting subtest: psr-modesetfrombusy
[69.723679] Subtest psr-modesetfrombusy: SUCCESS (6.187s)
[69.886183] [004/131] (947s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[69.972127] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[69.974050] Starting dynamic subtest: pipe-A-default-mode
[72.732637] Dynamic subtest pipe-A-default-mode: SUCCESS (2.758s)
[72.734658] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.759s)
[73.624767] [005/131] (943s left) gem_exec_params (sol-reset-invalid)
[73.694969] Starting subtest: sol-reset-invalid
[73.697431] Subtest sol-reset-invalid: SUCCESS (0.002s)
[75.009791] [006/131] (942s left) gem_spin_batch (resubmit-new)
[75.074454] Starting subtest: resubmit-new
[75.076823] Starting dynamic subtest: rcs0
[75.082653] Dynamic subtest rcs0: SUCCESS (0.008s)
[75.093288] Starting dynamic subtest: bcs0
[75.095560] Dynamic subtest bcs0: SUCCESS (0.004s)
[75.103247] Starting dynamic subtest: vcs0
[75.105668] Dynamic subtest vcs0: SUCCESS (0.004s)
[75.112654] Starting dynamic subtest: vcs1
[75.114751] Dynamic subtest vcs1: SUCCESS (0.005s)
[75.124308] Starting dynamic subtest: vecs0
[75.126254] Dynamic subtest vecs0: SUCCESS (0.004s)
[75.133171] Starting dynamic subtest: ccs0
[75.135104] Dynamic subtest ccs0: SUCCESS (0.003s)
[75.137046] Subtest resubmit-new: SUCCESS (0.030s)
[76.945586] [007/131] (940s left) gem_exec_schedule (preempt-user)
[77.025027] Starting subtest: preempt-user
[77.027052] Starting dynamic subtest: rcs0
[77.052896] Dynamic subtest rcs0: SUCCESS (0.033s)
[77.063081] Starting dynamic subtest: bcs0
[77.082667] Dynamic subtest bcs0: SUCCESS (0.030s)
[77.090174] Starting dynamic subtest: vcs0
[77.108422] Dynamic subtest vcs0: SUCCESS (0.025s)
[77.115938] Starting dynamic subtest: vcs1
[77.137729] Dynamic subtest vcs1: SUCCESS (0.029s)
[77.145242] Starting dynamic subtest: vecs0
[77.161450] Dynamic subtest vecs0: SUCCESS (0.023s)
[77.168750] Starting dynamic subtest: ccs0
[77.197074] Dynamic subtest ccs0: SUCCESS (0.036s)
[77.199491] Subtest preempt-user: SUCCESS (0.178s)
[79.068313] [008/131] (938s left) sysfs_heartbeat_interval (nopreempt)
[79.131384] Starting subtest: nopreempt
[79.133846] Starting dynamic subtest: vecs0
[88.936196] Dynamic subtest vecs0: SUCCESS (9.801s)
[88.947624] Starting dynamic subtest: ccs0
[92.981362] Dynamic subtest ccs0: SUCCESS (4.045s)
[92.992407] Starting dynamic subtest: vcs0
[102.957740] Dynamic subtest vcs0: SUCCESS (9.972s)
[102.968277] Starting dynamic subtest: bcs0
[106.918211] Dynamic subtest bcs0: SUCCESS (3.962s)
[106.929480] Starting dynamic subtest: rcs0
[111.048371] Dynamic subtest rcs0: SUCCESS (4.129s)
[111.059059] Starting dynamic subtest: vcs1
[120.927128] Dynamic subtest vcs1: SUCCESS (9.878s)
[120.929705] Subtest nopreempt: SUCCESS (41.793s)
[121.024342] [009/131] (896s left) kms_invalid_mode (zero-hdisplay)
[121.133641] Starting subtest: zero-hdisplay
[121.136078] Starting dynamic subtest: pipe-A-eDP-1
[121.435348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s)
[121.443767] Starting dynamic subtest: pipe-B-eDP-1
[121.445649] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[121.452882] Starting dynamic subtest: pipe-C-eDP-1
[121.454725] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[121.462419] Starting dynamic subtest: pipe-D-eDP-1
[121.464550] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[121.466676] Subtest zero-hdisplay: SUCCESS (0.306s)
[122.267311] [010/131] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[122.368387] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[122.372408] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[122.497020] [011/131] (895s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[122.600463] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[123.491318] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.892s)
[123.706510] [012/131] (894s left) kms_getfb (getfb-handle-zero)
[123.805511] Starting subtest: getfb-handle-zero
[123.807895] Subtest getfb-handle-zero: SUCCESS (0.000s)
[123.941887] [013/131] (893s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[124.013315] Starting subtest: yf-tiled-ccs-to-yf-tiled
[124.018053] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[124.215789] [014/131] (893s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[124.306694] Starting subtest: multiplane-rotation-cropping-bottom
[131.521016] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.215s)
[131.668973] [015/131] (886s left) gem_eio (wait-1us)
[131.893652] Starting subtest: wait-1us
[132.222923] Subtest wait-1us: SUCCESS (0.331s)
[132.432553] [016/131] (885s left) syncobj_wait (multi-wait-for-submit-signaled)
[132.478525] Starting subtest: multi-wait-for-submit-signaled
[132.480619] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[132.640245] [017/131] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[132.734446] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[132.736501] Starting dynamic subtest: pipe-A-default-mode
[133.020929] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[133.025724] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.285s)
[133.889522] [018/131] (884s left) kms_plane_alpha_blend (alpha-7efc)
[133.991232] Starting subtest: alpha-7efc
[134.311436] Starting dynamic subtest: pipe-A-eDP-1
[134.908177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.596s)
[134.938323] Starting dynamic subtest: pipe-D-eDP-1
[136.261026] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[136.263893] Subtest alpha-7efc: SUCCESS (2.270s)
[137.142263] [019/131] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[137.246403] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[137.250737] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[137.392846] [020/131] (880s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[137.490474] Starting subtest: fbc-psr2-primary-mmap-cpu
[137.492627] Starting dynamic subtest: eDP-1
[137.496660] Dynamic subtest eDP-1: SKIP (0.000s)
[137.500645] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[137.583598] [021/131] (880s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[137.695539] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[137.704360] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[137.804095] [022/131] (880s left) gem_exec_whisper (basic-normal-all)
[137.876660] Starting subtest: basic-normal-all
[140.435073] Subtest basic-normal-all: SUCCESS (2.557s)
[140.640247] [023/131] (877s left) kms_big_fb (linear-16bpp-rotate-180)
[140.756530] Starting subtest: linear-16bpp-rotate-180
[142.178302] Subtest linear-16bpp-rotate-180: SUCCESS (1.422s)
[142.341696] [024/131] (876s left) kms_frontbuffer_tracking (psr-slowdraw)
[142.448103] Starting subtest: psr-slowdraw
[167.627339] Subtest psr-slowdraw: SUCCESS (25.179s)
[167.774126] [025/131] (850s left) vgem_basic (dmabuf-fence)
[167.881336] Starting subtest: dmabuf-fence
[167.883640] Subtest dmabuf-fence: SUCCESS (0.002s)
[167.967136] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[167.970679] [026/131] (850s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[168.031311] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[168.033583] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[168.147176] [027/131] (850s left) kms_psr (pr-primary-render)
[168.247387] Starting subtest: pr-primary-render
[168.251855] Subtest pr-primary-render: SKIP (0.000s)
[168.344516] [028/131] (850s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[168.435501] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[168.437487] Starting dynamic subtest: pipe-A-eDP-1
[168.456429] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[168.465304] Starting dynamic subtest: pipe-B-eDP-1
[168.482550] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[168.490659] Starting dynamic subtest: pipe-C-eDP-1
[168.508734] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[168.516547] Starting dynamic subtest: pipe-D-eDP-1
[168.534514] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[168.538020] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[170.628760] [029/131] (847s left) core_auth (getclient-master-drop)
[170.666782] Starting subtest: getclient-master-drop
[170.692593] Subtest getclient-master-drop: SUCCESS (0.028s)
[170.836236] [030/131] (847s left) kms_plane_scaling (planes-downscale-factor-0-5)
[170.931450] Starting subtest: planes-downscale-factor-0-5
[170.933755] Starting dynamic subtest: pipe-A
[170.951710] Dynamic subtest pipe-A: SKIP (0.017s)
[170.961100] Starting dynamic subtest: pipe-B
[170.987156] Dynamic subtest pipe-B: SKIP (0.034s)
[170.996814] Starting dynamic subtest: pipe-C
[171.019935] Dynamic subtest pipe-C: SKIP (0.033s)
[171.028526] Starting dynamic subtest: pipe-D
[171.050513] Dynamic subtest pipe-D: SKIP (0.029s)
[171.054284] Subtest planes-downscale-factor-0-5: SKIP (0.115s)
[171.173644] [031/131] (847s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[171.268314] Starting subtest: fb-8bpc-vs-panel-8bpc
[171.270643] Starting dynamic subtest: pipe-A-eDP-1
[172.706400] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.440s)
[172.708834] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.441s)
[173.588169] [032/131] (845s left) gem_partial_pwrite_pread (reads-snoop)
[173.653549] Subtest reads-snoop: SKIP (0.000s)
[173.737190] [033/131] (844s left) gem_eio (in-flight-contexts-immediate)
[173.970623] Starting subtest: in-flight-contexts-immediate
[187.953531] Subtest in-flight-contexts-immediate: SUCCESS (13.981s)
[188.150195] [034/131] (830s left) gen3_render_mixed_blits
[188.283607] [035/131] (830s left) kms_pm_rpm (pm-tiling)
[190.110356] Starting subtest: pm-tiling
[190.115460] Subtest pm-tiling: SKIP (0.000s)
[190.532422] [036/131] (828s left) i915_module_load (reload-no-display)
[190.570363] Starting subtest: reload-no-display
[198.110837] Subtest reload-no-display: SUCCESS (7.540s)
[198.137659] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[198.138369] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[198.141489] [037/131] (820s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[199.733847] Starting subtest: plane-upscale-20x20-with-rotation
[199.736138] Starting dynamic subtest: pipe-A
[199.978818] Dynamic subtest pipe-A: SUCCESS (0.247s)
[199.986250] Starting dynamic subtest: pipe-B
[201.296809] Dynamic subtest pipe-B: SUCCESS (1.316s)
[201.308731] Starting dynamic subtest: pipe-C
[202.635566] Dynamic subtest pipe-C: SUCCESS (1.337s)
[202.644735] Starting dynamic subtest: pipe-D
[203.975769] Dynamic subtest pipe-D: SUCCESS (1.339s)
[203.978132] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.245s)
[205.137566] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[205.138746] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[205.142664] [038/131] (813s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[205.261740] Starting subtest: 4-tiled-8bpp-rotate-180
[206.422276] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.160s)
[206.598518] [039/131] (812s left) kms_rotation_crc (primary-rotation-90)
[206.695388] Starting subtest: primary-rotation-90
[206.698844] Subtest primary-rotation-90: SKIP (0.001s)
[206.791987] [040/131] (812s left) kms_cursor_crc (cursor-onscreen-32x10)
[206.952564] Starting subtest: cursor-onscreen-32x10
[206.996891] Subtest cursor-onscreen-32x10: SKIP (0.040s)
[207.298597] [041/131] (811s left) kms_vblank (wait-idle)
[207.389460] Starting subtest: wait-idle
[207.391181] Starting dynamic subtest: pipe-A-eDP-1
[209.150530] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.760s)
[209.163509] Starting dynamic subtest: pipe-D-eDP-1
[211.598317] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.446s)
[211.600979] Subtest wait-idle: SUCCESS (4.210s)
[212.442078] [042/131] (806s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[212.544307] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[212.548483] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[212.655226] [043/131] (806s left) kms_flip (2x-flip-vs-dpms)
[212.764099] Starting subtest: 2x-flip-vs-dpms
[212.775673] Subtest 2x-flip-vs-dpms: SKIP (0.012s)
[212.876456] [044/131] (806s left) gem_exec_fence (syncobj-channel)
[213.307840] Starting subtest: syncobj-channel
[214.326898] Subtest syncobj-channel: SUCCESS (1.016s)
[215.022496] [045/131] (804s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[215.124059] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[215.126273] Starting dynamic subtest: pipe-A-eDP-1
[215.134931] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[215.144298] Starting dynamic subtest: pipe-B-eDP-1
[215.153539] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[215.164103] Starting dynamic subtest: pipe-C-eDP-1
[215.172623] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.180338] Starting dynamic subtest: pipe-D-eDP-1
[215.188967] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.193129] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[217.398068] [046/131] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[217.504113] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[224.782310] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.280s)
[224.932300] [047/131] (794s left) kms_flip (busy-flip)
[225.037280] Starting subtest: busy-flip
[225.039562] Starting dynamic subtest: A-eDP1
[226.693597] Dynamic subtest A-eDP1: SUCCESS (1.656s)
[226.703966] Starting dynamic subtest: B-eDP1
[228.337616] Dynamic subtest B-eDP1: SUCCESS (1.643s)
[228.347989] Starting dynamic subtest: C-eDP1
[230.055587] Dynamic subtest C-eDP1: SUCCESS (1.716s)
[230.064649] Starting dynamic subtest: D-eDP1
[231.699841] Dynamic subtest D-eDP1: SUCCESS (1.642s)
[231.702176] Subtest busy-flip: SUCCESS (6.665s)
[232.979810] [048/131] (786s left) prime_mmap (test_aperture_limit)
[233.044797] Starting subtest: test_aperture_limit
[233.047353] Starting dynamic subtest: test_aperture_limit-smem
[233.055248] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[233.059298] Subtest test_aperture_limit: SKIP (0.008s)
[233.188337] [049/131] (786s left) i915_pm_rpm (sysfs-read)
[235.012392] Starting subtest: sysfs-read
[236.184977] Subtest sysfs-read: SUCCESS (1.169s)
[236.606558] [050/131] (782s left) kms_big_fb (yf-tiled-addfb)
[236.708919] Starting subtest: yf-tiled-addfb
[236.713279] Subtest yf-tiled-addfb: SKIP (0.000s)
[236.841284] [051/131] (782s left) sriov_basic (enable-vfs-autoprobe-on)
[236.916737] Starting subtest: enable-vfs-autoprobe-on
[236.919132] Starting dynamic subtest: numvfs-1
[236.997218] Dynamic subtest numvfs-1: FAIL (0.028s)
[237.005037] Starting dynamic subtest: numvfs-2
[237.077944] Dynamic subtest numvfs-2: FAIL (0.003s)
[237.087401] Starting dynamic subtest: numvfs-3
[237.160078] Dynamic subtest numvfs-3: FAIL (0.003s)
[237.169267] Starting dynamic subtest: numvfs-4
[237.242235] Dynamic subtest numvfs-4: FAIL (0.003s)
[237.251446] Starting dynamic subtest: numvfs-5
[237.323914] Dynamic subtest numvfs-5: FAIL (0.003s)
[237.333458] Starting dynamic subtest: numvfs-6
[237.406483] Dynamic subtest numvfs-6: FAIL (0.004s)
[237.416063] Starting dynamic subtest: numvfs-7
[237.489406] Dynamic subtest numvfs-7: FAIL (0.003s)
[237.497985] Starting dynamic subtest: numvfs-random
[237.560586] Dynamic subtest numvfs-random: FAIL (0.003s)
[237.569281] Starting dynamic subtest: numvfs-all
[237.628490] Dynamic subtest numvfs-all: FAIL (0.504s)
[237.630375] Subtest enable-vfs-autoprobe-on: FAIL (0.562s)
[237.667253] [052/131] (781s left) gem_exec_whisper (basic-queues)
[237.724488] Starting subtest: basic-queues
[244.855628] Subtest basic-queues: SUCCESS (7.126s)
[245.065084] [053/131] (774s left) kms_flip (2x-dpms-vs-vblank-race)
[245.168786] Starting subtest: 2x-dpms-vs-vblank-race
[245.176096] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[245.278943] [054/131] (774s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[245.371171] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[245.743506] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[248.553622] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.808s)
[248.565291] Starting dynamic subtest: pipe-A-eDP-1-4
[250.728694] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[250.739940] Starting dynamic subtest: pipe-A-eDP-1-4
[252.738823] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[252.750190] Starting dynamic subtest: pipe-A-eDP-1-x
[254.917412] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[255.280276] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[258.076837] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[258.088293] Starting dynamic subtest: pipe-B-eDP-1-4
[260.252107] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s)
[260.263208] Starting dynamic subtest: pipe-B-eDP-1-4
[262.262094] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[262.273252] Starting dynamic subtest: pipe-B-eDP-1-x
[264.452536] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[264.827452] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[267.603691] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.783s)
[267.615180] Starting dynamic subtest: pipe-C-eDP-1-4
[269.778703] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[269.789624] Starting dynamic subtest: pipe-C-eDP-1-4
[271.789386] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[271.800871] Starting dynamic subtest: pipe-C-eDP-1-x
[273.967776] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[274.334233] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[277.129070] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[277.139124] Starting dynamic subtest: pipe-D-eDP-1-4
[279.304320] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[279.315799] Starting dynamic subtest: pipe-D-eDP-1-4
[281.314700] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[281.326409] Starting dynamic subtest: pipe-D-eDP-1-x
[283.493394] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[283.496344] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.121s)
[284.734849] [055/131] (734s left) gem_mmap_gtt (basic-write-read-distinct)
[284.802916] Subtest basic-write-read-distinct: SKIP (0.000s)
[284.874307] [056/131] (734s left) gem_mmap_offset (oob-read)
[284.928210] Starting subtest: oob-read
[284.930283] Subtest oob-read: SUCCESS (0.000s)
[285.044487] [057/131] (734s left) kms_atomic (atomic-plane-damage)
[285.141177] Starting subtest: atomic-plane-damage
[285.192121] Starting dynamic subtest: pipe-A-eDP-1
[285.715856] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.526s)
[285.718219] Subtest atomic-plane-damage: SUCCESS (0.577s)
[286.565072] [058/131] (733s left) kms_atomic_transition (plane-all-transition-nonblocking)
[286.679139] Starting subtest: plane-all-transition-nonblocking
[286.681422] Starting dynamic subtest: pipe-A-eDP-1
[289.172695] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[289.479248] Starting dynamic subtest: pipe-B-eDP-1
[292.668303] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.198s)
[292.970048] Subtest plane-all-transition-nonblocking: SUCCESS (6.291s)
[293.818493] [059/131] (725s left) gem_exec_parallel (contexts)
[293.880651] Starting subtest: contexts
[293.883107] Starting dynamic subtest: rcs0
[296.977060] Dynamic subtest rcs0: SUCCESS (3.094s)
[296.988738] Starting dynamic subtest: bcs0
[300.388330] Dynamic subtest bcs0: SUCCESS (3.408s)
[300.400357] Starting dynamic subtest: vcs0
[304.358139] Dynamic subtest vcs0: SUCCESS (3.967s)
[304.366722] Starting dynamic subtest: vcs1
[308.397907] Dynamic subtest vcs1: SUCCESS (4.038s)
[308.408308] Starting dynamic subtest: vecs0
[312.352714] Dynamic subtest vecs0: SUCCESS (3.954s)
[312.364486] Starting dynamic subtest: ccs0
[315.698097] Dynamic subtest ccs0: SUCCESS (3.344s)
[315.700723] Subtest contexts: SUCCESS (21.817s)
[315.915539] [060/131] (703s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[316.034955] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[322.734405] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.701s)
[322.902235] [061/131] (696s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[323.017813] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[323.021954] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[323.151089] [062/131] (696s left) kms_atomic_interruptible (legacy-pageflip)
[323.244151] Starting subtest: legacy-pageflip
[323.246474] Starting dynamic subtest: pipe-A-eDP-1
[330.640192] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.396s)
[330.642592] Subtest legacy-pageflip: SUCCESS (7.398s)
[331.503425] [063/131] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[331.612654] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[331.616931] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[331.730053] [064/131] (688s left) kms_psr (psr2-sprite-mmap-cpu)
[331.823254] Starting subtest: psr2-sprite-mmap-cpu
[331.825533] Starting dynamic subtest: eDP-1
[333.574546] Dynamic subtest eDP-1: SUCCESS (1.750s)
[333.576507] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.751s)
[334.465910] [065/131] (685s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[334.569520] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[341.692383] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.124s)
[341.876138] [066/131] (678s left) gem_exec_schedule (fairslice-all)
[341.945671] Starting subtest: fairslice-all
[343.998856] Subtest fairslice-all: SUCCESS (2.059s)
[346.007394] [067/131] (674s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[351.059471] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[351.061800] Starting dynamic subtest: pipe-A-eDP-1
[351.854350] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[351.863879] Starting dynamic subtest: pipe-B-eDP-1
[352.984793] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[352.988945] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.922s)
[354.200794] [068/131] (665s left) api_intel_allocator (two-level-inception)
[354.265718] Starting subtest: two-level-inception
[359.668517] Subtest two-level-inception: SUCCESS (5.403s)
[359.833791] [069/131] (660s left) i915_suspend (debugfs-reader)
[359.893147] Starting subtest: debugfs-reader
[377.941455] Subtest debugfs-reader: SUCCESS (8.092s)
[378.121194] [070/131] (642s left) kms_flip (plain-flip-fb-recreate-interruptible)
[378.242267] Starting subtest: plain-flip-fb-recreate-interruptible
[378.245016] Starting dynamic subtest: A-eDP1
[387.106846] Dynamic subtest A-eDP1: SUCCESS (8.829s)
[387.117597] Starting dynamic subtest: B-eDP1
[395.956740] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[395.968954] Starting dynamic subtest: C-eDP1
[404.797723] Dynamic subtest C-eDP1: SUCCESS (8.830s)
[404.809603] Starting dynamic subtest: D-eDP1
[413.623605] Dynamic subtest D-eDP1: SUCCESS (8.818s)
[413.627645] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.324s)
[414.829257] [071/131] (605s left) gem_vm_create (invalid-destroy)
[414.896806] Starting subtest: invalid-destroy
[414.899301] Subtest invalid-destroy: SUCCESS (0.002s)
[415.043339] [072/131] (605s left) gem_ccs (ctrl-surf-copy-new-ctx)
[415.119954] Starting subtest: ctrl-surf-copy-new-ctx
[415.124142] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[415.267041] [073/131] (605s left) syncobj_basic (bad-destroy-pad)
[415.330514] Starting subtest: bad-destroy-pad
[415.332761] Subtest bad-destroy-pad: SUCCESS (0.000s)
[415.467130] [074/131] (605s left) kms_plane_multiple (2x-tiling-y)
[415.567551] Starting subtest: 2x-tiling-y
[415.572042] Subtest 2x-tiling-y: SKIP (0.000s)
[415.666484] [075/131] (604s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[415.763713] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[415.765565] Starting dynamic subtest: pipe-A-eDP-1
[415.784155] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[415.795065] Starting dynamic subtest: pipe-B-eDP-1
[415.812348] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[415.821105] Starting dynamic subtest: pipe-C-eDP-1
[415.838147] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[415.846890] Starting dynamic subtest: pipe-D-eDP-1
[415.864624] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[415.868053] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[418.001314] [076/131] (602s left) kms_pm_rpm (modeset-lpsp)
[420.032626] Starting subtest: modeset-lpsp
[421.498494] Subtest modeset-lpsp: SUCCESS (1.467s)
[421.613820] [077/131] (599s left) kms_setmode (basic)
[421.680368] Starting subtest: basic
[422.015143] Starting dynamic subtest: pipe-A-eDP-1
[424.082722] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.062s)
[424.440148] Starting dynamic subtest: pipe-B-eDP-1
[426.513223] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.077s)
[426.827659] Subtest basic: SUCCESS (5.142s)
[427.679977] [078/131] (593s left) kms_psr (fbc-psr-suspend)
[427.769475] Starting subtest: fbc-psr-suspend
[427.771750] Starting dynamic subtest: eDP-1
[427.775857] Dynamic subtest eDP-1: SKIP (0.000s)
[427.780149] Subtest fbc-psr-suspend: SKIP (0.001s)
[427.870249] [079/131] (592s left) gem_ringfill (engines-basic)
[433.849977] Starting subtest: engines-basic
[433.852453] Starting dynamic subtest: rcs0
[433.936903] Dynamic subtest rcs0: SUCCESS (0.086s)
[433.949782] Starting dynamic subtest: bcs0
[433.984415] Dynamic subtest bcs0: SUCCESS (0.046s)
[433.995518] Starting dynamic subtest: vcs0
[434.028421] Dynamic subtest vcs0: SUCCESS (0.042s)
[434.039098] Starting dynamic subtest: vcs1
[434.072385] Dynamic subtest vcs1: SUCCESS (0.042s)
[434.083114] Starting dynamic subtest: vecs0
[434.115317] Dynamic subtest vecs0: SUCCESS (0.041s)
[434.125899] Starting dynamic subtest: ccs0
[434.159531] Dynamic subtest ccs0: SUCCESS (0.042s)
[434.161963] Subtest engines-basic: SUCCESS (0.311s)
[434.265160] [080/131] (586s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[434.320714] Starting subtest: invalid-bsd2-flag-on-vebox
[434.323104] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[434.467570] [081/131] (586s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[434.570552] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[434.572840] Starting dynamic subtest: pipe-A-eDP-1
[434.592812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[434.605260] Starting dynamic subtest: pipe-B-eDP-1
[434.625557] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[434.637452] Starting dynamic subtest: pipe-C-eDP-1
[434.658738] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.034s)
[434.674431] Starting dynamic subtest: pipe-D-eDP-1
[434.695256] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[434.697185] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.099s)
[436.933261] [082/131] (583s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[437.023791] Starting subtest: extended-pageflip-modeset-hang-oldfb
[437.025685] Starting dynamic subtest: pipe-A
[444.917092] Dynamic subtest pipe-A: SUCCESS (7.890s)
[444.928825] Starting dynamic subtest: pipe-D
[453.516812] Dynamic subtest pipe-D: SUCCESS (8.591s)
[453.519183] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.485s)
[454.399139] [083/131] (566s left) gem_ppgtt (shrink-vs-evict-any)
[454.470282] Starting subtest: shrink-vs-evict-any
[459.865950] Subtest shrink-vs-evict-any: SUCCESS (5.392s)
[459.964863] [084/131] (560s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[460.030095] Starting subtest: etime-single-wait-for-submit-unsubmitted
[460.139401] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[460.248513] [085/131] (560s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[460.310973] Starting subtest: multi-wait-all-for-submit-signaled
[460.313529] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[460.431272] [086/131] (560s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[460.488369] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[460.596063] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[460.730191] [087/131] (560s left) gem_exec_schedule (implicit-write-read)
[460.812963] Starting subtest: implicit-write-read
[460.815084] Starting dynamic subtest: rcs0
[460.974666] Dynamic subtest rcs0: SUCCESS (0.171s)
[460.988445] Starting dynamic subtest: vcs0
[461.095809] Dynamic subtest vcs0: SUCCESS (0.120s)
[461.108847] Starting dynamic subtest: vcs1
[461.219535] Dynamic subtest vcs1: SUCCESS (0.123s)
[461.232729] Starting dynamic subtest: vecs0
[461.324205] Dynamic subtest vecs0: SUCCESS (0.103s)
[461.338295] Starting dynamic subtest: ccs0
[461.441220] Dynamic subtest ccs0: SUCCESS (0.116s)
[461.444098] Subtest implicit-write-read: SUCCESS (0.638s)
[462.977321] [088/131] (558s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[463.080072] Starting subtest: fbcpsr-rgb565-draw-blt
[470.093342] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.014s)
[470.265708] [089/131] (550s left) gem_ctx_persistence (processes)
[470.333687] Starting subtest: processes
[471.885220] Subtest processes: SUCCESS (1.550s)
[471.987034] [090/131] (549s left) kms_cursor_crc (cursor-sliding-32x10)
[472.154285] Starting subtest: cursor-sliding-32x10
[472.197867] Subtest cursor-sliding-32x10: SKIP (0.039s)
[472.484200] [091/131] (548s left) kms_psr (fbc-pr-primary-render)
[472.585678] Starting subtest: fbc-pr-primary-render
[472.589808] Subtest fbc-pr-primary-render: SKIP (0.000s)
[472.683212] [092/131] (548s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[472.737694] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[472.816081] [093/131] (548s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[472.870899] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[472.872858] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[473.004209] [094/131] (548s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[473.104056] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[473.107744] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[473.225957] [095/131] (548s left) gem_exec_async (concurrent-writes)
[473.285193] Starting subtest: concurrent-writes
[473.287129] Starting dynamic subtest: rcs0
[473.298764] Dynamic subtest rcs0: SUCCESS (0.013s)
[473.310882] Starting dynamic subtest: bcs0
[473.312854] Dynamic subtest bcs0: SUCCESS (0.006s)
[473.326188] Starting dynamic subtest: vcs0
[473.328106] Dynamic subtest vcs0: SUCCESS (0.005s)
[473.337748] Starting dynamic subtest: vcs1
[473.339257] Dynamic subtest vcs1: SUCCESS (0.005s)
[473.348199] Starting dynamic subtest: vecs0
[473.349794] Dynamic subtest vecs0: SUCCESS (0.006s)
[473.358374] Starting dynamic subtest: ccs0
[473.360030] Dynamic subtest ccs0: SUCCESS (0.006s)
[473.361659] Subtest concurrent-writes: SUCCESS (0.046s)
[473.580630] [096/131] (547s left) gem_mmap_gtt (basic-small-bo-tiledx)
[473.631600] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[473.700519] [097/131] (547s left) dmabuf_sync_file (import-basic)
[473.758638] Starting subtest: import-basic
[473.760764] Subtest import-basic: SUCCESS (0.003s)
[473.837419] [098/131] (547s left) kms_feature_discovery (display)
[473.931912] Starting subtest: display
[473.933796] Subtest display: SUCCESS (0.000s)
[474.030810] [099/131] (547s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[474.128841] Starting subtest: x-tiled-64bpp-rotate-90
[474.148296] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[474.307691] [100/131] (547s left) perf_pmu (busy-no-semaphores)
[474.352621] Starting subtest: busy-no-semaphores
[474.354675] Starting dynamic subtest: rcs0
[474.920566] Dynamic subtest rcs0: SUCCESS (0.568s)
[474.933013] Starting dynamic subtest: bcs0
[475.470098] Dynamic subtest bcs0: SUCCESS (0.547s)
[475.482196] Starting dynamic subtest: vcs0
[476.021258] Dynamic subtest vcs0: SUCCESS (0.549s)
[476.033470] Starting dynamic subtest: vcs1
[477.368649] Dynamic subtest vcs1: SUCCESS (1.346s)
[477.381128] Starting dynamic subtest: vecs0
[479.353965] Dynamic subtest vecs0: SUCCESS (1.984s)
[479.366400] Starting dynamic subtest: ccs0
[481.402624] Dynamic subtest ccs0: SUCCESS (2.047s)
[481.405446] Subtest busy-no-semaphores: SUCCESS (7.059s)
[481.547930] [101/131] (540s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[481.648196] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[481.652174] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[481.789874] [102/131] (539s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[481.915854] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[481.920168] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[482.091346] [103/131] (539s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[482.462596] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[483.288699] [104/131] (538s left) kms_getfb (getfb-reject-nv12)
[483.378949] Starting subtest: getfb-reject-nv12
[483.381349] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[483.518538] [105/131] (538s left) i915_drm_fdinfo (context-close-stress)
[483.564522] Starting subtest: context-close-stress
[494.302930] Subtest context-close-stress: SUCCESS (10.744s)
[494.400206] [106/131] (527s left) perf_pmu (module-unload)
[494.685043] Starting subtest: module-unload
[504.478257] Subtest module-unload: FAIL (9.688s)
[504.509375] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[504.510071] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[504.512982] [107/131] (517s left) kms_chamelium_edid (dp-edid-read)
[506.266500] Subtest dp-edid-read: SKIP (0.000s)
[507.093610] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[507.094842] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[507.098461] [108/131] (514s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[512.086894] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[512.089045] Starting dynamic subtest: pipe-A-eDP-1
[512.879802] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[512.889261] Starting dynamic subtest: pipe-B-eDP-1
[514.002898] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[514.007100] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.916s)
[515.207554] [109/131] (506s left) kms_vblank (query-busy)
[515.309784] Starting subtest: query-busy
[515.311948] Starting dynamic subtest: pipe-A-eDP-1
[517.181939] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s)
[517.196173] Starting dynamic subtest: pipe-D-eDP-1
[519.738232] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[519.740416] Subtest query-busy: SUCCESS (4.432s)
[520.569488] [110/131] (501s left) syncobj_timeline (wait-for-submit-complex)
[520.632173] Starting subtest: wait-for-submit-complex
[520.692119] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[520.795308] [111/131] (501s left) perf (invalid-create-userspace-config)
[520.927291] Starting subtest: invalid-create-userspace-config
[520.929602] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[520.967398] [112/131] (501s left) gem_exec_basic (basic)
[521.021338] Starting subtest: basic
[521.023687] Starting dynamic subtest: rcs0-smem
[521.025964] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[521.036518] Starting dynamic subtest: bcs0-smem
[521.038434] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[521.046380] Starting dynamic subtest: vcs0-smem
[521.048364] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[521.058799] Starting dynamic subtest: vcs1-smem
[521.060633] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[521.068689] Starting dynamic subtest: vecs0-smem
[521.070534] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[521.078894] Starting dynamic subtest: ccs0-smem
[521.080889] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[521.082850] Subtest basic: SUCCESS (0.014s)
[522.935605] [113/131] (499s left) kms_chamelium_color (ctm-0-25)
[523.044879] Subtest ctm-0-25: SKIP (0.000s)
[523.095682] [114/131] (499s left) gem_userptr_blits (process-exit-busy)
[523.179739] Starting subtest: process-exit-busy
[523.195423] Subtest process-exit-busy: SUCCESS (0.019s)
[523.373123] [115/131] (498s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[523.437156] Starting subtest: y-tiled-ccs-to-y-tiled
[523.441789] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[523.644748] [116/131] (498s left) gen7_exec_parse (bitmasks)
[523.711445] Subtest bitmasks: SKIP (0.000s)
[523.797725] [117/131] (498s left) gem_eio (wait-wedge-10ms)
[523.970819] Starting subtest: wait-wedge-10ms
[525.936290] Subtest wait-wedge-10ms: SUCCESS (1.964s)
[526.119063] [118/131] (496s left) kms_content_protection (atomic)
[526.273426] Starting subtest: atomic
[526.277890] Subtest atomic: SKIP (0.000s)
[526.443647] [119/131] (495s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[526.542811] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[526.544994] Starting dynamic subtest: pipe-A-default-mode
[526.829600] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[526.833947] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.287s)
[527.698473] [120/131] (494s left) gem_exec_params (invalid-flag)
[527.771460] Starting subtest: invalid-flag
[527.773821] Subtest invalid-flag: SUCCESS (0.000s)
[527.902854] [121/131] (494s left) kms_getfb (getfb-addfb-different-handles)
[527.991547] Starting subtest: getfb-addfb-different-handles
[527.993669] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[528.121558] [122/131] (494s left) gem_exec_flush (basic-uc-ro-default)
[528.178064] Starting subtest: basic-uc-ro-default
[533.628723] Subtest basic-uc-ro-default: SUCCESS (5.452s)
[533.847910] [123/131] (488s left) gem_sync (basic-each)
[533.938098] Starting subtest: basic-each
[536.522030] Subtest basic-each: SUCCESS (2.594s)
[536.733220] [124/131] (485s left) gem_exec_balancer (full)
[536.795516] Starting subtest: full
[541.742643] Subtest full: SUCCESS (4.946s)
[542.106065] [125/131] (480s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[542.213935] Starting subtest: y-tiled-8bpp-rotate-180
[542.218346] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[542.337896] [126/131] (480s left) sw_sync (sync_merge_invalid)
[542.376249] Starting subtest: sync_merge_invalid
[542.401924] Subtest sync_merge_invalid: SUCCESS (0.028s)
[542.481817] [127/131] (480s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[542.594696] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[546.992492] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.403s)
[548.189127] [128/131] (474s left) gem_lmem_swapping (parallel-random-verify-ccs)
[548.234650] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[548.279100] [129/131] (474s left) kms_lease (lease-unleased-connector)
[548.382817] Starting subtest: lease-unleased-connector
[548.385076] Starting dynamic subtest: pipe-A-eDP-1
[548.390214] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[548.400378] Starting dynamic subtest: pipe-B-eDP-1
[548.402610] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[548.412644] Starting dynamic subtest: pipe-C-eDP-1
[548.414831] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[548.423990] Starting dynamic subtest: pipe-D-eDP-1
[548.425836] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[548.427639] Subtest lease-unleased-connector: SUCCESS (0.040s)
[548.555001] [130/131] (474s left) perf (enable-disable)
[548.661326] Starting subtest: enable-disable
[548.663636] Starting dynamic subtest: 0-rcs0
[550.902686] Dynamic subtest 0-rcs0: SUCCESS (2.239s)
[550.912314] Starting dynamic subtest: 1-vcs1
[555.354066] Dynamic subtest 1-vcs1: SUCCESS (4.449s)
[555.356888] Subtest enable-disable: SUCCESS (6.691s)
[555.402369] [131/131] (467s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[555.546611] Starting subtest: cursor-rapid-movement-32x32
[555.626227] Subtest cursor-rapid-movement-32x32: SKIP (0.071s)
[555.941566] 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.