[59.599033] Initializing watchdogs
[59.599097]   /dev/watchdog0
[59.613163] [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.617427] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.620028] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.623203] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[59.740269] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[59.744161] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[59.837513] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[59.938161] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[59.942179] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[60.020679] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[60.131577] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[60.808561] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.680s)
[61.001685] [004/133] (959s left) gen7_exec_parse (basic-offset)
[61.077219] Subtest basic-offset: SKIP (0.000s)
[61.141250] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[61.244603] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[65.499618] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.257s)
[66.646359] [006/133] (953s left) tools_test (tools_test)
[66.698761] Starting subtest: tools_test
[66.748729] Subtest tools_test: SUCCESS (0.065s)
[66.821370] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[66.919238] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[66.923806] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[68.071609] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[68.164542] Starting subtest: modeset-vs-vblank-race
[68.166898] Starting dynamic subtest: A-eDP1
[72.895157] Dynamic subtest A-eDP1: SUCCESS (4.733s)
[72.902825] Starting dynamic subtest: B-eDP1
[77.640529] Dynamic subtest B-eDP1: SUCCESS (4.743s)
[77.650904] Starting dynamic subtest: C-eDP1
[82.183380] Dynamic subtest C-eDP1: SUCCESS (4.541s)
[82.191553] Starting dynamic subtest: D-eDP1
[86.738456] Dynamic subtest D-eDP1: SUCCESS (4.554s)
[86.740716] Subtest modeset-vs-vblank-race: SUCCESS (18.580s)
[87.910932] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[90.044607] Starting subtest: reg-read-ioctl
[92.427870] Subtest reg-read-ioctl: SUCCESS (2.382s)
[92.811839] [010/133] (927s left) gem_exec_balancer (hang)
[93.067385] Starting subtest: hang
[94.936737] Subtest hang: SUCCESS (1.869s)
[95.076827] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[95.178987] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[95.183428] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[95.252995] [012/133] (925s left) perf_pmu (faulting-read)
[95.295486] Starting subtest: faulting-read
[95.297723] Starting dynamic subtest: wb
[95.300034] Dynamic subtest wb: SUCCESS (0.001s)
[95.310076] Starting dynamic subtest: wc
[95.312318] Dynamic subtest wc: SUCCESS (0.000s)
[95.322607] Starting dynamic subtest: uc
[95.324924] Dynamic subtest uc: SUCCESS (0.000s)
[95.327107] Subtest faulting-read: SUCCESS (0.002s)
[95.395229] [013/133] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[95.494614] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[95.499047] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[95.587180] [014/133] (925s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[95.968059] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[96.802978] [015/133] (923s left) gem_exec_schedule (pi-distinct-iova)
[96.989675] Starting subtest: pi-distinct-iova
[96.991991] Starting dynamic subtest: rcs0
[97.059861] Dynamic subtest rcs0: SUCCESS (0.072s)
[97.068437] Starting dynamic subtest: vcs0
[97.122693] Dynamic subtest vcs0: SUCCESS (0.061s)
[97.135061] Starting dynamic subtest: vcs1
[97.183915] Dynamic subtest vcs1: SUCCESS (0.063s)
[97.193361] Starting dynamic subtest: vecs0
[97.249783] Dynamic subtest vecs0: SUCCESS (0.065s)
[97.259016] Starting dynamic subtest: ccs0
[97.311981] Dynamic subtest ccs0: SUCCESS (0.062s)
[97.314531] Subtest pi-distinct-iova: SUCCESS (0.325s)
[98.994203] [016/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[99.097495] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[99.101724] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[99.187631] [017/133] (921s left) drm_read (short-buffer-block)
[99.325045] Starting subtest: short-buffer-block
[99.327466] Subtest short-buffer-block: SUCCESS (0.000s)
[99.451995] [018/133] (921s left) perf (oa-formats)
[99.560114] Starting subtest: oa-formats
[99.562077] Starting dynamic subtest: 0-rcs0
[99.573394] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[99.583079] Starting dynamic subtest: 1-vcs0
[99.594992] Dynamic subtest 1-vcs0: SUCCESS (0.021s)
[99.597312] Subtest oa-formats: SUCCESS (0.037s)
[99.640970] [019/133] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[99.728569] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[99.732821] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[99.825981] [020/133] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[99.936405] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[99.940828] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[100.027383] [021/133] (920s left) kms_psr (pr-basic)
[100.118468] Starting subtest: pr-basic
[100.121833] Subtest pr-basic: SKIP (0.000s)
[100.184380] [022/133] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[100.279164] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[100.281084] Starting dynamic subtest: pipe-A-eDP-1
[100.301106] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.311570] Starting dynamic subtest: pipe-B-eDP-1
[100.328937] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.336026] Starting dynamic subtest: pipe-C-eDP-1
[100.353926] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.361168] Starting dynamic subtest: pipe-D-eDP-1
[100.379752] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.383474] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[102.580755] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[102.978756] Subtest hdmi-mode-timings: SKIP (0.000s)
[103.786325] [024/133] (917s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[103.922095] Starting subtest: dp-mst-lic-type-0-hdcp14
[103.926864] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[104.039972] [025/133] (916s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[104.136810] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[104.141251] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[104.201871] [026/133] (916s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[104.293429] Starting subtest: primary-4-tiled-reflect-x-180
[111.319927] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.028s)
[112.562095] [027/133] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[112.654082] Starting subtest: 2x-flip-vs-panning-interruptible
[112.665218] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[112.740797] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[112.849483] Starting subtest: plain-flip-fb-recreate
[112.851886] Starting dynamic subtest: A-eDP1
[121.752309] Dynamic subtest A-eDP1: SUCCESS (8.903s)
[121.762676] Starting dynamic subtest: B-eDP1
[130.577895] Dynamic subtest B-eDP1: SUCCESS (8.824s)
[130.588104] Starting dynamic subtest: C-eDP1
[139.389639] Dynamic subtest C-eDP1: SUCCESS (8.810s)
[139.404501] Starting dynamic subtest: D-eDP1
[148.219608] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[148.224042] Subtest plain-flip-fb-recreate: SUCCESS (35.376s)
[149.388497] [029/133] (871s left) gem_tiled_partial_pwrite_pread (writes)
[149.456221] Subtest writes: SKIP (0.000s)
[149.502259] [030/133] (871s left) gem_lmem_swapping (heavy-verify-random)
[149.547838] Subtest heavy-verify-random: SKIP (0.000s)
[149.590043] [031/133] (871s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[149.683109] Starting subtest: x-tiled-64bpp-rotate-90
[149.702421] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[149.811726] [032/133] (871s left) vgem_basic (debugfs)
[149.912990] Starting subtest: debugfs
[149.915287] Subtest debugfs: SUCCESS (0.000s)
[149.966865] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[149.970170] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[150.059066] Starting subtest: legacy-setmode
[150.061403] Starting dynamic subtest: pipe-A-eDP-1
[157.003646] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.943s)
[157.005554] Subtest legacy-setmode: SUCCESS (6.944s)
[157.853362] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[157.974463] Starting subtest: reject-modify-context-protection-off-2
[157.976913] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[158.084942] [035/133] (863s left) gem_exec_basic (basic)
[158.155439] Starting subtest: basic
[158.157971] Starting dynamic subtest: rcs0-smem
[158.160248] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[158.173248] Starting dynamic subtest: bcs0-smem
[158.177082] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[158.187731] Starting dynamic subtest: vcs0-smem
[158.189947] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[158.197505] Starting dynamic subtest: vcs1-smem
[158.199740] Dynamic subtest vcs1-smem: SUCCESS (0.003s)
[158.207297] Starting dynamic subtest: vecs0-smem
[158.209497] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[158.216843] Starting dynamic subtest: ccs0-smem
[158.219094] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[158.221254] Subtest basic: SUCCESS (0.023s)
[159.931248] [036/133] (861s left) api_intel_bb (offset-control)
[159.986920] Starting subtest: offset-control
[160.000064] Subtest offset-control: SUCCESS (0.015s)
[160.130187] [037/133] (861s left) kms_joiner (basic-max-non-joiner)
[160.230130] Starting subtest: basic-max-non-joiner
[160.234303] Subtest basic-max-non-joiner: SKIP (0.000s)
[160.294820] [038/133] (861s left) kms_addfb_basic (small-bo)
[160.386614] Starting subtest: small-bo
[160.388834] Subtest small-bo: SUCCESS (0.000s)
[160.491021] [039/133] (861s left) i915_query (query-topology-garbage-items)
[160.558488] Starting subtest: query-topology-garbage-items
[160.560689] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[160.649897] [040/133] (860s left) perf (gen12-group-exclusive-stream-ctx-handle)
[160.751956] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[160.774216] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.021s)
[160.812748] [041/133] (860s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[161.957686] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[161.962305] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[162.060336] [042/133] (859s left) gem_exec_params (cliprects-invalid)
[162.116148] Starting subtest: cliprects-invalid
[162.118469] Subtest cliprects-invalid: SUCCESS (0.000s)
[162.219959] [043/133] (859s left) kms_cursor_crc (cursor-random-64x64)
[162.398788] Starting subtest: cursor-random-64x64
[162.401096] Starting dynamic subtest: pipe-A-eDP-1
[165.736241] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.335s)
[165.761210] Starting dynamic subtest: pipe-D-eDP-1
[169.768227] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.011s)
[169.770499] Subtest cursor-random-64x64: SUCCESS (7.369s)
[170.616865] [044/133] (851s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[170.724792] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[170.728749] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[170.827385] [045/133] (850s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[170.942765] Starting subtest: 4-tiled-16bpp-rotate-180
[172.278767] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.337s)
[172.436706] [046/133] (849s left) dumb_buffer (create-valid-dumb)
[172.492699] Starting subtest: create-valid-dumb
[172.494491] Subtest create-valid-dumb: SUCCESS (0.000s)
[172.581926] [047/133] (849s left) gem_softpin (zero)
[172.641880] Starting subtest: zero
[172.646168] Subtest zero: SUCCESS (0.004s)
[172.764550] [048/133] (849s left) gem_blits (basic)
[172.818189] Starting subtest: basic
[174.193214] Subtest basic: SUCCESS (1.374s)
[174.300855] [049/133] (847s left) gem_busy (close-race)
[174.364032] Starting subtest: close-race
[197.911811] Subtest close-race: SUCCESS (23.547s)
[198.274387] [050/133] (823s left) gem_exec_alignment (forked)
[198.381799] Starting subtest: forked
[238.176412] Subtest forked: SUCCESS (39.740s)
[238.232368] [051/133] (783s left) syncobj_eventfd (binary-wait-before-signal)
[238.333516] Starting subtest: binary-wait-before-signal
[238.364289] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[238.457303] [052/133] (783s left) prime_mmap (test_errors)
[238.516108] Starting subtest: test_errors
[238.518316] Starting dynamic subtest: test_errors-smem
[238.615398] Dynamic subtest test_errors-smem: SUCCESS (0.100s)
[238.618153] Subtest test_errors: SUCCESS (0.101s)
[238.720670] [053/133] (783s left) gem_ctx_persistence (heartbeat-stop)
[238.789542] Starting subtest: heartbeat-stop
[238.793943] Subtest heartbeat-stop: SKIP (0.000s)
[238.894058] [054/133] (783s left) gem_ctx_param (invalid-get-ringsize)
[238.948798] Starting subtest: invalid-get-ringsize
[238.951020] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[239.063343] [055/133] (783s left) i915_query (query-topology-matches-eu-total)
[239.119507] Starting subtest: query-topology-matches-eu-total
[239.121800] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[239.212732] [056/133] (783s left) kms_cursor_edge_walk (64x64-right-edge)
[239.319894] Starting subtest: 64x64-right-edge
[239.321878] Starting dynamic subtest: pipe-A-eDP-1
[242.786056] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.465s)
[242.795299] Starting dynamic subtest: pipe-D-eDP-1
[245.904802] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[245.906929] Subtest 64x64-right-edge: SUCCESS (6.585s)
[246.720713] [057/133] (775s left) kms_plane (plane-position-covered)
[246.814981] Starting subtest: plane-position-covered
[247.319889] Starting dynamic subtest: pipe-A-plane-1
[248.704159] Dynamic subtest pipe-A-plane-1: SUCCESS (1.382s)
[248.717577] Starting dynamic subtest: pipe-A-plane-2
[249.950417] Dynamic subtest pipe-A-plane-2: SUCCESS (1.245s)
[249.959308] Starting dynamic subtest: pipe-A-plane-3
[251.342243] Dynamic subtest pipe-A-plane-3: SUCCESS (1.391s)
[251.351457] Starting dynamic subtest: pipe-A-plane-4
[252.623350] Dynamic subtest pipe-A-plane-4: SUCCESS (1.278s)
[252.633270] Starting dynamic subtest: pipe-A-plane-5
[252.649100] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[253.861763] Starting dynamic subtest: pipe-B-plane-1
[255.176595] Dynamic subtest pipe-B-plane-1: SUCCESS (1.321s)
[255.186845] Starting dynamic subtest: pipe-B-plane-2
[256.390441] Dynamic subtest pipe-B-plane-2: SUCCESS (1.214s)
[256.401142] Starting dynamic subtest: pipe-B-plane-3
[257.613680] Dynamic subtest pipe-B-plane-3: SUCCESS (1.222s)
[257.624261] Starting dynamic subtest: pipe-B-plane-4
[258.855730] Dynamic subtest pipe-B-plane-4: SUCCESS (1.241s)
[258.865992] Starting dynamic subtest: pipe-B-plane-5
[258.884064] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[258.886385] Subtest plane-position-covered: SUCCESS (12.070s)
[259.681573] [058/133] (762s left) kms_frontbuffer_tracking (psr-suspend)
[259.777541] Starting subtest: psr-suspend
[298.115620] Subtest psr-suspend: SUCCESS (8.086s)
[298.250085] [059/133] (724s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[298.364902] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[298.368955] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[298.479516] [060/133] (723s left) gem_exec_schedule (fairslice)
[298.559047] Starting subtest: fairslice
[298.561424] Starting dynamic subtest: rcs0
[300.574122] Dynamic subtest rcs0: SUCCESS (2.019s)
[300.585776] Starting dynamic subtest: bcs0
[302.594093] Dynamic subtest bcs0: SUCCESS (2.015s)
[302.605632] Starting dynamic subtest: vcs0
[304.614890] Dynamic subtest vcs0: SUCCESS (2.017s)
[304.624757] Starting dynamic subtest: vcs1
[306.631565] Dynamic subtest vcs1: SUCCESS (2.014s)
[306.642435] Starting dynamic subtest: vecs0
[308.701188] Dynamic subtest vecs0: SUCCESS (2.016s)
[308.713737] Starting dynamic subtest: ccs0
[310.667403] Dynamic subtest ccs0: SUCCESS (2.017s)
[310.669464] Subtest fairslice: SUCCESS (12.105s)
[310.980171] [061/133] (711s left) sw_sync (alloc_fence_invalid_timeline)
[311.036574] Starting subtest: alloc_fence_invalid_timeline
[311.039101] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[311.097974] [062/133] (711s left) gem_exec_whisper (basic-fds-forked)
[311.154866] Starting subtest: basic-fds-forked
[334.356170] Subtest basic-fds-forked: SUCCESS (23.185s)
[334.548313] [063/133] (688s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[334.650002] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[334.654557] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[334.746180] [064/133] (687s left) gem_vm_create (execbuf)
[334.802715] Starting subtest: execbuf
[334.810142] Subtest execbuf: SUCCESS (0.008s)
[334.926791] [065/133] (687s left) kms_cursor_crc (cursor-onscreen-256x85)
[335.170298] Starting subtest: cursor-onscreen-256x85
[335.216274] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[335.377203] [066/133] (687s left) kms_plane_alpha_blend (coverage-7efc)
[335.468403] Starting subtest: coverage-7efc
[335.764311] Starting dynamic subtest: pipe-A-eDP-1
[336.364493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[336.395589] Starting dynamic subtest: pipe-D-eDP-1
[337.682265] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s)
[337.684679] Subtest coverage-7efc: SUCCESS (2.214s)
[338.491511] [067/133] (684s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[338.594590] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[338.596743] Starting dynamic subtest: pipe-A
[338.614521] Dynamic subtest pipe-A: SKIP (0.016s)
[338.625256] Starting dynamic subtest: pipe-B
[338.643068] Dynamic subtest pipe-B: SKIP (0.029s)
[338.653427] Starting dynamic subtest: pipe-C
[338.673781] Dynamic subtest pipe-C: SKIP (0.029s)
[338.683752] Starting dynamic subtest: pipe-D
[338.702003] Dynamic subtest pipe-D: SKIP (0.029s)
[338.705820] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.105s)
[338.800736] [068/133] (683s left) vgem_basic (busy-fence)
[338.849170] Starting subtest: busy-fence
[338.851047] Subtest busy-fence: SUCCESS (0.000s)
[338.906753] [069/133] (683s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[339.002664] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[339.031934] Starting dynamic subtest: pipe-A-plane-0
[339.487405] Dynamic subtest pipe-A-plane-0: SUCCESS (0.455s)
[339.499314] Starting dynamic subtest: pipe-A-plane-3
[339.786892] Dynamic subtest pipe-A-plane-3: SUCCESS (0.297s)
[339.798612] Starting dynamic subtest: pipe-A-plane-5
[339.802728] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[340.879576] Starting dynamic subtest: pipe-B-plane-0
[341.339071] Dynamic subtest pipe-B-plane-0: SUCCESS (0.466s)
[341.349828] Starting dynamic subtest: pipe-B-plane-3
[341.595001] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[341.604575] Starting dynamic subtest: pipe-B-plane-5
[341.609095] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[341.916480] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.912s)
[342.785305] [070/133] (680s left) kms_addfb_basic (invalid-set-prop-any)
[342.848195] Starting subtest: invalid-set-prop-any
[342.850680] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[342.997219] [071/133] (679s left) kms_addfb_basic (size-max)
[343.102329] Starting subtest: size-max
[343.104493] Subtest size-max: SUCCESS (0.000s)
[343.205942] [072/133] (679s left) kms_addfb_basic (bad-pitch-128)
[343.252168] Starting subtest: bad-pitch-128
[343.254373] Subtest bad-pitch-128: SUCCESS (0.000s)
[343.382851] [073/133] (679s left) syncobj_timeline (single-wait-available-submitted)
[343.430541] Starting subtest: single-wait-available-submitted
[343.432786] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[343.524212] [074/133] (679s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[343.617627] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[344.584960] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.969s)
[344.728494] [075/133] (678s left) gem_pread (exhaustion)
[344.787482] Subtest exhaustion: SKIP (0.000s)
[344.850716] [076/133] (678s left) kms_frontbuffer_tracking (psr-1p-rte)
[344.938597] Starting subtest: psr-1p-rte
[350.342367] Subtest psr-1p-rte: SUCCESS (5.406s)
[350.458920] [077/133] (672s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[350.580738] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[367.971630] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.387s)
[368.774847] [078/133] (654s left) api_intel_allocator (fork-simple-once)
[368.842402] Starting subtest: fork-simple-once
[368.856432] Subtest fork-simple-once: SUCCESS (0.017s)
[368.978266] [079/133] (654s left) gem_set_tiling_vs_pwrite
[369.090676] [080/133] (654s left) kms_pm_backlight (brightness-with-dpms)
[369.194398] Starting subtest: brightness-with-dpms
[369.243369] Starting dynamic subtest: eDP-1
[371.861987] Dynamic subtest eDP-1: SUCCESS (2.618s)
[371.864477] Subtest brightness-with-dpms: SUCCESS (2.668s)
[372.740434] [081/133] (650s left) kms_lease (lease-invalid-crtc)
[372.834729] Starting subtest: lease-invalid-crtc
[372.836933] Starting dynamic subtest: pipe-A-eDP-1
[372.839261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[372.850229] Starting dynamic subtest: pipe-B-eDP-1
[372.852423] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[372.862308] Starting dynamic subtest: pipe-C-eDP-1
[372.864425] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[372.873733] Starting dynamic subtest: pipe-D-eDP-1
[372.876024] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[372.878672] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[372.917798] [082/133] (650s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[373.021374] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[373.025585] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[373.114160] [083/133] (650s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[373.208639] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[380.166423] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.958s)
[380.317845] [084/133] (643s left) kms_dp_linktrain_fallback (dp-fallback)
[380.410666] Starting subtest: dp-fallback
[380.416852] Subtest dp-fallback: SKIP (0.000s)
[380.482738] [085/133] (643s left) kms_vblank (ts-continuation-idle)
[380.574396] Starting subtest: ts-continuation-idle
[380.576538] Starting dynamic subtest: pipe-A-eDP-1
[380.980385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.406s)
[380.995610] Starting dynamic subtest: pipe-D-eDP-1
[382.068674] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.086s)
[382.071035] Subtest ts-continuation-idle: SUCCESS (1.497s)
[382.944145] [086/133] (640s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[383.045494] Starting subtest: fbc-psr-cursor-mmap-gtt
[383.047319] Starting dynamic subtest: eDP-1
[383.051235] Dynamic subtest eDP-1: SKIP (0.000s)
[383.055176] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[383.117914] [087/133] (640s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[383.220153] Starting subtest: cursor-vs-flip-varying-size
[414.344015] Subtest cursor-vs-flip-varying-size: SUCCESS (31.125s)
[415.178654] [088/133] (608s left) i915_drm_fdinfo (busy-check-all)
[415.232845] Starting subtest: busy-check-all
[415.234778] Starting dynamic subtest: rcs0
[415.239375] Dynamic subtest rcs0: SKIP (0.003s)
[415.250435] Starting dynamic subtest: bcs0
[415.254634] Dynamic subtest bcs0: SKIP (0.000s)
[415.264017] Starting dynamic subtest: vcs0
[415.268055] Dynamic subtest vcs0: SKIP (0.000s)
[415.277504] Starting dynamic subtest: vcs1
[415.281644] Dynamic subtest vcs1: SKIP (0.000s)
[415.291306] Starting dynamic subtest: vecs0
[415.295560] Dynamic subtest vecs0: SKIP (0.000s)
[415.304921] Starting dynamic subtest: ccs0
[415.309274] Dynamic subtest ccs0: SKIP (0.001s)
[415.313609] Subtest busy-check-all: SKIP (0.011s)
[415.352045] [089/133] (608s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[415.444868] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[415.447026] Starting dynamic subtest: pipe-A-eDP-1
[415.467523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[415.479955] Starting dynamic subtest: pipe-B-eDP-1
[415.499186] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[415.508321] Starting dynamic subtest: pipe-C-eDP-1
[415.527655] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[415.536728] Starting dynamic subtest: pipe-D-eDP-1
[415.555926] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[415.557815] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[417.730265] [090/133] (605s left) prime_busy (before-wait)
[417.806719] Starting subtest: before-wait
[417.809474] Starting dynamic subtest: rcs0
[417.844831] Dynamic subtest rcs0: SUCCESS (0.035s)
[417.856786] Starting dynamic subtest: bcs0
[417.895149] Dynamic subtest bcs0: SUCCESS (0.048s)
[417.909094] Starting dynamic subtest: vcs0
[417.935625] Dynamic subtest vcs0: SUCCESS (0.041s)
[417.945801] Starting dynamic subtest: vcs1
[417.977042] Dynamic subtest vcs1: SUCCESS (0.041s)
[417.986791] Starting dynamic subtest: vecs0
[418.018601] Dynamic subtest vecs0: SUCCESS (0.041s)
[418.028712] Starting dynamic subtest: ccs0
[418.059732] Dynamic subtest ccs0: SUCCESS (0.040s)
[418.169405] Subtest before-wait: SUCCESS (0.363s)
[418.247805] [091/133] (605s left) gem_ppgtt (blt-vs-render-ctx0)
[418.313079] Starting subtest: blt-vs-render-ctx0
[451.130089] Subtest blt-vs-render-ctx0: SUCCESS (32.814s)
[451.253124] [092/133] (572s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[451.418047] Starting subtest: cursorB-vs-flipB-atomic
[451.422629] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[451.564962] [093/133] (572s left) gem_exec_reloc (basic-wc-read-active)
[451.631239] Subtest basic-wc-read-active: SKIP (0.000s)
[451.710639] [094/133] (572s left) gem_exec_fence (syncobj-import)
[452.168982] Starting subtest: syncobj-import
[452.174935] Subtest syncobj-import: SUCCESS (0.006s)
[453.284966] [095/133] (570s left) kms_psr (fbc-psr2-sprite-blt)
[453.381061] Starting subtest: fbc-psr2-sprite-blt
[453.383396] Starting dynamic subtest: eDP-1
[453.387498] Dynamic subtest eDP-1: SKIP (0.000s)
[453.392151] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[453.453927] [096/133] (570s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[453.553388] Starting subtest: plane-lut1d-post-ctm3x4
[453.688156] Starting dynamic subtest: pipe-A-plane-0
[453.843709] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[453.853955] Starting dynamic subtest: pipe-A-plane-1
[453.977061] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[453.987092] Starting dynamic subtest: pipe-A-plane-2
[454.110028] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[455.307650] Starting dynamic subtest: pipe-B-plane-0
[455.455633] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[455.466642] Starting dynamic subtest: pipe-B-plane-1
[455.633077] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[455.643927] Starting dynamic subtest: pipe-B-plane-2
[455.788864] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[456.973541] Starting dynamic subtest: pipe-C-plane-0
[457.120993] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[457.131725] Starting dynamic subtest: pipe-C-plane-1
[457.265839] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[457.276064] Starting dynamic subtest: pipe-C-plane-2
[457.409913] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[458.582509] Starting dynamic subtest: pipe-D-plane-0
[458.729959] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[458.740094] Starting dynamic subtest: pipe-D-plane-1
[458.863548] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[458.873585] Starting dynamic subtest: pipe-D-plane-2
[459.018719] Dynamic subtest pipe-D-plane-2: SUCCESS (0.154s)
[459.310203] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.756s)
[460.149118] [097/133] (563s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[460.224335] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[460.228252] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[460.403563] [098/133] (563s left) kms_big_fb (linear-8bpp-rotate-180)
[460.501900] Starting subtest: linear-8bpp-rotate-180
[461.726928] Subtest linear-8bpp-rotate-180: SUCCESS (1.225s)
[461.848121] [099/133] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[461.935700] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[461.939177] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[462.028717] [100/133] (562s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[462.125067] Starting subtest: extended-modeset-hang-oldfb-with-reset
[462.127192] Starting dynamic subtest: pipe-A
[473.633131] Dynamic subtest pipe-A: SUCCESS (11.503s)
[473.645130] Starting dynamic subtest: pipe-D
[485.902740] Dynamic subtest pipe-D: SUCCESS (12.267s)
[485.905001] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.774s)
[486.711985] [101/133] (537s left) gem_exec_schedule (timeslicing)
[486.805628] Starting subtest: timeslicing
[486.807925] Starting dynamic subtest: rcs0
[486.815646] Dynamic subtest rcs0: SUCCESS (0.020s)
[486.829865] Starting dynamic subtest: bcs0
[486.836788] Dynamic subtest bcs0: SUCCESS (0.020s)
[486.847501] Starting dynamic subtest: vcs0
[486.858530] Dynamic subtest vcs0: SUCCESS (0.021s)
[486.868280] Starting dynamic subtest: vcs1
[486.879428] Dynamic subtest vcs1: SUCCESS (0.020s)
[486.889257] Starting dynamic subtest: vecs0
[486.901744] Dynamic subtest vecs0: SUCCESS (0.021s)
[486.912502] Starting dynamic subtest: ccs0
[486.924040] Dynamic subtest ccs0: SUCCESS (0.020s)
[486.926406] Subtest timeslicing: SUCCESS (0.130s)
[488.173849] [102/133] (536s left) kms_chamelium_color (ctm-0-25)
[488.276914] Subtest ctm-0-25: SKIP (0.000s)
[488.321076] [103/133] (535s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[488.426090] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[488.428947] Starting dynamic subtest: pipe-A-eDP-1
[488.512611] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[488.524550] Starting dynamic subtest: pipe-B-eDP-1
[489.681383] Dynamic subtest pipe-B-eDP-1: SKIP (1.168s)
[489.685983] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.259s)
[490.862011] [104/133] (533s left) gem_mmap (short-mmap)
[490.926609] Subtest short-mmap: SKIP (0.000s)
[490.987558] [105/133] (533s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[491.050081] Starting subtest: multi-wait-available-unsubmitted-submitted
[491.052411] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[491.155782] [106/133] (533s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[491.248735] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[491.253398] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[491.364117] [107/133] (533s left) kms_getfb (getfb2-accept-nv12)
[491.467268] Starting subtest: getfb2-accept-nv12
[491.469535] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[491.589744] [108/133] (532s left) syncobj_timeline (invalid-signal-zero-handles)
[491.644504] Starting subtest: invalid-signal-zero-handles
[491.646837] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[491.742845] [109/133] (532s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[491.845163] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[491.849045] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[491.917207] [110/133] (532s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[492.003557] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[492.005422] Starting dynamic subtest: pipe-A-eDP-1
[492.052921] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[492.064426] Starting dynamic subtest: pipe-B-eDP-1
[492.109775] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[492.120152] Starting dynamic subtest: pipe-C-eDP-1
[492.167483] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[492.180252] Starting dynamic subtest: pipe-D-eDP-1
[492.224409] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[492.227865] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[494.248216] [111/133] (530s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[494.331634] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[494.342772] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[494.460850] [112/133] (530s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[494.556875] Starting subtest: async-flip-with-page-flip-events-tiled
[494.928709] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[497.724778] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.793s)
[497.735053] Starting dynamic subtest: pipe-A-eDP-1-4
[499.897308] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.171s)
[499.907424] Starting dynamic subtest: pipe-A-eDP-1-4
[501.905838] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[501.916063] Starting dynamic subtest: pipe-A-eDP-1-x
[504.096425] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[504.480020] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[507.245317] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.773s)
[507.256697] Starting dynamic subtest: pipe-B-eDP-1-4
[509.418515] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.173s)
[509.429231] Starting dynamic subtest: pipe-B-eDP-1-4
[511.428578] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[511.439885] Starting dynamic subtest: pipe-B-eDP-1-x
[513.620410] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[513.987195] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[516.776672] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.795s)
[516.787811] Starting dynamic subtest: pipe-C-eDP-1-4
[519.010676] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[519.022545] Starting dynamic subtest: pipe-C-eDP-1-4
[520.960879] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[520.972017] Starting dynamic subtest: pipe-C-eDP-1-x
[523.174092] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.212s)
[523.535839] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[526.303318] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[526.314431] Starting dynamic subtest: pipe-D-eDP-1-4
[528.478915] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[528.489833] Starting dynamic subtest: pipe-D-eDP-1-4
[530.488978] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[530.502179] Starting dynamic subtest: pipe-D-eDP-1-x
[532.733251] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[532.735845] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.122s)
[533.896692] [113/133] (490s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[534.005245] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[534.009526] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[534.091610] [114/133] (490s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[534.143856] Starting subtest: etime-multi-wait-for-submit-submitted
[534.248662] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.105s)
[534.325545] [115/133] (490s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[536.263791] Starting subtest: modeset-non-lpsp-stress-no-wait
[536.323681] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.060s)
[536.652585] [116/133] (488s left) gem_exec_params (sol-reset-invalid)
[536.723530] Starting subtest: sol-reset-invalid
[536.725858] Subtest sol-reset-invalid: SUCCESS (0.002s)
[538.232517] [117/133] (486s left) gem_mmap_gtt (cpuset-big-copy)
[538.292902] Subtest cpuset-big-copy: SKIP (0.000s)
[538.358689] [118/133] (486s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[538.468377] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[545.948501] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.483s)
[546.060896] [119/133] (478s left) kms_psr (psr2-sprite-plane-onoff)
[546.151267] Starting subtest: psr2-sprite-plane-onoff
[546.153396] Starting dynamic subtest: eDP-1
[547.887708] Dynamic subtest eDP-1: SUCCESS (1.738s)
[547.890021] Subtest psr2-sprite-plane-onoff: SUCCESS (1.739s)
[548.734736] [120/133] (476s left) kms_dsc (dsc-with-output-formats)
[548.845614] Starting subtest: dsc-with-output-formats
[548.867766] Subtest dsc-with-output-formats: SKIP (0.001s)
[548.926069] [121/133] (476s left) gen3_mixed_blits
[549.036705] [122/133] (476s left) gem_mmap_offset (clear-via-pagefault)
[549.101799] Starting subtest: clear-via-pagefault
[549.103798] Starting dynamic subtest: smem0
[583.394092] Dynamic subtest smem0: SUCCESS (34.235s)
[583.396469] Subtest clear-via-pagefault: SUCCESS (34.237s)
[583.464794] [123/133] (441s left) gem_eio (reset-stress)
[583.703097] Starting subtest: reset-stress
[583.705080] Starting dynamic subtest: render
[588.746544] Dynamic subtest render: SUCCESS (5.042s)
[588.763592] Starting dynamic subtest: bsd1
[606.649393] Dynamic subtest bsd1: SUCCESS (17.899s)
[606.667108] Starting dynamic subtest: bsd2
[624.709565] Dynamic subtest bsd2: SUCCESS (18.059s)
[624.726027] Starting dynamic subtest: blt
[624.730234] Dynamic subtest blt: SKIP (0.000s)
[624.739709] Starting dynamic subtest: vebox
[642.711730] Dynamic subtest vebox: SUCCESS (17.999s)
[642.713896] Subtest reset-stress: SUCCESS (59.003s)
[644.230236] [124/133] (380s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[644.284436] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[644.286770] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[644.386175] [125/133] (380s left) kms_vblank (query-busy-hang)
[644.486127] Starting subtest: query-busy-hang
[644.488004] Starting dynamic subtest: pipe-A-eDP-1
[646.359538] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[646.375089] Starting dynamic subtest: pipe-D-eDP-1
[648.895398] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.530s)
[648.897723] Subtest query-busy-hang: SUCCESS (4.409s)
[649.695889] [126/133] (375s left) kms_psr (fbc-pr-cursor-plane-onoff)
[649.790567] Starting subtest: fbc-pr-cursor-plane-onoff
[649.795117] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[649.867772] [127/133] (375s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[649.962385] Starting subtest: psr-1p-primscrn-cur-indfb-move
[657.327653] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.368s)
[657.455417] [128/133] (367s left) tools_test (sysfs_l3_parity)
[657.512534] Starting subtest: sysfs_l3_parity
[657.581414] Subtest sysfs_l3_parity: SKIP (0.078s)
[657.639938] [129/133] (367s left) kms_vblank (crtc-id)
[657.722752] Starting subtest: crtc-id
[657.725002] Starting dynamic subtest: pipe-A-eDP-1
[658.163108] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s)
[658.178954] Starting dynamic subtest: pipe-D-eDP-1
[659.273998] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.110s)
[659.276577] Subtest crtc-id: SUCCESS (1.553s)
[660.105541] [130/133] (365s left) gem_ctx_engines (independent)
[660.165875] Starting subtest: independent
[660.168240] Starting dynamic subtest: rcs0
[660.319811] Dynamic subtest rcs0: SUCCESS (0.151s)
[660.330959] Starting dynamic subtest: bcs0
[660.461572] Dynamic subtest bcs0: SUCCESS (0.141s)
[660.473267] Starting dynamic subtest: vcs0
[660.628449] Dynamic subtest vcs0: SUCCESS (0.166s)
[660.641310] Starting dynamic subtest: vcs1
[660.803597] Dynamic subtest vcs1: SUCCESS (0.174s)
[660.816500] Starting dynamic subtest: vecs0
[660.972130] Dynamic subtest vecs0: SUCCESS (0.168s)
[660.984736] Starting dynamic subtest: ccs0
[661.148646] Dynamic subtest ccs0: SUCCESS (0.176s)
[661.159105] Starting dynamic subtest: all-engines
[661.877704] Dynamic subtest all-engines: SUCCESS (0.728s)
[661.880386] Subtest independent: SUCCESS (1.711s)
[662.321832] [131/133] (363s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[662.413478] Starting subtest: flip-vs-dpms-on-nop-interruptible
[662.415719] Starting dynamic subtest: A-eDP1
[664.310612] Dynamic subtest A-eDP1: SUCCESS (1.897s)
[664.323292] Starting dynamic subtest: B-eDP1
[666.158992] Dynamic subtest B-eDP1: SUCCESS (1.846s)
[666.172772] Starting dynamic subtest: C-eDP1
[667.990610] Dynamic subtest C-eDP1: SUCCESS (1.829s)
[668.005437] Starting dynamic subtest: D-eDP1
[669.815057] Dynamic subtest D-eDP1: SUCCESS (1.821s)
[669.817545] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.404s)
[671.017137] [132/133] (354s left) kms_plane_lowres (tiling-x)
[671.112600] Starting subtest: tiling-x
[671.114957] Starting dynamic subtest: pipe-A-eDP-1
[671.119599] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[671.408232] Starting dynamic subtest: pipe-B-eDP-1
[671.413007] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[671.423004] Starting dynamic subtest: pipe-C-eDP-1
[671.427635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[671.437357] Starting dynamic subtest: pipe-D-eDP-1
[671.441767] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[671.446173] Subtest tiling-x: SKIP (0.295s)
[672.271863] [133/133] (353s left) i915_pm_freq_api (freq-reset)
[672.336033] Starting subtest: freq-reset
[672.338415] Starting dynamic subtest: gt0
[672.527027] Dynamic subtest gt0: SUCCESS (0.190s)
[672.539254] Starting dynamic subtest: gt1
[672.698677] Dynamic subtest gt1: SUCCESS (0.169s)
[672.702242] Subtest freq-reset: SUCCESS (0.361s)
[672.776072] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gen7_exec_parse
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: tools_test
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: i915_pm_rpm
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: drm_read
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_chamelium_edid
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: vgem_basic
results: parsing output: 32/ for test: kms_atomic_interruptible
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: gem_exec_basic
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_joiner
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: i915_query
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: dumb_buffer
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: gem_blits
results: parsing output: 48/ for test: gem_busy
results: parsing output: 49/ for test: gem_exec_alignment
results: parsing output: 50/ for test: syncobj_eventfd
results: parsing output: 51/ for test: prime_mmap
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_cursor_edge_walk
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_vm_create
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_pread
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 79/ for test: kms_pm_backlight
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_dp_linktrain_fallback
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: prime_busy
results: parsing output: 90/ for test: gem_ppgtt
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_busy
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: gem_mmap
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_dsc
results: parsing output: 120/ for test: gen3_mixed_blits
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: tools_test
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: gem_ctx_engines
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_plane_lowres
results: parsing output: 132/ for test: i915_pm_freq_api
Done.