[58.692268] Initializing watchdogs
[58.692311]   /dev/watchdog0
[58.707157] [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]
[58.711445] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.713596] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.717101] [001/155] (960s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[58.846295] Starting subtest: psrhdr-slowdraw
[58.850801] Subtest psrhdr-slowdraw: SKIP (0.000s)
[58.940410] [002/155] (960s left) kms_pm_rpm (modeset-non-lpsp)
[60.501946] Starting subtest: modeset-non-lpsp
[61.658534] Subtest modeset-non-lpsp: SKIP (1.166s)
[62.042608] [003/155] (957s left) kms_setmode (basic)
[62.101646] Starting subtest: basic
[62.424546] Starting dynamic subtest: pipe-A-eDP-1
[66.007611] Dynamic subtest pipe-A-eDP-1: FAIL (3.480s)
[66.227327] Starting dynamic subtest: pipe-B-eDP-1
[69.825289] Dynamic subtest pipe-B-eDP-1: FAIL (3.479s)
[69.992795] Subtest basic: FAIL (7.923s)
[70.794365] [004/155] (948s left) gem_mmap_gtt (big-bo-tiledy)
[70.854570] Subtest big-bo-tiledY: SKIP (0.000s)
[70.909167] [005/155] (948s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[71.012720] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[71.017329] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[71.121616] [006/155] (948s left) kms_psr (pr-primary-mmap-cpu)
[71.210961] Starting subtest: pr-primary-mmap-cpu
[71.215477] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[71.293567] [007/155] (948s left) gem_exec_suspend (basic)
[71.352555] Starting subtest: basic
[71.354874] Starting dynamic subtest: smem
[73.274767] Dynamic subtest smem: SUCCESS (1.923s)
[73.277341] Subtest basic: SUCCESS (1.924s)
[73.453754] [008/155] (946s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[73.552699] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[73.556904] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[73.643654] [009/155] (945s left) gem_render_copy (y-tiled)
[73.702847] Starting subtest: y-tiled
[73.707456] Subtest y-tiled: SKIP (0.000s)
[73.891715] [010/155] (945s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[73.986427] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[75.006370] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.022s)
[75.169807] [011/155] (944s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[75.276916] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[75.280429] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[75.362833] [012/155] (944s left) prime_vgem (busy)
[75.500487] Starting subtest: busy
[75.502597] Starting dynamic subtest: rcs0
[75.552054] Dynamic subtest rcs0: SUCCESS (0.052s)
[75.559188] Starting dynamic subtest: bcs0
[75.610075] Dynamic subtest bcs0: SUCCESS (0.058s)
[75.617089] Starting dynamic subtest: vcs0
[75.660362] Dynamic subtest vcs0: SUCCESS (0.049s)
[75.667949] Starting dynamic subtest: vcs1
[75.703902] Dynamic subtest vcs1: SUCCESS (0.044s)
[75.711310] Starting dynamic subtest: vecs0
[75.749474] Dynamic subtest vecs0: SUCCESS (0.045s)
[75.756705] Starting dynamic subtest: ccs0
[75.798861] Dynamic subtest ccs0: SUCCESS (0.049s)
[75.800882] Subtest busy: SUCCESS (0.299s)
[75.909343] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true
[75.912450] [013/155] (943s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-plflip-blt)
[76.011600] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-plflip-blt
[76.014927] Subtest fbcpsrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[76.113164] [014/155] (943s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[76.218095] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[76.221871] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[76.304904] [015/155] (943s left) perf (create-destroy-userspace-config)
[76.426350] Starting subtest: create-destroy-userspace-config
[76.445943] Subtest create-destroy-userspace-config: SUCCESS (0.020s)
[76.489171] [016/155] (943s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[76.584270] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[76.586101] Starting dynamic subtest: pipe-A-eDP-1
[76.686999] Dynamic subtest pipe-A-eDP-1: SKIP (0.102s)
[76.695560] Starting dynamic subtest: pipe-B-eDP-1
[77.873396] Dynamic subtest pipe-B-eDP-1: SKIP (1.186s)
[77.878051] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.290s)
[79.083900] [017/155] (940s left) i915_pm_rps (waitboost)
[79.145303] Starting subtest: waitboost
[85.226367] Subtest waitboost: SUCCESS (6.085s)
[85.369200] [018/155] (934s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[85.480819] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[94.899365] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.422s)
[95.037252] [019/155] (924s left) kms_flip (flip-vs-suspend)
[95.143546] Starting subtest: flip-vs-suspend
[95.145655] Starting dynamic subtest: A-eDP1
[241.124053] Dynamic subtest A-eDP1: SUCCESS (12.071s)
[241.125982] Subtest flip-vs-suspend: SUCCESS (12.073s)
[241.259975] [020/155] (778s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[241.389101] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[241.398052] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[241.496456] [021/155] (778s left) kms_display_modes (extended-mode-basic)
[241.596566] Starting subtest: extended-mode-basic
[241.600704] Subtest extended-mode-basic: SKIP (0.000s)
[241.642926] [022/155] (778s left) kms_big_fb (linear-32bpp-rotate-180)
[241.758738] Starting subtest: linear-32bpp-rotate-180
[243.240593] Subtest linear-32bpp-rotate-180: SUCCESS (1.515s)
[243.370220] [023/155] (776s left) gem_workarounds (basic-read-fd)
[243.443401] Starting subtest: basic-read-fd
[243.455606] Subtest basic-read-fd: SUCCESS (0.012s)
[243.578254] [024/155] (776s left) core_getversion (basic)
[243.611347] Starting subtest: basic
[243.614971] Subtest basic: SUCCESS (0.000s)
[243.675047] [025/155] (776s left) perf_pmu (busy-hang)
[243.712893] Starting subtest: busy-hang
[243.714850] Starting dynamic subtest: rcs0
[244.991379] Dynamic subtest rcs0: SUCCESS (1.296s)
[245.002318] Starting dynamic subtest: bcs0
[246.230679] Dynamic subtest bcs0: SUCCESS (1.258s)
[246.243867] Starting dynamic subtest: vcs0
[248.724900] Dynamic subtest vcs0: SUCCESS (2.518s)
[248.736211] Starting dynamic subtest: vcs1
[250.705390] Dynamic subtest vcs1: SUCCESS (1.995s)
[250.716924] Starting dynamic subtest: vecs0
[252.687117] Dynamic subtest vecs0: SUCCESS (1.996s)
[252.697816] Starting dynamic subtest: ccs0
[253.926863] Dynamic subtest ccs0: SUCCESS (1.242s)
[253.929812] Subtest busy-hang: SUCCESS (10.312s)
[254.022792] [026/155] (766s left) kms_plane_alpha_blend (coverage-7efc)
[254.114643] Starting subtest: coverage-7efc
[254.400683] Starting dynamic subtest: pipe-A-eDP-1
[254.984062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[255.015821] Starting dynamic subtest: pipe-D-eDP-1
[256.350430] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[256.352775] Subtest coverage-7efc: SUCCESS (2.245s)
[257.185848] [027/155] (763s left) gem_tiled_fence_blits (basic)
[257.248075] Subtest basic: SKIP (0.000s)
[257.324703] [028/155] (762s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[257.423267] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[257.427385] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[257.517799] [029/155] (762s left) i915_hangman (gt-error-state-capture)
[257.584523] Starting subtest: gt-error-state-capture
[257.586945] Starting dynamic subtest: rcs0
[269.164431] Dynamic subtest rcs0: SUCCESS (11.600s)
[269.179403] Starting dynamic subtest: bcs0
[280.174045] Dynamic subtest bcs0: SUCCESS (11.007s)
[280.185580] Starting dynamic subtest: vcs0
[291.180727] Dynamic subtest vcs0: SUCCESS (11.003s)
[291.193315] Starting dynamic subtest: vcs1
[303.085353] Dynamic subtest vcs1: SUCCESS (11.904s)
[303.097048] Starting dynamic subtest: vecs0
[313.197108] Dynamic subtest vecs0: SUCCESS (10.113s)
[313.211142] Starting dynamic subtest: ccs0
[325.165216] Dynamic subtest ccs0: SUCCESS (11.969s)
[325.168166] Subtest gt-error-state-capture: SUCCESS (67.607s)
[325.250359] [030/155] (695s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[325.369278] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[325.373351] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[325.473579] [031/155] (694s left) syncobj_timeline (multi-wait-all-signaled)
[325.524235] Starting subtest: multi-wait-all-signaled
[325.526448] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[325.615419] [032/155] (694s left) kms_vrr (flip-basic)
[325.701028] Starting subtest: flip-basic
[325.707347] Subtest flip-basic: SKIP (0.000s)
[325.771855] [033/155] (694s left) kms_pm_dc (dc3co-vpb-simulation)
[326.867329] Starting subtest: dc3co-vpb-simulation
[335.823442] Subtest dc3co-vpb-simulation: SKIP (8.954s)
[335.967661] [034/155] (684s left) kms_psr (fbc-psr2-suspend)
[336.072213] Starting subtest: fbc-psr2-suspend
[336.074418] Starting dynamic subtest: eDP-1
[336.078352] Dynamic subtest eDP-1: SKIP (0.000s)
[336.082502] Subtest fbc-psr2-suspend: SKIP (0.001s)
[336.145925] [035/155] (684s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[336.247816] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[336.252421] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[336.336316] [036/155] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[336.439555] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[336.443584] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[336.552909] [037/155] (684s left) syncobj_wait (wait-for-submit-complex)
[336.606601] Starting subtest: wait-for-submit-complex
[336.667525] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[336.757837] [038/155] (683s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[336.920984] Starting subtest: cursor-rapid-movement-32x10
[336.967631] Subtest cursor-rapid-movement-32x10: SKIP (0.043s)
[337.257666] [039/155] (683s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[337.356242] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[337.359696] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[337.424480] [040/155] (683s left) prime_vgem (fence-write-hang)
[337.506470] Subtest fence-write-hang: SKIP (0.000s)
[337.606562] [041/155] (683s left) gem_exec_balancer (persistence)
[337.863315] Starting subtest: persistence
[338.759229] Subtest persistence: SUCCESS (0.895s)
[338.887150] [042/155] (681s left) kms_addfb_basic (bad-pitch-0)
[338.948177] Starting subtest: bad-pitch-0
[338.950224] Subtest bad-pitch-0: SUCCESS (0.000s)
[339.100775] [043/155] (681s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[339.173251] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[339.177933] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[339.356316] [044/155] (681s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[339.470769] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc
[339.475277] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[339.591774] [045/155] (681s left) gem_mmap_wc (coherency)
[339.648108] Subtest coherency: SKIP (0.000s)
[339.710887] [046/155] (681s left) i915_drm_fdinfo (memory-info-idle)
[339.748597] Starting subtest: memory-info-idle
[339.750758] Starting dynamic subtest: smem0
[339.788050] Dynamic subtest smem0: SUCCESS (0.042s)
[339.790624] Subtest memory-info-idle: SUCCESS (0.042s)
[339.860366] [047/155] (681s left) kms_properties (get_properties-sanity-atomic)
[339.952734] Starting subtest: get_properties-sanity-atomic
[339.957589] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[340.027447] [048/155] (681s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[340.069323] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[340.179477] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.109s)
[340.268476] [049/155] (680s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[340.359610] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[347.312816] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.956s)
[347.442192] [050/155] (673s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[347.552118] Starting subtest: yf-tiled-64bpp-rotate-270
[347.556775] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[347.646632] [051/155] (673s left) kms_cursor_crc (cursor-sliding-max-size)
[347.975772] Starting subtest: cursor-sliding-max-size
[347.982662] Subtest cursor-sliding-max-size: SKIP (0.000s)
[348.106431] [052/155] (673s left) syncobj_timeline (etime-multi-wait-submitted)
[348.157139] Starting subtest: etime-multi-wait-submitted
[348.267417] Subtest etime-multi-wait-submitted: SUCCESS (0.108s)
[348.356286] [053/155] (672s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[348.458549] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[348.463189] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[348.560606] [054/155] (672s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[348.665945] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[348.670217] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[348.766076] [055/155] (672s left) gem_exec_parallel (engines)
[348.818098] Starting subtest: engines
[348.820311] Starting dynamic subtest: basic
[352.144175] Dynamic subtest basic: SUCCESS (3.323s)
[352.155549] Starting dynamic subtest: contexts
[356.671098] Dynamic subtest contexts: SUCCESS (4.522s)
[356.684079] Starting dynamic subtest: fds
[360.442095] Dynamic subtest fds: SUCCESS (3.771s)
[360.452668] Starting dynamic subtest: userptr
[362.223021] Dynamic subtest userptr: SUCCESS (1.780s)
[362.225604] Subtest engines: SUCCESS (13.400s)
[362.414674] [056/155] (659s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[362.502833] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[362.507157] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[362.573846] [057/155] (658s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[362.957822] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[363.785836] [058/155] (657s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt)
[363.896827] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt
[363.901057] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[364.000963] [059/155] (657s left) kms_psr (fbc-pr-dpms)
[364.094268] Starting subtest: fbc-pr-dpms
[364.098708] Subtest fbc-pr-dpms: SKIP (0.000s)
[364.169627] [060/155] (657s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[364.228954] Starting subtest: yf-tiled-ccs-to-y-tiled
[364.233836] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[364.428814] [061/155] (657s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[364.525387] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[364.529796] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[364.626112] [062/155] (657s left) gem_softpin (allocator-nopin-reserve)
[364.680830] Starting subtest: allocator-nopin-reserve
[364.775508] Subtest allocator-nopin-reserve: SUCCESS (0.095s)
[364.900630] [063/155] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[364.999060] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[365.003337] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[365.096778] [064/155] (656s left) gem_exec_reloc (basic-cpu-active)
[365.153383] Subtest basic-cpu-active: SKIP (0.000s)
[365.230382] [065/155] (656s left) core_setmaster_vs_auth
[365.417588] [066/155] (656s left) kms_cdclk (plane-scaling)
[365.512888] Starting subtest: plane-scaling
[365.514902] Starting dynamic subtest: pipe-A-eDP-1
[365.811890] Dynamic subtest pipe-A-eDP-1: SKIP (0.295s)
[365.825086] Starting dynamic subtest: pipe-B-eDP-1
[365.829820] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[365.840856] Starting dynamic subtest: pipe-C-eDP-1
[365.845606] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[365.855189] Starting dynamic subtest: pipe-D-eDP-1
[365.859435] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[365.863700] Subtest plane-scaling: SKIP (0.302s)
[366.640946] [067/155] (655s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[366.730925] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[366.733278] Starting dynamic subtest: pipe-A-eDP-1
[366.757954] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[366.769807] Starting dynamic subtest: pipe-B-eDP-1
[366.790759] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[366.800170] Starting dynamic subtest: pipe-C-eDP-1
[366.821457] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[366.831705] Starting dynamic subtest: pipe-D-eDP-1
[366.855338] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[366.859047] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[368.973928] [068/155] (652s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[369.072610] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[376.151027] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.084s)
[376.293391] [069/155] (645s left) gem_exec_schedule (u-semaphore-user)
[376.367342] Starting subtest: u-semaphore-user
[376.422126] Subtest u-semaphore-user: SUCCESS (0.060s)
[378.229217] [070/155] (643s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[378.335410] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[382.454593] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.124s)
[383.684891] [071/155] (638s left) gem_wait (write-busy)
[383.745082] Starting subtest: write-busy
[383.747473] Starting dynamic subtest: all-engines
[384.382948] Dynamic subtest all-engines: SUCCESS (0.641s)
[384.394749] Starting dynamic subtest: rcs0
[384.944187] Dynamic subtest rcs0: SUCCESS (0.558s)
[384.960995] Starting dynamic subtest: bcs0
[385.496063] Dynamic subtest bcs0: SUCCESS (0.552s)
[385.513397] Starting dynamic subtest: vcs0
[387.214031] Dynamic subtest vcs0: SUCCESS (1.715s)
[387.232719] Starting dynamic subtest: vcs1
[389.197923] Dynamic subtest vcs1: SUCCESS (1.982s)
[389.215305] Starting dynamic subtest: vecs0
[391.181602] Dynamic subtest vecs0: SUCCESS (1.981s)
[391.199154] Starting dynamic subtest: ccs0
[391.731929] Dynamic subtest ccs0: SUCCESS (0.550s)
[391.734535] Subtest write-busy: SUCCESS (7.991s)
[391.930792] [072/155] (630s left) kms_plane_scaling (2x-scaler-multi-pipe)
[392.034281] Starting subtest: 2x-scaler-multi-pipe
[392.038944] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[392.131094] [073/155] (630s left) gem_exec_flush (basic-batch-kernel-default-wb)
[392.191044] Starting subtest: basic-batch-kernel-default-wb
[399.345264] Subtest basic-batch-kernel-default-wb: SUCCESS (7.155s)
[399.539946] [074/155] (622s left) kms_addfb_basic (master-rmfb)
[399.601249] Starting subtest: master-rmfb
[399.603170] Subtest master-rmfb: SUCCESS (0.001s)
[399.750655] [075/155] (622s left) drm_read (invalid-buffer)
[399.894080] Starting subtest: invalid-buffer
[399.896070] Subtest invalid-buffer: SUCCESS (0.000s)
[400.029716] [076/155] (622s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[400.127763] Starting subtest: 4-tiled-16bpp-rotate-0
[401.509112] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.381s)
[401.629702] [077/155] (620s left) kms_color (ctm-0-50)
[401.727868] Starting subtest: ctm-0-50
[401.729636] Starting dynamic subtest: pipe-A-eDP-1
[405.268994] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.540s)
[405.278985] Starting dynamic subtest: pipe-B-eDP-1
[409.553586] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.283s)
[409.563873] Starting dynamic subtest: pipe-C-eDP-1
[413.711637] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.159s)
[413.724576] Starting dynamic subtest: pipe-D-eDP-1
[417.705259] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.992s)
[417.707609] Subtest ctm-0-50: SUCCESS (15.979s)
[418.536939] [078/155] (603s left) syncobj_timeline (wait-delayed-signal)
[418.596413] Starting subtest: wait-delayed-signal
[418.699866] Subtest wait-delayed-signal: SUCCESS (0.103s)
[418.793960] [079/155] (603s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[418.895378] Starting subtest: psr-2p-primscrn-cur-indfb-move
[418.899561] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[418.996291] [080/155] (603s left) gem_caching (read-writes)
[419.051178] Subtest read-writes: SKIP (0.000s)
[419.131083] [081/155] (603s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[419.237646] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[425.809867] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.582s)
[425.935785] [082/155] (596s left) kms_cursor_crc (cursor-onscreen-128x128)
[426.153350] Starting subtest: cursor-onscreen-128x128
[426.158360] Starting dynamic subtest: pipe-A-eDP-1
[428.271788] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.114s)
[428.307403] Starting dynamic subtest: pipe-D-eDP-1
[431.041233] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.744s)
[431.043666] Subtest cursor-onscreen-128x128: SUCCESS (4.884s)
[431.854894] [083/155] (590s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[431.952509] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[431.956816] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[432.033256] [084/155] (590s left) kms_panel_fitting (legacy)
[432.120655] Starting subtest: legacy
[432.122889] Starting dynamic subtest: pipe-A-eDP-1
[432.650676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.532s)
[432.679623] Starting dynamic subtest: pipe-B-eDP-1
[434.196040] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.526s)
[434.225955] Starting dynamic subtest: pipe-C-eDP-1
[435.707843] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.492s)
[435.736096] Starting dynamic subtest: pipe-D-eDP-1
[437.228719] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.502s)
[437.230938] Subtest legacy: SUCCESS (5.112s)
[438.490928] [085/155] (584s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[438.610980] Starting subtest: cursorA-vs-flipB-atomic-transitions
[438.615493] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[438.759705] [086/155] (583s left) gem_userptr_blits (map-fixed-invalidate)
[438.836463] Starting subtest: map-fixed-invalidate
[438.840960] Subtest map-fixed-invalidate: SKIP (0.000s)
[438.980392] [087/155] (583s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[439.069403] Starting subtest: fbc-psr-cursor-mmap-gtt
[439.071717] Starting dynamic subtest: eDP-1
[439.075767] Dynamic subtest eDP-1: SKIP (0.000s)
[439.079837] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[439.142856] [088/155] (583s left) gem_lmem_swapping (verify-random)
[439.184162] Subtest verify-random: SKIP (0.000s)
[439.226741] [089/155] (583s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[439.322650] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[443.760415] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.444s)
[444.912276] [090/155] (577s left) kms_content_protection (atomic-dpms-hdcp14)
[445.052622] Starting subtest: atomic-dpms-hdcp14
[445.057226] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[445.168036] [091/155] (577s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[445.269421] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[445.273707] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[445.367826] [092/155] (577s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[445.457246] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[445.459524] Starting dynamic subtest: pipe-A-eDP-1
[445.479241] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[445.492584] Starting dynamic subtest: pipe-B-eDP-1
[445.511227] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[445.521128] Starting dynamic subtest: pipe-C-eDP-1
[445.540684] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[445.550525] Starting dynamic subtest: pipe-D-eDP-1
[445.570149] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[445.572379] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[447.733982] [093/155] (575s left) kms_flip (flip-vs-fences-interruptible)
[447.837745] Starting subtest: flip-vs-fences-interruptible
[447.842258] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[447.959442] [094/155] (575s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[448.056591] Starting subtest: fbcpsr-tiling-y
[448.060642] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[448.169151] [095/155] (574s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[448.256885] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[448.259138] Starting dynamic subtest: pipe-A-eDP-1
[448.282146] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[448.294928] Starting dynamic subtest: pipe-B-eDP-1
[448.316080] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[448.325836] Starting dynamic subtest: pipe-C-eDP-1
[448.347760] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[448.359180] Starting dynamic subtest: pipe-D-eDP-1
[448.381051] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[448.385118] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[450.523307] [096/155] (572s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[450.616437] Starting subtest: multiplane-rotation-cropping-top
[468.082750] Subtest multiplane-rotation-cropping-top: SUCCESS (17.471s)
[468.215663] [097/155] (554s left) gem_ccs (ctrl-surf-copy-new-ctx)
[468.279472] Starting subtest: ctrl-surf-copy-new-ctx
[468.283490] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[468.378504] [098/155] (554s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[468.475804] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[468.479364] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[468.598692] [099/155] (554s left) kms_draw_crc (draw-method-blt)
[468.697657] Starting subtest: draw-method-blt
[468.699605] Starting dynamic subtest: xrgb8888-untiled
[468.961200] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[468.971524] Starting dynamic subtest: rgb565-untiled
[469.194853] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[469.205126] Starting dynamic subtest: xrgb2101010-untiled
[469.417204] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[469.427138] Starting dynamic subtest: xbgr16161616f-untiled
[469.639326] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[469.649784] Starting dynamic subtest: xrgb8888-xtiled
[469.761389] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[469.771047] Starting dynamic subtest: rgb565-xtiled
[469.861597] Dynamic subtest rgb565-xtiled: SUCCESS (0.099s)
[469.871477] Starting dynamic subtest: xrgb2101010-xtiled
[469.973027] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[469.983686] Starting dynamic subtest: xbgr16161616f-xtiled
[470.083945] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[470.094401] Starting dynamic subtest: xrgb8888-4tiled
[470.206060] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[470.216615] Starting dynamic subtest: rgb565-4tiled
[470.306126] Dynamic subtest rgb565-4tiled: SUCCESS (0.099s)
[470.316879] Starting dynamic subtest: xrgb2101010-4tiled
[470.417723] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[470.429400] Starting dynamic subtest: xbgr16161616f-4tiled
[470.528417] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[470.530282] Subtest draw-method-blt: SUCCESS (1.834s)
[470.634979] [100/155] (552s left) gem_flink_basic (basic)
[470.690887] Starting subtest: basic
[470.692619] Subtest basic: SUCCESS (0.000s)
[470.805561] [101/155] (552s left) gen9_exec_parse (bb-large)
[470.855235] Subtest bb-large: SKIP (0.000s)
[470.932305] [102/155] (552s left) perf (buffer-fill)
[471.017060] Starting subtest: buffer-fill
[471.019123] Starting dynamic subtest: 0-rcs0
[473.268618] Dynamic subtest 0-rcs0: SUCCESS (2.248s)
[473.280759] Starting dynamic subtest: 1-vcs0
[477.665235] Dynamic subtest 1-vcs0: SUCCESS (4.395s)
[477.667577] Subtest buffer-fill: SUCCESS (6.646s)
[477.710853] [103/155] (545s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[477.819834] Starting subtest: bad-aux-stride-yf-tiled-ccs
[477.822173] Starting dynamic subtest: pipe-A-eDP-1
[477.845598] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[477.858284] Starting dynamic subtest: pipe-B-eDP-1
[477.879581] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[477.889360] Starting dynamic subtest: pipe-C-eDP-1
[477.911220] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[477.920932] Starting dynamic subtest: pipe-D-eDP-1
[477.943822] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[477.948593] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[480.110344] [104/155] (543s left) vgem_basic (dmabuf-mmap)
[480.159329] Starting subtest: dmabuf-mmap
[480.191860] Subtest dmabuf-mmap: SUCCESS (0.035s)
[480.263690] [105/155] (543s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[480.369741] Starting subtest: 4-tiled-32bpp-rotate-0
[481.794955] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.424s)
[481.927229] [106/155] (541s left) gem_exec_fence (syncobj-timeline-signal)
[482.462761] Starting subtest: syncobj-timeline-signal
[482.469387] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[484.270967] [107/155] (539s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[484.322871] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[484.325091] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[484.419720] [108/155] (539s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-fullscreen)
[484.538289] Starting subtest: hdr-1p-primscrn-spr-indfb-fullscreen
[484.542741] Subtest hdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[484.636967] [109/155] (539s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[484.752930] Starting subtest: 2x-flip-vs-cursor-legacy
[484.757230] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[484.895043] [110/155] (538s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[484.986608] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[484.990952] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[485.063143] [111/155] (538s left) gem_userptr_blits (sync-overlap)
[485.121324] Starting subtest: sync-overlap
[485.123599] Subtest sync-overlap: SUCCESS (0.000s)
[485.245128] [112/155] (538s left) perf_pmu (pmu-read)
[485.280041] Starting subtest: pmu-read
[485.284126] Subtest pmu-read: SUCCESS (0.003s)
[485.383356] [113/155] (538s left) gem_exec_schedule (pi-common)
[485.572798] Starting subtest: pi-common
[485.579986] Starting dynamic subtest: rcs0
[485.594920] Dynamic subtest rcs0: SUCCESS (0.026s)
[485.611745] Starting dynamic subtest: bcs0
[485.621559] Dynamic subtest bcs0: SUCCESS (0.026s)
[485.636995] Starting dynamic subtest: vcs0
[485.648438] Dynamic subtest vcs0: SUCCESS (0.026s)
[485.663501] Starting dynamic subtest: vcs1
[485.675243] Dynamic subtest vcs1: SUCCESS (0.026s)
[485.689389] Starting dynamic subtest: vecs0
[485.703400] Dynamic subtest vecs0: SUCCESS (0.027s)
[485.719268] Starting dynamic subtest: ccs0
[485.729902] Dynamic subtest ccs0: SUCCESS (0.026s)
[485.732088] Subtest pi-common: SUCCESS (0.162s)
[485.958879] [114/155] (537s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[486.049853] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[486.051826] Starting dynamic subtest: pipe-A-eDP-1
[486.977448] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.920s)
[486.988388] Starting dynamic subtest: pipe-B-eDP-1
[488.600849] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.619s)
[488.612720] Starting dynamic subtest: pipe-C-eDP-1
[490.131284] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.530s)
[490.142370] Starting dynamic subtest: pipe-D-eDP-1
[491.701463] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.570s)
[491.704423] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.643s)
[492.918332] [115/155] (531s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[493.033793] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[493.037974] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[493.120168] [116/155] (530s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[493.214581] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[493.218765] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[493.332386] [117/155] (530s left) gem_exec_schedule (u-submit-late-slice)
[493.414389] Starting subtest: u-submit-late-slice
[493.416718] Starting dynamic subtest: rcs0
[493.443321] Dynamic subtest rcs0: SUCCESS (0.036s)
[493.456938] Starting dynamic subtest: bcs0
[493.481887] Dynamic subtest bcs0: SUCCESS (0.037s)
[493.491994] Starting dynamic subtest: vcs0
[493.511631] Dynamic subtest vcs0: SUCCESS (0.030s)
[493.523403] Starting dynamic subtest: vcs1
[493.542552] Dynamic subtest vcs1: SUCCESS (0.030s)
[493.556158] Starting dynamic subtest: vecs0
[493.576644] Dynamic subtest vecs0: SUCCESS (0.033s)
[493.589243] Starting dynamic subtest: ccs0
[493.617298] Dynamic subtest ccs0: SUCCESS (0.040s)
[493.619643] Subtest u-submit-late-slice: SUCCESS (0.211s)
[495.263943] [118/155] (528s left) kms_pm_rpm (basic-rte)
[495.299393] Starting subtest: basic-rte
[498.775118] Subtest basic-rte: SUCCESS (3.477s)
[500.287603] [119/155] (523s left) gem_tiled_partial_pwrite_pread (writes)
[500.342950] Subtest writes: SKIP (0.000s)
[500.428525] [120/155] (523s left) gem_ctx_isolation (clean)
[500.497393] Starting subtest: clean
[500.499872] Starting dynamic subtest: rcs0
[500.540600] Dynamic subtest rcs0: SUCCESS (0.043s)
[500.553128] Starting dynamic subtest: bcs0
[500.624267] Dynamic subtest bcs0: SUCCESS (0.083s)
[500.634710] Starting dynamic subtest: vcs0
[500.686192] Dynamic subtest vcs0: SUCCESS (0.061s)
[500.696617] Starting dynamic subtest: vcs1
[502.234316] Dynamic subtest vcs1: SUCCESS (1.546s)
[502.244734] Starting dynamic subtest: vecs0
[504.239230] Dynamic subtest vecs0: SUCCESS (2.001s)
[504.250293] Starting dynamic subtest: ccs0
[506.214131] Dynamic subtest ccs0: SUCCESS (1.973s)
[506.216163] Subtest clean: SUCCESS (5.715s)
[506.403393] [121/155] (517s left) kms_chamelium_color (gamma)
[506.498188] Subtest gamma: SKIP (0.000s)
[506.543944] [122/155] (517s left) gem_ctx_sseu (mmap-args)
[506.610382] Subtest mmap-args: SKIP (0.000s)
[506.689328] [123/155] (517s left) gem_exec_balancer (bonded-false-hang)
[506.944259] Starting subtest: bonded-false-hang
[506.949660] Subtest bonded-false-hang: SKIP (0.000s)
[507.060535] [124/155] (517s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[507.164820] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[507.168983] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[507.278982] [125/155] (517s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[507.374776] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[507.378678] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[507.474260] [126/155] (516s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[507.512070] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[507.560193] [127/155] (516s left) gem_pxp (create-regular-buffer)
[507.684309] Starting subtest: create-regular-buffer
[507.686793] Subtest create-regular-buffer: SUCCESS (0.000s)
[507.815297] [128/155] (516s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[507.918565] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[507.923457] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[508.023663] [129/155] (516s left) syncobj_wait (wait-zero-handles)
[508.079192] Starting subtest: wait-zero-handles
[508.081074] Subtest wait-zero-handles: SUCCESS (0.000s)
[508.188682] [130/155] (516s left) kms_invalid_mode (zero-hdisplay)
[508.278696] Starting subtest: zero-hdisplay
[508.280650] Starting dynamic subtest: pipe-A-eDP-1
[508.565469] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[508.578355] Starting dynamic subtest: pipe-B-eDP-1
[508.580385] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[508.591390] Starting dynamic subtest: pipe-C-eDP-1
[508.593670] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[508.604093] Starting dynamic subtest: pipe-D-eDP-1
[508.606524] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[508.609012] Subtest zero-hdisplay: SUCCESS (0.290s)
[509.416292] [131/155] (515s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[509.517482] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[509.521670] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[509.617592] [132/155] (515s left) core_auth (getclient-master-drop)
[509.653942] Starting subtest: getclient-master-drop
[509.681506] Subtest getclient-master-drop: SUCCESS (0.033s)
[509.804181] [133/155] (514s left) gem_ctx_engines (invalid-engines)
[509.860653] Starting subtest: invalid-engines
[509.873305] Subtest invalid-engines: SUCCESS (0.013s)
[510.104644] [134/155] (514s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-render)
[510.200862] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-render
[510.205381] Subtest psrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[510.296393] [135/155] (514s left) kms_psr (psr2-sprite-plane-onoff)
[510.389622] Starting subtest: psr2-sprite-plane-onoff
[510.391904] Starting dynamic subtest: eDP-1
[512.141954] Dynamic subtest eDP-1: SUCCESS (1.752s)
[512.144365] Subtest psr2-sprite-plane-onoff: SUCCESS (1.753s)
[512.979737] [136/155] (511s left) i915_pm_rpm (gem-execbuf-stress)
[514.502944] Starting subtest: gem-execbuf-stress
[514.505883] Starting dynamic subtest: smem0
[527.351144] Dynamic subtest smem0: SUCCESS (12.846s)
[527.364469] Starting dynamic subtest: extra-wait-smem0
[590.177576] Dynamic subtest extra-wait-smem0: SUCCESS (62.825s)
[590.180414] Subtest gem-execbuf-stress: SUCCESS (75.678s)
[590.582408] [137/155] (434s left) gem_basic (create-fd-close)
[590.633752] Starting subtest: create-fd-close
[590.638142] Subtest create-fd-close: SUCCESS (0.000s)
[590.746566] [138/155] (434s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-rte)
[590.838159] Starting subtest: fbcpsrhdr-1p-rte
[590.842387] Subtest fbcpsrhdr-1p-rte: SKIP (0.000s)
[590.934208] [139/155] (434s left) kms_lease (setcrtc-implicit-plane)
[591.024100] Starting subtest: setcrtc-implicit-plane
[591.026427] Starting dynamic subtest: pipe-A-eDP-1
[591.499343] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.473s)
[591.510716] Starting dynamic subtest: pipe-B-eDP-1
[592.702477] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.201s)
[592.714586] Starting dynamic subtest: pipe-C-eDP-1
[593.808756] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[593.819870] Starting dynamic subtest: pipe-D-eDP-1
[594.961889] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.150s)
[594.964192] Subtest setcrtc-implicit-plane: SUCCESS (3.939s)
[595.805889] [140/155] (429s left) gem_exec_params (batch-first)
[595.853800] Starting subtest: batch-first
[595.855806] Subtest batch-first: SUCCESS (0.005s)
[596.001814] [141/155] (429s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[596.103279] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[596.107324] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[596.212323] [142/155] (428s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[596.308622] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[596.334727] Starting dynamic subtest: pipe-A-plane-0
[596.623185] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[596.635674] Starting dynamic subtest: pipe-A-plane-3
[596.856068] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[597.980838] Starting dynamic subtest: pipe-B-plane-0
[598.273895] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[598.284752] Starting dynamic subtest: pipe-B-plane-3
[598.516816] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[598.841073] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.533s)
[599.674585] [143/155] (425s left) gem_exec_gttfill (basic)
[599.731204] Starting subtest: basic
[603.151082] Subtest basic: SUCCESS (3.418s)
[603.346083] [144/155] (421s left) kms_universal_plane (universal-plane-pageflip-windowed)
[603.492614] Starting subtest: universal-plane-pageflip-windowed
[603.494943] Starting dynamic subtest: pipe-A-eDP-1
[604.040621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s)
[604.053460] Starting dynamic subtest: pipe-B-eDP-1
[605.255703] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s)
[605.267410] Starting dynamic subtest: pipe-C-eDP-1
[606.469195] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s)
[606.481443] Starting dynamic subtest: pipe-D-eDP-1
[607.694584] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[607.697017] Subtest universal-plane-pageflip-windowed: SUCCESS (4.204s)
[608.594466] [145/155] (416s left) gem_ctx_persistence (legacy-engines-hostile)
[608.665215] Starting subtest: legacy-engines-hostile
[608.667835] Starting dynamic subtest: render
[608.779097] Dynamic subtest render: SUCCESS (0.113s)
[608.795605] Starting dynamic subtest: bsd1
[608.869598] Dynamic subtest bsd1: SUCCESS (0.087s)
[608.883378] Starting dynamic subtest: bsd2
[608.965762] Dynamic subtest bsd2: SUCCESS (0.093s)
[608.978613] Starting dynamic subtest: blt
[608.993756] Dynamic subtest blt: SUCCESS (0.025s)
[609.004305] Starting dynamic subtest: vebox
[609.116280] Dynamic subtest vebox: SUCCESS (0.120s)
[609.118975] Subtest legacy-engines-hostile: SUCCESS (0.452s)
[609.210277] [146/155] (416s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-pwrite)
[609.315157] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-pwrite
[609.319187] Subtest fbchdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[609.423012] [147/155] (415s left) gem_exec_params (no-bsd)
[609.481045] Starting subtest: no-bsd
[609.486816] Subtest no-bsd: SUCCESS (0.002s)
[611.267941] [148/155] (414s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[611.369598] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[611.371513] Starting dynamic subtest: pipe-A-eDP-1
[611.443587] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.075s)
[611.762646] Starting dynamic subtest: pipe-B-eDP-1
[612.590792] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.841s)
[612.889757] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.519s)
[613.751351] [149/155] (411s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[613.850411] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[617.413563] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.570s)
[618.651314] [150/155] (406s left) kms_plane_scaling (invalid-num-scalers)
[618.740607] Starting subtest: invalid-num-scalers
[618.743280] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[618.760273] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.020s)
[618.772644] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[618.799295] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.038s)
[618.810832] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[618.833457] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[618.844757] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[618.869980] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[618.872214] Subtest invalid-num-scalers: SUCCESS (0.129s)
[618.983723] [151/155] (406s left) kms_atomic_interruptible (atomic-setmode)
[619.075669] Starting subtest: atomic-setmode
[619.077948] Starting dynamic subtest: pipe-A-eDP-1
[625.984627] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.911s)
[625.986914] Subtest atomic-setmode: SUCCESS (6.913s)
[626.859164] [152/155] (398s left) gem_mmap_gtt (flink-race)
[626.925921] Subtest flink-race: SKIP (0.000s)
[626.989285] [153/155] (398s left) kms_flip (flip-vs-wf_vblank-interruptible)
[627.092704] Starting subtest: flip-vs-wf_vblank-interruptible
[627.094964] Starting dynamic subtest: A-eDP1
[628.998046] Dynamic subtest A-eDP1: SUCCESS (1.904s)
[629.009200] Starting dynamic subtest: B-eDP1
[630.931144] Dynamic subtest B-eDP1: SUCCESS (1.932s)
[630.946238] Starting dynamic subtest: C-eDP1
[632.846302] Dynamic subtest C-eDP1: SUCCESS (1.912s)
[632.859556] Starting dynamic subtest: D-eDP1
[634.771609] Dynamic subtest D-eDP1: SUCCESS (1.924s)
[634.777720] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.684s)
[636.018362] [154/155] (389s left) kms_plane_multiple (tiling-yf)
[636.108639] Starting subtest: tiling-yf
[636.112606] Subtest tiling-yf: SKIP (0.000s)
[636.184909] [155/155] (389s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[636.281477] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[636.285730] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[636.369322] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: kms_setmode
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: gem_exec_suspend
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: prime_vgem
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: i915_pm_rps
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_display_modes
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_workarounds
results: parsing output: 23/ for test: core_getversion
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_plane_alpha_blend
results: parsing output: 26/ for test: gem_tiled_fence_blits
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: i915_hangman
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_vrr
results: parsing output: 32/ for test: kms_pm_dc
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: prime_vgem
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_mmap_wc
results: parsing output: 45/ for test: i915_drm_fdinfo
results: parsing output: 46/ for test: kms_properties
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_exec_parallel
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: kms_chamelium_hpd
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: core_setmaster_vs_auth
results: parsing output: 65/ for test: kms_cdclk
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_wait
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: gem_exec_flush
results: parsing output: 73/ for test: kms_addfb_basic
results: parsing output: 74/ for test: drm_read
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_color
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_caching
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_panel_fitting
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_content_protection
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_rotation_crc
results: parsing output: 96/ for test: gem_ccs
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_draw_crc
results: parsing output: 99/ for test: gem_flink_basic
results: parsing output: 100/ for test: gen9_exec_parse
results: parsing output: 101/ for test: perf
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: gem_userptr_blits
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_pm_rpm
results: parsing output: 118/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 119/ for test: gem_ctx_isolation
results: parsing output: 120/ for test: kms_chamelium_color
results: parsing output: 121/ for test: gem_ctx_sseu
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_lmem_swapping
results: parsing output: 126/ for test: gem_pxp
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_invalid_mode
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: core_auth
results: parsing output: 132/ for test: gem_ctx_engines
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_psr
results: parsing output: 135/ for test: i915_pm_rpm
results: parsing output: 136/ for test: gem_basic
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_lease
results: parsing output: 139/ for test: gem_exec_params
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_plane
results: parsing output: 142/ for test: gem_exec_gttfill
results: parsing output: 143/ for test: kms_universal_plane
results: parsing output: 144/ for test: gem_ctx_persistence
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: gem_exec_params
results: parsing output: 147/ for test: kms_atomic_transition
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_plane_scaling
results: parsing output: 150/ for test: kms_atomic_interruptible
results: parsing output: 151/ for test: gem_mmap_gtt
results: parsing output: 152/ for test: kms_flip
results: parsing output: 153/ for test: kms_plane_multiple
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.