[59.533928] Initializing watchdogs
[59.533977]   /dev/watchdog0
[59.547830] [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]
[59.552481] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.554705] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.558331] [001/133] (960s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[59.679114] Starting subtest: x-tiled-64bpp-rotate-180
[61.304398] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.622s)
[61.503647] [002/133] (958s left) gem_mmap_offset (bad-flags)
[61.565999] Starting subtest: bad-flags
[61.568357] Subtest bad-flags: SUCCESS (0.000s)
[61.671712] [003/133] (958s left) gem_set_tiling_vs_pwrite
[61.800894] [004/133] (958s left) sw_sync (sync_expired_merge)
[61.840633] Starting subtest: sync_expired_merge
[62.915858] Subtest sync_expired_merge: SUCCESS (1.074s)
[62.983074] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[63.090788] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[63.095452] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[63.190848] [006/133] (957s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[63.293732] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[63.304598] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[63.389302] [007/133] (956s left) kms_atomic (plane-overlay-legacy)
[63.475966] Starting subtest: plane-overlay-legacy
[63.478329] Starting dynamic subtest: pipe-A-eDP-1
[63.916160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[63.918500] Subtest plane-overlay-legacy: SUCCESS (0.442s)
[64.724977] [008/133] (955s left) kms_addfb_basic (basic)
[64.777906] Starting subtest: basic
[64.780143] Subtest basic: SUCCESS (0.000s)
[64.935079] [009/133] (955s left) kms_feature_discovery (display-3x)
[65.042543] Starting subtest: display-3x
[65.046680] Subtest display-3x: SKIP (0.000s)
[65.123966] [010/133] (955s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[65.225219] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[65.229970] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[65.299698] [011/133] (955s left) core_setmaster_vs_auth
[65.483998] [012/133] (954s left) kms_psr (fbc-psr-primary-mmap-gtt)
[65.580134] Starting subtest: fbc-psr-primary-mmap-gtt
[65.582086] Starting dynamic subtest: eDP-1
[65.586275] Dynamic subtest eDP-1: SKIP (0.000s)
[65.590431] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[65.673780] [013/133] (954s left) gem_exec_reloc (basic-concurrent0)
[65.739605] Subtest basic-concurrent0: SKIP (0.000s)
[65.822216] [014/133] (954s left) syncobj_basic (illegal-fd-to-handle)
[65.879984] Starting subtest: illegal-fd-to-handle
[65.881560] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[66.006904] [015/133] (954s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[66.072354] Starting subtest: map-fixed-invalidate-overlap
[66.076064] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[66.228664] [016/133] (954s left) i915_pm_rpm (debugfs-forcewake-user)
[68.049108] Starting subtest: debugfs-forcewake-user
[79.440882] Subtest debugfs-forcewake-user: SUCCESS (11.384s)
[79.844889] [017/133] (940s left) kms_flip (modeset-vs-vblank-race)
[79.958812] Starting subtest: modeset-vs-vblank-race
[79.961202] Starting dynamic subtest: A-eDP1
[84.643797] Dynamic subtest A-eDP1: SUCCESS (4.684s)
[84.652385] Starting dynamic subtest: B-eDP1
[89.371650] Dynamic subtest B-eDP1: SUCCESS (4.726s)
[89.380612] Starting dynamic subtest: C-eDP1
[93.981795] Dynamic subtest C-eDP1: SUCCESS (4.608s)
[93.989020] Starting dynamic subtest: D-eDP1
[98.550051] Dynamic subtest D-eDP1: SUCCESS (4.566s)
[98.554899] Subtest modeset-vs-vblank-race: SUCCESS (18.595s)
[99.737217] [018/133] (920s left) kms_invalid_mode (bad-htotal)
[99.853715] Starting subtest: bad-htotal
[99.856144] Starting dynamic subtest: pipe-A-eDP-1
[100.141597] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[100.150642] Starting dynamic subtest: pipe-B-eDP-1
[100.152627] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[100.159041] Starting dynamic subtest: pipe-C-eDP-1
[100.161021] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[100.167719] Starting dynamic subtest: pipe-D-eDP-1
[100.170049] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[100.172316] Subtest bad-htotal: SUCCESS (0.295s)
[100.965163] [019/133] (919s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[101.072176] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[101.074476] Starting dynamic subtest: pipe-A-eDP-1
[101.098086] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.107842] Starting dynamic subtest: pipe-B-eDP-1
[101.129243] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.136105] Starting dynamic subtest: pipe-C-eDP-1
[101.157558] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.164431] Starting dynamic subtest: pipe-D-eDP-1
[101.186287] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.190331] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[103.251906] [020/133] (917s left) i915_suspend (basic-s3-without-i915)
[103.291303] Starting subtest: basic-s3-without-i915
[105.104080] Subtest basic-s3-without-i915: SKIP (1.806s)
[106.669328] [021/133] (914s left) tools_test (tools_test)
[106.720783] Starting subtest: tools_test
[106.775996] Subtest tools_test: SUCCESS (0.068s)
[106.856127] [022/133] (913s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[111.606656] Starting subtest: dpms-mode-unset-non-lpsp
[112.750476] Subtest dpms-mode-unset-non-lpsp: SKIP (1.144s)
[113.137075] [023/133] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[113.227657] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[113.232232] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[113.360536] [024/133] (907s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[113.452707] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[113.456907] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[113.571852] [025/133] (907s left) gem_exec_store (dword)
[113.635751] Starting subtest: dword
[113.637600] Starting dynamic subtest: rcs0
[113.717984] Dynamic subtest rcs0: SUCCESS (0.083s)
[113.726693] Starting dynamic subtest: bcs0
[113.760270] Dynamic subtest bcs0: SUCCESS (0.041s)
[113.768033] Starting dynamic subtest: vcs0
[113.800989] Dynamic subtest vcs0: SUCCESS (0.040s)
[113.808821] Starting dynamic subtest: vcs1
[113.841225] Dynamic subtest vcs1: SUCCESS (0.039s)
[113.849191] Starting dynamic subtest: vecs0
[113.883203] Dynamic subtest vecs0: SUCCESS (0.041s)
[113.893533] Starting dynamic subtest: ccs0
[113.924409] Dynamic subtest ccs0: SUCCESS (0.040s)
[113.926807] Subtest dword: SUCCESS (0.291s)
[114.118441] [026/133] (906s left) gem_ctx_shared (detached-shared-gtt)
[114.176852] Starting subtest: detached-shared-gtt
[116.327329] Subtest detached-shared-gtt: SUCCESS (2.151s)
[116.723771] [027/133] (904s left) prime_self_import (basic-with_two_bos)
[116.764934] Starting subtest: basic-with_two_bos
[116.795853] Subtest basic-with_two_bos: SUCCESS (0.033s)
[116.920954] [028/133] (904s left) kms_flip (2x-busy-flip)
[117.022763] Starting subtest: 2x-busy-flip
[117.031459] Subtest 2x-busy-flip: SKIP (0.010s)
[117.117578] [029/133] (903s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[117.184661] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[117.289612] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[117.378215] [030/133] (903s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[117.491068] Starting subtest: fbcpsr-tiling-linear
[124.165446] Subtest fbcpsr-tiling-linear: SUCCESS (6.677s)
[124.332510] [031/133] (896s left) gem_exec_reloc (basic-write-read)
[124.391225] Subtest basic-write-read: SKIP (0.000s)
[124.473840] [032/133] (896s left) syncobj_timeline (wait-zero-handles)
[124.530273] Starting subtest: wait-zero-handles
[124.532140] Subtest wait-zero-handles: SUCCESS (0.000s)
[124.646050] [033/133] (896s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[124.755339] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[129.343368] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.589s)
[130.563693] [034/133] (890s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[130.660413] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[137.709804] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.053s)
[138.842392] [035/133] (882s left) gem_wait (write-busy)
[138.914292] Starting subtest: write-busy
[138.916640] Starting dynamic subtest: all-engines
[139.560969] Dynamic subtest all-engines: SUCCESS (0.646s)
[139.577452] Starting dynamic subtest: rcs0
[140.111783] Dynamic subtest rcs0: SUCCESS (0.549s)
[140.126076] Starting dynamic subtest: bcs0
[140.659363] Dynamic subtest bcs0: SUCCESS (0.547s)
[140.673981] Starting dynamic subtest: vcs0
[141.910341] Dynamic subtest vcs0: SUCCESS (1.248s)
[141.925393] Starting dynamic subtest: vcs1
[143.893272] Dynamic subtest vcs1: SUCCESS (1.981s)
[143.906965] Starting dynamic subtest: vecs0
[145.876857] Dynamic subtest vecs0: SUCCESS (1.982s)
[145.891532] Starting dynamic subtest: ccs0
[146.426030] Dynamic subtest ccs0: SUCCESS (0.549s)
[146.429210] Subtest write-busy: SUCCESS (7.512s)
[146.633812] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[146.637065] [036/133] (874s left) kms_getfb (getfb2-accept-nv12)
[146.742227] Starting subtest: getfb2-accept-nv12
[146.744580] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[146.851956] [037/133] (874s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[146.911012] Starting subtest: etime-multi-wait-all-submitted-signaled
[147.018275] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[147.103279] [038/133] (874s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[147.156520] Starting subtest: multi-wait-available-submitted-signaled
[147.158684] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[147.259185] [039/133] (874s left) kms_lease (cursor-implicit-plane)
[147.356671] Starting subtest: cursor-implicit-plane
[147.358972] Starting dynamic subtest: pipe-A-eDP-1
[147.801741] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[147.810823] Starting dynamic subtest: pipe-B-eDP-1
[148.940707] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.137s)
[148.948236] Starting dynamic subtest: pipe-C-eDP-1
[150.060022] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[150.070962] Starting dynamic subtest: pipe-D-eDP-1
[151.200077] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[151.202368] Subtest cursor-implicit-plane: SUCCESS (3.847s)
[152.069149] [040/133] (869s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[152.194306] Starting subtest: flip-vs-cursor-crc-atomic
[152.908833] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.713s)
[153.714023] [041/133] (867s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[153.810063] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[153.814546] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[153.922544] [042/133] (867s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[154.020390] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[154.022661] Starting dynamic subtest: pipe-A-eDP-1
[154.045877] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[154.056130] Starting dynamic subtest: pipe-B-eDP-1
[154.078411] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[154.086057] Starting dynamic subtest: pipe-C-eDP-1
[154.107870] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[154.115407] Starting dynamic subtest: pipe-D-eDP-1
[154.137583] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[154.141745] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[156.272785] [043/133] (865s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[156.367809] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[156.371788] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[156.449085] [044/133] (865s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[156.554675] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[156.558785] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[156.675568] [045/133] (865s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[156.778833] Starting subtest: fbc-psr2-cursor-plane-onoff
[156.781147] Starting dynamic subtest: eDP-1
[156.785601] Dynamic subtest eDP-1: SKIP (0.000s)
[156.789859] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[156.862935] [046/133] (864s left) kms_cursor_crc (cursor-onscreen-64x21)
[157.105774] Starting subtest: cursor-onscreen-64x21
[157.151542] Subtest cursor-onscreen-64x21: SKIP (0.040s)
[157.394784] [047/133] (864s left) kms_content_protection (uevent-hdcp14)
[157.527495] Starting subtest: uevent-hdcp14
[157.531349] Subtest uevent-hdcp14: SKIP (0.000s)
[157.671189] [048/133] (864s left) kms_color_pipeline (plane-lut1d-lut1d)
[157.761042] Starting subtest: plane-lut1d-lut1d
[157.776156] Starting dynamic subtest: pipe-A-eDP-1
[158.423732] Dynamic subtest pipe-A-eDP-1: FAIL (0.318s)
[159.153662] Starting dynamic subtest: pipe-B-eDP-1
[159.981151] Dynamic subtest pipe-B-eDP-1: FAIL (0.311s)
[160.586269] Starting dynamic subtest: pipe-C-eDP-1
[161.397808] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[161.917730] Starting dynamic subtest: pipe-D-eDP-1
[162.749650] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[162.751977] Subtest plane-lut1d-lut1d: FAIL (4.690s)
[163.328208] [049/133] (858s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[163.431244] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[163.435458] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[163.559257] [050/133] (858s left) gem_eio (in-flight-internal-1us)
[163.777703] Starting subtest: in-flight-internal-1us
[164.947462] Subtest in-flight-internal-1us: SUCCESS (1.168s)
[165.088751] [051/133] (856s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[165.174551] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[165.179081] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[165.286869] [052/133] (856s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[165.387208] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[172.589927] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.205s)
[172.770878] [053/133] (849s left) gem_eio (in-flight-suspend)
[172.994731] Starting subtest: in-flight-suspend
[216.169661] Subtest in-flight-suspend: SUCCESS (13.926s)
[216.345332] [054/133] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[216.465860] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[224.196251] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.668s)
[224.356774] [055/133] (797s left) i915_drm_fdinfo (busy-hang)
[224.402449] Starting subtest: busy-hang
[224.404844] Starting dynamic subtest: rcs0
[224.443767] Dynamic subtest rcs0: SKIP (0.040s)
[224.453997] Starting dynamic subtest: bcs0
[224.458372] Dynamic subtest bcs0: SKIP (0.001s)
[224.467166] Starting dynamic subtest: vcs0
[224.471302] Dynamic subtest vcs0: SKIP (0.000s)
[224.479881] Starting dynamic subtest: vcs1
[224.484405] Dynamic subtest vcs1: SKIP (0.000s)
[224.492926] Starting dynamic subtest: vecs0
[224.497457] Dynamic subtest vecs0: SKIP (0.000s)
[224.505818] Starting dynamic subtest: ccs0
[224.510369] Dynamic subtest ccs0: SKIP (0.000s)
[224.514865] Subtest busy-hang: SKIP (0.048s)
[224.550740] [056/133] (797s left) kms_chamelium_audio (dp-audio-edid)
[224.940484] Subtest dp-audio-edid: SKIP (0.000s)
[225.780749] [057/133] (796s left) kms_universal_plane (universal-plane-sanity)
[225.873809] Starting subtest: universal-plane-sanity
[225.875774] Starting dynamic subtest: pipe-A-eDP-1
[226.480159] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[226.490240] Starting dynamic subtest: pipe-B-eDP-1
[227.701640] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.215s)
[227.713520] Starting dynamic subtest: pipe-C-eDP-1
[228.926293] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.221s)
[228.936531] Starting dynamic subtest: pipe-D-eDP-1
[230.164125] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[230.166504] Subtest universal-plane-sanity: SUCCESS (4.279s)
[231.042244] [058/133] (791s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[231.103335] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[231.107908] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[231.297739] [059/133] (791s left) syncobj_eventfd (timeline-wait)
[231.352281] Starting subtest: timeline-wait
[231.360621] Subtest timeline-wait: SUCCESS (0.011s)
[231.487678] [060/133] (790s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[231.589893] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[231.593887] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[231.739184] [061/133] (790s left) gem_pwrite (basic-self)
[231.809124] Subtest basic-self: SKIP (0.000s)
[231.881265] [062/133] (790s left) gem_spin_batch (spin-each)
[231.948027] Starting subtest: spin-each
[235.304425] Subtest spin-each: SUCCESS (3.353s)
[236.314725] [063/133] (786s left) gem_pxp (regular-baseline-src-copy-readible)
[236.437554] Starting subtest: regular-baseline-src-copy-readible
[236.497137] Subtest regular-baseline-src-copy-readible: SUCCESS (0.062s)
[236.664072] [064/133] (785s left) kms_async_flips (alternate-sync-async-flip)
[236.765016] Starting subtest: alternate-sync-async-flip
[237.137700] Starting dynamic subtest: pipe-A-eDP-1
[239.940717] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.802s)
[240.315061] Starting dynamic subtest: pipe-B-eDP-1
[243.077057] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[243.475155] Starting dynamic subtest: pipe-C-eDP-1
[246.223776] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.753s)
[246.606564] Starting dynamic subtest: pipe-D-eDP-1
[249.361704] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[249.365109] Subtest alternate-sync-async-flip: SUCCESS (12.591s)
[250.553023] [065/133] (772s left) gem_eio (in-flight-10ms)
[250.758183] Starting subtest: in-flight-10ms
[258.891767] Subtest in-flight-10ms: SUCCESS (8.131s)
[259.089012] [066/133] (763s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[259.189937] Starting subtest: plane-all-modeset-transition-fencing
[259.194285] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[259.286955] [067/133] (763s left) gem_exec_schedule (submit-late-slice)
[259.371973] Starting subtest: submit-late-slice
[259.374185] Starting dynamic subtest: rcs0
[259.398470] Dynamic subtest rcs0: SUCCESS (0.036s)
[259.407974] Starting dynamic subtest: bcs0
[259.434571] Dynamic subtest bcs0: SUCCESS (0.035s)
[259.443907] Starting dynamic subtest: vcs0
[259.465738] Dynamic subtest vcs0: SUCCESS (0.030s)
[259.474412] Starting dynamic subtest: vcs1
[259.499721] Dynamic subtest vcs1: SUCCESS (0.033s)
[259.511943] Starting dynamic subtest: vecs0
[259.553381] Dynamic subtest vecs0: SUCCESS (0.051s)
[259.564531] Starting dynamic subtest: ccs0
[259.593022] Dynamic subtest ccs0: SUCCESS (0.039s)
[259.595226] Subtest submit-late-slice: SUCCESS (0.231s)
[261.254438] [068/133] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[261.362237] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[261.366280] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[261.468494] [069/133] (761s left) gem_exec_suspend (basic)
[261.535549] Starting subtest: basic
[261.537675] Starting dynamic subtest: smem
[263.126653] Dynamic subtest smem: SUCCESS (1.589s)
[263.129425] Subtest basic: SUCCESS (1.591s)
[263.325009] [070/133] (759s left) syncobj_timeline (invalid-signal-illegal-handle)
[263.390265] Starting subtest: invalid-signal-illegal-handle
[263.392534] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[263.506867] [071/133] (759s left) fbdev (read)
[263.546678] Starting subtest: read
[264.072628] Subtest read: SUCCESS (0.524s)
[264.146624] [072/133] (758s left) api_intel_bb (full-batch)
[264.194636] Starting subtest: full-batch
[264.202924] Subtest full-batch: SUCCESS (0.009s)
[264.359222] [073/133] (758s left) kms_pm_rpm (universal-planes-dpms)
[266.298629] Starting subtest: universal-planes-dpms
[266.300898] Starting dynamic subtest: plane-34
[274.875082] Dynamic subtest plane-34: SUCCESS (8.577s)
[274.887498] Starting dynamic subtest: plane-64
[283.190301] Dynamic subtest plane-64: SUCCESS (8.309s)
[283.202073] Starting dynamic subtest: plane-94
[291.772078] Dynamic subtest plane-94: SUCCESS (8.575s)
[291.784434] Starting dynamic subtest: plane-124
[300.365122] Dynamic subtest plane-124: SUCCESS (8.587s)
[300.377140] Starting dynamic subtest: plane-134
[308.699310] Dynamic subtest plane-134: SUCCESS (8.328s)
[308.710942] Starting dynamic subtest: plane-144
[317.281343] Dynamic subtest plane-144: SUCCESS (8.582s)
[317.284026] Subtest universal-planes-dpms: SUCCESS (50.975s)
[317.674817] [074/133] (705s left) perf (gen12-group-concurrent-oa-buffer-read)
[317.832034] Starting subtest: gen12-group-concurrent-oa-buffer-read
[327.915180] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.034s)
[327.954477] [075/133] (695s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[328.070914] Starting subtest: psr2-overlay-plane-move-continuous-sf
[328.073327] Starting dynamic subtest: pipe-A-eDP-1
[334.060038] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.988s)
[334.070798] Starting dynamic subtest: pipe-B-eDP-1
[340.716040] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.657s)
[340.718530] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.650s)
[341.619011] [076/133] (681s left) i915_hangman (gt-engine-hang)
[341.681181] Starting subtest: gt-engine-hang
[341.683538] Starting dynamic subtest: rcs0
[343.093313] Dynamic subtest rcs0: SUCCESS (1.410s)
[343.105997] Starting dynamic subtest: bcs0
[345.140377] Dynamic subtest bcs0: SUCCESS (2.044s)
[345.151232] Starting dynamic subtest: vcs0
[347.124614] Dynamic subtest vcs0: SUCCESS (1.982s)
[347.136716] Starting dynamic subtest: vcs1
[349.108644] Dynamic subtest vcs1: SUCCESS (1.981s)
[349.121018] Starting dynamic subtest: vecs0
[351.092210] Dynamic subtest vecs0: SUCCESS (1.981s)
[351.104219] Starting dynamic subtest: ccs0
[353.140566] Dynamic subtest ccs0: SUCCESS (2.046s)
[353.143467] Subtest gt-engine-hang: SUCCESS (11.460s)
[353.233953] [077/133] (669s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[353.343932] Starting subtest: primary-y-tiled-reflect-x-90
[353.348205] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[353.435485] [078/133] (669s left) perf (non-sampling-read-error)
[353.538623] Starting subtest: non-sampling-read-error
[353.547833] Subtest non-sampling-read-error: SUCCESS (0.007s)
[353.590799] [079/133] (669s left) syncobj_wait (wait-all-for-submit-complex)
[353.646192] Starting subtest: wait-all-for-submit-complex
[353.858603] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[353.948125] [080/133] (669s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[354.043496] Starting subtest: psr-rgb101010-draw-pwrite
[361.519455] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.478s)
[361.647303] [081/133] (661s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[361.767889] Starting subtest: basic-busy-flip-before-cursor-varying-size
[361.772584] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[361.941042] [082/133] (661s left) gem_create (create-ext-placement-each)
[362.100113] Starting subtest: create-ext-placement-each
[362.102441] Subtest create-ext-placement-each: SUCCESS (0.000s)
[362.227800] [083/133] (661s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[362.318770] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[362.321000] Starting dynamic subtest: pipe-A-eDP-1
[362.379762] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[362.398296] Starting dynamic subtest: pipe-B-eDP-1
[362.458624] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[362.469859] Starting dynamic subtest: pipe-C-eDP-1
[362.528592] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[362.539141] Starting dynamic subtest: pipe-D-eDP-1
[362.595356] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[362.599907] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[364.505235] [084/133] (658s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[364.559258] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[364.561435] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[364.691291] [085/133] (658s left) gem_ctx_persistence (engines-mixed-process)
[364.757447] Starting subtest: engines-mixed-process
[364.759751] Starting dynamic subtest: rcs0
[366.184898] Dynamic subtest rcs0: SUCCESS (1.427s)
[366.197088] Starting dynamic subtest: bcs0
[368.170245] Dynamic subtest bcs0: SUCCESS (1.984s)
[368.182351] Starting dynamic subtest: vcs0
[370.136450] Dynamic subtest vcs0: SUCCESS (1.964s)
[370.146812] Starting dynamic subtest: vcs1
[372.209003] Dynamic subtest vcs1: SUCCESS (2.070s)
[372.223922] Starting dynamic subtest: vecs0
[374.170761] Dynamic subtest vecs0: SUCCESS (1.960s)
[374.182464] Starting dynamic subtest: ccs0
[376.110112] Dynamic subtest ccs0: SUCCESS (1.937s)
[376.112915] Subtest engines-mixed-process: SUCCESS (11.351s)
[376.203767] [086/133] (647s left) gem_exec_balancer (individual)
[376.270040] Starting subtest: individual
[378.153876] Subtest individual: SUCCESS (1.882s)
[378.496964] [087/133] (645s left) prime_busy (before-wait)
[378.559308] Starting subtest: before-wait
[378.564417] Starting dynamic subtest: rcs0
[378.615852] Dynamic subtest rcs0: SUCCESS (0.052s)
[378.632236] Starting dynamic subtest: bcs0
[378.680532] Dynamic subtest bcs0: SUCCESS (0.063s)
[378.690885] Starting dynamic subtest: vcs0
[378.721384] Dynamic subtest vcs0: SUCCESS (0.040s)
[378.730761] Starting dynamic subtest: vcs1
[378.762275] Dynamic subtest vcs1: SUCCESS (0.040s)
[378.771573] Starting dynamic subtest: vecs0
[378.803845] Dynamic subtest vecs0: SUCCESS (0.041s)
[378.813171] Starting dynamic subtest: ccs0
[378.847560] Dynamic subtest ccs0: SUCCESS (0.042s)
[378.954650] Subtest before-wait: SUCCESS (0.394s)
[379.043078] [088/133] (644s left) gem_exec_fence (submit3)
[379.229163] Starting subtest: submit3
[379.233539] Subtest submit3: SKIP (0.000s)
[381.256997] [089/133] (642s left) kms_cursor_crc (cursor-random-max-size)
[381.609793] Starting subtest: cursor-random-max-size
[381.616014] Subtest cursor-random-max-size: SKIP (0.000s)
[381.777675] [090/133] (641s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[381.887333] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[381.891555] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[381.967843] [091/133] (641s left) core_setmaster (master-drop-set-user)
[382.060614] Starting subtest: master-drop-set-user
[382.075093] Subtest master-drop-set-user: SUCCESS (0.015s)
[382.111384] [092/133] (641s left) syncobj_timeline (wait-any-snapshot)
[382.162481] Starting subtest: wait-any-snapshot
[382.242926] Subtest wait-any-snapshot: SUCCESS (0.081s)
[382.335261] [093/133] (641s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[382.431927] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[382.435521] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[382.571689] [094/133] (641s left) gem_mmap_gtt (big-bo-tiledx)
[382.632336] Subtest big-bo-tiledX: SKIP (0.000s)
[382.695416] [095/133] (641s left) gem_gpgpu_fill (basic)
[382.750960] Starting subtest: basic
[382.753076] Starting dynamic subtest: smem
[382.758055] Dynamic subtest smem: SUCCESS (0.008s)
[382.760124] Subtest basic: SUCCESS (0.009s)
[382.914019] [096/133] (640s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[383.294164] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[384.099988] [097/133] (639s left) kms_flip (2x-blocking-absolute-wf_vblank)
[384.201148] Starting subtest: 2x-blocking-absolute-wf_vblank
[384.209338] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[384.303325] [098/133] (639s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[384.400671] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[384.402945] Starting dynamic subtest: pipe-A-eDP-1
[384.423660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[384.435571] Starting dynamic subtest: pipe-B-eDP-1
[384.455679] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[384.464790] Starting dynamic subtest: pipe-C-eDP-1
[384.484388] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[384.493402] Starting dynamic subtest: pipe-D-eDP-1
[384.512903] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[384.515112] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[386.604815] [099/133] (637s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[386.676636] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[386.747856] [100/133] (637s left) api_intel_bb (blit-reloc-keep-cache)
[386.798743] Starting subtest: blit-reloc-keep-cache
[386.803276] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[386.954036] [101/133] (637s left) gen7_exec_parse (oacontrol-tracking)
[387.016752] Subtest oacontrol-tracking: SKIP (0.000s)
[387.100009] [102/133] (637s left) gem_ctx_persistence (legacy-engines-queued)
[387.160812] Starting subtest: legacy-engines-queued
[387.163275] Starting dynamic subtest: render
[387.301055] Dynamic subtest render: SUCCESS (0.139s)
[387.313864] Starting dynamic subtest: bsd1
[389.106889] Dynamic subtest bsd1: SUCCESS (1.802s)
[389.119790] Starting dynamic subtest: bsd2
[391.145614] Dynamic subtest bsd2: SUCCESS (1.982s)
[391.157993] Starting dynamic subtest: blt
[391.160247] Dynamic subtest blt: SUCCESS (0.043s)
[391.170000] Starting dynamic subtest: vebox
[393.141992] Dynamic subtest vebox: SUCCESS (2.000s)
[393.144989] Subtest legacy-engines-queued: SUCCESS (5.979s)
[393.233427] [103/133] (630s left) gem_exec_balancer (persistence)
[393.504551] Starting subtest: persistence
[394.362800] Subtest persistence: SUCCESS (0.858s)
[394.523299] [104/133] (629s left) gem_exec_schedule (noreorder)
[394.723229] Starting subtest: noreorder
[394.725644] Starting dynamic subtest: rcs0
[394.815702] Dynamic subtest rcs0: SUCCESS (0.092s)
[394.827678] Starting dynamic subtest: vcs0
[396.204403] Dynamic subtest vcs0: SUCCESS (1.385s)
[396.216290] Starting dynamic subtest: vcs1
[398.149301] Dynamic subtest vcs1: SUCCESS (1.942s)
[398.162194] Starting dynamic subtest: vecs0
[400.228722] Dynamic subtest vecs0: SUCCESS (2.024s)
[400.237875] Starting dynamic subtest: ccs0
[400.263112] Dynamic subtest ccs0: SUCCESS (0.087s)
[400.265256] Subtest noreorder: SUCCESS (5.541s)
[400.473169] [105/133] (623s left) kms_big_fb (linear-64bpp-rotate-180)
[400.583629] Starting subtest: linear-64bpp-rotate-180
[402.229042] Subtest linear-64bpp-rotate-180: SUCCESS (1.644s)
[402.393806] [106/133] (621s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[402.485633] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[402.487806] Starting dynamic subtest: pipe-A
[402.547867] Dynamic subtest pipe-A: SUCCESS (0.064s)
[402.556768] Starting dynamic subtest: pipe-B
[403.723406] Dynamic subtest pipe-B: SUCCESS (1.174s)
[403.734761] Starting dynamic subtest: pipe-C
[404.836785] Dynamic subtest pipe-C: SUCCESS (1.112s)
[404.846978] Starting dynamic subtest: pipe-D
[405.979937] Dynamic subtest pipe-D: SUCCESS (1.142s)
[405.982169] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.496s)
[407.145189] [107/133] (617s left) gem_ctx_param (get-priority-new-ctx)
[407.199501] Starting subtest: get-priority-new-ctx
[407.201965] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[407.308051] [108/133] (617s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[407.415761] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[408.240473] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.825s)
[408.445135] [109/133] (615s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[408.550946] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[408.553262] Starting dynamic subtest: A-eDP1
[412.161498] Dynamic subtest A-eDP1: SUCCESS (3.608s)
[412.172666] Starting dynamic subtest: B-eDP1
[415.349498] Dynamic subtest B-eDP1: SUCCESS (3.184s)
[415.359941] Starting dynamic subtest: C-eDP1
[418.442490] Dynamic subtest C-eDP1: SUCCESS (3.093s)
[418.454186] Starting dynamic subtest: D-eDP1
[421.542632] Dynamic subtest D-eDP1: SUCCESS (3.099s)
[421.545050] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.991s)
[422.353963] [110/133] (602s left) gem_exec_reloc (basic-cpu-read-active)
[422.429457] Subtest basic-cpu-read-active: SKIP (0.000s)
[422.512457] [111/133] (601s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[422.613043] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[422.617518] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[422.747762] [112/133] (601s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[422.857892] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[422.861903] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[422.982452] [113/133] (601s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[423.087082] Starting subtest: 4-tiled-32bpp-rotate-90
[423.106691] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[423.245234] [114/133] (601s left) kms_plane_alpha_blend (constant-alpha-mid)
[423.333297] Starting subtest: constant-alpha-mid
[423.608117] Starting dynamic subtest: pipe-A-eDP-1
[424.399710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.788s)
[424.409979] Starting dynamic subtest: pipe-D-eDP-1
[425.975438] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.574s)
[425.977760] Subtest constant-alpha-mid: SUCCESS (2.642s)
[426.822746] [115/133] (597s left) kms_fbcon_fbt (psr)
[426.895893] Starting subtest: psr
[434.229460] Subtest psr: SUCCESS (7.336s)
[434.341965] [116/133] (590s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[434.446132] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[434.450361] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[434.527966] [117/133] (590s left) gem_mmap_gtt (basic-small-bo-tiledy)
[434.584643] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[434.640152] [118/133] (590s left) kms_psr (psr-primary-blt)
[434.731600] Starting subtest: psr-primary-blt
[434.733825] Starting dynamic subtest: eDP-1
[436.453816] Dynamic subtest eDP-1: SUCCESS (1.721s)
[436.456176] Subtest psr-primary-blt: SUCCESS (1.722s)
[437.322654] [119/133] (587s left) kms_chamelium_frames (dp-crc-fast)
[437.712413] Subtest dp-crc-fast: SKIP (0.000s)
[438.520823] [120/133] (586s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[438.645419] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[456.239068] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.597s)
[457.052708] [121/133] (567s left) gem_exec_params (invalid-bsd1-flag-on-render)
[457.117358] Starting subtest: invalid-bsd1-flag-on-render
[457.119813] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[457.249560] [122/133] (567s left) kms_cursor_legacy (torture-move)
[457.359448] Starting subtest: torture-move
[457.361725] Starting dynamic subtest: pipe-A
[463.403783] Dynamic subtest pipe-A: SUCCESS (6.040s)
[463.416404] Starting dynamic subtest: pipe-B
[470.288396] Dynamic subtest pipe-B: SUCCESS (6.886s)
[470.299049] Starting dynamic subtest: pipe-C
[478.559745] Dynamic subtest pipe-C: SUCCESS (8.270s)
[478.573014] Starting dynamic subtest: pipe-D
[485.303622] Dynamic subtest pipe-D: SUCCESS (6.742s)
[485.313856] Starting dynamic subtest: all-pipes
[493.182423] Dynamic subtest all-pipes: SUCCESS (7.876s)
[493.185080] Subtest torture-move: SUCCESS (35.823s)
[493.365005] [123/133] (531s left) gem_partial_pwrite_pread (write)
[493.426877] Subtest write: SKIP (0.000s)
[493.494161] [124/133] (531s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[493.584525] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[493.597238] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[493.671876] [125/133] (531s left) perf_pmu (render-node-busy)
[493.758442] Starting subtest: render-node-busy
[493.760838] Starting dynamic subtest: rcs0
[494.361361] Dynamic subtest rcs0: SUCCESS (0.605s)
[494.373999] Starting dynamic subtest: bcs0
[494.927442] Dynamic subtest bcs0: SUCCESS (0.564s)
[494.940166] Starting dynamic subtest: vcs0
[496.149704] Dynamic subtest vcs0: SUCCESS (1.219s)
[496.161230] Starting dynamic subtest: vcs1
[498.134636] Dynamic subtest vcs1: SUCCESS (1.981s)
[498.147957] Starting dynamic subtest: vecs0
[500.119658] Dynamic subtest vecs0: SUCCESS (1.982s)
[500.132431] Starting dynamic subtest: ccs0
[500.683754] Dynamic subtest ccs0: SUCCESS (0.563s)
[500.686488] Subtest render-node-busy: SUCCESS (6.930s)
[500.772596] [126/133] (524s left) kms_plane_scaling (invalid-num-scalers)
[500.876552] Starting subtest: invalid-num-scalers
[500.878847] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[500.895729] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[500.905787] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[500.924837] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[500.934925] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[500.956644] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[500.966368] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[500.988157] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[500.990468] Subtest invalid-num-scalers: SUCCESS (0.111s)
[501.134685] [127/133] (524s left) kms_vblank (ts-continuation-dpms-suspend)
[501.233199] Starting subtest: ts-continuation-dpms-suspend
[501.235121] Starting dynamic subtest: pipe-A-eDP-1
[518.440631] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.820s)
[518.456782] Starting dynamic subtest: pipe-D-eDP-1
[536.466410] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.481s)
[536.468833] Subtest ts-continuation-dpms-suspend: SUCCESS (4.305s)
[537.300201] [128/133] (487s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[537.419163] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[537.423354] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[537.556659] [129/133] (487s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[537.656331] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[537.670385] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[537.774177] [130/133] (487s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[537.829577] Subtest writes-after-reads: SKIP (0.000s)
[537.919212] [131/133] (487s left) gem_workarounds (reset)
[537.985316] Starting subtest: reset
[538.146324] Subtest reset: SUCCESS (0.159s)
[538.292764] [132/133] (487s left) kms_psr (pr-cursor-blt)
[538.395300] Starting subtest: pr-cursor-blt
[538.399253] Subtest pr-cursor-blt: SKIP (0.000s)
[538.482627] [133/133] (486s left) kms_psr (psr2-sprite-blt)
[538.564803] Starting subtest: psr2-sprite-blt
[538.566799] Starting dynamic subtest: eDP-1
[540.304663] Dynamic subtest eDP-1: SUCCESS (1.721s)
[540.306901] Subtest psr2-sprite-blt: SUCCESS (1.722s)
[541.198116] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_mmap_offset
results: parsing output: 2/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 3/ for test: sw_sync
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_atomic
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: kms_feature_discovery
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: core_setmaster_vs_auth
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: syncobj_basic
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: i915_pm_rpm
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_invalid_mode
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: i915_suspend
results: parsing output: 20/ for test: tools_test
results: parsing output: 21/ for test: kms_pm_rpm
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_store
results: parsing output: 25/ for test: gem_ctx_shared
results: parsing output: 26/ for test: prime_self_import
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_wait
results: parsing output: 35/ for test: kms_getfb
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_lease
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_eio
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_eio
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_chamelium_audio
results: parsing output: 56/ for test: kms_universal_plane
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: syncobj_eventfd
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_pwrite
results: parsing output: 61/ for test: gem_spin_batch
results: parsing output: 62/ for test: gem_pxp
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: gem_eio
results: parsing output: 65/ for test: kms_atomic_transition
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_suspend
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: fbdev
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_pm_rpm
results: parsing output: 73/ for test: perf
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: i915_hangman
results: parsing output: 76/ for test: kms_rotation_crc
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_create
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: prime_busy
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: core_setmaster
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: gem_gpgpu_fill
results: parsing output: 95/ for test: kms_chamelium_hpd
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: gen7_exec_parse
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: gem_ctx_param
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_plane_alpha_blend
results: parsing output: 114/ for test: kms_fbcon_fbt
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_chamelium_frames
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: gem_partial_pwrite_pread
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_plane_scaling
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_plane
results: parsing output: 129/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 130/ for test: gem_workarounds
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_psr
Done.