[61.723425] Initializing watchdogs
[61.723578]   /dev/watchdog0
[61.742046] [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]
[61.746559] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.748813] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.751168] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[61.860116] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[61.861645] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[61.961584] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[62.050565] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[62.052585] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[62.132999] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[62.227400] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[63.060762] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.837s)
[63.220609] [004/133] (959s left) gen7_exec_parse (basic-offset)
[63.278160] Subtest basic-offset: SKIP (0.000s)
[63.325815] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[63.411979] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[68.294627] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.895s)
[69.425053] [006/133] (952s left) tools_test (tools_test)
[69.459619] Starting subtest: tools_test
[69.527416] Subtest tools_test: SUCCESS (0.073s)
[69.583333] [007/133] (952s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[69.663344] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[69.665251] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[70.745368] [008/133] (951s left) kms_flip (modeset-vs-vblank-race)
[70.841398] Starting subtest: modeset-vs-vblank-race
[70.843666] Starting dynamic subtest: A-eDP1
[75.589331] Dynamic subtest A-eDP1: SUCCESS (4.750s)
[75.598322] Starting dynamic subtest: B-eDP1
[80.322837] Dynamic subtest B-eDP1: SUCCESS (4.733s)
[80.331382] Starting dynamic subtest: C-eDP1
[84.945189] Dynamic subtest C-eDP1: SUCCESS (4.620s)
[84.954256] Starting dynamic subtest: D-eDP1
[89.399040] Dynamic subtest D-eDP1: SUCCESS (4.452s)
[89.401158] Subtest modeset-vs-vblank-race: SUCCESS (18.563s)
[90.561795] [009/133] (931s left) i915_pm_rpm (reg-read-ioctl)
[92.092631] Starting subtest: reg-read-ioctl
[94.497490] Subtest reg-read-ioctl: SUCCESS (2.405s)
[94.873748] [010/133] (927s left) gem_exec_balancer (hang)
[95.158043] Starting subtest: hang
[96.934066] Subtest hang: SUCCESS (1.774s)
[97.046939] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[97.132638] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[97.134449] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[97.200331] [012/133] (925s left) perf_pmu (faulting-read)
[97.238400] Starting subtest: faulting-read
[97.239270] Starting dynamic subtest: wb
[97.240229] Dynamic subtest wb: SUCCESS (0.001s)
[97.247704] Starting dynamic subtest: wc
[97.248581] Dynamic subtest wc: SUCCESS (0.000s)
[97.255054] Starting dynamic subtest: uc
[97.255932] Dynamic subtest uc: SUCCESS (0.000s)
[97.256852] Subtest faulting-read: SUCCESS (0.003s)
[97.344921] [013/133] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[97.429535] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[97.431224] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[97.518220] [014/133] (925s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[97.899577] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[98.677809] [015/133] (924s left) gem_exec_schedule (pi-distinct-iova)
[98.861885] Starting subtest: pi-distinct-iova
[98.862981] Starting dynamic subtest: rcs0
[98.930377] Dynamic subtest rcs0: SUCCESS (0.077s)
[98.940499] Starting dynamic subtest: vcs0
[98.988746] Dynamic subtest vcs0: SUCCESS (0.058s)
[99.000622] Starting dynamic subtest: vcs1
[99.049027] Dynamic subtest vcs1: SUCCESS (0.059s)
[99.060291] Starting dynamic subtest: vecs0
[99.104546] Dynamic subtest vecs0: SUCCESS (0.056s)
[99.111567] Starting dynamic subtest: ccs0
[99.170412] Dynamic subtest ccs0: SUCCESS (0.066s)
[99.171665] Subtest pi-distinct-iova: SUCCESS (0.318s)
[100.967191] [016/133] (921s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[101.056792] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[101.059030] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[101.154669] [017/133] (921s left) drm_read (short-buffer-block)
[101.289021] Starting subtest: short-buffer-block
[101.289865] Subtest short-buffer-block: SUCCESS (0.000s)
[101.394422] [018/133] (921s left) perf (oa-formats)
[101.513229] Starting subtest: oa-formats
[101.514144] Starting dynamic subtest: 0-rcs0
[101.529047] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[101.538456] Starting dynamic subtest: 1-vcs0
[101.553085] Dynamic subtest 1-vcs0: SUCCESS (0.023s)
[101.554233] Subtest oa-formats: SUCCESS (0.041s)
[101.599565] [019/133] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[101.683421] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[101.685089] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[101.781318] [020/133] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[101.869094] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[101.870906] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[101.988661] [021/133] (920s left) kms_psr (pr-basic)
[102.083659] Starting subtest: pr-basic
[102.085471] Subtest pr-basic: SKIP (0.000s)
[102.148539] [022/133] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[102.236256] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[102.237243] Starting dynamic subtest: pipe-A-eDP-1
[102.246048] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[102.254466] Starting dynamic subtest: pipe-B-eDP-1
[102.262638] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[102.270617] Starting dynamic subtest: pipe-C-eDP-1
[102.278277] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[102.284682] Starting dynamic subtest: pipe-D-eDP-1
[102.292539] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[102.294096] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[104.476851] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[104.872598] Subtest hdmi-mode-timings: SKIP (0.000s)
[105.677192] [024/133] (917s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[105.811898] Starting subtest: dp-mst-lic-type-0-hdcp14
[105.813855] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[105.941937] [025/133] (917s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[106.029950] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[106.031914] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[106.106912] [026/133] (916s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[106.189389] Starting subtest: primary-4-tiled-reflect-x-180
[113.074480] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.886s)
[114.257204] [027/133] (908s left) kms_flip (2x-flip-vs-panning-interruptible)
[114.357848] Starting subtest: 2x-flip-vs-panning-interruptible
[114.369610] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[114.438516] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[114.529697] Starting subtest: plain-flip-fb-recreate
[114.531824] Starting dynamic subtest: A-eDP1
[123.364694] Dynamic subtest A-eDP1: SUCCESS (8.833s)
[123.372302] Starting dynamic subtest: B-eDP1
[132.194396] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[132.204417] Starting dynamic subtest: C-eDP1
[141.014846] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[141.028066] Starting dynamic subtest: D-eDP1
[149.849545] Dynamic subtest D-eDP1: SUCCESS (8.833s)
[149.854222] Subtest plain-flip-fb-recreate: SUCCESS (35.324s)
[151.023497] [029/133] (872s left) gem_tiled_partial_pwrite_pread (writes)
[151.074765] Subtest writes: SKIP (0.000s)
[151.136620] [030/133] (872s left) gem_lmem_swapping (heavy-verify-random)
[151.175947] Subtest heavy-verify-random: SKIP (0.000s)
[151.214452] [031/133] (871s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[151.319352] Starting subtest: x-tiled-64bpp-rotate-90
[151.337921] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[151.443706] [032/133] (871s left) vgem_basic (debugfs)
[151.527988] Starting subtest: debugfs
[151.529022] Subtest debugfs: SUCCESS (0.000s)
[151.575735] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[151.577466] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[151.667341] Starting subtest: legacy-setmode
[151.668253] Starting dynamic subtest: pipe-A-eDP-1
[158.583545] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.915s)
[158.584454] Subtest legacy-setmode: SUCCESS (6.916s)
[159.445482] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[159.558230] Starting subtest: reject-modify-context-protection-off-2
[159.559567] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[159.693135] [035/133] (863s left) gem_exec_basic (basic)
[159.754786] Starting subtest: basic
[159.755801] Starting dynamic subtest: rcs0-smem
[159.758166] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[159.766513] Starting dynamic subtest: bcs0-smem
[159.767415] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[159.774460] Starting dynamic subtest: vcs0-smem
[159.775467] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[159.782353] Starting dynamic subtest: vcs1-smem
[159.783236] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[159.789776] Starting dynamic subtest: vecs0-smem
[159.790646] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[159.797234] Starting dynamic subtest: ccs0-smem
[159.798052] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[159.798881] Subtest basic: SUCCESS (0.013s)
[160.950778] [036/133] (862s left) api_intel_bb (offset-control)
[161.000041] Starting subtest: offset-control
[161.009434] Subtest offset-control: SUCCESS (0.010s)
[161.124677] [037/133] (862s left) kms_joiner (basic-max-non-joiner)
[161.219551] Starting subtest: basic-max-non-joiner
[161.221427] Subtest basic-max-non-joiner: SKIP (0.000s)
[161.284916] [038/133] (862s left) kms_addfb_basic (small-bo)
[161.369357] Starting subtest: small-bo
[161.370225] Subtest small-bo: SUCCESS (0.000s)
[161.466672] [039/133] (862s left) i915_query (query-topology-garbage-items)
[161.514082] Starting subtest: query-topology-garbage-items
[161.514993] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[161.601546] [040/133] (861s left) perf (gen12-group-exclusive-stream-ctx-handle)
[161.699584] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[161.722470] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.023s)
[161.771025] [041/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[162.911446] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[162.912871] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[163.027239] [042/133] (860s left) gem_exec_params (cliprects-invalid)
[163.088472] Starting subtest: cliprects-invalid
[163.089517] Subtest cliprects-invalid: SUCCESS (0.000s)
[163.176183] [043/133] (860s left) kms_cursor_crc (cursor-random-64x64)
[163.338349] Starting subtest: cursor-random-64x64
[163.342357] Starting dynamic subtest: pipe-A-eDP-1
[166.674152] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.332s)
[166.702777] Starting dynamic subtest: pipe-D-eDP-1
[170.688475] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.992s)
[170.689369] Subtest cursor-random-64x64: SUCCESS (7.349s)
[171.512263] [044/133] (852s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[171.607489] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[171.609508] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[171.706425] [045/133] (851s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[171.807062] Starting subtest: 4-tiled-16bpp-rotate-180
[173.152587] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.346s)
[173.262674] [046/133] (850s left) dumb_buffer (create-valid-dumb)
[173.314028] Starting subtest: create-valid-dumb
[173.314939] Subtest create-valid-dumb: SUCCESS (0.000s)
[173.403245] [047/133] (850s left) gem_softpin (zero)
[173.456182] Starting subtest: zero
[173.460087] Subtest zero: SUCCESS (0.004s)
[173.567652] [048/133] (850s left) gem_blits (basic)
[173.622298] Starting subtest: basic
[175.036696] Subtest basic: SUCCESS (1.406s)
[175.125530] [049/133] (848s left) gem_busy (close-race)
[175.185969] Starting subtest: close-race
[198.931750] Subtest close-race: SUCCESS (23.745s)
[199.252387] [050/133] (824s left) gem_exec_alignment (forked)
[199.365415] Starting subtest: forked
[240.426479] Subtest forked: SUCCESS (41.014s)
[240.464277] [051/133] (783s left) syncobj_eventfd (binary-wait-before-signal)
[240.566507] Starting subtest: binary-wait-before-signal
[240.597023] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[240.670096] [052/133] (783s left) prime_mmap (test_errors)
[240.715790] Starting subtest: test_errors
[240.716929] Starting dynamic subtest: test_errors-smem
[240.823048] Dynamic subtest test_errors-smem: SUCCESS (0.108s)
[240.824190] Subtest test_errors: SUCCESS (0.108s)
[240.919785] [053/133] (783s left) gem_ctx_persistence (heartbeat-stop)
[240.965590] Starting subtest: heartbeat-stop
[240.967371] Subtest heartbeat-stop: SKIP (0.000s)
[241.069454] [054/133] (782s left) gem_ctx_param (invalid-get-ringsize)
[241.118290] Starting subtest: invalid-get-ringsize
[241.119156] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[241.204795] [055/133] (782s left) i915_query (query-topology-matches-eu-total)
[241.262974] Starting subtest: query-topology-matches-eu-total
[241.264095] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[241.367447] [056/133] (782s left) kms_cursor_edge_walk (64x64-right-edge)
[241.458899] Starting subtest: 64x64-right-edge
[241.459763] Starting dynamic subtest: pipe-A-eDP-1
[244.880039] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.420s)
[244.889098] Starting dynamic subtest: pipe-D-eDP-1
[248.004518] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[248.005471] Subtest 64x64-right-edge: SUCCESS (6.546s)
[248.811857] [057/133] (775s left) kms_plane (plane-position-covered)
[248.906364] Starting subtest: plane-position-covered
[249.452581] Starting dynamic subtest: pipe-A-plane-1
[250.724126] Dynamic subtest pipe-A-plane-1: SUCCESS (1.270s)
[250.740273] Starting dynamic subtest: pipe-A-plane-2
[252.052380] Dynamic subtest pipe-A-plane-2: SUCCESS (1.328s)
[252.060345] Starting dynamic subtest: pipe-A-plane-3
[253.361450] Dynamic subtest pipe-A-plane-3: SUCCESS (1.308s)
[253.369454] Starting dynamic subtest: pipe-A-plane-4
[254.621202] Dynamic subtest pipe-A-plane-4: SUCCESS (1.259s)
[254.629207] Starting dynamic subtest: pipe-A-plane-5
[254.647799] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[255.851459] Starting dynamic subtest: pipe-B-plane-1
[257.190276] Dynamic subtest pipe-B-plane-1: SUCCESS (1.346s)
[257.202231] Starting dynamic subtest: pipe-B-plane-2
[258.499501] Dynamic subtest pipe-B-plane-2: SUCCESS (1.307s)
[258.507266] Starting dynamic subtest: pipe-B-plane-3
[259.819417] Dynamic subtest pipe-B-plane-3: SUCCESS (1.320s)
[259.827190] Starting dynamic subtest: pipe-B-plane-4
[261.095173] Dynamic subtest pipe-B-plane-4: SUCCESS (1.274s)
[261.104542] Starting dynamic subtest: pipe-B-plane-5
[261.137083] Dynamic subtest pipe-B-plane-5: SUCCESS (0.040s)
[261.138091] Subtest plane-position-covered: SUCCESS (12.231s)
[261.949248] [058/133] (762s left) kms_frontbuffer_tracking (psr-suspend)
[262.037477] Starting subtest: psr-suspend
[300.617627] Subtest psr-suspend: SUCCESS (8.855s)
[306.748178] [059/133] (723s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[306.839517] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[306.841413] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[306.938480] [060/133] (723s left) gem_exec_schedule (fairslice)
[306.994761] Starting subtest: fairslice
[306.995735] Starting dynamic subtest: rcs0
[309.032054] Dynamic subtest rcs0: SUCCESS (2.087s)
[309.042988] Starting dynamic subtest: bcs0
[311.055866] Dynamic subtest bcs0: SUCCESS (2.064s)
[311.067102] Starting dynamic subtest: vcs0
[313.079746] Dynamic subtest vcs0: SUCCESS (2.054s)
[313.090189] Starting dynamic subtest: vcs1
[315.100871] Dynamic subtest vcs1: SUCCESS (2.044s)
[315.111883] Starting dynamic subtest: vecs0
[317.119344] Dynamic subtest vecs0: SUCCESS (2.036s)
[317.129446] Starting dynamic subtest: ccs0
[319.136089] Dynamic subtest ccs0: SUCCESS (2.033s)
[319.137039] Subtest fairslice: SUCCESS (12.326s)
[319.444261] [061/133] (710s left) sw_sync (alloc_fence_invalid_timeline)
[319.473753] Starting subtest: alloc_fence_invalid_timeline
[319.474717] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[319.525945] [062/133] (710s left) gem_exec_whisper (basic-fds-forked)
[319.583049] Starting subtest: basic-fds-forked
[342.951436] Subtest basic-fds-forked: SUCCESS (23.410s)
[343.140220] [063/133] (687s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[343.235375] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[343.237199] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[343.343186] [064/133] (687s left) gem_vm_create (execbuf)
[343.401868] Starting subtest: execbuf
[343.407296] Subtest execbuf: SUCCESS (0.007s)
[343.547053] [065/133] (686s left) kms_cursor_crc (cursor-onscreen-256x85)
[343.813549] Starting subtest: cursor-onscreen-256x85
[343.858673] Subtest cursor-onscreen-256x85: SKIP (0.044s)
[344.031413] [066/133] (686s left) kms_plane_alpha_blend (coverage-7efc)
[344.113001] Starting subtest: coverage-7efc
[344.415911] Starting dynamic subtest: pipe-A-eDP-1
[345.015303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[345.045032] Starting dynamic subtest: pipe-D-eDP-1
[346.289703] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.253s)
[346.290589] Subtest coverage-7efc: SUCCESS (2.177s)
[347.135811] [067/133] (683s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[347.227202] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[347.228213] Starting dynamic subtest: pipe-A
[347.245482] Dynamic subtest pipe-A: SKIP (0.018s)
[347.256540] Starting dynamic subtest: pipe-B
[347.278633] Dynamic subtest pipe-B: SKIP (0.032s)
[347.288041] Starting dynamic subtest: pipe-C
[347.311861] Dynamic subtest pipe-C: SKIP (0.033s)
[347.320592] Starting dynamic subtest: pipe-D
[347.346554] Dynamic subtest pipe-D: SKIP (0.033s)
[347.348190] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.118s)
[347.437598] [068/133] (683s left) vgem_basic (busy-fence)
[347.481213] Starting subtest: busy-fence
[347.482101] Subtest busy-fence: SUCCESS (0.001s)
[347.540097] [069/133] (683s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[347.623294] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[347.653509] Starting dynamic subtest: pipe-A-plane-0
[348.075463] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[348.085663] Starting dynamic subtest: pipe-A-plane-3
[348.342076] Dynamic subtest pipe-A-plane-3: SUCCESS (0.264s)
[348.352400] Starting dynamic subtest: pipe-A-plane-5
[348.354134] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[349.428880] Starting dynamic subtest: pipe-B-plane-0
[349.873710] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[349.884119] Starting dynamic subtest: pipe-B-plane-3
[350.129065] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[350.139309] Starting dynamic subtest: pipe-B-plane-5
[350.141044] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[350.454078] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.831s)
[351.304019] [070/133] (679s left) kms_addfb_basic (invalid-set-prop-any)
[351.362874] Starting subtest: invalid-set-prop-any
[351.363998] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[351.486666] [071/133] (679s left) kms_addfb_basic (size-max)
[351.574087] Starting subtest: size-max
[351.574963] Subtest size-max: SUCCESS (0.000s)
[351.659694] [072/133] (679s left) kms_addfb_basic (bad-pitch-128)
[351.714610] Starting subtest: bad-pitch-128
[351.715464] Subtest bad-pitch-128: SUCCESS (0.000s)
[351.839219] [073/133] (678s left) syncobj_timeline (single-wait-available-submitted)
[351.898544] Starting subtest: single-wait-available-submitted
[351.899564] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[352.004987] [074/133] (678s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[352.100345] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[353.201730] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.102s)
[353.334758] [075/133] (677s left) gem_pread (exhaustion)
[353.396509] Subtest exhaustion: SKIP (0.000s)
[353.451463] [076/133] (677s left) kms_frontbuffer_tracking (psr-1p-rte)
[353.544710] Starting subtest: psr-1p-rte
[358.875193] Subtest psr-1p-rte: SUCCESS (5.334s)
[359.009486] [077/133] (671s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[359.116559] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[376.746671] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.635s)
[377.536190] [078/133] (653s left) api_intel_allocator (fork-simple-once)
[377.589106] Starting subtest: fork-simple-once
[377.604717] Subtest fork-simple-once: SUCCESS (0.017s)
[377.708074] [079/133] (653s left) gem_set_tiling_vs_pwrite
[377.812865] [080/133] (653s left) kms_pm_backlight (brightness-with-dpms)
[377.898240] Starting subtest: brightness-with-dpms
[377.948274] Starting dynamic subtest: eDP-1
[380.375822] Dynamic subtest eDP-1: SUCCESS (2.427s)
[380.377455] Subtest brightness-with-dpms: SUCCESS (2.477s)
[381.239445] [081/133] (649s left) kms_lease (lease-invalid-crtc)
[381.332266] Starting subtest: lease-invalid-crtc
[381.333248] Starting dynamic subtest: pipe-A-eDP-1
[381.334092] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[381.343382] Starting dynamic subtest: pipe-B-eDP-1
[381.344215] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[381.352991] Starting dynamic subtest: pipe-C-eDP-1
[381.353788] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[381.362210] Starting dynamic subtest: pipe-D-eDP-1
[381.363096] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[381.364010] Subtest lease-invalid-crtc: SUCCESS (0.005s)
[381.407178] [082/133] (649s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[381.502777] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[381.504534] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[381.610823] [083/133] (649s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[381.693061] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[388.809712] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.119s)
[388.944592] [084/133] (642s left) kms_dp_linktrain_fallback (dp-fallback)
[389.031317] Starting subtest: dp-fallback
[389.033872] Subtest dp-fallback: SKIP (0.000s)
[389.102974] [085/133] (642s left) kms_vblank (ts-continuation-idle)
[389.201785] Starting subtest: ts-continuation-idle
[389.202816] Starting dynamic subtest: pipe-A-eDP-1
[389.611562] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[389.622372] Starting dynamic subtest: pipe-D-eDP-1
[390.669364] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.055s)
[390.670351] Subtest ts-continuation-idle: SUCCESS (1.468s)
[391.540766] [086/133] (639s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[391.648917] Starting subtest: fbc-psr-cursor-mmap-gtt
[391.649685] Starting dynamic subtest: eDP-1
[391.651170] Dynamic subtest eDP-1: SKIP (0.000s)
[391.652793] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[391.732898] [087/133] (639s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[391.847379] Starting subtest: cursor-vs-flip-varying-size
[423.313236] Subtest cursor-vs-flip-varying-size: SUCCESS (31.455s)
[424.182384] [088/133] (607s left) i915_drm_fdinfo (busy-check-all)
[424.217225] Starting subtest: busy-check-all
[424.218285] Starting dynamic subtest: rcs0
[424.223656] Dynamic subtest rcs0: SKIP (0.005s)
[424.239128] Starting dynamic subtest: bcs0
[424.240919] Dynamic subtest bcs0: SKIP (0.001s)
[424.253633] Starting dynamic subtest: vcs0
[424.255422] Dynamic subtest vcs0: SKIP (0.000s)
[424.263716] Starting dynamic subtest: vcs1
[424.265571] Dynamic subtest vcs1: SKIP (0.000s)
[424.273865] Starting dynamic subtest: vecs0
[424.275629] Dynamic subtest vecs0: SKIP (0.001s)
[424.285475] Starting dynamic subtest: ccs0
[424.287220] Dynamic subtest ccs0: SKIP (0.000s)
[424.288998] Subtest busy-check-all: SKIP (0.015s)
[424.321700] [089/133] (606s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[424.413339] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[424.414264] Starting dynamic subtest: pipe-A-eDP-1
[424.422271] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[424.436638] Starting dynamic subtest: pipe-B-eDP-1
[424.444532] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[424.453555] Starting dynamic subtest: pipe-C-eDP-1
[424.460835] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[424.469575] Starting dynamic subtest: pipe-D-eDP-1
[424.476728] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[424.477551] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[426.646703] [090/133] (604s left) prime_busy (before-wait)
[426.713353] Starting subtest: before-wait
[426.716629] Starting dynamic subtest: rcs0
[426.758895] Dynamic subtest rcs0: SUCCESS (0.042s)
[426.769602] Starting dynamic subtest: bcs0
[426.798528] Dynamic subtest bcs0: SUCCESS (0.039s)
[426.807561] Starting dynamic subtest: vcs0
[426.840046] Dynamic subtest vcs0: SUCCESS (0.041s)
[426.848924] Starting dynamic subtest: vcs1
[426.882681] Dynamic subtest vcs1: SUCCESS (0.042s)
[426.892723] Starting dynamic subtest: vecs0
[426.925475] Dynamic subtest vecs0: SUCCESS (0.042s)
[426.936623] Starting dynamic subtest: ccs0
[426.966663] Dynamic subtest ccs0: SUCCESS (0.040s)
[427.074565] Subtest before-wait: SUCCESS (0.360s)
[427.150096] [091/133] (604s left) gem_ppgtt (blt-vs-render-ctx0)
[427.198307] Starting subtest: blt-vs-render-ctx0
[460.022099] Subtest blt-vs-render-ctx0: SUCCESS (32.816s)
[460.145150] [092/133] (571s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[460.311168] Starting subtest: cursorB-vs-flipB-atomic
[460.312782] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[460.465362] [093/133] (570s left) gem_exec_reloc (basic-wc-read-active)
[460.524932] Subtest basic-wc-read-active: SKIP (0.000s)
[460.581895] [094/133] (570s left) gem_exec_fence (syncobj-import)
[461.052658] Starting subtest: syncobj-import
[461.057929] Subtest syncobj-import: SUCCESS (0.005s)
[462.715679] [095/133] (568s left) kms_psr (fbc-psr2-sprite-blt)
[462.806354] Starting subtest: fbc-psr2-sprite-blt
[462.807268] Starting dynamic subtest: eDP-1
[462.809113] Dynamic subtest eDP-1: SKIP (0.000s)
[462.810698] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[462.878929] [096/133] (568s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[462.983620] Starting subtest: plane-lut1d-post-ctm3x4
[463.164876] Starting dynamic subtest: pipe-A-plane-0
[463.365056] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[463.376293] Starting dynamic subtest: pipe-A-plane-1
[463.520125] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[463.529871] Starting dynamic subtest: pipe-A-plane-2
[463.664590] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[464.834063] Starting dynamic subtest: pipe-B-plane-0
[464.991777] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[465.002646] Starting dynamic subtest: pipe-B-plane-1
[465.158300] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[465.168418] Starting dynamic subtest: pipe-B-plane-2
[465.302693] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[466.463478] Starting dynamic subtest: pipe-C-plane-0
[466.610055] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[466.620244] Starting dynamic subtest: pipe-C-plane-1
[466.765892] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[466.775886] Starting dynamic subtest: pipe-C-plane-2
[466.910325] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[468.101294] Starting dynamic subtest: pipe-D-plane-0
[468.236500] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[468.245906] Starting dynamic subtest: pipe-D-plane-1
[468.380774] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[468.389681] Starting dynamic subtest: pipe-D-plane-2
[468.525773] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[468.826805] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.844s)
[469.709041] [097/133] (561s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[469.778727] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[469.780583] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[469.960857] [098/133] (561s left) kms_big_fb (linear-8bpp-rotate-180)
[470.057043] Starting subtest: linear-8bpp-rotate-180
[471.334242] Subtest linear-8bpp-rotate-180: SUCCESS (1.269s)
[471.449740] [099/133] (560s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[471.546613] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[471.548490] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[471.643808] [100/133] (560s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[471.747943] Starting subtest: extended-modeset-hang-oldfb-with-reset
[471.748740] Starting dynamic subtest: pipe-A
[483.257959] Dynamic subtest pipe-A: SUCCESS (11.511s)
[483.269776] Starting dynamic subtest: pipe-D
[495.627669] Dynamic subtest pipe-D: SUCCESS (12.370s)
[495.629744] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.887s)
[496.422123] [101/133] (535s left) gem_exec_schedule (timeslicing)
[496.489548] Starting subtest: timeslicing
[496.490517] Starting dynamic subtest: rcs0
[496.513047] Dynamic subtest rcs0: SUCCESS (0.023s)
[496.525553] Starting dynamic subtest: bcs0
[496.541292] Dynamic subtest bcs0: SUCCESS (0.026s)
[496.554380] Starting dynamic subtest: vcs0
[496.564100] Dynamic subtest vcs0: SUCCESS (0.021s)
[496.574325] Starting dynamic subtest: vcs1
[496.589215] Dynamic subtest vcs1: SUCCESS (0.024s)
[496.600721] Starting dynamic subtest: vecs0
[496.610653] Dynamic subtest vecs0: SUCCESS (0.020s)
[496.619397] Starting dynamic subtest: ccs0
[496.630456] Dynamic subtest ccs0: SUCCESS (0.019s)
[496.631387] Subtest timeslicing: SUCCESS (0.142s)
[498.646015] [102/133] (533s left) kms_chamelium_color (ctm-0-25)
[498.732725] Subtest ctm-0-25: SKIP (0.000s)
[498.776621] [103/133] (533s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[498.866619] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[498.867489] Starting dynamic subtest: pipe-A-eDP-1
[498.959738] Dynamic subtest pipe-A-eDP-1: SKIP (0.092s)
[498.976261] Starting dynamic subtest: pipe-B-eDP-1
[500.106827] Dynamic subtest pipe-B-eDP-1: SKIP (1.143s)
[500.108631] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.241s)
[501.292382] [104/133] (530s left) gem_mmap (short-mmap)
[501.351783] Subtest short-mmap: SKIP (0.000s)
[501.411024] [105/133] (530s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[501.459965] Starting subtest: multi-wait-available-unsubmitted-submitted
[501.460798] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[501.552282] [106/133] (530s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[501.638484] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[501.640168] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[501.745828] [107/133] (530s left) kms_getfb (getfb2-accept-nv12)
[501.834247] Starting subtest: getfb2-accept-nv12
[501.835127] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[501.943863] [108/133] (530s left) syncobj_timeline (invalid-signal-zero-handles)
[502.022361] Starting subtest: invalid-signal-zero-handles
[502.023315] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[502.125147] [109/133] (529s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[502.211236] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[502.212786] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[502.297670] [110/133] (529s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[502.408785] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[502.409593] Starting dynamic subtest: pipe-A-eDP-1
[502.429393] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[502.439097] Starting dynamic subtest: pipe-B-eDP-1
[502.458437] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[502.467375] Starting dynamic subtest: pipe-C-eDP-1
[502.487168] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[502.495879] Starting dynamic subtest: pipe-D-eDP-1
[502.514925] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[502.516347] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[504.668157] [111/133] (527s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[504.756678] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[504.766884] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[504.858855] [112/133] (527s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[504.944406] Starting subtest: async-flip-with-page-flip-events-tiled
[505.328850] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[508.123095] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.786s)
[508.134826] Starting dynamic subtest: pipe-A-eDP-1-4
[510.307893] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.183s)
[510.317737] Starting dynamic subtest: pipe-A-eDP-1-4
[512.316661] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[512.326244] Starting dynamic subtest: pipe-A-eDP-1-x
[514.518491] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s)
[514.885208] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[517.645456] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.765s)
[517.658323] Starting dynamic subtest: pipe-B-eDP-1-4
[519.830179] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[519.840238] Starting dynamic subtest: pipe-B-eDP-1-4
[521.839526] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[521.849322] Starting dynamic subtest: pipe-B-eDP-1-x
[524.028748] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s)
[524.386990] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[527.173633] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.786s)
[527.184127] Starting dynamic subtest: pipe-C-eDP-1-4
[529.348644] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[529.360397] Starting dynamic subtest: pipe-C-eDP-1-4
[531.359271] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[531.368891] Starting dynamic subtest: pipe-C-eDP-1-x
[533.539639] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[533.895300] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[536.707755] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.811s)
[536.722800] Starting dynamic subtest: pipe-D-eDP-1-4
[538.883139] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[538.892739] Starting dynamic subtest: pipe-D-eDP-1-4
[540.893388] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.007s)
[540.905491] Starting dynamic subtest: pipe-D-eDP-1-x
[543.072778] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[543.074084] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.121s)
[544.273400] [113/133] (487s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[544.376441] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[544.378354] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[544.465558] [114/133] (487s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[544.510973] Starting subtest: etime-multi-wait-for-submit-submitted
[544.614879] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[544.689134] [115/133] (487s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[546.733185] Starting subtest: modeset-non-lpsp-stress-no-wait
[546.779832] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.048s)
[547.105866] [116/133] (485s left) gem_exec_params (sol-reset-invalid)
[547.160023] Starting subtest: sol-reset-invalid
[547.162521] Subtest sol-reset-invalid: SUCCESS (0.002s)
[548.704115] [117/133] (483s left) gem_mmap_gtt (cpuset-big-copy)
[548.759093] Subtest cpuset-big-copy: SKIP (0.000s)
[548.831062] [118/133] (483s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[548.915740] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[557.006856] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (8.091s)
[557.139039] [119/133] (475s left) kms_psr (psr2-sprite-plane-onoff)
[557.236287] Starting subtest: psr2-sprite-plane-onoff
[557.237256] Starting dynamic subtest: eDP-1
[559.000929] Dynamic subtest eDP-1: SUCCESS (1.764s)
[559.001853] Subtest psr2-sprite-plane-onoff: SUCCESS (1.765s)
[559.852547] [120/133] (472s left) kms_dsc (dsc-with-output-formats)
[559.939022] Starting subtest: dsc-with-output-formats
[559.947616] Subtest dsc-with-output-formats: SKIP (0.000s)
[560.011611] [121/133] (472s left) gen3_mixed_blits
[560.114528] [122/133] (472s left) gem_mmap_offset (clear-via-pagefault)
[560.165011] Starting subtest: clear-via-pagefault
[560.165915] Starting dynamic subtest: smem0
[594.114573] Dynamic subtest smem0: SUCCESS (33.943s)
[594.116148] Subtest clear-via-pagefault: SUCCESS (33.945s)
[594.243238] [123/133] (438s left) gem_eio (reset-stress)
[594.491977] Starting subtest: reset-stress
[594.493145] Starting dynamic subtest: render
[599.696383] Dynamic subtest render: SUCCESS (5.202s)
[599.713302] Starting dynamic subtest: bsd1
[618.192706] Dynamic subtest bsd1: SUCCESS (18.497s)
[618.209340] Starting dynamic subtest: bsd2
[636.176616] Dynamic subtest bsd2: SUCCESS (17.984s)
[636.193238] Starting dynamic subtest: blt
[636.195399] Dynamic subtest blt: SKIP (0.000s)
[636.206488] Starting dynamic subtest: vebox
[654.160450] Dynamic subtest vebox: SUCCESS (17.984s)
[654.161755] Subtest reset-stress: SUCCESS (59.671s)
[655.654155] [124/133] (376s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[655.704990] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[655.705787] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[655.806734] [125/133] (376s left) kms_vblank (query-busy-hang)
[655.898262] Starting subtest: query-busy-hang
[655.899120] Starting dynamic subtest: pipe-A-eDP-1
[657.786066] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[657.796920] Starting dynamic subtest: pipe-D-eDP-1
[660.416793] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.627s)
[660.417794] Subtest query-busy-hang: SUCCESS (4.520s)
[661.207624] [126/133] (371s left) kms_psr (fbc-pr-cursor-plane-onoff)
[661.292100] Starting subtest: fbc-pr-cursor-plane-onoff
[661.294080] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[661.363795] [127/133] (371s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[661.445961] Starting subtest: psr-1p-primscrn-cur-indfb-move
[668.836965] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.393s)
[668.960106] [128/133] (363s left) tools_test (sysfs_l3_parity)
[668.997464] Starting subtest: sysfs_l3_parity
[669.097194] Subtest sysfs_l3_parity: SKIP (0.103s)
[669.150638] [129/133] (363s left) kms_vblank (crtc-id)
[669.240958] Starting subtest: crtc-id
[669.241783] Starting dynamic subtest: pipe-A-eDP-1
[669.683864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[669.694671] Starting dynamic subtest: pipe-D-eDP-1
[670.863751] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.178s)
[670.864616] Subtest crtc-id: SUCCESS (1.623s)
[671.692472] [130/133] (361s left) gem_ctx_engines (independent)
[671.762079] Starting subtest: independent
[671.763105] Starting dynamic subtest: rcs0
[671.931566] Dynamic subtest rcs0: SUCCESS (0.160s)
[671.942600] Starting dynamic subtest: bcs0
[672.095177] Dynamic subtest bcs0: SUCCESS (0.162s)
[672.106327] Starting dynamic subtest: vcs0
[672.285332] Dynamic subtest vcs0: SUCCESS (0.190s)
[672.296920] Starting dynamic subtest: vcs1
[672.444825] Dynamic subtest vcs1: SUCCESS (0.158s)
[672.456438] Starting dynamic subtest: vecs0
[672.644097] Dynamic subtest vecs0: SUCCESS (0.198s)
[672.655387] Starting dynamic subtest: ccs0
[672.823995] Dynamic subtest ccs0: SUCCESS (0.179s)
[672.836451] Starting dynamic subtest: all-engines
[673.426004] Dynamic subtest all-engines: SUCCESS (0.601s)
[673.426890] Subtest independent: SUCCESS (1.656s)
[673.828144] [131/133] (359s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[673.918624] Starting subtest: flip-vs-dpms-on-nop-interruptible
[673.921037] Starting dynamic subtest: A-eDP1
[675.796509] Dynamic subtest A-eDP1: SUCCESS (1.875s)
[675.810319] Starting dynamic subtest: B-eDP1
[677.621281] Dynamic subtest B-eDP1: SUCCESS (1.821s)
[677.633614] Starting dynamic subtest: C-eDP1
[679.434906] Dynamic subtest C-eDP1: SUCCESS (1.810s)
[679.445809] Starting dynamic subtest: D-eDP1
[681.266078] Dynamic subtest D-eDP1: SUCCESS (1.828s)
[681.267010] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.349s)
[682.431251] [132/133] (350s left) kms_plane_lowres (tiling-x)
[682.528920] Starting subtest: tiling-x
[682.529692] Starting dynamic subtest: pipe-A-eDP-1
[682.531365] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[682.824115] Starting dynamic subtest: pipe-B-eDP-1
[682.825645] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[682.834770] Starting dynamic subtest: pipe-C-eDP-1
[682.836326] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[682.845288] Starting dynamic subtest: pipe-D-eDP-1
[682.846886] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[682.848580] Subtest tiling-x: SKIP (0.293s)
[683.654433] [133/133] (349s left) i915_pm_freq_api (freq-reset)
[683.724508] Starting subtest: freq-reset
[683.725669] Starting dynamic subtest: gt0
[683.920408] Dynamic subtest gt0: SUCCESS (0.194s)
[683.930313] Starting dynamic subtest: gt1
[684.105896] Dynamic subtest gt1: SUCCESS (0.176s)
[684.106987] Subtest freq-reset: SUCCESS (0.372s)
[684.167767] 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.