[56.681553] Initializing watchdogs
[56.681659]   /dev/watchdog0
[56.706204] [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]
[56.710167] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.712810] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.716221] [001/131] (960s left) gem_mmap_wc (copy)
[56.836458] Subtest copy: SKIP (0.000s)
[56.898268] [002/131] (960s left) kms_psr (fbc-pr-dpms)
[57.007409] Starting subtest: fbc-pr-dpms
[57.011890] Subtest fbc-pr-dpms: SKIP (0.000s)
[57.069836] [003/131] (960s left) gem_create (busy-create)
[57.129619] Starting subtest: busy-create
[57.131867] Starting dynamic subtest: smem0
[90.861924] Dynamic subtest smem0: SUCCESS (33.700s)
[90.863990] Subtest busy-create: SUCCESS (33.701s)
[91.037362] [004/131] (926s left) gem_exec_schedule (thriceslice)
[91.111231] Starting subtest: thriceslice
[91.113677] Starting dynamic subtest: rcs0
[91.158504] Dynamic subtest rcs0: SUCCESS (0.053s)
[91.168057] Starting dynamic subtest: bcs0
[91.215942] Dynamic subtest bcs0: SUCCESS (0.056s)
[91.223015] Starting dynamic subtest: vcs0
[91.250592] Dynamic subtest vcs0: SUCCESS (0.035s)
[91.256820] Starting dynamic subtest: vcs1
[91.280021] Dynamic subtest vcs1: SUCCESS (0.029s)
[91.287254] Starting dynamic subtest: vecs0
[91.331773] Dynamic subtest vecs0: SUCCESS (0.051s)
[91.343669] Starting dynamic subtest: ccs0
[91.363601] Dynamic subtest ccs0: SUCCESS (0.033s)
[91.366668] Subtest thriceslice: SUCCESS (0.258s)
[91.661922] [005/131] (925s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[91.761036] Starting subtest: psr-rgb101010-draw-mmap-cpu
[96.592130] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (4.835s)
[96.698401] [006/131] (920s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[96.806382] Starting subtest: fbcpsr-slowdraw
[119.829413] Subtest fbcpsr-slowdraw: SUCCESS (23.026s)
[119.955883] [007/131] (897s left) kms_frontbuffer_tracking (fbc-2p-rte)
[120.055762] Starting subtest: fbc-2p-rte
[120.060096] Subtest fbc-2p-rte: SKIP (0.000s)
[120.138410] [008/131] (897s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[120.235320] Starting subtest: flip-primary-invalidate-overlay
[132.639562] Subtest flip-primary-invalidate-overlay: SUCCESS (12.407s)
[132.967742] [009/131] (884s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[133.032241] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[133.136452] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[133.202417] [010/131] (884s left) kms_cursor_crc (cursor-offscreen-512x512)
[133.445804] Starting subtest: cursor-offscreen-512x512
[133.450544] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[133.603469] [011/131] (883s left) kms_cursor_crc (cursor-onscreen-128x128)
[133.790655] Starting subtest: cursor-onscreen-128x128
[133.793203] Starting dynamic subtest: pipe-A-eDP-1
[136.086697] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.292s)
[136.110518] Starting dynamic subtest: pipe-D-eDP-1
[139.096336] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.991s)
[139.102650] Subtest cursor-onscreen-128x128: SUCCESS (5.306s)
[139.880285] [012/131] (877s left) syncobj_timeline (invalid-wait-illegal-handle)
[139.945183] Starting subtest: invalid-wait-illegal-handle
[139.947498] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[140.056534] [013/131] (877s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[140.162928] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[140.166978] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[140.249498] [014/131] (877s left) kms_cursor_crc (cursor-suspend)
[140.371483] Starting subtest: cursor-suspend
[140.374404] Starting dynamic subtest: pipe-A-eDP-1
[172.849728] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.125s)
[172.860116] Starting dynamic subtest: pipe-D-eDP-1
[205.834790] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.567s)
[205.837751] Subtest cursor-suspend: SUCCESS (6.693s)
[206.715061] [015/131] (869s left) gem_exec_schedule (pi-ringfull)
[206.906469] Starting subtest: pi-ringfull
[206.908907] Starting dynamic subtest: rcs0
[207.028479] Dynamic subtest rcs0: SUCCESS (0.124s)
[207.043685] Starting dynamic subtest: bcs0
[207.107426] Dynamic subtest bcs0: SUCCESS (0.077s)
[207.122795] Starting dynamic subtest: vcs0
[207.183430] Dynamic subtest vcs0: SUCCESS (0.075s)
[207.198966] Starting dynamic subtest: vcs1
[207.259465] Dynamic subtest vcs1: SUCCESS (0.075s)
[207.273175] Starting dynamic subtest: vecs0
[207.335317] Dynamic subtest vecs0: SUCCESS (0.075s)
[207.351006] Starting dynamic subtest: ccs0
[207.409948] Dynamic subtest ccs0: SUCCESS (0.074s)
[207.412851] Subtest pi-ringfull: SUCCESS (0.503s)
[207.645360] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[207.648943] [016/131] (868s left) api_intel_allocator (standalone)
[207.712731] Starting subtest: standalone
[207.732670] Subtest standalone: SUCCESS (0.023s)
[207.875774] [017/131] (868s left) gem_exec_balancer (full-late-pulse)
[207.928685] Starting subtest: full-late-pulse
[212.475283] Subtest full-late-pulse: SUCCESS (4.519s)
[212.804474] [018/131] (863s left) kms_writeback (writeback-check-output)
[212.911161] Subtest writeback-check-output: SKIP (0.000s)
[212.949567] [019/131] (863s left) perf (blocking)
[213.059865] Starting subtest: blocking
[213.062080] Starting dynamic subtest: 0-rcs0
[223.096269] Dynamic subtest 0-rcs0: SUCCESS (10.014s)
[223.104660] Starting dynamic subtest: 1-vcs1
[233.127038] Dynamic subtest 1-vcs1: SUCCESS (10.022s)
[233.130154] Subtest blocking: SUCCESS (20.037s)
[233.171352] [020/131] (843s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[233.285948] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[233.292137] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[233.362437] [021/131] (843s left) kms_chamelium_audio (dp-audio)
[233.758240] Subtest dp-audio: SKIP (0.000s)
[234.586086] [022/131] (842s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[234.703502] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[235.560887] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.859s)
[235.741254] [023/131] (841s left) gem_exec_reloc (basic-gtt-wc-active)
[235.810189] Subtest basic-gtt-wc-active: SKIP (0.000s)
[235.883116] [024/131] (840s left) kms_hdr (static-toggle-dpms)
[235.985190] Starting subtest: static-toggle-dpms
[235.992497] Subtest static-toggle-dpms: SKIP (0.000s)
[236.053247] [025/131] (840s left) syncobj_wait (invalid-reset-bad-pad)
[236.118126] Starting subtest: invalid-reset-bad-pad
[236.120792] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[236.224061] [026/131] (840s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[236.328183] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[236.330669] Starting dynamic subtest: pipe-A-eDP-1
[236.354728] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[236.363688] Starting dynamic subtest: pipe-B-eDP-1
[236.390101] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[236.397839] Starting dynamic subtest: pipe-C-eDP-1
[236.424467] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[236.432123] Starting dynamic subtest: pipe-D-eDP-1
[236.458708] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[236.463349] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.002s)
[238.468031] [027/131] (838s left) gem_exec_reloc (basic-cpu-read)
[238.539421] Subtest basic-cpu-read: SKIP (0.000s)
[238.609401] [028/131] (838s left) kms_frontbuffer_tracking (fbc-stridechange)
[238.711176] Starting subtest: fbc-stridechange
[240.964070] Subtest fbc-stridechange: SUCCESS (2.256s)
[241.129713] [029/131] (835s left) gem_exec_balancer (bonded-sync)
[241.194705] Starting subtest: bonded-sync
[241.199982] Subtest bonded-sync: SKIP (0.000s)
[241.499184] [030/131] (835s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[241.599745] Starting subtest: fbc-dirtyfb-ioctl
[241.602598] Starting dynamic subtest: A-eDP-1
[243.224894] Dynamic subtest A-eDP-1: SUCCESS (1.620s)
[243.228005] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.621s)
[244.024503] [031/131] (833s left) kms_pm_rpm (modeset-non-lpsp)
[245.863098] Starting subtest: modeset-non-lpsp
[247.019311] Subtest modeset-non-lpsp: SKIP (1.154s)
[247.364533] [032/131] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[247.469901] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[247.475030] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[247.551556] [033/131] (829s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[247.658748] Starting subtest: psr-1p-primscrn-cur-indfb-move
[252.749637] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (5.093s)
[252.890218] [034/131] (824s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[252.985891] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[252.988351] Starting dynamic subtest: pipe-A-default-mode
[253.302750] Dynamic subtest pipe-A-default-mode: SKIP (0.313s)
[253.308414] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.314s)
[254.137926] [035/131] (823s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[254.238725] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[254.243887] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[254.329204] [036/131] (822s left) gem_ctx_isolation (preservation)
[254.399702] Starting subtest: preservation
[254.402504] Starting dynamic subtest: rcs0
[254.650694] Dynamic subtest rcs0: SUCCESS (0.249s)
[254.661758] Starting dynamic subtest: bcs0
[254.952050] Dynamic subtest bcs0: SUCCESS (0.301s)
[254.960482] Starting dynamic subtest: vcs0
[255.252688] Dynamic subtest vcs0: SUCCESS (0.300s)
[255.265210] Starting dynamic subtest: vcs1
[256.916452] Dynamic subtest vcs1: SUCCESS (1.663s)
[256.927532] Starting dynamic subtest: vecs0
[258.928936] Dynamic subtest vecs0: SUCCESS (2.011s)
[258.941775] Starting dynamic subtest: ccs0
[260.933395] Dynamic subtest ccs0: SUCCESS (2.003s)
[260.936090] Subtest preservation: SUCCESS (6.529s)
[261.174146] [037/131] (816s left) kms_plane_lowres (tiling-none)
[261.281423] Starting subtest: tiling-none
[261.284064] Starting dynamic subtest: pipe-A-eDP-1
[261.289049] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[261.587538] Starting dynamic subtest: pipe-B-eDP-1
[261.592352] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[261.601910] Starting dynamic subtest: pipe-C-eDP-1
[261.606957] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[261.615080] Starting dynamic subtest: pipe-D-eDP-1
[261.620169] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[261.624905] Subtest tiling-none: SKIP (0.303s)
[262.379145] [038/131] (815s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc)
[262.482101] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc
[267.042755] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.563s)
[267.173772] [039/131] (810s left) gem_close (basic)
[267.239542] Starting subtest: basic
[267.242633] Subtest basic: SUCCESS (0.000s)
[267.349357] [040/131] (810s left) prime_vgem (coherency-blt)
[267.434774] Starting subtest: coherency-blt
[268.417113] Subtest coherency-blt: SUCCESS (0.980s)
[268.535626] [041/131] (808s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[268.642156] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[268.644798] Starting dynamic subtest: pipe-A
[269.169928] Dynamic subtest pipe-A: SUCCESS (0.527s)
[269.179745] Starting dynamic subtest: pipe-B
[270.816536] Dynamic subtest pipe-B: SUCCESS (1.645s)
[270.826900] Starting dynamic subtest: pipe-C
[272.429414] Dynamic subtest pipe-C: SUCCESS (1.612s)
[272.437487] Starting dynamic subtest: pipe-D
[274.041559] Dynamic subtest pipe-D: SUCCESS (1.610s)
[274.044377] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (5.397s)
[275.135485] [042/131] (802s left) gem_render_tiled_blits (basic)
[275.199162] Subtest basic: SKIP (0.000s)
[275.274303] [043/131] (802s left) drm_read (invalid-buffer)
[275.427899] Starting subtest: invalid-buffer
[275.430702] Subtest invalid-buffer: SUCCESS (0.000s)
[275.571420] [044/131] (802s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[275.684597] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[275.689525] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[275.769438] [045/131] (801s left) gem_userptr_blits (stress-mm)
[275.837447] Starting subtest: stress-mm
[281.208969] Subtest stress-mm: SUCCESS (5.369s)
[281.358133] [046/131] (796s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[281.467667] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[281.471913] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[281.586752] [047/131] (796s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[281.687003] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[281.692050] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[281.786370] [048/131] (795s left) gem_exercise_blt (fast-copy)
[281.853488] Starting subtest: fast-copy
[281.855818] Starting dynamic subtest: linear-smem-smem
[281.875735] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[281.885172] Starting dynamic subtest: xmajor-smem-smem
[281.893384] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[281.901943] Starting dynamic subtest: tile4-smem-smem
[281.913267] Dynamic subtest tile4-smem-smem: SUCCESS (0.019s)
[281.923822] Starting dynamic subtest: tile64-smem-smem
[281.931472] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s)
[281.933918] Subtest fast-copy: SUCCESS (0.079s)
[282.043559] [049/131] (795s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[282.147613] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[282.150348] Starting dynamic subtest: pipe-A-eDP-1
[282.216901] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[282.225906] Starting dynamic subtest: pipe-B-eDP-1
[282.284711] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[282.293189] Starting dynamic subtest: pipe-C-eDP-1
[282.351673] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[282.360385] Starting dynamic subtest: pipe-D-eDP-1
[282.416505] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[282.420900] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[284.275805] [050/131] (793s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[284.342899] Starting subtest: etime-single-wait-for-submit-submitted
[284.449676] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s)
[284.521402] [051/131] (793s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[284.582438] Starting subtest: yf-tiled-ccs-to-y-tiled
[284.587774] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[284.763231] [052/131] (793s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[284.866525] Starting subtest: modeset-transition-nonblocking-fencing
[284.868807] Starting dynamic subtest: 1x-outputs
[295.407336] Dynamic subtest 1x-outputs: SUCCESS (10.542s)
[295.683593] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.818s)
[296.529159] [053/131] (781s left) gem_linear_blits (normal)
[296.919143] Starting subtest: normal
[300.944650] Subtest normal: SUCCESS (4.025s)
[301.173187] [054/131] (776s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[301.333471] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[301.335653] Starting dynamic subtest: pipe-A-default-mode
[304.032453] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s)
[304.035503] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.702s)
[304.809085] [055/131] (773s left) kms_psr (psr2-suspend)
[304.916683] Starting subtest: psr2-suspend
[304.919507] Starting dynamic subtest: eDP-1
[322.841909] Dynamic subtest eDP-1: SUCCESS (2.875s)
[322.844353] Subtest psr2-suspend: SUCCESS (2.877s)
[323.635301] [056/131] (769s left) gem_render_copy_redux (flink)
[323.706595] Starting subtest: flink
[324.573473] Subtest flink: SUCCESS (0.858s)
[324.719865] [057/131] (768s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[324.832999] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[325.897406] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.055s)
[326.069737] [058/131] (767s left) drm_fdinfo (busy-check-all)
[326.121451] Starting subtest: busy-check-all
[326.123942] Starting dynamic subtest: rcs0
[326.128865] Dynamic subtest rcs0: SKIP (0.004s)
[326.138873] Starting dynamic subtest: bcs0
[326.143208] Dynamic subtest bcs0: SKIP (0.000s)
[326.152137] Starting dynamic subtest: vcs0
[326.156639] Dynamic subtest vcs0: SKIP (0.000s)
[326.164777] Starting dynamic subtest: vcs1
[326.169712] Dynamic subtest vcs1: SKIP (0.000s)
[326.180117] Starting dynamic subtest: vecs0
[326.184751] Dynamic subtest vecs0: SKIP (0.000s)
[326.193405] Starting dynamic subtest: ccs0
[326.198111] Dynamic subtest ccs0: SKIP (0.000s)
[326.202324] Subtest busy-check-all: SKIP (0.008s)
[326.233491] [059/131] (766s left) kms_color (invalid-ctm-matrix-sizes)
[326.339032] Starting subtest: invalid-ctm-matrix-sizes
[326.341314] Starting dynamic subtest: pipe-A
[326.343624] Dynamic subtest pipe-A: SUCCESS (0.002s)
[326.354112] Starting dynamic subtest: pipe-B
[326.356569] Dynamic subtest pipe-B: SUCCESS (0.003s)
[326.366579] Starting dynamic subtest: pipe-C
[326.368766] Dynamic subtest pipe-C: SUCCESS (0.004s)
[326.379487] Starting dynamic subtest: pipe-D
[326.381830] Dynamic subtest pipe-D: SUCCESS (0.005s)
[326.383800] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.016s)
[326.421519] [060/131] (766s left) gem_mmap_gtt (cpuset-medium-copy)
[326.481001] Subtest cpuset-medium-copy: SKIP (0.000s)
[326.536224] [061/131] (766s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[326.642099] Starting subtest: plane-upscale-factor-0-25-with-rotation
[326.644275] Starting dynamic subtest: pipe-A
[326.871659] Dynamic subtest pipe-A: SUCCESS (0.227s)
[326.881098] Starting dynamic subtest: pipe-B
[328.146635] Dynamic subtest pipe-B: SUCCESS (1.266s)
[328.155634] Starting dynamic subtest: pipe-C
[329.476251] Dynamic subtest pipe-C: SUCCESS (1.322s)
[329.485624] Starting dynamic subtest: pipe-D
[330.809554] Dynamic subtest pipe-D: SUCCESS (1.326s)
[330.811914] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.144s)
[331.987684] [062/131] (761s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[332.096928] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[332.099830] Starting dynamic subtest: pipe-A-eDP-1
[332.125001] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[332.135814] Starting dynamic subtest: pipe-B-eDP-1
[332.158938] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[332.167348] Starting dynamic subtest: pipe-C-eDP-1
[332.190115] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[332.198359] Starting dynamic subtest: pipe-D-eDP-1
[332.223299] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[332.227598] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[334.254383] [063/131] (759s left) gem_softpin (invalid)
[334.319874] Starting subtest: invalid
[334.328624] Subtest invalid: SUCCESS (0.006s)
[334.454752] [064/131] (758s left) drm_fdinfo (virtual-busy-idle-all)
[334.495717] Starting subtest: virtual-busy-idle-all
[334.499822] Subtest virtual-busy-idle-all: SKIP (0.000s)
[334.560377] [065/131] (758s left) gem_spin_batch (legacy-resubmit)
[334.633631] Starting subtest: legacy-resubmit
[334.636380] Starting dynamic subtest: default
[334.641979] Dynamic subtest default: SUCCESS (0.006s)
[334.652700] Starting dynamic subtest: render
[334.655145] Dynamic subtest render: SUCCESS (0.001s)
[334.663574] Starting dynamic subtest: bsd
[334.665507] Dynamic subtest bsd: SUCCESS (0.003s)
[334.673133] Starting dynamic subtest: bsd1
[334.675030] Dynamic subtest bsd1: SUCCESS (0.002s)
[334.682659] Starting dynamic subtest: bsd2
[334.684615] Dynamic subtest bsd2: SUCCESS (0.001s)
[334.692100] Starting dynamic subtest: blt
[334.694008] Dynamic subtest blt: SUCCESS (0.002s)
[334.701821] Starting dynamic subtest: vebox
[334.703707] Dynamic subtest vebox: SUCCESS (0.003s)
[334.705651] Subtest legacy-resubmit: SUCCESS (0.022s)
[334.886575] [066/131] (758s left) gen7_exec_parse (oacontrol-tracking)
[334.954108] Subtest oacontrol-tracking: SKIP (0.000s)
[335.011896] [067/131] (758s left) gem_softpin (allocator-fork)
[335.080104] Starting subtest: allocator-fork
[337.299450] Subtest allocator-fork: SUCCESS (2.212s)
[337.445016] [068/131] (756s left) kms_prop_blob (invalid-get-prop)
[337.507957] Starting subtest: invalid-get-prop
[337.510425] Subtest invalid-get-prop: SUCCESS (0.000s)
[337.620508] [069/131] (755s left) api_intel_bb (misplaced-blitter)
[337.700287] Starting subtest: misplaced-blitter
[337.710508] Subtest misplaced-blitter: SUCCESS (0.013s)
[337.852346] [070/131] (755s left) gem_userptr_blits (usage-restrictions)
[337.922153] Starting subtest: usage-restrictions
[337.924301] Subtest usage-restrictions: SUCCESS (0.000s)
[338.067770] [071/131] (755s left) gem_create (create-massive)
[338.124516] Starting subtest: create-massive
[338.126688] Subtest create-massive: SUCCESS (0.000s)
[338.305597] [072/131] (755s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[338.414040] Starting subtest: fbc-psr2-sprite-mmap-gtt
[338.416347] Starting dynamic subtest: eDP-1
[338.420887] Dynamic subtest eDP-1: SKIP (0.000s)
[338.425524] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[338.479622] [073/131] (755s left) gem_workarounds (suspend-resume-context)
[338.540544] Starting subtest: suspend-resume-context
[354.435815] Subtest suspend-resume-context: SUCCESS (1.174s)
[354.561718] [074/131] (753s left) i915_query (engine-info)
[354.614475] Starting subtest: engine-info
[354.616783] Subtest engine-info: SUCCESS (0.006s)
[354.748249] [075/131] (753s left) vgem_basic (busy-fence)
[354.793099] Starting subtest: busy-fence
[354.795492] Subtest busy-fence: SUCCESS (0.000s)
[354.848713] [076/131] (753s left) i915_pm_rc6_residency (rc6-fence)
[354.905880] Starting subtest: rc6-fence
[354.938154] Starting dynamic subtest: gt0
[367.339258] Dynamic subtest gt0: SUCCESS (12.330s)
[367.351368] Starting dynamic subtest: gt1
[384.355626] Dynamic subtest gt1: SUCCESS (16.989s)
[384.358376] Subtest rc6-fence: SUCCESS (29.358s)
[384.429151] [077/131] (724s left) gem_lmem_swapping (verify-random)
[384.468583] Subtest verify-random: SKIP (0.000s)
[384.502131] [078/131] (724s left) kms_lease (master-vs-lease)
[384.609915] Starting subtest: master-vs-lease
[384.612330] Subtest master-vs-lease: SUCCESS (0.002s)
[384.724915] [079/131] (724s left) kms_invalid_mode (int-max-clock)
[384.821749] Starting subtest: int-max-clock
[384.824057] Starting dynamic subtest: pipe-A-eDP-1
[385.103516] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s)
[385.113527] Starting dynamic subtest: pipe-B-eDP-1
[385.115815] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[385.123958] Starting dynamic subtest: pipe-C-eDP-1
[385.126287] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[385.134764] Starting dynamic subtest: pipe-D-eDP-1
[385.137094] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[385.139524] Subtest int-max-clock: SUCCESS (0.286s)
[385.889927] [080/131] (722s left) gem_ctx_persistence (processes)
[385.956419] Starting subtest: processes
[387.436278] Subtest processes: SUCCESS (1.479s)
[387.509892] [081/131] (721s left) sw_sync (alloc_timeline)
[387.551258] Starting subtest: alloc_timeline
[387.553637] Subtest alloc_timeline: SUCCESS (0.000s)
[387.596669] [082/131] (721s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[387.650100] Subtest untiled-to-tiled: SKIP (0.000s)
[387.722265] [083/131] (721s left) gem_flink_basic (bad-open)
[387.790788] Starting subtest: bad-open
[387.793235] Subtest bad-open: SUCCESS (0.000s)
[387.897885] [084/131] (721s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[388.286379] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[389.095499] [085/131] (719s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[389.199551] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[389.204073] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[389.311031] [086/131] (719s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[389.418976] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[389.422937] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[389.504516] [087/131] (719s left) syncobj_timeline (wait-all-for-submit-snapshot)
[389.560109] Starting subtest: wait-all-for-submit-snapshot
[389.642194] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[389.711731] [088/131] (719s left) gen9_exec_parse (cmd-crossing-page)
[389.771615] Subtest cmd-crossing-page: SKIP (0.000s)
[389.838497] [089/131] (719s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[389.936782] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[389.941267] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[390.044495] [090/131] (719s left) syncobj_wait (single-wait-all-for-submit-signaled)
[390.106602] Starting subtest: single-wait-all-for-submit-signaled
[390.108745] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[390.187651] [091/131] (718s left) syncobj_timeline (single-wait-all-available-submitted)
[390.244712] Starting subtest: single-wait-all-available-submitted
[390.246613] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[390.354427] [092/131] (718s left) kms_atomic (plane-cursor-legacy)
[390.458209] Starting subtest: plane-cursor-legacy
[390.460493] Starting dynamic subtest: pipe-A-eDP-1
[390.837490] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s)
[390.839831] Subtest plane-cursor-legacy: SUCCESS (0.377s)
[391.643046] [093/131] (717s left) kms_addfb_basic (bad-pitch-0)
[391.707304] Starting subtest: bad-pitch-0
[391.709518] Subtest bad-pitch-0: SUCCESS (0.000s)
[391.848565] [094/131] (717s left) kms_vblank (query-idle-hang)
[391.944704] Starting subtest: query-idle-hang
[391.947087] Starting dynamic subtest: pipe-A-eDP-1
[418.203183] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.251s)
[418.219050] Starting dynamic subtest: pipe-D-eDP-1
[433.191417] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.983s)
[433.193460] Subtest query-idle-hang: SUCCESS (41.238s)
[433.992201] [095/131] (675s left) perf (global-sseu-config)
[434.089193] Starting subtest: global-sseu-config
[434.093680] Subtest global-sseu-config: SKIP (0.000s)
[434.125149] [096/131] (675s left) gem_partial_pwrite_pread (reads-snoop)
[434.195715] Subtest reads-snoop: SKIP (0.000s)
[434.280143] [097/131] (675s left) kms_dp_link_training (non-uhbr-sst)
[434.363744] Starting subtest: non-uhbr-sst
[434.372297] Subtest non-uhbr-sst: SKIP (0.000s)
[434.433169] [098/131] (675s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[434.530491] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[434.532921] Starting dynamic subtest: pipe-A-eDP-1
[434.555555] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[434.566762] Starting dynamic subtest: pipe-B-eDP-1
[434.588577] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[434.596718] Starting dynamic subtest: pipe-C-eDP-1
[434.617808] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[434.625739] Starting dynamic subtest: pipe-D-eDP-1
[434.650156] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[434.654813] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[436.637096] [099/131] (672s left) gem_mmap_offset (partial-mmap)
[436.695713] Starting subtest: partial-mmap
[436.698127] Starting dynamic subtest: smem0
[436.700541] Dynamic subtest smem0: SUCCESS (0.005s)
[436.702578] Subtest partial-mmap: SUCCESS (0.006s)
[436.812732] [100/131] (672s left) kms_chamelium_hpd (dp-hpd-fast)
[437.191796] Subtest dp-hpd-fast: SKIP (0.000s)
[437.949765] [101/131] (671s left) kms_psr (psr2-sprite-mmap-gtt)
[438.055748] Starting subtest: psr2-sprite-mmap-gtt
[438.057910] Starting dynamic subtest: eDP-1
[439.465769] Dynamic subtest eDP-1: SKIP (1.407s)
[439.470760] Subtest psr2-sprite-mmap-gtt: SKIP (1.409s)
[439.592207] [102/131] (669s left) kms_addfb_basic (bad-pitch-256)
[439.651583] Starting subtest: bad-pitch-256
[439.654077] Subtest bad-pitch-256: SUCCESS (0.000s)
[439.790182] [103/131] (669s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[444.838709] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[444.841129] Starting dynamic subtest: pipe-A-eDP-1
[456.874856] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.033s)
[456.884570] Starting dynamic subtest: pipe-B-eDP-1
[468.906329] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.031s)
[468.908745] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.067s)
[469.749035] [104/131] (639s left) gem_exec_fence (submit3)
[469.949020] Starting subtest: submit3
[469.953717] Subtest submit3: SKIP (0.000s)
[471.562918] [105/131] (638s left) gem_exec_schedule (noreorder)
[471.750882] Starting subtest: noreorder
[471.753535] Starting dynamic subtest: rcs0
[471.818688] Dynamic subtest rcs0: SUCCESS (0.067s)
[471.835775] Starting dynamic subtest: vcs0
[473.431892] Dynamic subtest vcs0: SUCCESS (1.610s)
[473.443846] Starting dynamic subtest: vcs1
[475.439641] Dynamic subtest vcs1: SUCCESS (2.005s)
[475.452398] Starting dynamic subtest: vecs0
[477.451853] Dynamic subtest vecs0: SUCCESS (2.010s)
[477.464369] Starting dynamic subtest: ccs0
[477.525441] Dynamic subtest ccs0: SUCCESS (0.073s)
[477.527827] Subtest noreorder: SUCCESS (5.776s)
[477.707554] [106/131] (632s left) i915_selftest (perf)
[481.208487] Starting subtest: perf
[481.211909] Starting dynamic subtest: engine_cs
[485.499961] Dynamic subtest engine_cs: SUCCESS (4.290s)
[485.509451] Starting dynamic subtest: request
[492.772883] Dynamic subtest request: SUCCESS (7.270s)
[492.781973] Starting dynamic subtest: migrate
[497.114051] Dynamic subtest migrate: SUCCESS (4.338s)
[497.123275] Starting dynamic subtest: region
[502.919242] Dynamic subtest region: SUCCESS (5.802s)
[502.922206] Subtest perf: SUCCESS (21.708s)
[502.945302] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[502.946306] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[502.949460] [107/131] (606s left) perf_pmu (idle)
[504.263168] Starting subtest: idle
[504.265555] Starting dynamic subtest: rcs0
[504.839067] Dynamic subtest rcs0: SUCCESS (0.573s)
[504.850678] Starting dynamic subtest: bcs0
[505.366375] Dynamic subtest bcs0: SUCCESS (0.527s)
[505.378026] Starting dynamic subtest: vcs0
[505.898196] Dynamic subtest vcs0: SUCCESS (0.528s)
[505.909587] Starting dynamic subtest: vcs1
[506.428267] Dynamic subtest vcs1: SUCCESS (0.527s)
[506.438533] Starting dynamic subtest: vecs0
[506.959750] Dynamic subtest vecs0: SUCCESS (0.525s)
[506.969541] Starting dynamic subtest: ccs0
[507.486506] Dynamic subtest ccs0: SUCCESS (0.528s)
[507.489188] Subtest idle: SUCCESS (3.221s)
[507.562833] [FACT perf_pmu (idle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[507.564583] [FACT perf_pmu (idle)] new: kernel.kmod_is_loaded.i915: true
[507.568674] [108/131] (602s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[507.684959] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[507.689245] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[507.788327] [109/131] (602s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[507.851705] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[507.958301] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[508.028529] [110/131] (601s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[508.127456] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[511.653111] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.530s)
[511.783937] [111/131] (598s left) gem_exec_flush (basic-uc-ro-default)
[511.847246] Starting subtest: basic-uc-ro-default
[517.327240] Subtest basic-uc-ro-default: SUCCESS (5.478s)
[517.508914] [112/131] (592s left) kms_flip (2x-flip-vs-panning)
[517.621726] Starting subtest: 2x-flip-vs-panning
[517.632398] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[517.704942] [113/131] (592s left) gem_pread (snoop)
[517.775650] Subtest snoop: SKIP (0.000s)
[517.842584] [114/131] (592s left) kms_flip (2x-flip-vs-suspend)
[517.935865] Starting subtest: 2x-flip-vs-suspend
[517.947089] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[518.021337] [115/131] (592s left) kms_plane_scaling (planes-upscale-20x20)
[518.124796] Starting subtest: planes-upscale-20x20
[518.127098] Starting dynamic subtest: pipe-A
[518.190777] Dynamic subtest pipe-A: SUCCESS (0.066s)
[518.200616] Starting dynamic subtest: pipe-B
[519.275473] Dynamic subtest pipe-B: SUCCESS (1.083s)
[519.291194] Starting dynamic subtest: pipe-C
[520.372979] Dynamic subtest pipe-C: SUCCESS (1.096s)
[520.381778] Starting dynamic subtest: pipe-D
[521.494213] Dynamic subtest pipe-D: SUCCESS (1.119s)
[521.496464] Subtest planes-upscale-20x20: SUCCESS (3.369s)
[522.641036] [116/131] (587s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[522.753831] Starting subtest: x-tiled-16bpp-rotate-90
[522.774510] Subtest x-tiled-16bpp-rotate-90: SKIP (0.021s)
[522.913615] [117/131] (587s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[523.041967] Starting subtest: flip-vs-cursor-crc-atomic
[523.647161] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.605s)
[524.466048] [118/131] (585s left) syncobj_wait (single-wait-all-submitted)
[524.526282] Starting subtest: single-wait-all-submitted
[524.631196] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[524.702715] [119/131] (585s left) gem_exec_fence (syncobj-repeat)
[525.109850] Starting subtest: syncobj-repeat
[525.279317] Subtest syncobj-repeat: SUCCESS (0.168s)
[526.539042] [120/131] (583s left) kms_flip (flip-vs-expired-vblank-interruptible)
[526.635134] Starting subtest: flip-vs-expired-vblank-interruptible
[526.637453] Starting dynamic subtest: A-eDP1
[535.280113] Dynamic subtest A-eDP1: SUCCESS (8.641s)
[535.288829] Starting dynamic subtest: B-eDP1
[544.005330] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[544.015969] Starting dynamic subtest: C-eDP1
[552.619514] Dynamic subtest C-eDP1: SUCCESS (8.610s)
[552.629375] Starting dynamic subtest: D-eDP1
[561.244779] Dynamic subtest D-eDP1: SUCCESS (8.621s)
[561.247159] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.602s)
[562.410321] [121/131] (547s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[562.517375] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[565.227174] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.713s)
[565.370132] [122/131] (544s left) kms_psr (pr-cursor-plane-onoff)
[565.460456] Starting subtest: pr-cursor-plane-onoff
[565.464200] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[565.528341] [123/131] (544s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[565.633739] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[565.637114] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[565.721281] [124/131] (544s left) core_getstats
[565.887691] [125/131] (544s left) gem_exec_gttfill (basic)
[565.952959] Starting subtest: basic
[570.548366] Subtest basic: SUCCESS (4.592s)
[570.732126] [126/131] (539s left) sw_sync (alloc_fence_invalid_timeline)
[570.810995] Starting subtest: alloc_fence_invalid_timeline
[570.813469] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[570.869665] [127/131] (539s left) kms_flip (plain-flip-fb-recreate)
[570.978794] Starting subtest: plain-flip-fb-recreate
[570.981090] Starting dynamic subtest: A-eDP1
[579.932786] Dynamic subtest A-eDP1: SUCCESS (8.951s)
[579.942126] Starting dynamic subtest: B-eDP1
[588.772811] Dynamic subtest B-eDP1: SUCCESS (8.841s)
[588.780847] Starting dynamic subtest: C-eDP1
[597.681714] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[597.690313] Starting dynamic subtest: D-eDP1
[606.608902] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[606.613755] Subtest plain-flip-fb-recreate: SUCCESS (35.639s)
[607.771431] [128/131] (502s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[607.879249] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[607.883612] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[607.953303] [129/131] (502s left) api_intel_allocator (alloc-simple)
[608.021991] Starting subtest: alloc-simple
[608.024534] Subtest alloc-simple: SUCCESS (0.004s)
[608.145741] [130/131] (502s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[613.122237] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[613.127201] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[613.975525] [131/131] (496s left) gem_pxp (create-regular-context-2)
[614.102803] Starting subtest: create-regular-context-2
[614.105327] Subtest create-regular-context-2: SUCCESS (0.002s)
[614.202035] Closing watchdogs
Done.