[57.948576] Initializing watchdogs
[57.948625]   /dev/watchdog0
[57.965391] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.969755] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.971994] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.975450] [001/131] (960s left) fbdev (unaligned-read)
[58.037880] Starting subtest: unaligned-read
[58.052889] Subtest unaligned-read: SUCCESS (0.015s)
[58.129956] [002/131] (960s left) gem_ctx_isolation (dirty-switch)
[58.202420] Starting subtest: dirty-switch
[58.204894] Starting dynamic subtest: rcs0
[58.458824] Dynamic subtest rcs0: SUCCESS (0.255s)
[58.469152] Starting dynamic subtest: bcs0
[58.744521] Dynamic subtest bcs0: SUCCESS (0.283s)
[58.752497] Starting dynamic subtest: vcs0
[58.979603] Dynamic subtest vcs0: SUCCESS (0.234s)
[58.989110] Starting dynamic subtest: vcs1
[60.148895] Dynamic subtest vcs1: SUCCESS (1.164s)
[60.158904] Starting dynamic subtest: vecs0
[62.140976] Dynamic subtest vecs0: SUCCESS (1.986s)
[62.148258] Starting dynamic subtest: ccs0
[64.126823] Dynamic subtest ccs0: SUCCESS (1.981s)
[64.129186] Subtest dirty-switch: SUCCESS (5.906s)
[64.408819] [003/131] (954s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[64.518467] Starting subtest: psr-modesetfrombusy
[70.619675] Subtest psr-modesetfrombusy: SUCCESS (6.099s)
[70.803170] [004/131] (947s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[70.897973] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[70.899849] Starting dynamic subtest: pipe-A-default-mode
[73.654786] Dynamic subtest pipe-A-default-mode: SUCCESS (2.754s)
[73.657582] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.755s)
[74.537479] [005/131] (944s left) gem_exec_params (sol-reset-invalid)
[74.610789] Starting subtest: sol-reset-invalid
[74.613064] Subtest sol-reset-invalid: SUCCESS (0.002s)
[76.040046] [006/131] (942s left) gem_spin_batch (resubmit-new)
[76.104819] Starting subtest: resubmit-new
[76.107156] Starting dynamic subtest: rcs0
[76.113566] Dynamic subtest rcs0: SUCCESS (0.009s)
[76.121580] Starting dynamic subtest: bcs0
[76.123863] Dynamic subtest bcs0: SUCCESS (0.004s)
[76.131720] Starting dynamic subtest: vcs0
[76.134092] Dynamic subtest vcs0: SUCCESS (0.004s)
[76.141615] Starting dynamic subtest: vcs1
[76.143546] Dynamic subtest vcs1: SUCCESS (0.004s)
[76.150430] Starting dynamic subtest: vecs0
[76.152410] Dynamic subtest vecs0: SUCCESS (0.005s)
[76.159299] Starting dynamic subtest: ccs0
[76.161184] Dynamic subtest ccs0: SUCCESS (0.006s)
[76.163073] Subtest resubmit-new: SUCCESS (0.034s)
[77.970587] [007/131] (940s left) gem_exec_schedule (preempt-user)
[78.040647] Starting subtest: preempt-user
[78.043190] Starting dynamic subtest: rcs0
[78.069485] Dynamic subtest rcs0: SUCCESS (0.035s)
[78.082427] Starting dynamic subtest: bcs0
[78.100664] Dynamic subtest bcs0: SUCCESS (0.031s)
[78.108233] Starting dynamic subtest: vcs0
[78.131785] Dynamic subtest vcs0: SUCCESS (0.031s)
[78.141581] Starting dynamic subtest: vcs1
[78.155919] Dynamic subtest vcs1: SUCCESS (0.024s)
[78.165805] Starting dynamic subtest: vecs0
[78.181128] Dynamic subtest vecs0: SUCCESS (0.025s)
[78.188250] Starting dynamic subtest: ccs0
[78.211833] Dynamic subtest ccs0: SUCCESS (0.030s)
[78.214064] Subtest preempt-user: SUCCESS (0.178s)
[80.015308] [008/131] (938s left) sysfs_heartbeat_interval (nopreempt)
[80.087468] Starting subtest: nopreempt
[80.089821] Starting dynamic subtest: vecs0
[89.901454] Dynamic subtest vecs0: SUCCESS (9.808s)
[89.912156] Starting dynamic subtest: ccs0
[93.997763] Dynamic subtest ccs0: SUCCESS (4.096s)
[94.008667] Starting dynamic subtest: vcs0
[103.917898] Dynamic subtest vcs0: SUCCESS (9.915s)
[103.928781] Starting dynamic subtest: bcs0
[107.912886] Dynamic subtest bcs0: SUCCESS (3.996s)
[107.921284] Starting dynamic subtest: rcs0
[112.027799] Dynamic subtest rcs0: SUCCESS (4.114s)
[112.038147] Starting dynamic subtest: vcs1
[121.970012] Dynamic subtest vcs1: SUCCESS (9.938s)
[121.972553] Subtest nopreempt: SUCCESS (41.874s)
[122.068851] [009/131] (896s left) kms_invalid_mode (zero-hdisplay)
[122.164131] Starting subtest: zero-hdisplay
[122.166502] Starting dynamic subtest: pipe-A-eDP-1
[122.455102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[122.464578] Starting dynamic subtest: pipe-B-eDP-1
[122.466789] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[122.474601] Starting dynamic subtest: pipe-C-eDP-1
[122.476823] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[122.484819] Starting dynamic subtest: pipe-D-eDP-1
[122.486876] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[122.488903] Subtest zero-hdisplay: SUCCESS (0.300s)
[123.274426] [010/131] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[123.380252] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[123.384570] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[123.523652] [011/131] (895s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[123.629684] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[124.476765] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.848s)
[124.669740] [012/131] (894s left) kms_getfb (getfb-handle-zero)
[124.784831] Starting subtest: getfb-handle-zero
[124.787120] Subtest getfb-handle-zero: SUCCESS (0.000s)
[124.923986] [013/131] (894s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[124.985846] Starting subtest: yf-tiled-ccs-to-yf-tiled
[124.990213] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[125.187756] [014/131] (893s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[125.290923] Starting subtest: multiplane-rotation-cropping-bottom
[132.540596] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.251s)
[132.702173] [015/131] (886s left) gem_eio (wait-1us)
[132.951456] Starting subtest: wait-1us
[133.298847] Subtest wait-1us: SUCCESS (0.350s)
[133.479053] [016/131] (885s left) syncobj_wait (multi-wait-for-submit-signaled)
[133.542116] Starting subtest: multi-wait-for-submit-signaled
[133.544505] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[133.668967] [017/131] (885s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[133.763230] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[133.765482] Starting dynamic subtest: pipe-A-default-mode
[134.058544] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[134.063115] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.291s)
[134.904151] [018/131] (884s left) kms_plane_alpha_blend (alpha-7efc)
[135.011962] Starting subtest: alpha-7efc
[135.295310] Starting dynamic subtest: pipe-A-eDP-1
[135.885511] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[135.916187] Starting dynamic subtest: pipe-D-eDP-1
[137.190657] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.281s)
[137.193026] Subtest alpha-7efc: SUCCESS (2.181s)
[138.058490] [019/131] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[138.167517] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[138.171802] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[138.299815] [020/131] (880s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[138.405794] Starting subtest: fbc-psr2-primary-mmap-cpu
[138.408035] Starting dynamic subtest: eDP-1
[138.412135] Dynamic subtest eDP-1: SKIP (0.000s)
[138.416133] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[138.510671] [021/131] (880s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[138.594080] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[138.605037] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[138.743801] [022/131] (880s left) gem_exec_whisper (basic-normal-all)
[138.819565] Starting subtest: basic-normal-all
[141.315981] Subtest basic-normal-all: SUCCESS (2.497s)
[141.542740] [023/131] (877s left) kms_big_fb (linear-16bpp-rotate-180)
[141.653144] Starting subtest: linear-16bpp-rotate-180
[142.998167] Subtest linear-16bpp-rotate-180: SUCCESS (1.345s)
[143.175194] [024/131] (876s left) kms_frontbuffer_tracking (psr-slowdraw)
[143.276937] Starting subtest: psr-slowdraw
[168.506167] Subtest psr-slowdraw: SUCCESS (25.231s)
[168.673832] [025/131] (850s left) vgem_basic (dmabuf-fence)
[168.771551] Starting subtest: dmabuf-fence
[168.773859] Subtest dmabuf-fence: SUCCESS (0.002s)
[168.847483] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[168.850420] [026/131] (850s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[168.913922] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[168.916150] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[169.041136] [027/131] (850s left) kms_psr (pr-primary-render)
[169.137458] Starting subtest: pr-primary-render
[169.141737] Subtest pr-primary-render: SKIP (0.000s)
[169.233301] [028/131] (850s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[169.339446] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[169.341410] Starting dynamic subtest: pipe-A-eDP-1
[169.360321] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[169.370392] Starting dynamic subtest: pipe-B-eDP-1
[169.387812] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[169.395804] Starting dynamic subtest: pipe-C-eDP-1
[169.412852] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[169.420571] Starting dynamic subtest: pipe-D-eDP-1
[169.437995] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[169.441539] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[171.563878] [029/131] (848s left) core_auth (getclient-master-drop)
[171.602354] Starting subtest: getclient-master-drop
[171.627238] Subtest getclient-master-drop: SUCCESS (0.024s)
[171.762480] [030/131] (847s left) kms_plane_scaling (planes-downscale-factor-0-5)
[171.856283] Starting subtest: planes-downscale-factor-0-5
[171.858552] Starting dynamic subtest: pipe-A
[171.881295] Dynamic subtest pipe-A: SKIP (0.021s)
[171.890370] Starting dynamic subtest: pipe-B
[171.922077] Dynamic subtest pipe-B: SKIP (0.041s)
[171.932680] Starting dynamic subtest: pipe-C
[171.960830] Dynamic subtest pipe-C: SKIP (0.039s)
[171.969758] Starting dynamic subtest: pipe-D
[171.992130] Dynamic subtest pipe-D: SKIP (0.031s)
[171.995708] Subtest planes-downscale-factor-0-5: SKIP (0.134s)
[172.117577] [031/131] (847s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[172.210982] Starting subtest: fb-8bpc-vs-panel-8bpc
[172.213357] Starting dynamic subtest: pipe-A-eDP-1
[173.610394] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.398s)
[173.612316] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.400s)
[174.426410] [032/131] (845s left) gem_partial_pwrite_pread (reads-snoop)
[174.495519] Subtest reads-snoop: SKIP (0.000s)
[174.566368] [033/131] (845s left) gem_eio (in-flight-contexts-immediate)
[174.808946] Starting subtest: in-flight-contexts-immediate
[188.903836] Subtest in-flight-contexts-immediate: SUCCESS (14.093s)
[189.107402] [034/131] (830s left) gen3_render_mixed_blits
[189.235849] [035/131] (830s left) kms_pm_rpm (pm-tiling)
[191.064189] Starting subtest: pm-tiling
[191.069664] Subtest pm-tiling: SKIP (0.000s)
[191.561630] [036/131] (828s left) i915_module_load (reload-no-display)
[191.600292] Starting subtest: reload-no-display
[197.844262] Subtest reload-no-display: SUCCESS (6.246s)
[197.872425] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[197.873209] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[197.875724] [037/131] (822s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[199.489296] Starting subtest: plane-upscale-20x20-with-rotation
[199.491724] Starting dynamic subtest: pipe-A
[199.733068] Dynamic subtest pipe-A: SUCCESS (0.245s)
[199.740638] Starting dynamic subtest: pipe-B
[200.985102] Dynamic subtest pipe-B: SUCCESS (1.251s)
[200.992958] Starting dynamic subtest: pipe-C
[202.358107] Dynamic subtest pipe-C: SUCCESS (1.371s)
[202.366233] Starting dynamic subtest: pipe-D
[203.653877] Dynamic subtest pipe-D: SUCCESS (1.294s)
[203.656294] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.167s)
[204.815373] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[204.816616] [FACT kms_plane_scaling (plane-upscale-20x20-with-rotation)] new: kernel.kmod_is_loaded.i915: true
[204.819920] [038/131] (815s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[204.928597] Starting subtest: 4-tiled-8bpp-rotate-180
[206.145340] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.217s)
[206.302549] [039/131] (813s left) kms_rotation_crc (primary-rotation-90)
[206.399998] Starting subtest: primary-rotation-90
[206.403610] Subtest primary-rotation-90: SKIP (0.001s)
[206.514653] [040/131] (813s left) kms_cursor_crc (cursor-onscreen-32x10)
[206.674494] Starting subtest: cursor-onscreen-32x10
[206.720936] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[207.020819] [041/131] (813s left) kms_vblank (wait-idle)
[207.114875] Starting subtest: wait-idle
[207.116514] Starting dynamic subtest: pipe-A-eDP-1
[208.875120] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.758s)
[208.888635] Starting dynamic subtest: pipe-D-eDP-1
[211.271160] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.396s)
[211.273488] Subtest wait-idle: SUCCESS (4.158s)
[212.122379] [042/131] (807s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[212.225164] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[212.229478] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[212.361437] [043/131] (807s left) kms_flip (2x-flip-vs-dpms)
[212.465809] Starting subtest: 2x-flip-vs-dpms
[212.477403] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[212.604556] [044/131] (807s left) gem_exec_fence (syncobj-channel)
[213.027643] Starting subtest: syncobj-channel
[214.046305] Subtest syncobj-channel: SUCCESS (1.015s)
[215.051745] [045/131] (805s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[215.152977] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[215.155235] Starting dynamic subtest: pipe-A-eDP-1
[215.164548] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[215.173965] Starting dynamic subtest: pipe-B-eDP-1
[215.182991] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[215.191308] Starting dynamic subtest: pipe-C-eDP-1
[215.199760] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.207470] Starting dynamic subtest: pipe-D-eDP-1
[215.215889] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.219969] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[217.390800] [046/131] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[217.492295] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[224.766523] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.276s)
[224.936545] [047/131] (795s left) kms_flip (busy-flip)
[225.044057] Starting subtest: busy-flip
[225.046682] Starting dynamic subtest: A-eDP1
[226.699636] Dynamic subtest A-eDP1: SUCCESS (1.657s)
[226.708116] Starting dynamic subtest: B-eDP1
[228.347345] Dynamic subtest B-eDP1: SUCCESS (1.647s)
[228.357841] Starting dynamic subtest: C-eDP1
[229.971506] Dynamic subtest C-eDP1: SUCCESS (1.622s)
[229.981705] Starting dynamic subtest: D-eDP1
[231.595051] Dynamic subtest D-eDP1: SUCCESS (1.622s)
[231.600070] Subtest busy-flip: SUCCESS (6.557s)
[232.869547] [048/131] (787s left) prime_mmap (test_aperture_limit)
[232.927288] Starting subtest: test_aperture_limit
[232.929463] Starting dynamic subtest: test_aperture_limit-smem
[232.937564] Dynamic subtest test_aperture_limit-smem: SKIP (0.009s)
[232.942022] Subtest test_aperture_limit: SKIP (0.010s)
[233.073959] [049/131] (787s left) i915_pm_rpm (sysfs-read)
[235.011666] Starting subtest: sysfs-read
[236.181784] Subtest sysfs-read: SUCCESS (1.169s)
[236.569299] [050/131] (783s left) kms_big_fb (yf-tiled-addfb)
[236.678280] Starting subtest: yf-tiled-addfb
[236.682911] Subtest yf-tiled-addfb: SKIP (0.000s)
[236.797962] [051/131] (783s left) sriov_basic (enable-vfs-autoprobe-on)
[236.855722] Starting subtest: enable-vfs-autoprobe-on
[236.857695] Starting dynamic subtest: numvfs-1
[236.936837] Dynamic subtest numvfs-1: FAIL (0.030s)
[236.947112] Starting dynamic subtest: numvfs-2
[237.021252] Dynamic subtest numvfs-2: FAIL (0.004s)
[237.031568] Starting dynamic subtest: numvfs-3
[237.105190] Dynamic subtest numvfs-3: FAIL (0.004s)
[237.114864] Starting dynamic subtest: numvfs-4
[237.188825] Dynamic subtest numvfs-4: FAIL (0.004s)
[237.199743] Starting dynamic subtest: numvfs-5
[237.273039] Dynamic subtest numvfs-5: FAIL (0.003s)
[237.282706] Starting dynamic subtest: numvfs-6
[237.356119] Dynamic subtest numvfs-6: FAIL (0.003s)
[237.365447] Starting dynamic subtest: numvfs-7
[237.439076] Dynamic subtest numvfs-7: FAIL (0.004s)
[237.448999] Starting dynamic subtest: numvfs-random
[237.515137] Dynamic subtest numvfs-random: FAIL (0.003s)
[237.524622] Starting dynamic subtest: numvfs-all
[237.586498] Dynamic subtest numvfs-all: FAIL (0.517s)
[237.588210] Subtest enable-vfs-autoprobe-on: FAIL (0.580s)
[237.626203] [052/131] (782s left) gem_exec_whisper (basic-queues)
[237.700445] Starting subtest: basic-queues
[243.359641] Subtest basic-queues: SUCCESS (5.655s)
[243.569163] [053/131] (776s left) kms_flip (2x-dpms-vs-vblank-race)
[243.665918] Starting subtest: 2x-dpms-vs-vblank-race
[243.677903] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[243.782329] [054/131] (776s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[243.883164] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[244.255079] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[247.018449] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.762s)
[247.030205] Starting dynamic subtest: pipe-A-eDP-1-4
[249.194099] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[249.204861] Starting dynamic subtest: pipe-A-eDP-1-4
[251.204019] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[251.212347] Starting dynamic subtest: pipe-A-eDP-1-x
[253.383021] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[253.749966] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[256.541655] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.800s)
[256.553114] Starting dynamic subtest: pipe-B-eDP-1-4
[258.727965] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[258.738749] Starting dynamic subtest: pipe-B-eDP-1-4
[260.737842] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[260.746343] Starting dynamic subtest: pipe-B-eDP-1-x
[262.928707] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[263.301275] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[266.070425] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.774s)
[266.081658] Starting dynamic subtest: pipe-C-eDP-1-4
[268.246021] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[268.256277] Starting dynamic subtest: pipe-C-eDP-1-4
[270.256205] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[270.267886] Starting dynamic subtest: pipe-C-eDP-1-x
[272.447640] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.191s)
[272.807069] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[275.594800] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.795s)
[275.606284] Starting dynamic subtest: pipe-D-eDP-1-4
[277.770479] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[277.781388] Starting dynamic subtest: pipe-D-eDP-1-4
[279.781493] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[279.792840] Starting dynamic subtest: pipe-D-eDP-1-x
[281.970859] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[281.973525] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.087s)
[283.204220] [055/131] (737s left) gem_mmap_gtt (basic-write-read-distinct)
[283.269776] Subtest basic-write-read-distinct: SKIP (0.000s)
[283.336902] [056/131] (737s left) gem_mmap_offset (oob-read)
[283.393894] Starting subtest: oob-read
[283.396075] Subtest oob-read: SUCCESS (0.000s)
[283.520936] [057/131] (737s left) kms_atomic (atomic-plane-damage)
[283.609045] Starting subtest: atomic-plane-damage
[283.665354] Starting dynamic subtest: pipe-A-eDP-1
[284.215470] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[284.217701] Subtest atomic-plane-damage: SUCCESS (0.607s)
[285.036812] [058/131] (735s left) kms_atomic_transition (plane-all-transition-nonblocking)
[285.142385] Starting subtest: plane-all-transition-nonblocking
[285.144731] Starting dynamic subtest: pipe-A-eDP-1
[287.636837] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[287.953911] Starting dynamic subtest: pipe-B-eDP-1
[291.151446] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.204s)
[291.449573] Subtest plane-all-transition-nonblocking: SUCCESS (6.306s)
[292.302827] [059/131] (728s left) gem_exec_parallel (contexts)
[292.386077] Starting subtest: contexts
[292.388500] Starting dynamic subtest: rcs0
[295.280423] Dynamic subtest rcs0: SUCCESS (2.896s)
[295.290050] Starting dynamic subtest: bcs0
[298.721473] Dynamic subtest bcs0: SUCCESS (3.438s)
[298.732344] Starting dynamic subtest: vcs0
[302.415244] Dynamic subtest vcs0: SUCCESS (3.692s)
[302.426751] Starting dynamic subtest: vcs1
[306.527375] Dynamic subtest vcs1: SUCCESS (4.109s)
[306.537075] Starting dynamic subtest: vecs0
[312.213581] Dynamic subtest vecs0: SUCCESS (5.683s)
[312.225370] Starting dynamic subtest: ccs0
[316.122662] Dynamic subtest ccs0: SUCCESS (3.907s)
[316.125345] Subtest contexts: SUCCESS (23.739s)
[316.366279] [060/131] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[316.489074] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[323.225463] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.738s)
[323.385011] [061/131] (697s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[323.483986] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[323.488355] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[323.613926] [062/131] (697s left) kms_atomic_interruptible (legacy-pageflip)
[323.712117] Starting subtest: legacy-pageflip
[323.714392] Starting dynamic subtest: pipe-A-eDP-1
[331.103208] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.390s)
[331.105549] Subtest legacy-pageflip: SUCCESS (7.392s)
[331.962317] [063/131] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[332.060757] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[332.065039] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[332.203964] [064/131] (688s left) kms_psr (psr2-sprite-mmap-cpu)
[332.293973] Starting subtest: psr2-sprite-mmap-cpu
[332.296254] Starting dynamic subtest: eDP-1
[334.036113] Dynamic subtest eDP-1: SUCCESS (1.743s)
[334.038449] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.744s)
[334.919170] [065/131] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[335.029362] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[342.205826] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.178s)
[342.364999] [066/131] (678s left) gem_exec_schedule (fairslice-all)
[342.448401] Starting subtest: fairslice-all
[344.499969] Subtest fairslice-all: SUCCESS (2.059s)
[345.957046] [067/131] (675s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[350.975866] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[350.978084] Starting dynamic subtest: pipe-A-eDP-1
[351.770574] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[351.780366] Starting dynamic subtest: pipe-B-eDP-1
[352.900923] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[352.905629] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.925s)
[354.212276] [068/131] (667s left) api_intel_allocator (two-level-inception)
[354.278158] Starting subtest: two-level-inception
[359.675331] Subtest two-level-inception: SUCCESS (5.397s)
[359.833021] [069/131] (661s left) i915_suspend (debugfs-reader)
[359.895057] Starting subtest: debugfs-reader
[378.085637] Subtest debugfs-reader: SUCCESS (8.726s)
[378.183899] [070/131] (643s left) kms_flip (plain-flip-fb-recreate-interruptible)
[378.301582] Starting subtest: plain-flip-fb-recreate-interruptible
[378.306460] Starting dynamic subtest: A-eDP1
[398.954560] Dynamic subtest A-eDP1: SUCCESS (20.494s)
[398.968195] Starting dynamic subtest: B-eDP1
[407.804299] Dynamic subtest B-eDP1: SUCCESS (8.835s)
[407.815313] Starting dynamic subtest: C-eDP1
[416.623352] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[416.633352] Starting dynamic subtest: D-eDP1
[425.455947] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[425.460623] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (46.984s)
[426.660957] [071/131] (594s left) gem_vm_create (invalid-destroy)
[426.727257] Starting subtest: invalid-destroy
[426.729702] Subtest invalid-destroy: SUCCESS (0.002s)
[426.880437] [072/131] (594s left) gem_ccs (ctrl-surf-copy-new-ctx)
[426.934088] Starting subtest: ctrl-surf-copy-new-ctx
[426.938109] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[427.068572] [073/131] (594s left) syncobj_basic (bad-destroy-pad)
[427.126823] Starting subtest: bad-destroy-pad
[427.128842] Subtest bad-destroy-pad: SUCCESS (0.000s)
[427.259368] [074/131] (594s left) kms_plane_multiple (2x-tiling-y)
[427.362342] Starting subtest: 2x-tiling-y
[427.366374] Subtest 2x-tiling-y: SKIP (0.000s)
[427.462003] [075/131] (594s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[427.560807] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[427.563073] Starting dynamic subtest: pipe-A-eDP-1
[427.582033] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.592325] Starting dynamic subtest: pipe-B-eDP-1
[427.609991] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.620685] Starting dynamic subtest: pipe-C-eDP-1
[427.638031] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.647510] Starting dynamic subtest: pipe-D-eDP-1
[427.664506] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.667833] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[429.837735] [076/131] (591s left) kms_pm_rpm (modeset-lpsp)
[431.567542] Starting subtest: modeset-lpsp
[433.028698] Subtest modeset-lpsp: SUCCESS (1.463s)
[433.139410] [077/131] (588s left) kms_setmode (basic)
[433.197720] Starting subtest: basic
[433.521480] Starting dynamic subtest: pipe-A-eDP-1
[435.601415] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.074s)
[435.948671] Starting dynamic subtest: pipe-B-eDP-1
[438.034812] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.092s)
[438.346185] Subtest basic: SUCCESS (5.146s)
[439.205746] [078/131] (582s left) kms_psr (fbc-psr-suspend)
[439.304935] Starting subtest: fbc-psr-suspend
[439.307211] Starting dynamic subtest: eDP-1
[439.311205] Dynamic subtest eDP-1: SKIP (0.000s)
[439.315186] Subtest fbc-psr-suspend: SKIP (0.001s)
[439.402884] [079/131] (582s left) gem_ringfill (engines-basic)
[445.380816] Starting subtest: engines-basic
[445.383372] Starting dynamic subtest: rcs0
[445.447695] Dynamic subtest rcs0: SUCCESS (0.067s)
[445.462260] Starting dynamic subtest: bcs0
[445.495592] Dynamic subtest bcs0: SUCCESS (0.045s)
[445.506813] Starting dynamic subtest: vcs0
[445.537993] Dynamic subtest vcs0: SUCCESS (0.042s)
[445.549128] Starting dynamic subtest: vcs1
[445.579969] Dynamic subtest vcs1: SUCCESS (0.041s)
[445.590640] Starting dynamic subtest: vecs0
[445.621200] Dynamic subtest vecs0: SUCCESS (0.040s)
[445.631990] Starting dynamic subtest: ccs0
[445.673076] Dynamic subtest ccs0: SUCCESS (0.050s)
[445.675858] Subtest engines-basic: SUCCESS (0.294s)
[445.812535] [080/131] (575s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[445.863577] Starting subtest: invalid-bsd2-flag-on-vebox
[445.865915] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[446.003149] [081/131] (575s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[446.106168] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[446.108251] Starting dynamic subtest: pipe-A-eDP-1
[446.128256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[446.139614] Starting dynamic subtest: pipe-B-eDP-1
[446.158448] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[446.168294] Starting dynamic subtest: pipe-C-eDP-1
[446.187422] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[446.197380] Starting dynamic subtest: pipe-D-eDP-1
[446.217208] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[446.219345] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.086s)
[448.456757] [082/131] (573s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[448.552892] Starting subtest: extended-pageflip-modeset-hang-oldfb
[448.555173] Starting dynamic subtest: pipe-A
[456.464007] Dynamic subtest pipe-A: SUCCESS (7.908s)
[456.474877] Starting dynamic subtest: pipe-D
[465.071835] Dynamic subtest pipe-D: SUCCESS (8.600s)
[465.074132] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.513s)
[465.928641] [083/131] (555s left) gem_ppgtt (shrink-vs-evict-any)
[466.000077] Starting subtest: shrink-vs-evict-any
[474.303643] Subtest shrink-vs-evict-any: SUCCESS (8.299s)
[474.417998] [084/131] (547s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[474.478360] Starting subtest: etime-single-wait-for-submit-unsubmitted
[474.582132] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[474.687022] [085/131] (547s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[474.752265] Starting subtest: multi-wait-all-for-submit-signaled
[474.754551] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[474.899499] [086/131] (547s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[474.960063] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[475.062217] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[475.191144] [087/131] (546s left) gem_exec_schedule (implicit-write-read)
[475.270772] Starting subtest: implicit-write-read
[475.272754] Starting dynamic subtest: rcs0
[475.457756] Dynamic subtest rcs0: SUCCESS (0.195s)
[475.473747] Starting dynamic subtest: vcs0
[475.574117] Dynamic subtest vcs0: SUCCESS (0.115s)
[475.587093] Starting dynamic subtest: vcs1
[475.682026] Dynamic subtest vcs1: SUCCESS (0.107s)
[475.696029] Starting dynamic subtest: vecs0
[475.799673] Dynamic subtest vecs0: SUCCESS (0.117s)
[475.814472] Starting dynamic subtest: ccs0
[475.928932] Dynamic subtest ccs0: SUCCESS (0.128s)
[475.931666] Subtest implicit-write-read: SUCCESS (0.668s)
[476.494008] [088/131] (545s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[476.602345] Starting subtest: fbcpsr-rgb565-draw-blt
[483.629912] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.032s)
[483.810997] [089/131] (538s left) gem_ctx_persistence (processes)
[483.873212] Starting subtest: processes
[485.338776] Subtest processes: SUCCESS (1.468s)
[485.444122] [090/131] (536s left) kms_cursor_crc (cursor-sliding-32x10)
[485.607693] Starting subtest: cursor-sliding-32x10
[485.655751] Subtest cursor-sliding-32x10: SKIP (0.043s)
[485.963618] [091/131] (536s left) kms_psr (fbc-pr-primary-render)
[486.070997] Starting subtest: fbc-pr-primary-render
[486.075498] Subtest fbc-pr-primary-render: SKIP (0.000s)
[486.175027] [092/131] (536s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[486.243641] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[486.329946] [093/131] (536s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[486.384639] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[486.386630] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[486.500572] [094/131] (535s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[486.595944] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[486.599316] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[486.747338] [095/131] (535s left) gem_exec_async (concurrent-writes)
[486.807497] Starting subtest: concurrent-writes
[486.809480] Starting dynamic subtest: rcs0
[486.825582] Dynamic subtest rcs0: SUCCESS (0.018s)
[486.838691] Starting dynamic subtest: bcs0
[486.840603] Dynamic subtest bcs0: SUCCESS (0.006s)
[486.850774] Starting dynamic subtest: vcs0
[486.852693] Dynamic subtest vcs0: SUCCESS (0.006s)
[486.862504] Starting dynamic subtest: vcs1
[486.864241] Dynamic subtest vcs1: SUCCESS (0.006s)
[486.873879] Starting dynamic subtest: vecs0
[486.875641] Dynamic subtest vecs0: SUCCESS (0.005s)
[486.885383] Starting dynamic subtest: ccs0
[486.887236] Dynamic subtest ccs0: SUCCESS (0.006s)
[486.888983] Subtest concurrent-writes: SUCCESS (0.050s)
[487.124284] [096/131] (535s left) gem_mmap_gtt (basic-small-bo-tiledx)
[487.181973] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[487.248044] [097/131] (535s left) dmabuf_sync_file (import-basic)
[487.293165] Starting subtest: import-basic
[487.294986] Subtest import-basic: SUCCESS (0.001s)
[487.374563] [098/131] (535s left) kms_feature_discovery (display)
[487.472014] Starting subtest: display
[487.473879] Subtest display: SUCCESS (0.000s)
[487.569160] [099/131] (535s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[487.674879] Starting subtest: x-tiled-64bpp-rotate-90
[487.694529] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[487.856850] [100/131] (534s left) perf_pmu (busy-no-semaphores)
[487.899900] Starting subtest: busy-no-semaphores
[487.901528] Starting dynamic subtest: rcs0
[488.474628] Dynamic subtest rcs0: SUCCESS (0.574s)
[488.488231] Starting dynamic subtest: bcs0
[489.025973] Dynamic subtest bcs0: SUCCESS (0.548s)
[489.039321] Starting dynamic subtest: vcs0
[489.575992] Dynamic subtest vcs0: SUCCESS (0.547s)
[489.589381] Starting dynamic subtest: vcs1
[490.886955] Dynamic subtest vcs1: SUCCESS (1.308s)
[490.900117] Starting dynamic subtest: vecs0
[492.868374] Dynamic subtest vecs0: SUCCESS (1.979s)
[492.882256] Starting dynamic subtest: ccs0
[494.855885] Dynamic subtest ccs0: SUCCESS (1.984s)
[494.859013] Subtest busy-no-semaphores: SUCCESS (6.958s)
[495.013093] [101/131] (527s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[495.129033] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[495.133131] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[495.262969] [102/131] (527s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[495.391388] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[495.395716] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[495.559107] [103/131] (527s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[495.945561] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[496.712062] [104/131] (526s left) kms_getfb (getfb-reject-nv12)
[496.821229] Starting subtest: getfb-reject-nv12
[496.823510] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[496.971675] [105/131] (525s left) i915_drm_fdinfo (context-close-stress)
[497.009895] Starting subtest: context-close-stress
[507.756610] Subtest context-close-stress: SUCCESS (10.745s)
[507.861130] [106/131] (515s left) perf_pmu (module-unload)
[508.100882] Starting subtest: module-unload
[513.400281] Subtest module-unload: FAIL (5.188s)
[513.432769] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[513.433487] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[513.436012] [107/131] (509s left) kms_chamelium_edid (dp-edid-read)
[515.249881] Subtest dp-edid-read: SKIP (0.000s)
[516.054059] [FACT kms_chamelium_edid (dp-edid-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[516.055287] [FACT kms_chamelium_edid (dp-edid-read)] new: kernel.kmod_is_loaded.i915: true
[516.059026] [108/131] (506s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[521.048011] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[521.050462] Starting dynamic subtest: pipe-A-eDP-1
[521.863906] Dynamic subtest pipe-A-eDP-1: SKIP (0.813s)
[521.874128] Starting dynamic subtest: pipe-B-eDP-1
[523.000096] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[523.004561] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.950s)
[524.208232] [109/131] (498s left) kms_vblank (query-busy)
[524.314113] Starting subtest: query-busy
[524.315983] Starting dynamic subtest: pipe-A-eDP-1
[526.201587] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[526.218632] Starting dynamic subtest: pipe-D-eDP-1
[528.758770] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s)
[528.760979] Subtest query-busy: SUCCESS (4.443s)
[529.580118] [110/131] (493s left) syncobj_timeline (wait-for-submit-complex)
[529.645386] Starting subtest: wait-for-submit-complex
[529.704749] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[529.805555] [111/131] (493s left) perf (invalid-create-userspace-config)
[529.948996] Starting subtest: invalid-create-userspace-config
[529.951295] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[529.999281] [112/131] (493s left) gem_exec_basic (basic)
[530.058081] Starting subtest: basic
[530.060495] Starting dynamic subtest: rcs0-smem
[530.062819] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[530.074307] Starting dynamic subtest: bcs0-smem
[530.076478] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[530.085217] Starting dynamic subtest: vcs0-smem
[530.087381] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[530.096192] Starting dynamic subtest: vcs1-smem
[530.098380] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[530.107025] Starting dynamic subtest: vecs0-smem
[530.109271] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[530.118033] Starting dynamic subtest: ccs0-smem
[530.120267] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[530.122454] Subtest basic: SUCCESS (0.015s)
[531.458602] [113/131] (491s left) kms_chamelium_color (ctm-0-25)
[531.559466] Subtest ctm-0-25: SKIP (0.000s)
[531.634107] [114/131] (491s left) gem_userptr_blits (process-exit-busy)
[531.715932] Starting subtest: process-exit-busy
[531.726866] Subtest process-exit-busy: SUCCESS (0.012s)
[531.876440] [115/131] (491s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[531.950197] Starting subtest: y-tiled-ccs-to-y-tiled
[531.954281] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[532.161068] [116/131] (491s left) gen7_exec_parse (bitmasks)
[532.221328] Subtest bitmasks: SKIP (0.000s)
[532.283973] [117/131] (491s left) gem_eio (wait-wedge-10ms)
[532.477473] Starting subtest: wait-wedge-10ms
[534.393996] Subtest wait-wedge-10ms: SUCCESS (1.918s)
[534.561263] [118/131] (488s left) kms_content_protection (atomic)
[534.702033] Starting subtest: atomic
[534.706633] Subtest atomic: SKIP (0.000s)
[534.872800] [119/131] (488s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[534.960884] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[534.963122] Starting dynamic subtest: pipe-A-default-mode
[535.254099] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[535.258614] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.291s)
[536.112603] [120/131] (487s left) gem_exec_params (invalid-flag)
[536.180090] Starting subtest: invalid-flag
[536.182495] Subtest invalid-flag: SUCCESS (0.000s)
[536.300819] [121/131] (487s left) kms_getfb (getfb-addfb-different-handles)
[536.394035] Starting subtest: getfb-addfb-different-handles
[536.396361] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[536.528318] [122/131] (487s left) gem_exec_flush (basic-uc-ro-default)
[536.596644] Starting subtest: basic-uc-ro-default
[542.048359] Subtest basic-uc-ro-default: SUCCESS (5.451s)
[542.257324] [123/131] (481s left) gem_sync (basic-each)
[542.325710] Starting subtest: basic-each
[544.904095] Subtest basic-each: SUCCESS (2.586s)
[545.119127] [124/131] (478s left) gem_exec_balancer (full)
[545.185093] Starting subtest: full
[550.259091] Subtest full: SUCCESS (5.072s)
[550.608877] [125/131] (473s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[550.706107] Starting subtest: y-tiled-8bpp-rotate-180
[550.710638] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[550.839626] [126/131] (472s left) sw_sync (sync_merge_invalid)
[550.878240] Starting subtest: sync_merge_invalid
[550.888834] Subtest sync_merge_invalid: SUCCESS (0.013s)
[550.973479] [127/131] (472s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[551.069194] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[555.631982] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.565s)
[556.832345] [128/131] (467s left) gem_lmem_swapping (parallel-random-verify-ccs)
[556.874214] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[556.916318] [129/131] (466s left) kms_lease (lease-unleased-connector)
[557.016137] Starting subtest: lease-unleased-connector
[557.018435] Starting dynamic subtest: pipe-A-eDP-1
[557.024664] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[557.035340] Starting dynamic subtest: pipe-B-eDP-1
[557.037657] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[557.048799] Starting dynamic subtest: pipe-C-eDP-1
[557.050657] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[557.059896] Starting dynamic subtest: pipe-D-eDP-1
[557.061912] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[557.063800] Subtest lease-unleased-connector: SUCCESS (0.032s)
[557.186513] [130/131] (466s left) perf (enable-disable)
[557.299773] Starting subtest: enable-disable
[557.302254] Starting dynamic subtest: 0-rcs0
[559.564677] Dynamic subtest 0-rcs0: SUCCESS (2.262s)
[559.575761] Starting dynamic subtest: 1-vecs0
[564.050846] Dynamic subtest 1-vecs0: SUCCESS (4.484s)
[564.053579] Subtest enable-disable: SUCCESS (6.748s)
[564.100758] [131/131] (459s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[564.250732] Starting subtest: cursor-rapid-movement-32x32
[564.294865] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[564.648932] 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.