[60.401321] Initializing watchdogs
[60.401374]   /dev/watchdog0
[60.415158] [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]
[60.419707] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.421892] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.423948] [001/131] (960s left) fbdev (unaligned-read)
[60.469730] Starting subtest: unaligned-read
[60.485494] Subtest unaligned-read: SUCCESS (0.016s)
[60.562318] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[60.626448] Starting subtest: dirty-switch
[60.627567] Starting dynamic subtest: rcs0
[60.868505] Dynamic subtest rcs0: SUCCESS (0.242s)
[60.878983] Starting dynamic subtest: bcs0
[61.215563] Dynamic subtest bcs0: SUCCESS (0.346s)
[61.223907] Starting dynamic subtest: vcs0
[61.462137] Dynamic subtest vcs0: SUCCESS (0.246s)
[61.470095] Starting dynamic subtest: vcs1
[63.140861] Dynamic subtest vcs1: SUCCESS (1.676s)
[63.148984] Starting dynamic subtest: vecs0
[65.142969] Dynamic subtest vecs0: SUCCESS (2.000s)
[65.148992] Starting dynamic subtest: ccs0
[67.492464] Dynamic subtest ccs0: SUCCESS (2.346s)
[67.493849] Subtest dirty-switch: SUCCESS (6.858s)
[67.827666] [003/131] (953s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[67.943620] Starting subtest: psr-modesetfrombusy
[74.076671] Subtest psr-modesetfrombusy: SUCCESS (6.131s)
[74.247332] [004/131] (946s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[74.329931] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[74.330835] Starting dynamic subtest: pipe-A-default-mode
[77.014331] Dynamic subtest pipe-A-default-mode: SUCCESS (2.683s)
[77.015322] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.684s)
[77.901693] [005/131] (943s left) gem_exec_params (sol-reset-invalid)
[77.947990] Starting subtest: sol-reset-invalid
[77.950955] Subtest sol-reset-invalid: SUCCESS (0.003s)
[79.979966] [006/131] (941s left) gem_spin_batch (resubmit-new)
[80.041515] Starting subtest: resubmit-new
[80.042474] Starting dynamic subtest: rcs0
[80.049968] Dynamic subtest rcs0: SUCCESS (0.008s)
[80.056129] Starting dynamic subtest: bcs0
[80.056966] Dynamic subtest bcs0: SUCCESS (0.004s)
[80.062561] Starting dynamic subtest: vcs0
[80.063448] Dynamic subtest vcs0: SUCCESS (0.004s)
[80.068959] Starting dynamic subtest: vcs1
[80.069875] Dynamic subtest vcs1: SUCCESS (0.004s)
[80.075787] Starting dynamic subtest: vecs0
[80.076729] Dynamic subtest vecs0: SUCCESS (0.004s)
[80.082078] Starting dynamic subtest: ccs0
[80.082924] Dynamic subtest ccs0: SUCCESS (0.004s)
[80.083832] Subtest resubmit-new: SUCCESS (0.031s)
[81.996563] [007/131] (939s left) gem_exec_schedule (preempt-user)
[82.060196] Starting subtest: preempt-user
[82.061132] Starting dynamic subtest: rcs0
[82.098138] Dynamic subtest rcs0: SUCCESS (0.038s)
[82.106079] Starting dynamic subtest: bcs0
[82.129576] Dynamic subtest bcs0: SUCCESS (0.031s)
[82.135772] Starting dynamic subtest: vcs0
[82.159140] Dynamic subtest vcs0: SUCCESS (0.029s)
[82.165063] Starting dynamic subtest: vcs1
[82.182900] Dynamic subtest vcs1: SUCCESS (0.023s)
[82.189629] Starting dynamic subtest: vecs0
[82.208564] Dynamic subtest vecs0: SUCCESS (0.026s)
[82.214082] Starting dynamic subtest: ccs0
[82.237117] Dynamic subtest ccs0: SUCCESS (0.028s)
[82.238039] Subtest preempt-user: SUCCESS (0.177s)
[84.046950] [008/131] (937s left) sysfs_heartbeat_interval (nopreempt)
[84.098288] Starting subtest: nopreempt
[84.099398] Starting dynamic subtest: vecs0
[92.915726] Dynamic subtest vecs0: SUCCESS (8.814s)
[92.923890] Starting dynamic subtest: ccs0
[97.022228] Dynamic subtest ccs0: SUCCESS (4.106s)
[97.032045] Starting dynamic subtest: vcs0
[106.935834] Dynamic subtest vcs0: SUCCESS (9.910s)
[106.944689] Starting dynamic subtest: bcs0
[110.952023] Dynamic subtest bcs0: SUCCESS (4.018s)
[110.960892] Starting dynamic subtest: rcs0
[115.072769] Dynamic subtest rcs0: SUCCESS (4.120s)
[115.081573] Starting dynamic subtest: vcs1
[124.913492] Dynamic subtest vcs1: SUCCESS (9.839s)
[124.914938] Subtest nopreempt: SUCCESS (40.812s)
[125.037207] [009/131] (896s left) kms_invalid_mode (zero-hdisplay)
[125.131404] Starting subtest: zero-hdisplay
[125.132350] Starting dynamic subtest: pipe-A-eDP-1
[125.417437] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[125.423886] Starting dynamic subtest: pipe-B-eDP-1
[125.424824] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[125.430529] Starting dynamic subtest: pipe-C-eDP-1
[125.431428] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[125.437070] Starting dynamic subtest: pipe-D-eDP-1
[125.437917] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[125.438844] Subtest zero-hdisplay: SUCCESS (0.290s)
[126.225618] [010/131] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[126.322288] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[126.324046] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[126.441449] [011/131] (894s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[126.538400] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[127.375132] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.837s)
[127.565485] [012/131] (893s left) kms_getfb (getfb-handle-zero)
[127.645946] Starting subtest: getfb-handle-zero
[127.647095] Subtest getfb-handle-zero: SUCCESS (0.000s)
[127.769709] [013/131] (893s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[127.818525] Starting subtest: yf-tiled-ccs-to-yf-tiled
[127.820468] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[128.015342] [014/131] (893s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[128.111884] Starting subtest: multiplane-rotation-cropping-bottom
[135.349581] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.237s)
[135.504707] [015/131] (885s left) gem_eio (wait-1us)
[135.730318] Starting subtest: wait-1us
[136.075556] Subtest wait-1us: SUCCESS (0.346s)
[136.235850] [016/131] (885s left) syncobj_wait (multi-wait-for-submit-signaled)
[136.289172] Starting subtest: multi-wait-for-submit-signaled
[136.290052] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[136.399468] [017/131] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[136.496560] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[136.497632] Starting dynamic subtest: pipe-A-default-mode
[136.787536] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[136.789406] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.291s)
[137.653564] [018/131] (883s left) kms_plane_alpha_blend (alpha-7efc)
[137.746474] Starting subtest: alpha-7efc
[138.028164] Starting dynamic subtest: pipe-A-eDP-1
[138.628042] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[138.654166] Starting dynamic subtest: pipe-D-eDP-1
[139.929274] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.281s)
[139.930265] Subtest alpha-7efc: SUCCESS (2.184s)
[140.803430] [019/131] (880s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[140.896998] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[140.898681] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[141.020603] [020/131] (880s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[141.134529] Starting subtest: fbc-psr2-primary-mmap-cpu
[141.135381] Starting dynamic subtest: eDP-1
[141.136994] Dynamic subtest eDP-1: SKIP (0.000s)
[141.138656] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[141.231444] [021/131] (880s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[141.324865] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[141.335209] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[141.431461] [022/131] (880s left) gem_exec_whisper (basic-normal-all)
[141.487921] Starting subtest: basic-normal-all
[143.748114] Subtest basic-normal-all: SUCCESS (2.258s)
[143.947585] [023/131] (877s left) kms_big_fb (linear-16bpp-rotate-180)
[144.050104] Starting subtest: linear-16bpp-rotate-180
[145.339479] Subtest linear-16bpp-rotate-180: SUCCESS (1.290s)
[145.506844] [024/131] (876s left) kms_frontbuffer_tracking (psr-slowdraw)
[145.605826] Starting subtest: psr-slowdraw
[170.684171] Subtest psr-slowdraw: SUCCESS (25.078s)
[170.809735] [025/131] (850s left) vgem_basic (dmabuf-fence)
[170.905171] Starting subtest: dmabuf-fence
[170.906064] Subtest dmabuf-fence: SUCCESS (0.001s)
[170.978326] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[170.980556] [026/131] (850s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[171.030846] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[171.031804] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[171.136776] [027/131] (850s left) kms_psr (pr-primary-render)
[171.225902] Starting subtest: pr-primary-render
[171.227726] Subtest pr-primary-render: SKIP (0.000s)
[171.313664] [028/131] (850s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[171.390803] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[171.391796] Starting dynamic subtest: pipe-A-eDP-1
[171.400686] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[171.408541] Starting dynamic subtest: pipe-B-eDP-1
[171.417639] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[171.425629] Starting dynamic subtest: pipe-C-eDP-1
[171.433901] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[171.440373] Starting dynamic subtest: pipe-D-eDP-1
[171.448706] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[171.450379] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[173.600195] [029/131] (848s left) core_auth (getclient-master-drop)
[173.628391] Starting subtest: getclient-master-drop
[173.658477] Subtest getclient-master-drop: SUCCESS (0.030s)
[173.789553] [030/131] (848s left) kms_plane_scaling (planes-downscale-factor-0-5)
[173.877437] Starting subtest: planes-downscale-factor-0-5
[173.878385] Starting dynamic subtest: pipe-A
[173.893099] Dynamic subtest pipe-A: SKIP (0.014s)
[173.904155] Starting dynamic subtest: pipe-B
[173.922840] Dynamic subtest pipe-B: SKIP (0.029s)
[173.930058] Starting dynamic subtest: pipe-C
[173.954398] Dynamic subtest pipe-C: SKIP (0.031s)
[173.960950] Starting dynamic subtest: pipe-D
[173.981715] Dynamic subtest pipe-D: SKIP (0.027s)
[173.983389] Subtest planes-downscale-factor-0-5: SKIP (0.104s)
[174.114683] [031/131] (847s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[174.209194] Starting subtest: fb-8bpc-vs-panel-8bpc
[174.210010] Starting dynamic subtest: pipe-A-eDP-1
[175.587664] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.377s)
[175.588560] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.379s)
[176.471533] [032/131] (845s left) gem_partial_pwrite_pread (reads-snoop)
[176.531947] Subtest reads-snoop: SKIP (0.000s)
[176.615167] [033/131] (845s left) gem_eio (in-flight-contexts-immediate)
[176.854568] Starting subtest: in-flight-contexts-immediate
[190.945201] Subtest in-flight-contexts-immediate: SUCCESS (14.091s)
[191.141900] [034/131] (830s left) gen3_render_mixed_blits
[191.256240] [035/131] (830s left) kms_pm_rpm (pm-tiling)
[193.069063] Starting subtest: pm-tiling
[193.071648] Subtest pm-tiling: SKIP (0.000s)
[193.507975] [036/131] (828s left) i915_module_load (reload-no-display)
[193.542179] Starting subtest: reload-no-display
[199.561250] Subtest reload-no-display: SUCCESS (6.018s)
[199.582325] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[199.583076] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[199.584756] [037/131] (822s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[201.128161] Starting subtest: plane-upscale-20x20-with-rotation
[201.129035] Starting dynamic subtest: pipe-A
[201.371201] Dynamic subtest pipe-A: SUCCESS (0.243s)
[201.378089] Starting dynamic subtest: pipe-B
[202.706091] Dynamic subtest pipe-B: SUCCESS (1.334s)
[202.712880] Starting dynamic subtest: pipe-C
[204.047293] Dynamic subtest pipe-C: SUCCESS (1.340s)
[204.054304] Starting dynamic subtest: pipe-D
[205.367662] Dynamic subtest pipe-D: SUCCESS (1.319s)
[205.368855] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.241s)
[206.737595] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[206.738831] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[206.740905] [038/131] (815s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[206.843209] Starting subtest: 4-tiled-8bpp-rotate-180
[207.915751] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.073s)
[208.058585] [039/131] (814s left) kms_rotation_crc (primary-rotation-90)
[208.150986] Starting subtest: primary-rotation-90
[208.152600] Subtest primary-rotation-90: SKIP (0.001s)
[208.242675] [040/131] (813s left) kms_cursor_crc (cursor-onscreen-32x10)
[208.398411] Starting subtest: cursor-onscreen-32x10
[208.436516] Subtest cursor-onscreen-32x10: SKIP (0.037s)
[208.734287] [041/131] (813s left) kms_vblank (wait-idle)
[208.828366] Starting subtest: wait-idle
[208.829265] Starting dynamic subtest: pipe-A-eDP-1
[210.579315] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.751s)
[210.586997] Starting dynamic subtest: pipe-D-eDP-1
[213.011182] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.427s)
[213.012156] Subtest wait-idle: SUCCESS (4.182s)
[213.844799] [042/131] (808s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[213.941010] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[213.943060] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[214.071458] [043/131] (808s left) kms_flip (2x-flip-vs-dpms)
[214.167560] Starting subtest: 2x-flip-vs-dpms
[214.178060] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[214.315845] [044/131] (807s left) gem_exec_fence (syncobj-channel)
[214.743960] Starting subtest: syncobj-channel
[215.762648] Subtest syncobj-channel: SUCCESS (1.014s)
[216.073022] [045/131] (806s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[216.160495] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[216.161467] Starting dynamic subtest: pipe-A-eDP-1
[216.165075] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[216.171624] Starting dynamic subtest: pipe-B-eDP-1
[216.175345] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[216.181810] Starting dynamic subtest: pipe-C-eDP-1
[216.185828] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[216.192697] Starting dynamic subtest: pipe-D-eDP-1
[216.196354] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[216.198092] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[218.339531] [046/131] (804s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[218.436885] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[225.645420] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.210s)
[225.799047] [047/131] (796s left) kms_flip (busy-flip)
[225.890394] Starting subtest: busy-flip
[225.892916] Starting dynamic subtest: A-eDP1
[227.566302] Dynamic subtest A-eDP1: SUCCESS (1.673s)
[227.575470] Starting dynamic subtest: B-eDP1
[229.295306] Dynamic subtest B-eDP1: SUCCESS (1.727s)
[229.303073] Starting dynamic subtest: C-eDP1
[230.928723] Dynamic subtest C-eDP1: SUCCESS (1.631s)
[230.936288] Starting dynamic subtest: D-eDP1
[232.570949] Dynamic subtest D-eDP1: SUCCESS (1.640s)
[232.575796] Subtest busy-flip: SUCCESS (6.685s)
[233.845603] [048/131] (788s left) prime_mmap (test_aperture_limit)
[233.911585] Starting subtest: test_aperture_limit
[233.912600] Starting dynamic subtest: test_aperture_limit-smem
[233.920678] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[233.922566] Subtest test_aperture_limit: SKIP (0.009s)
[234.010623] [049/131] (788s left) i915_pm_rpm (sysfs-read)
[236.041267] Starting subtest: sysfs-read
[237.195546] Subtest sysfs-read: SUCCESS (1.154s)
[237.592915] [050/131] (784s left) kms_big_fb (yf-tiled-addfb)
[237.693516] Starting subtest: yf-tiled-addfb
[237.695377] Subtest yf-tiled-addfb: SKIP (0.000s)
[237.820587] [051/131] (784s left) sriov_basic (enable-vfs-autoprobe-on)
[237.864273] Starting subtest: enable-vfs-autoprobe-on
[237.865262] Starting dynamic subtest: numvfs-1
[237.896898] Dynamic subtest numvfs-1: FAIL (0.015s)
[237.903918] Starting dynamic subtest: numvfs-2
[237.931200] Dynamic subtest numvfs-2: FAIL (0.004s)
[237.937500] Starting dynamic subtest: numvfs-3
[237.963236] Dynamic subtest numvfs-3: FAIL (0.004s)
[237.969279] Starting dynamic subtest: numvfs-4
[237.994268] Dynamic subtest numvfs-4: FAIL (0.007s)
[238.000416] Starting dynamic subtest: numvfs-5
[238.025740] Dynamic subtest numvfs-5: FAIL (0.004s)
[238.031924] Starting dynamic subtest: numvfs-6
[238.061863] Dynamic subtest numvfs-6: FAIL (0.004s)
[238.069155] Starting dynamic subtest: numvfs-7
[238.095651] Dynamic subtest numvfs-7: FAIL (0.004s)
[238.101458] Starting dynamic subtest: numvfs-random
[238.128044] Dynamic subtest numvfs-random: FAIL (0.003s)
[238.134346] Starting dynamic subtest: numvfs-all
[238.160415] Dynamic subtest numvfs-all: FAIL (0.004s)
[238.161191] Subtest enable-vfs-autoprobe-on: FAIL (0.054s)
[238.187150] [052/131] (784s left) gem_exec_whisper (basic-queues)
[238.256581] Starting subtest: basic-queues
[243.960022] Subtest basic-queues: SUCCESS (5.701s)
[244.157817] [053/131] (778s left) kms_flip (2x-dpms-vs-vblank-race)
[244.260326] Starting subtest: 2x-dpms-vs-vblank-race
[244.272019] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[244.389344] [054/131] (778s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[244.476216] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[244.846035] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[247.647903] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[247.657213] Starting dynamic subtest: pipe-A-eDP-1-4
[249.822068] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[249.828380] Starting dynamic subtest: pipe-A-eDP-1-4
[251.833260] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[251.842635] Starting dynamic subtest: pipe-A-eDP-1-x
[254.011752] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[254.377730] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[257.172987] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.798s)
[257.188848] Starting dynamic subtest: pipe-B-eDP-1-4
[259.370635] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.195s)
[259.379487] Starting dynamic subtest: pipe-B-eDP-1-4
[261.382070] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[261.391103] Starting dynamic subtest: pipe-B-eDP-1-x
[263.570911] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[263.938837] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[266.699456] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.764s)
[266.707968] Starting dynamic subtest: pipe-C-eDP-1-4
[268.885800] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[268.892357] Starting dynamic subtest: pipe-C-eDP-1-4
[270.896544] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[270.906410] Starting dynamic subtest: pipe-C-eDP-1-x
[273.086424] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[273.444958] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[276.232778] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[276.239896] Starting dynamic subtest: pipe-D-eDP-1-4
[278.407948] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[278.414601] Starting dynamic subtest: pipe-D-eDP-1-4
[280.417949] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[280.424479] Starting dynamic subtest: pipe-D-eDP-1-x
[282.597401] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[282.598882] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.118s)
[283.849289] [055/131] (738s left) gem_mmap_gtt (basic-write-read-distinct)
[283.906755] Subtest basic-write-read-distinct: SKIP (0.000s)
[283.972309] [056/131] (738s left) gem_mmap_offset (oob-read)
[284.025041] Starting subtest: oob-read
[284.026051] Subtest oob-read: SUCCESS (0.001s)
[284.159584] [057/131] (738s left) kms_atomic (atomic-plane-damage)
[284.262421] Starting subtest: atomic-plane-damage
[284.312481] Starting dynamic subtest: pipe-A-eDP-1
[284.917369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s)
[284.918218] Subtest atomic-plane-damage: SUCCESS (0.655s)
[285.778159] [058/131] (736s left) kms_atomic_transition (plane-all-transition-nonblocking)
[285.877575] Starting subtest: plane-all-transition-nonblocking
[285.878517] Starting dynamic subtest: pipe-A-eDP-1
[288.372034] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[288.674642] Starting dynamic subtest: pipe-B-eDP-1
[291.892966] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.224s)
[292.188163] Subtest plane-all-transition-nonblocking: SUCCESS (6.310s)
[293.030729] [059/131] (729s left) gem_exec_parallel (contexts)
[293.096577] Starting subtest: contexts
[293.097470] Starting dynamic subtest: rcs0
[296.142661] Dynamic subtest rcs0: SUCCESS (3.044s)
[296.152519] Starting dynamic subtest: bcs0
[299.826548] Dynamic subtest bcs0: SUCCESS (3.681s)
[299.834664] Starting dynamic subtest: vcs0
[304.304761] Dynamic subtest vcs0: SUCCESS (4.476s)
[304.313947] Starting dynamic subtest: vcs1
[308.256573] Dynamic subtest vcs1: SUCCESS (3.949s)
[308.263269] Starting dynamic subtest: vecs0
[312.415648] Dynamic subtest vecs0: SUCCESS (4.158s)
[312.422638] Starting dynamic subtest: ccs0
[316.263324] Dynamic subtest ccs0: SUCCESS (3.845s)
[316.264537] Subtest contexts: SUCCESS (23.166s)
[316.466500] [060/131] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[316.558630] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[323.216245] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.658s)
[323.387843] [061/131] (699s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[323.486436] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[323.488247] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[323.596105] [062/131] (699s left) kms_atomic_interruptible (legacy-pageflip)
[323.692567] Starting subtest: legacy-pageflip
[323.693498] Starting dynamic subtest: pipe-A-eDP-1
[331.095816] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.402s)
[331.099487] Subtest legacy-pageflip: SUCCESS (7.405s)
[331.933480] [063/131] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[332.032146] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[332.033878] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[332.162825] [064/131] (690s left) kms_psr (psr2-sprite-mmap-cpu)
[332.257930] Starting subtest: psr2-sprite-mmap-cpu
[332.258944] Starting dynamic subtest: eDP-1
[334.024517] Dynamic subtest eDP-1: SUCCESS (1.767s)
[334.025410] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.768s)
[334.913720] [065/131] (688s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[335.017508] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[341.945863] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (6.930s)
[342.120637] [066/131] (680s left) gem_exec_schedule (fairslice-all)
[342.182503] Starting subtest: fairslice-all
[344.238194] Subtest fairslice-all: SUCCESS (2.055s)
[346.001468] [067/131] (677s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[350.991205] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[350.992130] Starting dynamic subtest: pipe-A-eDP-1
[351.784283] Dynamic subtest pipe-A-eDP-1: SKIP (0.792s)
[351.792725] Starting dynamic subtest: pipe-B-eDP-1
[352.910159] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[352.911935] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.920s)
[354.117589] [068/131] (668s left) api_intel_allocator (two-level-inception)
[354.166952] Starting subtest: two-level-inception
[359.565539] Subtest two-level-inception: SUCCESS (5.397s)
[359.718961] [069/131] (663s left) i915_suspend (debugfs-reader)
[359.785585] Starting subtest: debugfs-reader
[378.297621] Subtest debugfs-reader: SUCCESS (7.771s)
[383.378948] [070/131] (644s left) kms_flip (plain-flip-fb-recreate-interruptible)
[383.484462] Starting subtest: plain-flip-fb-recreate-interruptible
[383.486814] Starting dynamic subtest: A-eDP1
[404.181214] Dynamic subtest A-eDP1: SUCCESS (20.594s)
[404.193377] Starting dynamic subtest: B-eDP1
[413.028229] Dynamic subtest B-eDP1: SUCCESS (8.835s)
[413.038694] Starting dynamic subtest: C-eDP1
[421.850897] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[421.859702] Starting dynamic subtest: D-eDP1
[430.694723] Dynamic subtest D-eDP1: SUCCESS (8.838s)
[430.697413] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (47.094s)
[431.886619] [071/131] (596s left) gem_vm_create (invalid-destroy)
[431.944758] Starting subtest: invalid-destroy
[431.947462] Subtest invalid-destroy: SUCCESS (0.002s)
[432.084849] [072/131] (596s left) gem_ccs (ctrl-surf-copy-new-ctx)
[432.147161] Starting subtest: ctrl-surf-copy-new-ctx
[432.148855] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[432.283409] [073/131] (596s left) syncobj_basic (bad-destroy-pad)
[432.335807] Starting subtest: bad-destroy-pad
[432.336791] Subtest bad-destroy-pad: SUCCESS (0.000s)
[432.462315] [074/131] (595s left) kms_plane_multiple (2x-tiling-y)
[432.543202] Starting subtest: 2x-tiling-y
[432.544889] Subtest 2x-tiling-y: SKIP (0.000s)
[432.633636] [075/131] (595s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[432.727523] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[432.728393] Starting dynamic subtest: pipe-A-eDP-1
[432.736740] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[432.750320] Starting dynamic subtest: pipe-B-eDP-1
[432.759956] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[432.768859] Starting dynamic subtest: pipe-C-eDP-1
[432.777094] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[432.784547] Starting dynamic subtest: pipe-D-eDP-1
[432.793096] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[432.794705] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[434.979136] [076/131] (593s left) kms_pm_rpm (modeset-lpsp)
[436.802093] Starting subtest: modeset-lpsp
[438.259764] Subtest modeset-lpsp: SUCCESS (1.461s)
[438.370659] [077/131] (590s left) kms_setmode (basic)
[438.413174] Starting subtest: basic
[438.731881] Starting dynamic subtest: pipe-A-eDP-1
[440.832798] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s)
[441.175375] Starting dynamic subtest: pipe-B-eDP-1
[443.266869] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.095s)
[443.569967] Subtest basic: SUCCESS (5.154s)
[444.425140] [078/131] (584s left) kms_psr (fbc-psr-suspend)
[444.511114] Starting subtest: fbc-psr-suspend
[444.512103] Starting dynamic subtest: eDP-1
[444.514015] Dynamic subtest eDP-1: SKIP (0.000s)
[444.515980] Subtest fbc-psr-suspend: SKIP (0.003s)
[444.608833] [079/131] (583s left) gem_ringfill (engines-basic)
[450.641023] Starting subtest: engines-basic
[450.642519] Starting dynamic subtest: rcs0
[450.723026] Dynamic subtest rcs0: SUCCESS (0.081s)
[450.733985] Starting dynamic subtest: bcs0
[450.767819] Dynamic subtest bcs0: SUCCESS (0.043s)
[450.778264] Starting dynamic subtest: vcs0
[450.810930] Dynamic subtest vcs0: SUCCESS (0.041s)
[450.821331] Starting dynamic subtest: vcs1
[450.852903] Dynamic subtest vcs1: SUCCESS (0.040s)
[450.864419] Starting dynamic subtest: vecs0
[450.896884] Dynamic subtest vecs0: SUCCESS (0.042s)
[450.906689] Starting dynamic subtest: ccs0
[450.941732] Dynamic subtest ccs0: SUCCESS (0.043s)
[450.942938] Subtest engines-basic: SUCCESS (0.302s)
[451.037967] [080/131] (577s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[451.110032] Starting subtest: invalid-bsd2-flag-on-vebox
[451.111173] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[451.243388] [081/131] (577s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[451.349098] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[451.349920] Starting dynamic subtest: pipe-A-eDP-1
[451.370013] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[451.378819] Starting dynamic subtest: pipe-B-eDP-1
[451.391405] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[451.399934] Starting dynamic subtest: pipe-C-eDP-1
[451.411707] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[451.420233] Starting dynamic subtest: pipe-D-eDP-1
[451.432662] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[451.433575] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.084s)
[453.588601] [082/131] (575s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[453.689326] Starting subtest: extended-pageflip-modeset-hang-oldfb
[453.690184] Starting dynamic subtest: pipe-A
[461.610609] Dynamic subtest pipe-A: SUCCESS (7.916s)
[461.619725] Starting dynamic subtest: pipe-D
[470.202304] Dynamic subtest pipe-D: SUCCESS (8.586s)
[470.204231] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.507s)
[471.062250] [083/131] (557s left) gem_ppgtt (shrink-vs-evict-any)
[471.122627] Starting subtest: shrink-vs-evict-any
[476.651239] Subtest shrink-vs-evict-any: SUCCESS (5.527s)
[476.748077] [084/131] (551s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[476.810948] Starting subtest: etime-single-wait-for-submit-unsubmitted
[476.913015] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[477.012199] [085/131] (551s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[477.074769] Starting subtest: multi-wait-all-for-submit-signaled
[477.076034] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[477.221656] [086/131] (551s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[477.265658] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[477.370438] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[477.466758] [087/131] (551s left) gem_exec_schedule (implicit-write-read)
[477.541495] Starting subtest: implicit-write-read
[477.542702] Starting dynamic subtest: rcs0
[477.732983] Dynamic subtest rcs0: SUCCESS (0.188s)
[477.742037] Starting dynamic subtest: vcs0
[477.840620] Dynamic subtest vcs0: SUCCESS (0.109s)
[477.851556] Starting dynamic subtest: vcs1
[477.942328] Dynamic subtest vcs1: SUCCESS (0.101s)
[477.953086] Starting dynamic subtest: vecs0
[478.043680] Dynamic subtest vecs0: SUCCESS (0.101s)
[478.054446] Starting dynamic subtest: ccs0
[478.163073] Dynamic subtest ccs0: SUCCESS (0.118s)
[478.164876] Subtest implicit-write-read: SUCCESS (0.622s)
[478.805894] [088/131] (550s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[478.896117] Starting subtest: fbcpsr-rgb565-draw-blt
[485.896700] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.007s)
[486.086373] [089/131] (542s left) gem_ctx_persistence (processes)
[486.140106] Starting subtest: processes
[487.670937] Subtest processes: SUCCESS (1.532s)
[487.768096] [090/131] (541s left) kms_cursor_crc (cursor-sliding-32x10)
[487.932216] Starting subtest: cursor-sliding-32x10
[487.970809] Subtest cursor-sliding-32x10: SKIP (0.036s)
[488.264619] [091/131] (540s left) kms_psr (fbc-pr-primary-render)
[488.364363] Starting subtest: fbc-pr-primary-render
[488.366015] Subtest fbc-pr-primary-render: SKIP (0.000s)
[488.459062] [092/131] (540s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[488.526947] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[488.613491] [093/131] (540s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[488.665115] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[488.665986] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[488.785704] [094/131] (540s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[488.872669] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[488.874305] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[488.983490] [095/131] (540s left) gem_exec_async (concurrent-writes)
[489.042018] Starting subtest: concurrent-writes
[489.043039] Starting dynamic subtest: rcs0
[489.057485] Dynamic subtest rcs0: SUCCESS (0.015s)
[489.068287] Starting dynamic subtest: bcs0
[489.069092] Dynamic subtest bcs0: SUCCESS (0.005s)
[489.077551] Starting dynamic subtest: vcs0
[489.078425] Dynamic subtest vcs0: SUCCESS (0.004s)
[489.086814] Starting dynamic subtest: vcs1
[489.087650] Dynamic subtest vcs1: SUCCESS (0.006s)
[489.096440] Starting dynamic subtest: vecs0
[489.097304] Dynamic subtest vecs0: SUCCESS (0.012s)
[489.105503] Starting dynamic subtest: ccs0
[489.106280] Dynamic subtest ccs0: SUCCESS (0.010s)
[489.107141] Subtest concurrent-writes: SUCCESS (0.059s)
[489.361439] [096/131] (539s left) gem_mmap_gtt (basic-small-bo-tiledx)
[489.418035] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[489.482704] [097/131] (539s left) dmabuf_sync_file (import-basic)
[489.520848] Starting subtest: import-basic
[489.523024] Subtest import-basic: SUCCESS (0.002s)
[489.597056] [098/131] (539s left) kms_feature_discovery (display)
[489.685604] Starting subtest: display
[489.686522] Subtest display: SUCCESS (0.000s)
[489.777920] [099/131] (539s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[489.876435] Starting subtest: x-tiled-64bpp-rotate-90
[489.897642] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[490.043093] [100/131] (539s left) perf_pmu (busy-no-semaphores)
[490.078860] Starting subtest: busy-no-semaphores
[490.079842] Starting dynamic subtest: rcs0
[490.663338] Dynamic subtest rcs0: SUCCESS (0.582s)
[490.674121] Starting dynamic subtest: bcs0
[491.211411] Dynamic subtest bcs0: SUCCESS (0.546s)
[491.222473] Starting dynamic subtest: vcs0
[491.761761] Dynamic subtest vcs0: SUCCESS (0.547s)
[491.773378] Starting dynamic subtest: vcs1
[493.200691] Dynamic subtest vcs1: SUCCESS (1.436s)
[493.211825] Starting dynamic subtest: vecs0
[495.185138] Dynamic subtest vecs0: SUCCESS (1.982s)
[495.196320] Starting dynamic subtest: ccs0
[497.170437] Dynamic subtest ccs0: SUCCESS (1.983s)
[497.171673] Subtest busy-no-semaphores: SUCCESS (7.094s)
[497.330075] [101/131] (531s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[497.435974] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[497.437746] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[497.563242] [102/131] (531s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[497.695485] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[497.698297] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[497.859377] [103/131] (531s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[498.228491] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[499.056626] [104/131] (530s left) kms_getfb (getfb-reject-nv12)
[499.146386] Starting subtest: getfb-reject-nv12
[499.147208] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[499.274739] [105/131] (530s left) i915_drm_fdinfo (context-close-stress)
[499.314935] Starting subtest: context-close-stress
[510.060854] Subtest context-close-stress: SUCCESS (10.745s)
[510.154670] [106/131] (519s left) perf_pmu (module-unload)
[510.408175] Starting subtest: module-unload
[517.128864] Subtest module-unload: FAIL (6.686s)
[517.149455] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[517.150144] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[517.151772] [107/131] (512s left) kms_chamelium_edid (dp-edid-read)
[518.831728] Subtest dp-edid-read: SKIP (0.000s)
[519.672920] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[519.674176] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[519.676508] [108/131] (509s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[524.655708] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[524.656656] Starting dynamic subtest: pipe-A-eDP-1
[525.462953] Dynamic subtest pipe-A-eDP-1: SKIP (0.807s)
[525.471963] Starting dynamic subtest: pipe-B-eDP-1
[526.603308] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[526.604887] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.949s)
[527.810642] [109/131] (501s left) kms_vblank (query-busy)
[527.901883] Starting subtest: query-busy
[527.902903] Starting dynamic subtest: pipe-A-eDP-1
[529.777522] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s)
[529.786949] Starting dynamic subtest: pipe-D-eDP-1
[532.357124] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.577s)
[532.358013] Subtest query-busy: SUCCESS (4.454s)
[533.178257] [110/131] (496s left) syncobj_timeline (wait-for-submit-complex)
[533.234097] Starting subtest: wait-for-submit-complex
[533.295484] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[533.388008] [111/131] (496s left) perf (invalid-create-userspace-config)
[533.524142] Starting subtest: invalid-create-userspace-config
[533.524980] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[533.561925] [112/131] (496s left) gem_exec_basic (basic)
[533.607471] Starting subtest: basic
[533.608456] Starting dynamic subtest: rcs0-smem
[533.614442] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[533.627225] Starting dynamic subtest: bcs0-smem
[533.628337] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[533.640956] Starting dynamic subtest: vcs0-smem
[533.642061] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[533.651338] Starting dynamic subtest: vcs1-smem
[533.652435] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[533.661425] Starting dynamic subtest: vecs0-smem
[533.662337] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[533.668993] Starting dynamic subtest: ccs0-smem
[533.669924] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[533.670806] Subtest basic: SUCCESS (0.023s)
[535.686788] [113/131] (493s left) kms_chamelium_color (ctm-0-25)
[535.811919] Subtest ctm-0-25: SKIP (0.000s)
[535.852893] [114/131] (493s left) gem_userptr_blits (process-exit-busy)
[535.918269] Starting subtest: process-exit-busy
[535.932885] Subtest process-exit-busy: SUCCESS (0.016s)
[536.086996] [115/131] (493s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[536.132765] Starting subtest: y-tiled-ccs-to-y-tiled
[536.134492] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[536.338270] [116/131] (493s left) gen7_exec_parse (bitmasks)
[536.400358] Subtest bitmasks: SKIP (0.000s)
[536.466853] [117/131] (493s left) gem_eio (wait-wedge-10ms)
[536.658108] Starting subtest: wait-wedge-10ms
[537.722582] Subtest wait-wedge-10ms: SUCCESS (1.064s)
[537.906297] [118/131] (491s left) kms_content_protection (atomic)
[538.053558] Starting subtest: atomic
[538.055547] Subtest atomic: SKIP (0.000s)
[538.216646] [119/131] (491s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[538.307492] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[538.308474] Starting dynamic subtest: pipe-A-default-mode
[538.602852] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[538.604756] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.295s)
[539.405849] [120/131] (490s left) gem_exec_params (invalid-flag)
[539.459497] Starting subtest: invalid-flag
[539.460381] Subtest invalid-flag: SUCCESS (0.000s)
[539.597804] [121/131] (490s left) kms_getfb (getfb-addfb-different-handles)
[539.697652] Starting subtest: getfb-addfb-different-handles
[539.698654] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[539.836217] [122/131] (490s left) gem_exec_flush (basic-uc-ro-default)
[539.902629] Starting subtest: basic-uc-ro-default
[545.357219] Subtest basic-uc-ro-default: SUCCESS (5.453s)
[545.564063] [123/131] (484s left) gem_sync (basic-each)
[545.633807] Starting subtest: basic-each
[548.133236] Subtest basic-each: SUCCESS (2.500s)
[548.332322] [124/131] (481s left) gem_exec_balancer (full)
[548.393440] Starting subtest: full
[553.566226] Subtest full: SUCCESS (5.172s)
[553.924025] [125/131] (476s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[554.020492] Starting subtest: y-tiled-8bpp-rotate-180
[554.022184] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[554.152400] [126/131] (475s left) sw_sync (sync_merge_invalid)
[554.181887] Starting subtest: sync_merge_invalid
[554.216070] Subtest sync_merge_invalid: SUCCESS (0.034s)
[554.293494] [127/131] (475s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[554.393637] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[558.863804] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.468s)
[560.004059] [128/131] (470s left) gem_lmem_swapping (parallel-random-verify-ccs)
[560.039132] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[560.076816] [129/131] (470s left) kms_lease (lease-unleased-connector)
[560.169327] Starting subtest: lease-unleased-connector
[560.170128] Starting dynamic subtest: pipe-A-eDP-1
[560.176646] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[560.186547] Starting dynamic subtest: pipe-B-eDP-1
[560.187427] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[560.197907] Starting dynamic subtest: pipe-C-eDP-1
[560.198726] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[560.206139] Starting dynamic subtest: pipe-D-eDP-1
[560.206944] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[560.207745] Subtest lease-unleased-connector: SUCCESS (0.030s)
[560.338833] [130/131] (469s left) perf (enable-disable)
[560.444575] Starting subtest: enable-disable
[560.445686] Starting dynamic subtest: 0-rcs0
[562.851747] Dynamic subtest 0-rcs0: SUCCESS (2.404s)
[562.860448] Starting dynamic subtest: 1-vcs0
[567.334112] Dynamic subtest 1-vcs0: SUCCESS (4.480s)
[567.335564] Subtest enable-disable: SUCCESS (6.886s)
[567.376480] [131/131] (462s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[567.522626] Starting subtest: cursor-rapid-movement-32x32
[567.560946] Subtest cursor-rapid-movement-32x32: SKIP (0.037s)
[567.883584] 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.