[57.369063] Initializing watchdogs
[57.369116]   /dev/watchdog0
[57.384161] [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]
[57.388529] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.390716] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.394254] [001/133] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[57.503767] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[57.506070] Starting dynamic subtest: pipe-A-eDP-1
[57.570551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[57.578870] Starting dynamic subtest: pipe-B-eDP-1
[57.632911] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.062s)
[57.641821] Starting dynamic subtest: pipe-C-eDP-1
[57.691612] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.060s)
[57.699795] Starting dynamic subtest: pipe-D-eDP-1
[57.755526] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.063s)
[57.757878] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.251s)
[60.003196] [002/133] (957s left) gem_softpin (zero)
[60.060697] Starting subtest: zero
[60.067993] Subtest zero: SUCCESS (0.006s)
[60.188098] [003/133] (957s left) kms_joiner (invalid-modeset-ultra-joiner)
[60.292315] Starting subtest: invalid-modeset-ultra-joiner
[60.296832] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[60.359647] [004/133] (957s left) gem_unfence_active_buffers
[60.498734] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[60.593999] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[60.598254] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[60.678178] [006/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[60.777322] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[60.781363] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[60.879962] [007/133] (957s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[61.000819] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[61.005465] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[61.156313] [008/133] (957s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[61.253456] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[61.255395] Starting dynamic subtest: pipe-A-eDP-1
[61.273066] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[61.282206] Starting dynamic subtest: pipe-B-eDP-1
[61.297577] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[61.303955] Starting dynamic subtest: pipe-C-eDP-1
[61.319240] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[61.325559] Starting dynamic subtest: pipe-D-eDP-1
[61.341066] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[61.342595] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[63.492752] [009/133] (954s left) syncobj_basic (bad-flags-fd-to-handle)
[63.551113] Starting subtest: bad-flags-fd-to-handle
[63.553504] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[63.671075] [010/133] (954s left) gem_userptr_blits (set-cache-level)
[63.728997] Starting subtest: set-cache-level
[63.733327] Subtest set-cache-level: SKIP (0.000s)
[63.847896] [011/133] (954s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[64.229520] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[64.997246] [012/133] (953s left) kms_flip (modeset-vs-vblank-race)
[65.090776] Starting subtest: modeset-vs-vblank-race
[65.093144] Starting dynamic subtest: A-eDP1
[69.849852] Dynamic subtest A-eDP1: SUCCESS (4.759s)
[69.860063] Starting dynamic subtest: B-eDP1
[74.570052] Dynamic subtest B-eDP1: SUCCESS (4.720s)
[74.581789] Starting dynamic subtest: C-eDP1
[79.188200] Dynamic subtest C-eDP1: SUCCESS (4.616s)
[79.197995] Starting dynamic subtest: D-eDP1
[83.731291] Dynamic subtest D-eDP1: SUCCESS (4.542s)
[83.733770] Subtest modeset-vs-vblank-race: SUCCESS (18.645s)
[84.896158] [013/133] (933s left) gem_pxp (display-protected-crc)
[85.033031] Starting subtest: display-protected-crc
[86.692816] Subtest display-protected-crc: SUCCESS (1.661s)
[86.806058] [014/133] (931s left) kms_cursor_crc (cursor-sliding-max-size)
[87.105238] Starting subtest: cursor-sliding-max-size
[87.111616] Subtest cursor-sliding-max-size: SKIP (0.000s)
[87.229864] [015/133] (931s left) prime_vgem (wait)
[87.342667] Starting subtest: wait
[87.345145] Starting dynamic subtest: rcs0
[87.377366] Dynamic subtest rcs0: SUCCESS (0.035s)
[87.385493] Starting dynamic subtest: bcs0
[87.434416] Dynamic subtest bcs0: SUCCESS (0.056s)
[87.442054] Starting dynamic subtest: vcs0
[87.481118] Dynamic subtest vcs0: SUCCESS (0.046s)
[87.489391] Starting dynamic subtest: vcs1
[87.523459] Dynamic subtest vcs1: SUCCESS (0.043s)
[87.530850] Starting dynamic subtest: vecs0
[87.571155] Dynamic subtest vecs0: SUCCESS (0.047s)
[87.578369] Starting dynamic subtest: ccs0
[87.615546] Dynamic subtest ccs0: SUCCESS (0.045s)
[87.617467] Subtest wait: SUCCESS (0.274s)
[87.736735] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[87.740214] [016/133] (930s left) kms_fence_pin_leak
[87.906792] [017/133] (930s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[87.997242] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[88.000903] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[88.101445] [018/133] (930s left) kms_chamelium_frames (dp-frame-dump)
[88.478713] Subtest dp-frame-dump: SKIP (0.000s)
[89.297853] [019/133] (929s left) gem_mmap (bad-offset)
[89.360737] Subtest bad-offset: SKIP (0.000s)
[89.431007] [020/133] (929s left) kms_cursor_crc (cursor-random-128x42)
[89.652328] Starting subtest: cursor-random-128x42
[89.709629] Subtest cursor-random-128x42: SKIP (0.053s)
[89.890703] [021/133] (928s left) kms_flip (flip-vs-fences)
[89.993055] Starting subtest: flip-vs-fences
[89.997215] Subtest flip-vs-fences: SKIP (0.000s)
[90.103851] [022/133] (928s left) kms_psr (fbc-pr-sprite-plane-move)
[90.195341] Starting subtest: fbc-pr-sprite-plane-move
[90.199827] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[90.265248] [023/133] (928s left) i915_drm_fdinfo (isolation)
[90.307255] Starting subtest: isolation
[90.309330] Starting dynamic subtest: rcs0
[90.332508] Dynamic subtest rcs0: SKIP (0.025s)
[90.342067] Starting dynamic subtest: bcs0
[90.345674] Dynamic subtest bcs0: SKIP (0.000s)
[90.352887] Starting dynamic subtest: vcs0
[90.356370] Dynamic subtest vcs0: SKIP (0.000s)
[90.363384] Starting dynamic subtest: vcs1
[90.366967] Dynamic subtest vcs1: SKIP (0.000s)
[90.373935] Starting dynamic subtest: vecs0
[90.377577] Dynamic subtest vecs0: SKIP (0.000s)
[90.384679] Starting dynamic subtest: ccs0
[90.388331] Dynamic subtest ccs0: SKIP (0.000s)
[90.391896] Subtest isolation: SKIP (0.028s)
[90.426806] [024/133] (928s left) gem_pxp (reject-modify-context-protection-off-1)
[90.483100] Starting subtest: reject-modify-context-protection-off-1
[90.484656] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[90.576883] [025/133] (928s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[90.647144] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[90.651259] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[90.844206] [026/133] (928s left) i915_pm_rpm (debugfs-forcewake-user)
[93.072051] Starting subtest: debugfs-forcewake-user
[104.462460] Subtest debugfs-forcewake-user: SUCCESS (11.393s)
[104.840581] [027/133] (914s left) syncobj_timeline (wait-all-for-submit-snapshot)
[104.904166] Starting subtest: wait-all-for-submit-snapshot
[104.986448] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[105.074386] [028/133] (913s left) kms_hdr (bpc-switch)
[105.161608] Starting subtest: bpc-switch
[106.209436] Starting dynamic subtest: pipe-A-eDP-1
[109.708957] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.499s)
[109.711369] Subtest bpc-switch: SUCCESS (4.549s)
[109.822491] [029/133] (909s left) gem_userptr_blits (unsync-unmap)
[109.889723] Subtest unsync-unmap: SKIP (0.000s)
[109.999397] [030/133] (909s left) kms_cursor_crc (cursor-onscreen-256x256)
[110.224529] Starting subtest: cursor-onscreen-256x256
[110.229577] Starting dynamic subtest: pipe-A-eDP-1
[112.351265] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.120s)
[112.383562] Starting dynamic subtest: pipe-D-eDP-1
[115.157290] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[115.159646] Subtest cursor-onscreen-256x256: SUCCESS (4.931s)
[116.025649] [031/133] (903s left) syncobj_timeline (device-submit-unordered)
[116.082818] Starting subtest: device-submit-unordered
[116.085165] Subtest device-submit-unordered: SUCCESS (0.000s)
[116.176403] [032/133] (902s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[116.290879] Starting subtest: fbcpsr-rgb101010-draw-blt
[123.087125] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.800s)
[123.224824] [033/133] (895s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[123.314605] Starting subtest: fbc-pr-cursor-plane-update-sf
[123.319025] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[123.380964] [034/133] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[123.472540] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[123.476659] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[123.573036] [035/133] (895s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[123.688319] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[124.335027] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.648s)
[124.497060] [036/133] (894s left) api_intel_bb (purge-bb)
[124.546174] Starting subtest: purge-bb
[124.548518] Subtest purge-bb: SUCCESS (0.004s)
[124.666853] [037/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[124.769236] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[132.070837] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.306s)
[132.200812] [038/133] (887s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[132.309253] Starting subtest: psr-rgb565-draw-render
[139.265104] Subtest psr-rgb565-draw-render: SUCCESS (6.959s)
[139.378206] [039/133] (880s left) perf (create-destroy-userspace-config)
[139.511099] Starting subtest: create-destroy-userspace-config
[139.530558] Subtest create-destroy-userspace-config: SUCCESS (0.018s)
[139.577950] [040/133] (879s left) perf (missing-sample-flags)
[139.674338] Starting subtest: missing-sample-flags
[139.676705] Subtest missing-sample-flags: SUCCESS (0.000s)
[139.716804] [041/133] (879s left) gem_exec_balancer (full-late-pulse)
[139.770496] Starting subtest: full-late-pulse
[144.747277] Subtest full-late-pulse: SUCCESS (4.976s)
[145.057515] [042/133] (874s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[145.148584] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[145.152777] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[145.222160] [043/133] (874s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[145.311846] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[145.316095] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[145.407462] [044/133] (874s left) sw_sync (alloc_merge_fence)
[145.448450] Starting subtest: alloc_merge_fence
[145.450738] Subtest alloc_merge_fence: SUCCESS (0.000s)
[145.505772] [045/133] (874s left) kms_plane_multiple (tiling-y)
[145.595963] Starting subtest: tiling-y
[145.600378] Subtest tiling-y: SKIP (0.000s)
[145.682396] [046/133] (874s left) gem_mmap_wc (write-gtt-read-wc)
[145.737850] Subtest write-gtt-read-wc: SKIP (0.000s)
[145.804388] [047/133] (873s left) perf (gen12-group-exclusive-stream-ctx-handle)
[145.900144] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[145.931476] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.029s)
[145.970546] [048/133] (873s left) gem_mmap_offset (isolation)
[147.833370] Starting subtest: isolation
[147.852751] Subtest isolation: SUCCESS (0.007s)
[147.939601] [049/133] (871s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[148.038114] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[148.042294] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[148.169685] [050/133] (871s left) gem_ctx_create (basic)
[148.241736] Starting subtest: basic
[148.244203] Subtest basic: SUCCESS (0.000s)
[148.426390] [051/133] (871s left) syncobj_wait (wait-any-interrupted)
[148.481157] Starting subtest: wait-any-interrupted
[148.582074] Subtest wait-any-interrupted: SUCCESS (0.101s)
[148.657964] [052/133] (871s left) gen9_exec_parse (bb-large)
[148.714069] Subtest bb-large: SKIP (0.000s)
[148.777267] [053/133] (871s left) syncobj_timeline (multi-wait-signaled)
[148.843867] Starting subtest: multi-wait-signaled
[148.846099] Subtest multi-wait-signaled: SUCCESS (0.000s)
[148.928639] [054/133] (871s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[149.063715] Starting subtest: multiplane-atomic-fence-wait
[149.385991] Subtest multiplane-atomic-fence-wait: SUCCESS (0.320s)
[150.534488] [055/133] (869s left) kms_invalid_mode (zero-vdisplay)
[150.625283] Starting subtest: zero-vdisplay
[150.627433] Starting dynamic subtest: pipe-A-eDP-1
[150.917291] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[150.926251] Starting dynamic subtest: pipe-B-eDP-1
[150.928324] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[150.936864] Starting dynamic subtest: pipe-C-eDP-1
[150.939028] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[150.947349] Starting dynamic subtest: pipe-D-eDP-1
[150.949199] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[150.951443] Subtest zero-vdisplay: SUCCESS (0.297s)
[151.761698] [056/133] (868s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[151.857562] Starting subtest: fbc-rgb101010-draw-blt
[156.480232] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.626s)
[157.686959] [057/133] (862s left) gen3_render_linear_blits
[157.819092] [058/133] (862s left) gem_exec_reloc (basic-concurrent0)
[157.878584] Subtest basic-concurrent0: SKIP (0.000s)
[157.958725] [059/133] (862s left) syncobj_wait (multi-wait-for-submit-signaled)
[158.009073] Starting subtest: multi-wait-for-submit-signaled
[158.011340] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[158.102648] [060/133] (862s left) kms_big_fb (4-tiled-addfb-size-overflow)
[158.198641] Starting subtest: 4-tiled-addfb-size-overflow
[158.200799] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[158.290536] [061/133] (862s left) sw_sync (alloc_fence)
[158.333996] Starting subtest: alloc_fence
[158.335953] Subtest alloc_fence: SUCCESS (0.000s)
[158.387229] [062/133] (862s left) kms_prime (d3hot)
[158.468351] Subtest D3hot: SKIP (0.000s)
[158.562429] [063/133] (861s left) perf_pmu (idle-no-semaphores)
[158.600045] Starting subtest: idle-no-semaphores
[158.602042] Starting dynamic subtest: rcs0
[159.159401] Dynamic subtest rcs0: SUCCESS (0.558s)
[159.171551] Starting dynamic subtest: bcs0
[159.675505] Dynamic subtest bcs0: SUCCESS (0.513s)
[159.690370] Starting dynamic subtest: vcs0
[160.197854] Dynamic subtest vcs0: SUCCESS (0.519s)
[160.209143] Starting dynamic subtest: vcs1
[160.717543] Dynamic subtest vcs1: SUCCESS (0.516s)
[160.728999] Starting dynamic subtest: vecs0
[161.241060] Dynamic subtest vecs0: SUCCESS (0.521s)
[161.252299] Starting dynamic subtest: ccs0
[161.763375] Dynamic subtest ccs0: SUCCESS (0.519s)
[161.766407] Subtest idle-no-semaphores: SUCCESS (3.164s)
[161.862540] [064/133] (858s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[161.972021] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[161.976133] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[162.056676] [065/133] (858s left) kms_pm_dc (dc9-dpms)
[163.167053] Starting subtest: dc9-dpms
[164.596368] Subtest dc9-dpms: SUCCESS (1.429s)
[164.672997] [066/133] (855s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[164.731636] Starting subtest: legacy-engines-hostile-preempt
[164.733473] Starting dynamic subtest: render
[164.801952] Dynamic subtest render: SUCCESS (0.072s)
[164.812742] Starting dynamic subtest: bsd1
[165.908453] Dynamic subtest bsd1: SUCCESS (1.103s)
[165.921719] Starting dynamic subtest: bsd2
[167.889290] Dynamic subtest bsd2: SUCCESS (1.978s)
[167.903930] Starting dynamic subtest: blt
[167.932444] Dynamic subtest blt: SUCCESS (0.042s)
[167.944864] Starting dynamic subtest: vebox
[169.940333] Dynamic subtest vebox: SUCCESS (2.005s)
[169.943174] Subtest legacy-engines-hostile-preempt: SUCCESS (5.210s)
[170.020762] [067/133] (850s left) gem_userptr_blits (create-destroy-sync)
[170.103877] Starting subtest: create-destroy-sync
[175.117811] Subtest create-destroy-sync: SUCCESS (5.014s)
[175.276080] [068/133] (845s left) kms_cursor_legacy (torture-move)
[175.400349] Starting subtest: torture-move
[175.402563] Starting dynamic subtest: pipe-A
[181.348591] Dynamic subtest pipe-A: SUCCESS (5.944s)
[181.359645] Starting dynamic subtest: pipe-B
[188.173972] Dynamic subtest pipe-B: SUCCESS (6.825s)
[188.188342] Starting dynamic subtest: pipe-C
[194.825469] Dynamic subtest pipe-C: SUCCESS (6.651s)
[194.834237] Starting dynamic subtest: pipe-D
[202.702846] Dynamic subtest pipe-D: SUCCESS (7.875s)
[202.712312] Starting dynamic subtest: all-pipes
[209.340452] Dynamic subtest all-pipes: SUCCESS (6.634s)
[209.342876] Subtest torture-move: SUCCESS (33.937s)
[209.500701] [069/133] (811s left) device_reset (cold-reset-bound)
[209.552154] Starting subtest: cold-reset-bound
[209.556805] Subtest cold-reset-bound: SKIP (0.000s)
[209.623722] [070/133] (811s left) syncobj_timeline (etime-multi-wait-submitted)
[209.680154] Starting subtest: etime-multi-wait-submitted
[209.787450] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[209.860434] [071/133] (810s left) kms_async_flips (invalid-async-flip-atomic)
[209.951215] Starting subtest: invalid-async-flip-atomic
[210.334407] Starting dynamic subtest: pipe-A-eDP-1
[211.166806] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s)
[211.530320] Starting dynamic subtest: pipe-B-eDP-1
[212.388059] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.865s)
[212.749835] Starting dynamic subtest: pipe-C-eDP-1
[213.520201] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.777s)
[213.886179] Starting dynamic subtest: pipe-D-eDP-1
[214.645439] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[214.647757] Subtest invalid-async-flip-atomic: SUCCESS (4.697s)
[215.788849] [072/133] (805s left) gem_exec_schedule (preempt-hang)
[215.954802] Starting subtest: preempt-hang
[215.957305] Starting dynamic subtest: rcs0
[216.191329] Dynamic subtest rcs0: SUCCESS (0.239s)
[216.200413] Starting dynamic subtest: bcs0
[216.423962] Dynamic subtest bcs0: SUCCESS (0.233s)
[216.434629] Starting dynamic subtest: vcs0
[216.651710] Dynamic subtest vcs0: SUCCESS (0.226s)
[216.661574] Starting dynamic subtest: vcs1
[216.879871] Dynamic subtest vcs1: SUCCESS (0.226s)
[216.891996] Starting dynamic subtest: vecs0
[217.104192] Dynamic subtest vecs0: SUCCESS (0.225s)
[217.113745] Starting dynamic subtest: ccs0
[217.336194] Dynamic subtest ccs0: SUCCESS (0.231s)
[217.338278] Subtest preempt-hang: SUCCESS (1.385s)
[218.045864] [073/133] (802s left) gem_mmap (basic-small-bo)
[218.106154] Subtest basic-small-bo: SKIP (0.000s)
[218.168753] [074/133] (802s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[218.265645] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[218.270122] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[218.393960] [075/133] (802s left) kms_plane (plane-position-covered)
[218.506860] Starting subtest: plane-position-covered
[219.039199] Starting dynamic subtest: pipe-A-plane-1
[220.312104] Dynamic subtest pipe-A-plane-1: SUCCESS (1.273s)
[220.321829] Starting dynamic subtest: pipe-A-plane-2
[221.620724] Dynamic subtest pipe-A-plane-2: SUCCESS (1.307s)
[221.630239] Starting dynamic subtest: pipe-A-plane-3
[222.869866] Dynamic subtest pipe-A-plane-3: SUCCESS (1.246s)
[222.879959] Starting dynamic subtest: pipe-A-plane-4
[224.118555] Dynamic subtest pipe-A-plane-4: SUCCESS (1.249s)
[224.128695] Starting dynamic subtest: pipe-A-plane-5
[224.149071] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s)
[225.384640] Starting dynamic subtest: pipe-B-plane-1
[226.720501] Dynamic subtest pipe-B-plane-1: SUCCESS (1.343s)
[226.730339] Starting dynamic subtest: pipe-B-plane-2
[228.009466] Dynamic subtest pipe-B-plane-2: SUCCESS (1.290s)
[228.020263] Starting dynamic subtest: pipe-B-plane-3
[229.259587] Dynamic subtest pipe-B-plane-3: SUCCESS (1.250s)
[229.269577] Starting dynamic subtest: pipe-B-plane-4
[230.589585] Dynamic subtest pipe-B-plane-4: SUCCESS (1.329s)
[230.599095] Starting dynamic subtest: pipe-B-plane-5
[230.616545] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[230.618870] Subtest plane-position-covered: SUCCESS (12.109s)
[231.406925] [076/133] (789s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[231.506123] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[231.510248] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[231.577955] [077/133] (789s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[231.666873] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[231.669143] Starting dynamic subtest: pipe-A-eDP-1
[231.677955] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[231.687813] Starting dynamic subtest: pipe-B-eDP-1
[231.696807] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[231.706401] Starting dynamic subtest: pipe-C-eDP-1
[231.714881] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[231.723481] Starting dynamic subtest: pipe-D-eDP-1
[231.731676] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[231.735859] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[233.959317] [078/133] (787s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[234.047405] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[234.049713] Starting dynamic subtest: pipe-A
[234.071663] Dynamic subtest pipe-A: SKIP (0.019s)
[234.082626] Starting dynamic subtest: pipe-B
[234.102765] Dynamic subtest pipe-B: SKIP (0.032s)
[234.111728] Starting dynamic subtest: pipe-C
[234.136338] Dynamic subtest pipe-C: SKIP (0.032s)
[234.145300] Starting dynamic subtest: pipe-D
[234.167894] Dynamic subtest pipe-D: SKIP (0.031s)
[234.172159] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.118s)
[234.279414] [079/133] (786s left) kms_color (deep-color)
[234.373318] Starting subtest: deep-color
[235.422220] Starting dynamic subtest: pipe-A-eDP-1-gamma
[236.146726] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.726s)
[236.156775] Starting dynamic subtest: pipe-A-eDP-1-degamma
[237.615677] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.467s)
[237.625203] Starting dynamic subtest: pipe-A-eDP-1-ctm
[239.072663] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.456s)
[239.834057] Starting dynamic subtest: pipe-B-eDP-1-gamma
[240.556469] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.729s)
[240.565432] Starting dynamic subtest: pipe-B-eDP-1-degamma
[242.058041] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.501s)
[242.069396] Starting dynamic subtest: pipe-B-eDP-1-ctm
[243.466667] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.409s)
[244.229708] Starting dynamic subtest: pipe-C-eDP-1-gamma
[244.918337] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.695s)
[244.927506] Starting dynamic subtest: pipe-C-eDP-1-degamma
[246.310246] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.391s)
[246.319760] Starting dynamic subtest: pipe-C-eDP-1-ctm
[247.719173] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.407s)
[248.527171] Starting dynamic subtest: pipe-D-eDP-1-gamma
[249.224627] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.703s)
[249.234357] Starting dynamic subtest: pipe-D-eDP-1-degamma
[250.689346] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.467s)
[250.698765] Starting dynamic subtest: pipe-D-eDP-1-ctm
[252.111679] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.422s)
[252.113900] Subtest deep-color: SUCCESS (17.741s)
[252.981718] [080/133] (768s left) kms_atomic_transition (plane-all-transition-nonblocking)
[253.075223] Starting subtest: plane-all-transition-nonblocking
[253.077515] Starting dynamic subtest: pipe-A-eDP-1
[255.580168] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.506s)
[255.889964] Starting dynamic subtest: pipe-B-eDP-1
[259.103261] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.223s)
[259.412913] Subtest plane-all-transition-nonblocking: SUCCESS (6.338s)
[260.241960] [081/133] (761s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[260.356983] Starting subtest: psr-2p-primscrn-cur-indfb-move
[260.361572] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[260.466429] [082/133] (760s left) i915_query (engine-info-invalid)
[260.521890] Starting subtest: engine-info-invalid
[260.524197] Subtest engine-info-invalid: SUCCESS (0.000s)
[260.629734] [083/133] (760s left) kms_rotation_crc (sprite-rotation-90)
[260.725812] Starting subtest: sprite-rotation-90
[260.730128] Subtest sprite-rotation-90: SKIP (0.001s)
[260.801107] [084/133] (760s left) gem_userptr_blits (coherency-sync)
[260.870220] Starting subtest: coherency-sync
[261.293446] Subtest coherency-sync: SKIP (0.386s)
[261.385070] [085/133] (760s left) api_intel_allocator (default-alignment)
[261.481449] Starting subtest: default-alignment
[261.483656] Subtest default-alignment: SUCCESS (0.003s)
[261.608137] [086/133] (759s left) kms_psr (pr-cursor-render)
[261.733708] Starting subtest: pr-cursor-render
[261.738194] Subtest pr-cursor-render: SKIP (0.000s)
[261.815553] [087/133] (759s left) gem_exec_flush (basic-wb-pro-default)
[261.886462] Starting subtest: basic-wb-pro-default
[267.343223] Subtest basic-wb-pro-default: SUCCESS (5.459s)
[267.537205] [088/133] (754s left) gem_eio (kms)
[267.826921] Starting subtest: kms
[286.623594] Subtest kms: SUCCESS (18.796s)
[287.812361] [089/133] (733s left) template (a)
[287.874514] Starting subtest: A
[287.877052] Subtest A: SUCCESS (0.000s)
[287.974816] [090/133] (733s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[288.076380] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[288.078701] Starting dynamic subtest: pipe-A-default-mode
[290.829481] Dynamic subtest pipe-A-default-mode: SUCCESS (2.753s)
[290.831794] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.755s)
[291.721717] [091/133] (729s left) gem_exec_schedule (semaphore-noskip)
[291.800328] Starting subtest: semaphore-noskip
[292.220211] Subtest semaphore-noskip: SUCCESS (0.427s)
[292.574597] [092/133] (729s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[292.695657] Starting subtest: basic-flip-before-cursor-legacy
[293.610222] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.913s)
[294.435041] [093/133] (727s left) fbdev (write)
[294.477834] Starting subtest: write
[294.839679] Subtest write: SUCCESS (0.360s)
[294.904556] [094/133] (726s left) kms_flip (2x-blocking-absolute-wf_vblank)
[295.007256] Starting subtest: 2x-blocking-absolute-wf_vblank
[295.018935] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[295.104026] [095/133] (726s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[295.173767] Starting subtest: multi-wait-for-submit-unsubmitted
[295.283436] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.109s)
[295.360298] [096/133] (726s left) kms_big_fb (x-tiled-addfb)
[295.477348] Starting subtest: x-tiled-addfb
[295.479666] Subtest x-tiled-addfb: SUCCESS (0.000s)
[295.582312] [097/133] (726s left) kms_selftest (drm_cmdline_parser)
[295.625916] Starting subtest: drm_cmdline_parser
[295.640104] Starting dynamic subtest: drm_test_cmdline_force_d_only
[295.727101] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.086s)
[295.737755] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[295.818127] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.090s)
[295.827617] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[295.915509] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.098s)
[295.925096] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[296.003417] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.086s)
[296.013888] Starting dynamic subtest: drm_test_cmdline_force_e_only
[296.096414] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.092s)
[296.105687] Starting dynamic subtest: drm_test_cmdline_res
[296.195662] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.099s)
[296.205328] Starting dynamic subtest: drm_test_cmdline_res_vesa
[296.287738] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.090s)
[296.298076] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[296.390543] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.102s)
[296.400407] Starting dynamic subtest: drm_test_cmdline_res_rblank
[296.491074] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.100s)
[296.501319] Starting dynamic subtest: drm_test_cmdline_res_bpp
[296.588715] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.096s)
[296.598800] Starting dynamic subtest: drm_test_cmdline_res_refresh
[296.682512] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.093s)
[296.692460] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[296.765743] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.082s)
[296.774641] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[296.857327] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.091s)
[296.866257] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[296.945436] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.088s)
[296.954311] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[297.033463] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.087s)
[297.042414] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[297.127666] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.092s)
[297.136596] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[297.223690] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.094s)
[297.238685] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[297.310442] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.087s)
[297.320179] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[297.396204] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.083s)
[297.404850] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[297.483000] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.085s)
[297.493806] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[297.570308] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.086s)
[297.579344] Starting dynamic subtest: drm_test_cmdline_name
[297.671454] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.099s)
[297.680513] Starting dynamic subtest: drm_test_cmdline_name_bpp
[297.755646] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.082s)
[297.765995] Starting dynamic subtest: drm_test_cmdline_name_option
[297.864376] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.108s)
[297.874294] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[297.962553] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.097s)
[297.973276] Starting dynamic subtest: drm_test_cmdline_rotate_0
[298.058316] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.095s)
[298.068813] Starting dynamic subtest: drm_test_cmdline_rotate_90
[298.151355] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.092s)
[298.160232] Starting dynamic subtest: drm_test_cmdline_rotate_180
[298.238866] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.086s)
[298.248684] Starting dynamic subtest: drm_test_cmdline_rotate_270
[298.336094] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.094s)
[298.344934] Starting dynamic subtest: drm_test_cmdline_hmirror
[298.418529] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.081s)
[298.427544] Starting dynamic subtest: drm_test_cmdline_vmirror
[298.507465] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.089s)
[298.516674] Starting dynamic subtest: drm_test_cmdline_margin_options
[298.591772] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.081s)
[298.602512] Starting dynamic subtest: drm_test_cmdline_multiple_options
[298.695376] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.103s)
[298.706023] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[298.786752] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.090s)
[298.797282] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[298.865683] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.076s)
[298.876122] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[298.967366] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.102s)
[298.977918] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[299.058202] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.089s)
[299.068804] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[299.154484] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.095s)
[299.164296] Starting dynamic subtest: drm_test_cmdline_invalid
[299.259358] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.104s)
[299.268239] Starting dynamic subtest: drm_test_cmdline_tv_options
[299.354917] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.094s)
[299.356517] Subtest drm_cmdline_parser: SUCCESS (3.728s)
[299.513720] [098/133] (722s left) gem_exec_balancer (sequential)
[299.583079] Starting subtest: sequential
[302.713137] Subtest sequential: SUCCESS (3.131s)
[303.063233] [099/133] (718s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[303.151059] Starting subtest: fbc-psr2-sprite-mmap-cpu
[303.153372] Starting dynamic subtest: eDP-1
[303.157786] Dynamic subtest eDP-1: SKIP (0.000s)
[303.162252] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[303.239586] [100/133] (718s left) gem_exec_fence (nb-await)
[303.418695] Starting subtest: nb-await
[303.420632] Starting dynamic subtest: rcs0
[303.481595] Dynamic subtest rcs0: SUCCESS (0.066s)
[303.492216] Starting dynamic subtest: bcs0
[303.538122] Dynamic subtest bcs0: SUCCESS (0.055s)
[303.549588] Starting dynamic subtest: vcs0
[303.598086] Dynamic subtest vcs0: SUCCESS (0.058s)
[303.608597] Starting dynamic subtest: vcs1
[303.657577] Dynamic subtest vcs1: SUCCESS (0.057s)
[303.668750] Starting dynamic subtest: vecs0
[303.716405] Dynamic subtest vecs0: SUCCESS (0.057s)
[303.727857] Starting dynamic subtest: ccs0
[303.775212] Dynamic subtest ccs0: SUCCESS (0.056s)
[303.778083] Subtest nb-await: SUCCESS (0.360s)
[305.971989] [101/133] (716s left) sysfs_timeslice_duration (idempotent)
[306.029527] Starting subtest: idempotent
[306.031966] Starting dynamic subtest: vecs0
[306.034325] Dynamic subtest vecs0: SUCCESS (0.000s)
[306.045549] Starting dynamic subtest: ccs0
[306.047761] Dynamic subtest ccs0: SUCCESS (0.000s)
[306.057264] Starting dynamic subtest: vcs0
[306.059127] Dynamic subtest vcs0: SUCCESS (0.000s)
[306.071249] Starting dynamic subtest: bcs0
[306.073433] Dynamic subtest bcs0: SUCCESS (0.000s)
[306.082711] Starting dynamic subtest: rcs0
[306.084649] Dynamic subtest rcs0: SUCCESS (0.000s)
[306.093680] Starting dynamic subtest: vcs1
[306.095680] Dynamic subtest vcs1: SUCCESS (0.000s)
[306.097675] Subtest idempotent: SUCCESS (0.006s)
[306.136238] [102/133] (716s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[306.240310] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[306.244542] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[306.345520] [103/133] (715s left) gem_exec_store (basic)
[306.410406] Starting subtest: basic
[306.515239] Subtest basic: SUCCESS (0.105s)
[306.714156] [104/133] (715s left) intel_hwmon (hwmon-read)
[306.782695] Subtest hwmon-read: SKIP (0.000s)
[306.840560] [105/133] (715s left) i915_getparams_basic (basic-eu-total)
[306.899245] Starting subtest: basic-eu-total
[306.903612] Subtest basic-eu-total: SUCCESS (0.000s)
[307.000456] [106/133] (715s left) kms_big_fb (linear-16bpp-rotate-90)
[307.094873] Starting subtest: linear-16bpp-rotate-90
[307.113892] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[307.228868] [107/133] (715s left) kms_vblank (query-forked-busy)
[307.325179] Starting subtest: query-forked-busy
[307.327349] Starting dynamic subtest: pipe-A-eDP-1
[309.216683] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.892s)
[309.231264] Starting dynamic subtest: pipe-D-eDP-1
[311.784403] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.565s)
[311.786730] Subtest query-forked-busy: SUCCESS (4.461s)
[312.598390] [108/133] (709s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[312.698073] Starting subtest: nonblocking-crc-frame-sequence
[312.700258] Starting dynamic subtest: pipe-A-eDP-1
[313.444805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[313.455064] Starting dynamic subtest: pipe-B-eDP-1
[314.900960] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.452s)
[314.911039] Starting dynamic subtest: pipe-C-eDP-1
[316.293434] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[316.303728] Starting dynamic subtest: pipe-D-eDP-1
[317.621709] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[317.624089] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.925s)
[318.426108] [109/133] (704s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[318.534980] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[318.537319] Starting dynamic subtest: pipe-A-eDP-1
[324.377158] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.846s)
[324.387450] Starting dynamic subtest: pipe-B-eDP-1
[331.025046] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.645s)
[331.027322] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.495s)
[331.899582] [110/133] (690s left) kms_flip (2x-plain-flip-interruptible)
[332.015348] Starting subtest: 2x-plain-flip-interruptible
[332.027798] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[332.134137] [111/133] (690s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[332.224980] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[332.227326] Starting dynamic subtest: pipe-A-eDP-1
[343.226271] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.003s)
[343.235982] Starting dynamic subtest: pipe-B-eDP-1
[354.898418] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.671s)
[354.900925] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.677s)
[355.760513] [112/133] (666s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[355.857850] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[355.859729] Starting dynamic subtest: pipe-A-eDP-1
[356.379040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.493s)
[356.390772] Starting dynamic subtest: pipe-B-eDP-1
[357.839474] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.459s)
[357.851297] Starting dynamic subtest: pipe-C-eDP-1
[359.186649] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s)
[359.198279] Starting dynamic subtest: pipe-D-eDP-1
[360.566067] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.380s)
[360.568139] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.684s)
[361.710683] [113/133] (660s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[361.828475] Starting subtest: cursorB-vs-flipA-varying-size
[361.832908] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[361.974396] [114/133] (660s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[362.064779] Starting subtest: pipe-fbc-rte
[362.071509] Starting dynamic subtest: pipe-B-eDP-1
[367.493934] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.433s)
[367.501175] Subtest pipe-fbc-rte: SUCCESS (5.435s)
[369.749581] [115/133] (652s left) syncobj_timeline (invalid-query-bad-pad)
[369.805330] Starting subtest: invalid-query-bad-pad
[369.807352] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[369.898042] [116/133] (652s left) gem_exercise_blt (fast-copy-emit)
[369.951394] Starting subtest: fast-copy-emit
[369.953347] Starting dynamic subtest: linear-smem-smem-emit
[369.970082] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s)
[369.981775] Starting dynamic subtest: xmajor-smem-smem-emit
[369.987650] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[369.997363] Starting dynamic subtest: tile4-smem-smem-emit
[370.004300] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[370.013668] Starting dynamic subtest: tile64-smem-smem-emit
[370.021916] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[370.024270] Subtest fast-copy-emit: SUCCESS (0.074s)
[370.129666] [117/133] (652s left) gem_ctx_persistence (engines-queued)
[370.201517] Starting subtest: engines-queued
[370.203739] Starting dynamic subtest: rcs0
[370.277645] Dynamic subtest rcs0: SUCCESS (0.076s)
[370.290490] Starting dynamic subtest: bcs0
[370.301282] Dynamic subtest bcs0: SUCCESS (0.022s)
[370.310636] Starting dynamic subtest: vcs0
[371.895518] Dynamic subtest vcs0: SUCCESS (1.592s)
[371.908284] Starting dynamic subtest: vcs1
[373.876874] Dynamic subtest vcs1: SUCCESS (1.978s)
[373.888456] Starting dynamic subtest: vecs0
[375.861793] Dynamic subtest vecs0: SUCCESS (1.981s)
[375.873650] Starting dynamic subtest: ccs0
[376.041334] Dynamic subtest ccs0: SUCCESS (0.178s)
[376.043771] Subtest engines-queued: SUCCESS (5.841s)
[376.192918] [118/133] (646s left) kms_big_fb (y-tiled-addfb)
[376.323076] Starting subtest: y-tiled-addfb
[376.327420] Subtest y-tiled-addfb: SKIP (0.000s)
[376.425464] [119/133] (646s left) gem_partial_pwrite_pread (write-display)
[376.498078] Subtest write-display: SKIP (0.000s)
[376.578758] [120/133] (646s left) kms_psr (psr2-sprite-plane-move)
[376.673372] Starting subtest: psr2-sprite-plane-move
[376.675706] Starting dynamic subtest: eDP-1
[378.460401] Dynamic subtest eDP-1: SUCCESS (1.787s)
[378.462781] Subtest psr2-sprite-plane-move: SUCCESS (1.789s)
[379.290591] [121/133] (643s left) gem_close_race (multigpu-basic-threads)
[379.353847] Starting subtest: multigpu-basic-threads
[379.358177] Subtest multigpu-basic-threads: SKIP (0.000s)
[379.595884] [122/133] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[379.696309] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[379.700362] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[379.793616] [123/133] (643s left) kms_content_protection (dp-mst-type-0)
[379.932570] Starting subtest: dp-mst-type-0
[379.937076] Subtest dp-mst-type-0: SKIP (0.000s)
[380.065225] [124/133] (643s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[380.157794] Starting subtest: fbcpsr-stridechange
[386.442806] Subtest fbcpsr-stridechange: SUCCESS (6.287s)
[386.599333] [125/133] (636s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[386.702818] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[386.707277] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[386.799890] [126/133] (636s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[386.897645] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[386.899996] Starting dynamic subtest: pipe-A-eDP-1
[387.784701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.882s)
[387.795773] Starting dynamic subtest: pipe-B-eDP-1
[389.475522] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.687s)
[389.485376] Starting dynamic subtest: pipe-C-eDP-1
[390.939319] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.464s)
[390.950176] Starting dynamic subtest: pipe-D-eDP-1
[392.484066] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.544s)
[392.486442] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.582s)
[393.662901] [127/133] (629s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[393.765983] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[393.770484] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[393.865052] [128/133] (629s left) kms_psr (psr-sprite-render)
[393.954507] Starting subtest: psr-sprite-render
[393.956829] Starting dynamic subtest: eDP-1
[395.671584] Dynamic subtest eDP-1: SUCCESS (1.716s)
[395.673522] Subtest psr-sprite-render: SUCCESS (1.717s)
[396.508617] [129/133] (626s left) syncobj_wait (wait-all-for-submit-complex)
[396.568804] Starting subtest: wait-all-for-submit-complex
[396.782531] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[396.857382] [130/133] (626s left) gem_ctx_param (invalid-param-get)
[396.912633] Starting subtest: invalid-param-get
[396.915041] Subtest invalid-param-get: SUCCESS (0.001s)
[397.008211] [131/133] (626s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[397.131799] Starting subtest: basic-flip-before-cursor-varying-size
[398.058405] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.924s)
[398.947906] [132/133] (624s left) kms_chamelium_color (ctm-0-50)
[399.049132] Subtest ctm-0-50: SKIP (0.000s)
[399.095323] [133/133] (624s left) gem_ctx_param (invalid-ctx-get)
[399.162972] Starting subtest: invalid-ctx-get
[399.165724] Subtest invalid-ctx-get: SUCCESS (0.000s)
[399.266809] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_softpin
results: parsing output: 2/ for test: kms_joiner
results: parsing output: 3/ for test: gem_unfence_active_buffers
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: syncobj_basic
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: gem_pxp
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: kms_fence_pin_leak
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_chamelium_frames
results: parsing output: 18/ for test: gem_mmap
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: gem_pxp
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: i915_pm_rpm
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_hdr
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: sw_sync
results: parsing output: 44/ for test: kms_plane_multiple
results: parsing output: 45/ for test: gem_mmap_wc
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: gem_mmap_offset
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_ctx_create
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: gen9_exec_parse
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_explicit_fence
results: parsing output: 54/ for test: kms_invalid_mode
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gen3_render_linear_blits
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: kms_prime
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: kms_pm_dc
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: device_reset
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_async_flips
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: gem_mmap
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_color
results: parsing output: 79/ for test: kms_atomic_transition
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: i915_query
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: api_intel_allocator
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_exec_flush
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: template
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: fbdev
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_selftest
results: parsing output: 97/ for test: gem_exec_balancer
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: sysfs_timeslice_duration
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_store
results: parsing output: 103/ for test: intel_hwmon
results: parsing output: 104/ for test: i915_getparams_basic
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: kms_pipe_crc_basic
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_exercise_blt
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_partial_pwrite_pread
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_close_race
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_ctx_param
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_chamelium_color
results: parsing output: 132/ for test: gem_ctx_param
Done.