[59.431949] Initializing watchdogs
[59.431999]   /dev/watchdog0
[59.449887] [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.455180] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.458068] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.461502] [001/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[59.581856] Starting subtest: x-tiled-8bpp-rotate-90
[59.617073] Subtest x-tiled-8bpp-rotate-90: SKIP (0.035s)
[59.722632] [002/133] (960s left) kms_pm_rpm (pc8-residency)
[61.273332] Starting subtest: pc8-residency
[61.278055] Subtest pc8-residency: SKIP (0.000s)
[62.022570] [003/133] (958s left) vgem_basic (sysfs)
[62.107104] Starting subtest: sysfs
[62.108942] Subtest sysfs: SUCCESS (0.000s)
[62.158981] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[62.161990] [004/133] (957s left) kms_plane_alpha_blend (constant-alpha-mid)
[62.243853] Starting subtest: constant-alpha-mid
[62.524460] Starting dynamic subtest: pipe-A-eDP-1
[63.319434] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.795s)
[63.331194] Starting dynamic subtest: pipe-D-eDP-1
[64.794380] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.473s)
[64.796757] Subtest constant-alpha-mid: SUCCESS (2.551s)
[65.664214] [005/133] (954s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[65.771054] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[65.773401] Starting dynamic subtest: pipe-A-eDP-1
[77.074943] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.308s)
[77.086030] Starting dynamic subtest: pipe-B-eDP-1
[89.091802] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.016s)
[89.094182] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.325s)
[89.940616] [006/133] (930s left) gem_exec_params (batch-first)
[89.998988] Starting subtest: batch-first
[90.004162] Subtest batch-first: SUCCESS (0.004s)
[90.115786] [007/133] (930s left) i915_drm_fdinfo (busy-idle)
[90.161997] Starting subtest: busy-idle
[90.163940] Starting dynamic subtest: rcs0
[90.177759] Dynamic subtest rcs0: SKIP (0.015s)
[90.184848] Starting dynamic subtest: bcs0
[90.188962] Dynamic subtest bcs0: SKIP (0.000s)
[90.195875] Starting dynamic subtest: vcs0
[90.200141] Dynamic subtest vcs0: SKIP (0.000s)
[90.206863] Starting dynamic subtest: vcs1
[90.210972] Dynamic subtest vcs1: SKIP (0.000s)
[90.217457] Starting dynamic subtest: vecs0
[90.221543] Dynamic subtest vecs0: SKIP (0.000s)
[90.228448] Starting dynamic subtest: ccs0
[90.232537] Dynamic subtest ccs0: SKIP (0.000s)
[90.236590] Subtest busy-idle: SKIP (0.018s)
[90.271416] [008/133] (929s left) kms_tv_load_detect (load-detect)
[90.326314] Subtest load-detect: SKIP (0.000s)
[90.382883] [009/133] (929s left) kms_color (ctm-blue-to-red)
[90.486160] Starting subtest: ctm-blue-to-red
[90.488102] Starting dynamic subtest: pipe-A-eDP-1
[91.166430] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s)
[91.174587] Starting dynamic subtest: pipe-B-eDP-1
[92.572481] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s)
[92.581476] Starting dynamic subtest: pipe-C-eDP-1
[93.899078] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.324s)
[93.907442] Starting dynamic subtest: pipe-D-eDP-1
[95.230354] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[95.232731] Subtest ctm-blue-to-red: SUCCESS (4.744s)
[96.060948] [010/133] (924s left) kms_cursor_legacy (single-move)
[96.177513] Starting subtest: single-move
[96.179854] Starting dynamic subtest: pipe-A
[101.559123] Dynamic subtest pipe-A: SUCCESS (5.378s)
[101.568974] Starting dynamic subtest: pipe-B
[106.941644] Dynamic subtest pipe-B: SUCCESS (5.381s)
[106.951077] Starting dynamic subtest: pipe-C
[112.323068] Dynamic subtest pipe-C: SUCCESS (5.380s)
[112.332331] Starting dynamic subtest: pipe-D
[117.704939] Dynamic subtest pipe-D: SUCCESS (5.380s)
[117.714535] Starting dynamic subtest: all-pipes
[123.093891] Dynamic subtest all-pipes: SUCCESS (5.387s)
[123.096407] Subtest single-move: SUCCESS (26.914s)
[123.248917] [011/133] (897s left) kms_vrr (flip-basic-fastset)
[123.356617] Starting subtest: flip-basic-fastset
[123.363150] Subtest flip-basic-fastset: SKIP (0.000s)
[123.434910] [012/133] (896s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[123.497038] Starting subtest: multi-wait-available-unsubmitted-submitted
[123.499357] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[123.601485] [013/133] (896s left) kms_psr (pr-cursor-blt)
[123.693021] Starting subtest: pr-cursor-blt
[123.697194] Subtest pr-cursor-blt: SKIP (0.000s)
[123.763822] [014/133] (896s left) i915_power (sanity)
[123.831361] Starting subtest: sanity
[127.883561] Subtest sanity: SUCCESS (4.045s)
[129.962188] [015/133] (890s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[130.053851] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[130.438970] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[133.232988] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[133.242105] Starting dynamic subtest: pipe-A-eDP-1-4
[135.419078] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[135.429789] Starting dynamic subtest: pipe-A-eDP-1-4
[137.429423] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[137.440460] Starting dynamic subtest: pipe-A-eDP-1-x
[139.606470] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[139.977193] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[142.759822] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[142.770870] Starting dynamic subtest: pipe-B-eDP-1-4
[144.945775] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[144.955939] Starting dynamic subtest: pipe-B-eDP-1-4
[146.955844] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[146.966883] Starting dynamic subtest: pipe-B-eDP-1-x
[149.155892] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[149.528428] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[152.281236] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.760s)
[152.289167] Starting dynamic subtest: pipe-C-eDP-1-4
[154.455368] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[154.465101] Starting dynamic subtest: pipe-C-eDP-1-4
[156.466505] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[156.478907] Starting dynamic subtest: pipe-C-eDP-1-x
[158.644732] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.176s)
[159.009877] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[161.803079] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[161.811925] Starting dynamic subtest: pipe-D-eDP-1-4
[163.977449] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[163.986427] Starting dynamic subtest: pipe-D-eDP-1-4
[165.987317] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[165.997883] Starting dynamic subtest: pipe-D-eDP-1-x
[168.154808] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.167s)
[168.157270] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.102s)
[169.296814] [016/133] (851s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[169.409405] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[169.413763] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[169.503743] [017/133] (851s left) gem_userptr_blits (stress-mm-invalidate-close)
[169.575778] Starting subtest: stress-mm-invalidate-close
[171.726428] Subtest stress-mm-invalidate-close: SUCCESS (2.149s)
[171.863247] [018/133] (848s left) syncobj_basic (bad-flags-handle-to-fd)
[171.918132] Starting subtest: bad-flags-handle-to-fd
[171.920119] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[172.008916] [019/133] (848s left) kms_properties (invalid-properties-atomic)
[172.096913] Starting subtest: invalid-properties-atomic
[172.399924] Subtest invalid-properties-atomic: SUCCESS (0.303s)
[172.471251] [020/133] (848s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[172.525770] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[172.635486] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.109s)
[172.721704] [021/133] (848s left) i915_pm_rc6_residency (rc6-fence)
[172.771123] Starting subtest: rc6-fence
[172.791731] Starting dynamic subtest: gt0
[185.109834] Dynamic subtest gt0: SUCCESS (12.318s)
[185.120966] Starting dynamic subtest: gt1
[200.854431] Dynamic subtest gt1: SUCCESS (15.741s)
[200.857205] Subtest rc6-fence: SUCCESS (28.084s)
[200.943394] [022/133] (819s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[200.997113] Starting subtest: invalid-multi-wait-unsubmitted
[200.999370] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[201.093349] [023/133] (819s left) gem_mmap_gtt (hang-busy)
[201.138623] Subtest hang-busy: SKIP (0.000s)
[201.203473] [024/133] (819s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[201.303321] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[201.307366] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[201.380879] [025/133] (819s left) syncobj_timeline (single-wait-all-signaled)
[201.432987] Starting subtest: single-wait-all-signaled
[201.435076] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[201.531407] [026/133] (819s left) kms_flip (basic-flip-vs-dpms)
[201.619138] Starting subtest: basic-flip-vs-dpms
[201.621477] Starting dynamic subtest: A-eDP1
[204.194649] Dynamic subtest A-eDP1: SUCCESS (2.574s)
[204.204257] Starting dynamic subtest: B-eDP1
[206.351407] Dynamic subtest B-eDP1: SUCCESS (2.154s)
[206.360240] Starting dynamic subtest: C-eDP1
[208.679322] Dynamic subtest C-eDP1: SUCCESS (2.325s)
[208.688604] Starting dynamic subtest: D-eDP1
[210.760663] Dynamic subtest D-eDP1: SUCCESS (2.081s)
[210.764982] Subtest basic-flip-vs-dpms: SUCCESS (9.146s)
[211.553912] [027/133] (809s left) i915_hangman (hangcheck-unterminated)
[211.622255] Starting subtest: hangcheck-unterminated
[222.837871] Subtest hangcheck-unterminated: SUCCESS (11.214s)
[222.968815] [028/133] (798s left) gem_reg_read (timestamp-moving)
[223.027484] Starting subtest: timestamp-moving
[224.028249] Subtest timestamp-moving: SUCCESS (1.001s)
[224.120213] [029/133] (796s left) kms_invalid_mode (zero-vdisplay)
[224.226378] Starting subtest: zero-vdisplay
[224.228665] Starting dynamic subtest: pipe-A-eDP-1
[224.505689] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[224.514741] Starting dynamic subtest: pipe-B-eDP-1
[224.517073] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[224.525402] Starting dynamic subtest: pipe-C-eDP-1
[224.527598] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[224.535945] Starting dynamic subtest: pipe-D-eDP-1
[224.538178] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[224.540279] Subtest zero-vdisplay: SUCCESS (0.288s)
[225.370700] [030/133] (795s left) syncobj_wait (invalid-signal-illegal-handle)
[225.422900] Starting subtest: invalid-signal-illegal-handle
[225.424897] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[225.526414] [031/133] (795s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[225.625504] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[226.632073] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.007s)
[226.859755] [032/133] (794s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[226.958576] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[226.962822] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[227.061203] [033/133] (794s left) gem_userptr_blits (process-exit)
[227.124541] Starting subtest: process-exit
[227.131249] Subtest process-exit: SUCCESS (0.007s)
[227.262148] [034/133] (794s left) gem_exec_schedule (u-semaphore-resolve)
[227.331968] Starting subtest: u-semaphore-resolve
[227.360793] Subtest u-semaphore-resolve: SUCCESS (0.036s)
[227.693352] [035/133] (793s left) kms_busy (extended-modeset-hang-oldfb)
[227.793833] Starting subtest: extended-modeset-hang-oldfb
[227.796049] Starting dynamic subtest: pipe-A
[239.557420] Dynamic subtest pipe-A: SUCCESS (11.763s)
[239.568012] Starting dynamic subtest: pipe-D
[251.843800] Dynamic subtest pipe-D: SUCCESS (12.284s)
[251.846075] Subtest extended-modeset-hang-oldfb: SUCCESS (24.051s)
[252.713522] [036/133] (768s left) gem_mmap_wc (bad-object)
[252.767586] Subtest bad-object: SKIP (0.000s)
[252.820328] [037/133] (768s left) kms_pm_lpsp (screens-disabled)
[253.926858] Starting subtest: screens-disabled
[253.930881] Subtest screens-disabled: SKIP (0.000s)
[253.996680] [038/133] (767s left) kms_hdr (brightness-with-hdr)
[254.077065] Starting subtest: brightness-with-hdr
[254.083387] Subtest brightness-with-hdr: SKIP (0.000s)
[254.151310] [039/133] (767s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[254.248276] Starting subtest: fbc-rgb101010-draw-render
[258.840512] Subtest fbc-rgb101010-draw-render: SUCCESS (4.595s)
[260.041893] [040/133] (761s left) kms_content_protection (suspend-resume)
[260.182464] Starting subtest: suspend-resume
[260.187086] Subtest suspend-resume: SKIP (0.000s)
[260.317710] [041/133] (761s left) kms_psr (psr-suspend)
[260.418275] Starting subtest: psr-suspend
[260.420648] Starting dynamic subtest: eDP-1
[278.026286] Dynamic subtest eDP-1: SUCCESS (3.026s)
[278.028451] Subtest psr-suspend: SUCCESS (3.027s)
[278.880541] [042/133] (742s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[279.004724] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[279.008830] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[279.119291] [043/133] (742s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[279.220334] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[279.224475] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[279.304387] [044/133] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[279.431236] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[279.435942] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[279.533520] [045/133] (742s left) perf (gen12-group-concurrent-oa-buffer-read)
[279.664748] Starting subtest: gen12-group-concurrent-oa-buffer-read
[289.693770] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.024s)
[289.745376] [046/133] (732s left) kms_flip (nonexisting-fb)
[289.841463] Starting subtest: nonexisting-fb
[289.843891] Starting dynamic subtest: A-eDP1
[290.981372] Dynamic subtest A-eDP1: SUCCESS (1.139s)
[290.991285] Starting dynamic subtest: B-eDP1
[292.122075] Dynamic subtest B-eDP1: SUCCESS (1.138s)
[292.132184] Starting dynamic subtest: C-eDP1
[293.260822] Dynamic subtest C-eDP1: SUCCESS (1.138s)
[293.271402] Starting dynamic subtest: D-eDP1
[294.393940] Dynamic subtest D-eDP1: SUCCESS (1.131s)
[294.396351] Subtest nonexisting-fb: SUCCESS (4.555s)
[295.575735] [047/133] (726s left) kms_plane_lowres (tiling-yf)
[295.671042] Starting subtest: tiling-yf
[295.674964] Subtest tiling-yf: SKIP (0.000s)
[295.746890] [048/133] (726s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[295.839043] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[295.864981] Starting dynamic subtest: pipe-A-plane-0
[296.298217] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[296.308043] Starting dynamic subtest: pipe-A-plane-3
[296.553413] Dynamic subtest pipe-A-plane-3: SUCCESS (0.253s)
[296.563368] Starting dynamic subtest: pipe-A-plane-5
[296.567010] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[297.653523] Starting dynamic subtest: pipe-B-plane-0
[298.079179] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[298.092197] Starting dynamic subtest: pipe-B-plane-3
[298.334299] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[298.344708] Starting dynamic subtest: pipe-B-plane-5
[298.349394] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[298.642836] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.804s)
[299.528742] [049/133] (722s left) kms_addfb_basic (bad-pitch-63)
[299.596193] Starting subtest: bad-pitch-63
[299.598495] Subtest bad-pitch-63: SUCCESS (0.000s)
[299.754569] [050/133] (722s left) kms_feature_discovery (chamelium)
[299.864740] Starting subtest: chamelium
[299.869257] Subtest chamelium: SKIP (0.000s)
[299.938569] [051/133] (722s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[300.033520] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[300.037797] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[300.135043] [052/133] (721s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[300.238327] Starting subtest: random-ccs-data-y-tiled-ccs
[300.240575] Starting dynamic subtest: pipe-A-eDP-1
[300.266698] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[300.278660] Starting dynamic subtest: pipe-B-eDP-1
[300.302208] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[300.310734] Starting dynamic subtest: pipe-C-eDP-1
[300.334336] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[300.343630] Starting dynamic subtest: pipe-D-eDP-1
[300.367348] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[300.371662] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[302.409708] [053/133] (719s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[302.500285] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[302.504910] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[303.653404] [054/133] (718s left) gem_softpin (evict-single-offset)
[303.711703] Starting subtest: evict-single-offset
[331.468191] Subtest evict-single-offset: SUCCESS (27.751s)
[331.569967] [055/133] (690s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[331.724728] Starting subtest: cursorA-vs-flipA-varying-size
[342.907224] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.179s)
[343.765237] [056/133] (678s left) syncobj_wait (wait-zero-handles)
[343.846019] Starting subtest: wait-zero-handles
[343.848567] Subtest wait-zero-handles: SUCCESS (0.000s)
[343.958726] [057/133] (678s left) gem_exec_reloc (basic-wc-read-noreloc)
[344.028385] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[344.108481] [058/133] (678s left) gem_exec_whisper (basic-fds-forked-all)
[344.169880] Starting subtest: basic-fds-forked-all
[364.147759] Subtest basic-fds-forked-all: SUCCESS (19.972s)
[364.336098] [059/133] (658s left) kms_cursor_crc (cursor-onscreen-64x64)
[364.523766] Starting subtest: cursor-onscreen-64x64
[364.528739] Starting dynamic subtest: pipe-A-eDP-1
[366.731499] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.204s)
[366.763672] Starting dynamic subtest: pipe-D-eDP-1
[369.569439] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.814s)
[369.571731] Subtest cursor-onscreen-64x64: SUCCESS (5.045s)
[370.415146] [060/133] (652s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[370.529253] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[370.533385] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[370.614213] [061/133] (651s left) prime_mmap (test_dup)
[370.677621] Starting subtest: test_dup
[370.679825] Starting dynamic subtest: test_dup-smem
[370.705870] Dynamic subtest test_dup-smem: SUCCESS (0.030s)
[370.708402] Subtest test_dup: SUCCESS (0.031s)
[370.780725] [062/133] (651s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[370.878713] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[370.883228] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[370.967392] [063/133] (651s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[371.028445] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[371.030727] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[371.134075] [064/133] (651s left) gem_exec_balancer (indices)
[371.197091] Starting subtest: indices
[373.480550] Subtest indices: SUCCESS (2.282s)
[373.882061] [065/133] (648s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[373.986242] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[373.988574] Starting dynamic subtest: pipe-A
[375.226599] Dynamic subtest pipe-A: SUCCESS (1.242s)
[375.236590] Starting dynamic subtest: pipe-B
[377.442900] Dynamic subtest pipe-B: SUCCESS (2.215s)
[377.456056] Starting dynamic subtest: pipe-C
[378.621540] Dynamic subtest pipe-C: SUCCESS (1.177s)
[378.631649] Starting dynamic subtest: pipe-D
[379.833378] Dynamic subtest pipe-D: SUCCESS (1.211s)
[379.835732] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.850s)
[381.034912] [066/133] (641s left) kms_psr (psr2-dpms)
[381.130101] Starting subtest: psr2-dpms
[381.132405] Starting dynamic subtest: eDP-1
[384.062956] Dynamic subtest eDP-1: SUCCESS (2.932s)
[384.065098] Subtest psr2-dpms: SUCCESS (2.934s)
[384.940418] [067/133] (637s left) gem_userptr_blits (sd-probe)
[385.002462] Starting subtest: sd-probe
[385.004707] Subtest sd-probe: SUCCESS (0.000s)
[385.132512] [068/133] (637s left) kms_properties (get_properties-sanity-non-atomic)
[385.221325] Starting subtest: get_properties-sanity-non-atomic
[385.223579] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[385.293751] [069/133] (637s left) gem_fence_thrash (bo-write-verify-threaded-y)
[385.329892] Starting subtest: bo-write-verify-threaded-y
[385.352021] Subtest bo-write-verify-threaded-y: SKIP (0.021s)
[385.411992] [070/133] (637s left) gem_exec_schedule (preempt-other)
[385.480478] Starting subtest: preempt-other
[385.482447] Starting dynamic subtest: rcs0
[385.555009] Dynamic subtest rcs0: SUCCESS (0.082s)
[385.567585] Starting dynamic subtest: bcs0
[385.626917] Dynamic subtest bcs0: SUCCESS (0.071s)
[385.639481] Starting dynamic subtest: vcs0
[385.696209] Dynamic subtest vcs0: SUCCESS (0.069s)
[385.709094] Starting dynamic subtest: vcs1
[385.767760] Dynamic subtest vcs1: SUCCESS (0.069s)
[385.781948] Starting dynamic subtest: vecs0
[385.837812] Dynamic subtest vecs0: SUCCESS (0.071s)
[385.854037] Starting dynamic subtest: ccs0
[385.905191] Dynamic subtest ccs0: SUCCESS (0.066s)
[385.907589] Subtest preempt-other: SUCCESS (0.433s)
[387.546603] [071/133] (635s left) dmabuf_sync_file (export-wait-after-attach)
[387.599183] Starting subtest: export-wait-after-attach
[387.601568] Subtest export-wait-after-attach: SUCCESS (0.001s)
[387.655401] [072/133] (635s left) gem_tiling_max_stride
[387.783611] [073/133] (635s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[388.171601] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[388.937704] [074/133] (634s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[389.040885] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[389.043316] Starting dynamic subtest: pipe-A-eDP-1
[400.026558] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.986s)
[400.037820] Starting dynamic subtest: pipe-B-eDP-1
[411.776235] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.748s)
[411.778552] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.737s)
[412.641422] [075/133] (610s left) kms_big_fb (linear-addfb)
[412.746863] Starting subtest: linear-addfb
[412.749175] Subtest linear-addfb: SUCCESS (0.000s)
[412.861661] [076/133] (610s left) gem_exec_reloc (basic-cpu-gtt)
[412.923235] Subtest basic-cpu-gtt: SKIP (0.000s)
[412.994835] [077/133] (610s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[413.079284] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[413.081187] Starting dynamic subtest: pipe-A-eDP-1
[413.906022] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s)
[413.917268] Starting dynamic subtest: pipe-B-eDP-1
[415.591423] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.681s)
[415.601720] Starting dynamic subtest: pipe-C-eDP-1
[417.185114] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.594s)
[417.197341] Starting dynamic subtest: pipe-D-eDP-1
[418.674052] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.486s)
[418.676064] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.587s)
[419.864562] [078/133] (603s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[419.962990] Starting subtest: 2x-plain-flip-ts-check-interruptible
[419.973939] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[420.067617] [079/133] (603s left) perf (buffer-fill)
[420.187070] Starting subtest: buffer-fill
[420.189581] Starting dynamic subtest: 0-rcs0
[422.428246] Dynamic subtest 0-rcs0: SUCCESS (2.238s)
[422.439867] Starting dynamic subtest: 1-vcs1
[426.867182] Dynamic subtest 1-vcs1: SUCCESS (4.438s)
[426.869905] Subtest buffer-fill: SUCCESS (6.679s)
[426.912824] [080/133] (596s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[427.019582] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[427.023937] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[427.131853] [081/133] (596s left) gem_fenced_exec_thrash (no-spare-fences)
[427.191765] Subtest no-spare-fences: SKIP (0.000s)
[427.283756] [082/133] (596s left) gem_create (create-ext-set-pat)
[427.454065] Starting subtest: create-ext-set-pat
[427.456714] Subtest create-ext-set-pat: SUCCESS (0.001s)
[427.548668] [083/133] (595s left) gen9_exec_parse (bb-start-far)
[427.614540] Subtest bb-start-far: SKIP (0.000s)
[427.696077] [084/133] (595s left) gem_ringfill (basic-all)
[433.487507] Starting subtest: basic-all
[434.659309] Subtest basic-all: SUCCESS (1.170s)
[434.786502] [085/133] (588s left) gem_ctx_persistence (engines-mixed-process)
[434.839681] Starting subtest: engines-mixed-process
[434.842198] Starting dynamic subtest: rcs0
[436.516487] Dynamic subtest rcs0: SUCCESS (1.677s)
[436.529468] Starting dynamic subtest: bcs0
[438.490684] Dynamic subtest bcs0: SUCCESS (1.969s)
[438.502389] Starting dynamic subtest: vcs0
[440.506673] Dynamic subtest vcs0: SUCCESS (2.015s)
[440.517801] Starting dynamic subtest: vcs1
[442.456912] Dynamic subtest vcs1: SUCCESS (1.952s)
[442.469897] Starting dynamic subtest: vecs0
[444.473412] Dynamic subtest vecs0: SUCCESS (2.014s)
[444.484638] Starting dynamic subtest: ccs0
[446.458845] Dynamic subtest ccs0: SUCCESS (1.984s)
[446.461197] Subtest engines-mixed-process: SUCCESS (11.618s)
[446.563268] [086/133] (577s left) kms_psr (fbc-psr-sprite-plane-onoff)
[446.658076] Starting subtest: fbc-psr-sprite-plane-onoff
[446.660422] Starting dynamic subtest: eDP-1
[446.664746] Dynamic subtest eDP-1: SKIP (0.000s)
[446.669174] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[446.732449] [087/133] (576s left) gem_exec_params (invalid-batch-start-offset)
[446.791193] Starting subtest: invalid-batch-start-offset
[446.793410] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[446.914902] [088/133] (576s left) kms_lease (invalid-create-leases)
[447.010213] Starting subtest: invalid-create-leases
[447.016632] Subtest invalid-create-leases: SUCCESS (0.007s)
[447.129027] [089/133] (576s left) gem_exec_create (madvise)
[447.186154] Starting subtest: madvise
[447.188507] Starting dynamic subtest: smem
[468.551514] Dynamic subtest smem: SUCCESS (21.362s)
[468.554006] Subtest madvise: SUCCESS (21.363s)
[469.791685] [090/133] (553s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[469.851177] Starting subtest: multi-wait-all-for-submit-submitted
[469.959011] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[470.039905] [091/133] (553s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[470.106173] Starting subtest: legacy-engines-hostile-preempt
[470.108891] Starting dynamic subtest: render
[470.196480] Dynamic subtest render: SUCCESS (0.092s)
[470.208955] Starting dynamic subtest: bsd1
[471.504615] Dynamic subtest bsd1: SUCCESS (1.305s)
[471.516439] Starting dynamic subtest: bsd2
[473.478901] Dynamic subtest bsd2: SUCCESS (1.971s)
[473.494772] Starting dynamic subtest: blt
[473.537036] Dynamic subtest blt: SUCCESS (0.057s)
[473.552368] Starting dynamic subtest: vebox
[475.460639] Dynamic subtest vebox: SUCCESS (1.920s)
[475.463718] Subtest legacy-engines-hostile-preempt: SUCCESS (5.356s)
[475.542698] [092/133] (548s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[475.588073] Starting subtest: etime-single-wait-for-submit-submitted
[475.694973] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s)
[475.809735] [093/133] (548s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[475.917046] Starting subtest: fbc-psr2-primary-mmap-cpu
[475.919306] Starting dynamic subtest: eDP-1
[475.923764] Dynamic subtest eDP-1: SKIP (0.000s)
[475.928097] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.003s)
[475.999348] [094/133] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[476.095090] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[482.614652] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.521s)
[482.751504] [095/133] (541s left) kms_rotation_crc (cursor-rotation-180)
[482.855463] Starting subtest: cursor-rotation-180
[484.357956] Subtest cursor-rotation-180: SUCCESS (1.502s)
[485.569205] [096/133] (538s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[485.665569] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[485.667994] Starting dynamic subtest: pipe-A-default-mode
[486.820855] Dynamic subtest pipe-A-default-mode: SKIP (1.152s)
[486.825053] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.154s)
[486.967265] [097/133] (537s left) gem_fence_thrash (bo-write-verify-none)
[487.002826] Starting subtest: bo-write-verify-none
[487.025328] Subtest bo-write-verify-none: SKIP (0.021s)
[487.087153] [098/133] (537s left) kms_sequence (get-idle)
[487.188099] Starting subtest: get-idle
[487.190187] Starting dynamic subtest: pipe-A-eDP-1
[488.990962] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s)
[489.002196] Starting dynamic subtest: pipe-B-eDP-1
[491.458761] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.469s)
[491.469999] Starting dynamic subtest: pipe-C-eDP-1
[493.888396] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.425s)
[493.899687] Starting dynamic subtest: pipe-D-eDP-1
[496.320289] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.432s)
[496.322637] Subtest get-idle: SUCCESS (9.133s)
[497.167018] [099/133] (527s left) kms_cursor_edge_walk (64x64-top-edge)
[497.270363] Starting subtest: 64x64-top-edge
[497.272648] Starting dynamic subtest: pipe-A-eDP-1
[500.699186] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s)
[500.710950] Starting dynamic subtest: pipe-D-eDP-1
[503.845327] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.146s)
[503.847650] Subtest 64x64-top-edge: SUCCESS (6.576s)
[504.634878] [100/133] (519s left) perf_pmu (most-busy-idle-check-all)
[504.679351] Starting subtest: most-busy-idle-check-all
[504.681535] Starting dynamic subtest: rcs0
[506.507722] Dynamic subtest rcs0: SUCCESS (1.828s)
[506.521169] Starting dynamic subtest: bcs0
[508.491045] Dynamic subtest bcs0: SUCCESS (1.981s)
[508.504737] Starting dynamic subtest: vcs0
[510.475813] Dynamic subtest vcs0: SUCCESS (1.981s)
[510.490168] Starting dynamic subtest: vcs1
[512.459013] Dynamic subtest vcs1: SUCCESS (1.980s)
[512.470705] Starting dynamic subtest: vecs0
[514.443975] Dynamic subtest vecs0: SUCCESS (1.981s)
[514.458525] Starting dynamic subtest: ccs0
[516.491899] Dynamic subtest ccs0: SUCCESS (2.045s)
[516.495085] Subtest most-busy-idle-check-all: SUCCESS (11.814s)
[516.590954] [101/133] (507s left) prime_busy (hang-wait)
[516.657450] Starting subtest: hang-wait
[516.659868] Starting dynamic subtest: rcs0
[542.951564] Dynamic subtest rcs0: SUCCESS (26.289s)
[542.964462] Starting dynamic subtest: bcs0
[550.109210] Dynamic subtest bcs0: SUCCESS (7.153s)
[550.120845] Starting dynamic subtest: vcs0
[557.081321] Dynamic subtest vcs0: SUCCESS (6.972s)
[557.091683] Starting dynamic subtest: vcs1
[564.119034] Dynamic subtest vcs1: SUCCESS (7.036s)
[564.129097] Starting dynamic subtest: vecs0
[571.093791] Dynamic subtest vecs0: SUCCESS (6.971s)
[571.103522] Starting dynamic subtest: ccs0
[584.999200] Dynamic subtest ccs0: SUCCESS (13.903s)
[585.002087] Subtest hang-wait: SUCCESS (68.339s)
[585.143177] [102/133] (439s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[585.254094] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[585.258885] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[585.365222] [103/133] (438s left) syncobj_basic (bad-flags-fd-to-handle)
[585.424960] Starting subtest: bad-flags-fd-to-handle
[585.427177] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[585.545980] [104/133] (438s left) kms_cursor_crc (cursor-random-512x170)
[585.847821] Starting subtest: cursor-random-512x170
[585.852162] Subtest cursor-random-512x170: SKIP (0.001s)
[585.979869] [105/133] (438s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[586.075576] Starting subtest: plane-upscale-20x20-with-modifiers
[586.077358] Starting dynamic subtest: pipe-A
[586.410935] Dynamic subtest pipe-A: SUCCESS (0.338s)
[586.422546] Starting dynamic subtest: pipe-B
[587.830781] Dynamic subtest pipe-B: SUCCESS (1.417s)
[587.848541] Starting dynamic subtest: pipe-C
[589.266590] Dynamic subtest pipe-C: SUCCESS (1.434s)
[589.279354] Starting dynamic subtest: pipe-D
[590.700210] Dynamic subtest pipe-D: SUCCESS (1.433s)
[590.702355] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.627s)
[591.870722] [106/133] (432s left) kms_atomic (test-only)
[591.986600] Starting subtest: test-only
[592.058402] Starting dynamic subtest: pipe-A-eDP-1
[594.570567] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.514s)
[594.572977] Subtest test-only: SUCCESS (2.585s)
[595.369535] [107/133] (429s left) gem_exec_fence (syncobj-channel)
[595.842040] Starting subtest: syncobj-channel
[596.862735] Subtest syncobj-channel: SUCCESS (1.016s)
[597.602405] [108/133] (426s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[597.713461] Starting subtest: bad-rotation-90-y-tiled-ccs
[597.715722] Starting dynamic subtest: pipe-A-eDP-1
[597.738662] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[597.751379] Starting dynamic subtest: pipe-B-eDP-1
[597.773227] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[597.785856] Starting dynamic subtest: pipe-C-eDP-1
[597.805956] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[597.815226] Starting dynamic subtest: pipe-D-eDP-1
[597.836758] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[597.841143] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.014s)
[600.031488] [109/133] (424s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[600.416502] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[601.251617] [110/133] (423s left) api_intel_allocator (gem-pool)
[601.309425] Starting subtest: gem-pool
[601.315496] Subtest gem-pool: SUCCESS (0.008s)
[601.437033] [111/133] (423s left) gem_exec_reloc (basic-write-cpu)
[601.498310] Subtest basic-write-cpu: SKIP (0.000s)
[601.570643] [112/133] (423s left) gem_partial_pwrite_pread (reads-snoop)
[601.634568] Subtest reads-snoop: SKIP (0.000s)
[601.715090] [113/133] (423s left) gem_exec_params (invalid-bsd1-flag-on-render)
[601.770626] Starting subtest: invalid-bsd1-flag-on-render
[601.772987] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[601.875549] [114/133] (422s left) gem_busy (parallel)
[602.052408] Starting subtest: parallel
[602.054342] Starting dynamic subtest: rcs0
[603.468328] Dynamic subtest rcs0: SUCCESS (1.416s)
[603.482373] Starting dynamic subtest: bcs0
[605.516088] Dynamic subtest bcs0: SUCCESS (2.044s)
[605.533800] Starting dynamic subtest: vcs0
[607.500182] Dynamic subtest vcs0: SUCCESS (1.982s)
[607.513669] Starting dynamic subtest: vcs1
[609.484406] Dynamic subtest vcs1: SUCCESS (1.981s)
[609.498550] Starting dynamic subtest: vecs0
[611.469595] Dynamic subtest vecs0: SUCCESS (1.982s)
[611.483574] Starting dynamic subtest: ccs0
[613.516534] Dynamic subtest ccs0: SUCCESS (2.044s)
[613.519367] Subtest parallel: SUCCESS (11.466s)
[613.754208] [115/133] (411s left) api_intel_bb (render)
[613.809386] Starting subtest: render
[613.811761] Starting dynamic subtest: render-none-512
[613.917596] Dynamic subtest render-none-512: SUCCESS (0.107s)
[613.930213] Starting dynamic subtest: render-none-1024
[614.420982] Dynamic subtest render-none-1024: SUCCESS (0.502s)
[614.434395] Starting dynamic subtest: render-x-512
[614.505122] Dynamic subtest render-x-512: SUCCESS (0.085s)
[614.516074] Starting dynamic subtest: render-x-1024
[614.846126] Dynamic subtest render-x-1024: SUCCESS (0.338s)
[614.859377] Starting dynamic subtest: render-y-512
[614.932793] Dynamic subtest render-y-512: SUCCESS (0.087s)
[614.945496] Starting dynamic subtest: render-y-1024
[615.273474] Dynamic subtest render-y-1024: SUCCESS (0.339s)
[615.276203] Subtest render: SUCCESS (1.464s)
[615.400330] [116/133] (409s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[615.506476] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[615.510901] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[615.607066] [117/133] (409s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[615.709986] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[615.714411] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[615.806345] [118/133] (409s left) kms_fence_pin_leak
[616.005229] [119/133] (409s left) gem_exec_async (forked-writes)
[616.067960] Starting subtest: forked-writes
[616.070220] Starting dynamic subtest: rcs0
[616.093892] Dynamic subtest rcs0: SUCCESS (0.028s)
[616.107563] Starting dynamic subtest: bcs0
[616.117102] Dynamic subtest bcs0: SUCCESS (0.021s)
[616.127978] Starting dynamic subtest: vcs0
[616.143286] Dynamic subtest vcs0: SUCCESS (0.024s)
[616.154540] Starting dynamic subtest: vcs1
[616.166257] Dynamic subtest vcs1: SUCCESS (0.022s)
[616.177178] Starting dynamic subtest: vecs0
[616.192857] Dynamic subtest vecs0: SUCCESS (0.026s)
[616.204097] Starting dynamic subtest: ccs0
[616.216441] Dynamic subtest ccs0: SUCCESS (0.022s)
[616.218585] Subtest forked-writes: SUCCESS (0.152s)
[616.452871] [120/133] (408s left) gem_exec_balancer (semaphore)
[616.507856] Starting subtest: semaphore
[618.479651] Subtest semaphore: SUCCESS (1.971s)
[618.799209] [121/133] (406s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[618.896257] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[625.475625] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.581s)
[625.604672] [122/133] (399s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[625.709077] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[625.713369] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[625.814457] [123/133] (399s left) gem_pxp (protected-raw-src-copy-not-readible)
[625.931207] Starting subtest: protected-raw-src-copy-not-readible
[625.987726] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[626.098222] [124/133] (399s left) gem_lmem_swapping (heavy-multi)
[626.145652] Subtest heavy-multi: SKIP (0.000s)
[626.183787] [125/133] (399s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[626.256217] Starting subtest: map-fixed-invalidate-overlap-busy
[626.260701] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[626.373640] [126/133] (399s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[626.475889] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[626.480023] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[626.603056] [127/133] (398s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[626.696601] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[626.698243] Starting dynamic subtest: pipe-A-eDP-1
[626.929250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.206s)
[626.946734] Starting dynamic subtest: pipe-B-eDP-1
[628.213930] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.277s)
[628.227451] Starting dynamic subtest: pipe-C-eDP-1
[629.500367] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.285s)
[629.512701] Starting dynamic subtest: pipe-D-eDP-1
[630.722581] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[630.724793] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.998s)
[631.856256] [128/133] (393s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[631.960452] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[638.760266] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.804s)
[638.883048] [129/133] (386s left) gem_lmem_swapping (verify-ccs)
[638.933823] Subtest verify-ccs: SKIP (0.000s)
[638.977867] [130/133] (386s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[639.079311] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[639.747992] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[639.925848] [131/133] (385s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[640.036721] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[640.045795] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[640.138682] [132/133] (385s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[640.238875] Starting subtest: fbcpsr-slowdraw
[665.505680] Subtest fbcpsr-slowdraw: SUCCESS (25.266s)
[665.617021] [133/133] (360s left) gem_exec_flush (basic-uc-prw-default)
[665.682316] Starting subtest: basic-uc-prw-default
[671.141442] Subtest basic-uc-prw-default: SUCCESS (5.460s)
[671.339009] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: vgem_basic
results: parsing output: 3/ for test: kms_plane_alpha_blend
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: gem_exec_params
results: parsing output: 6/ for test: i915_drm_fdinfo
results: parsing output: 7/ for test: kms_tv_load_detect
results: parsing output: 8/ for test: kms_color
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_vrr
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: i915_power
results: parsing output: 14/ for test: kms_async_flips
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: syncobj_basic
results: parsing output: 18/ for test: kms_properties
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: i915_pm_rc6_residency
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: i915_hangman
results: parsing output: 27/ for test: gem_reg_read
results: parsing output: 28/ for test: kms_invalid_mode
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: kms_busy
results: parsing output: 35/ for test: gem_mmap_wc
results: parsing output: 36/ for test: kms_pm_lpsp
results: parsing output: 37/ for test: kms_hdr
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_content_protection
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_plane_lowres
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_feature_discovery
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gem_softpin
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: prime_mmap
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_exec_balancer
results: parsing output: 64/ for test: kms_plane_scaling
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: kms_properties
results: parsing output: 68/ for test: gem_fence_thrash
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: dmabuf_sync_file
results: parsing output: 71/ for test: gem_tiling_max_stride
results: parsing output: 72/ for test: kms_chamelium_edid
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_fenced_exec_thrash
results: parsing output: 81/ for test: gem_create
results: parsing output: 82/ for test: gen9_exec_parse
results: parsing output: 83/ for test: gem_ringfill
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: kms_lease
results: parsing output: 88/ for test: gem_exec_create
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_rotation_crc
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: gem_fence_thrash
results: parsing output: 97/ for test: kms_sequence
results: parsing output: 98/ for test: kms_cursor_edge_walk
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: prime_busy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: kms_atomic
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: api_intel_allocator
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_partial_pwrite_pread
results: parsing output: 112/ for test: gem_exec_params
results: parsing output: 113/ for test: gem_busy
results: parsing output: 114/ for test: api_intel_bb
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_fence_pin_leak
results: parsing output: 118/ for test: gem_exec_async
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: gem_lmem_swapping
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_lmem_swapping
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_flush
Done.