[57.232607] Initializing watchdogs
[57.232654]   /dev/watchdog0
[57.246111] [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.250256] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.253044] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.256630] [001/133] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[57.379103] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[57.381514] Starting dynamic subtest: pipe-A-eDP-1
[57.436884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[57.445836] Starting dynamic subtest: pipe-B-eDP-1
[57.498877] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s)
[57.506597] Starting dynamic subtest: pipe-C-eDP-1
[57.560632] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.060s)
[57.568950] Starting dynamic subtest: pipe-D-eDP-1
[57.621554] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[57.623922] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.245s)
[59.929182] [002/133] (957s left) gem_softpin (zero)
[59.999501] Starting subtest: zero
[60.006327] Subtest zero: SUCCESS (0.005s)
[60.121032] [003/133] (957s left) kms_joiner (invalid-modeset-ultra-joiner)
[60.221792] Starting subtest: invalid-modeset-ultra-joiner
[60.226197] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[60.299992] [004/133] (957s left) gem_unfence_active_buffers
[60.445606] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[60.557154] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[60.561066] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[60.676311] [006/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[60.775128] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[60.779151] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[60.871249] [007/133] (957s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[60.979408] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[60.983750] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[61.121149] [008/133] (956s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[61.203078] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[61.205068] Starting dynamic subtest: pipe-A-eDP-1
[61.221642] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[61.229850] Starting dynamic subtest: pipe-B-eDP-1
[61.245543] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[61.252429] Starting dynamic subtest: pipe-C-eDP-1
[61.267598] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[61.273979] Starting dynamic subtest: pipe-D-eDP-1
[61.289716] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[61.291472] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[63.437430] [009/133] (954s left) syncobj_basic (bad-flags-fd-to-handle)
[63.492790] Starting subtest: bad-flags-fd-to-handle
[63.494690] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[63.592397] [010/133] (954s left) gem_userptr_blits (set-cache-level)
[63.656797] Starting subtest: set-cache-level
[63.660987] Subtest set-cache-level: SKIP (0.000s)
[63.782906] [011/133] (954s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[64.165094] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[65.018130] [012/133] (953s left) kms_flip (modeset-vs-vblank-race)
[65.117753] Starting subtest: modeset-vs-vblank-race
[65.120229] Starting dynamic subtest: A-eDP1
[69.848207] Dynamic subtest A-eDP1: SUCCESS (4.731s)
[69.858445] Starting dynamic subtest: B-eDP1
[74.580640] Dynamic subtest B-eDP1: SUCCESS (4.730s)
[74.590377] Starting dynamic subtest: C-eDP1
[79.201311] Dynamic subtest C-eDP1: SUCCESS (4.619s)
[79.211510] Starting dynamic subtest: D-eDP1
[83.758452] Dynamic subtest D-eDP1: SUCCESS (4.556s)
[83.763476] Subtest modeset-vs-vblank-race: SUCCESS (18.648s)
[84.919140] [013/133] (933s left) gem_pxp (display-protected-crc)
[85.049825] Starting subtest: display-protected-crc
[86.809681] Subtest display-protected-crc: SUCCESS (1.763s)
[86.921642] [014/133] (931s left) kms_cursor_crc (cursor-sliding-max-size)
[87.232995] Starting subtest: cursor-sliding-max-size
[87.239585] Subtest cursor-sliding-max-size: SKIP (0.000s)
[87.381348] [015/133] (930s left) prime_vgem (wait)
[87.490377] Starting subtest: wait
[87.492376] Starting dynamic subtest: rcs0
[87.528097] Dynamic subtest rcs0: SUCCESS (0.038s)
[87.535528] Starting dynamic subtest: bcs0
[87.593075] Dynamic subtest bcs0: SUCCESS (0.064s)
[87.600673] Starting dynamic subtest: vcs0
[87.640823] Dynamic subtest vcs0: SUCCESS (0.047s)
[87.647944] Starting dynamic subtest: vcs1
[87.686329] Dynamic subtest vcs1: SUCCESS (0.045s)
[87.692884] Starting dynamic subtest: vecs0
[87.731461] Dynamic subtest vecs0: SUCCESS (0.045s)
[87.738172] Starting dynamic subtest: ccs0
[87.778089] Dynamic subtest ccs0: SUCCESS (0.046s)
[87.779913] Subtest wait: SUCCESS (0.289s)
[87.916322] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[87.919239] [016/133] (930s left) kms_fence_pin_leak
[88.090986] [017/133] (930s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[88.180472] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[88.183917] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[88.280709] [018/133] (930s left) kms_chamelium_frames (dp-frame-dump)
[88.667866] Subtest dp-frame-dump: SKIP (0.000s)
[89.428730] [019/133] (929s left) gem_mmap (bad-offset)
[89.500541] Subtest bad-offset: SKIP (0.000s)
[89.565751] [020/133] (928s left) kms_cursor_crc (cursor-random-128x42)
[89.797981] Starting subtest: cursor-random-128x42
[89.847439] Subtest cursor-random-128x42: SKIP (0.046s)
[90.059123] [021/133] (928s left) kms_flip (flip-vs-fences)
[90.151135] Starting subtest: flip-vs-fences
[90.155257] Subtest flip-vs-fences: SKIP (0.000s)
[90.261613] [022/133] (928s left) kms_psr (fbc-pr-sprite-plane-move)
[90.355054] Starting subtest: fbc-pr-sprite-plane-move
[90.359664] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[90.430674] [023/133] (928s left) i915_drm_fdinfo (isolation)
[90.471952] Starting subtest: isolation
[90.473711] Starting dynamic subtest: rcs0
[90.498258] Dynamic subtest rcs0: SKIP (0.025s)
[90.506875] Starting dynamic subtest: bcs0
[90.517205] Dynamic subtest bcs0: SKIP (0.019s)
[90.524062] Starting dynamic subtest: vcs0
[90.527277] Dynamic subtest vcs0: SKIP (0.001s)
[90.534491] Starting dynamic subtest: vcs1
[90.537969] Dynamic subtest vcs1: SKIP (0.000s)
[90.544697] Starting dynamic subtest: vecs0
[90.548189] Dynamic subtest vecs0: SKIP (0.000s)
[90.554287] Starting dynamic subtest: ccs0
[90.557535] Dynamic subtest ccs0: SKIP (0.000s)
[90.560767] Subtest isolation: SKIP (0.049s)
[90.594222] [024/133] (928s left) gem_pxp (reject-modify-context-protection-off-1)
[90.649232] Starting subtest: reject-modify-context-protection-off-1
[90.650925] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[90.738648] [025/133] (927s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[90.807185] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[90.811358] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[91.001867] [026/133] (927s left) i915_pm_rpm (debugfs-forcewake-user)
[93.034481] Starting subtest: debugfs-forcewake-user
[104.433422] Subtest debugfs-forcewake-user: SUCCESS (11.401s)
[104.824760] [027/133] (913s left) syncobj_timeline (wait-all-for-submit-snapshot)
[104.878703] Starting subtest: wait-all-for-submit-snapshot
[104.960740] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[105.034146] [028/133] (913s left) kms_hdr (bpc-switch)
[105.126097] Starting subtest: bpc-switch
[106.180105] Starting dynamic subtest: pipe-A-eDP-1
[109.677601] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.497s)
[109.680062] Subtest bpc-switch: SUCCESS (4.554s)
[109.789492] [029/133] (909s left) gem_userptr_blits (unsync-unmap)
[109.861082] Subtest unsync-unmap: SKIP (0.000s)
[109.998975] [030/133] (908s left) kms_cursor_crc (cursor-onscreen-256x256)
[110.225566] Starting subtest: cursor-onscreen-256x256
[110.230356] Starting dynamic subtest: pipe-A-eDP-1
[112.340741] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s)
[112.368312] Starting dynamic subtest: pipe-D-eDP-1
[115.092436] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.727s)
[115.094362] Subtest cursor-onscreen-256x256: SUCCESS (4.865s)
[115.901499] [031/133] (903s left) syncobj_timeline (device-submit-unordered)
[115.959178] Starting subtest: device-submit-unordered
[115.961452] Subtest device-submit-unordered: SUCCESS (0.001s)
[116.039300] [032/133] (902s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[116.139026] Starting subtest: fbcpsr-rgb101010-draw-blt
[122.855170] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.720s)
[122.970818] [033/133] (896s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[123.080719] Starting subtest: fbc-pr-cursor-plane-update-sf
[123.085084] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[123.147264] [034/133] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[123.242472] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[123.246509] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[123.342376] [035/133] (895s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[123.441912] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[124.053924] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.614s)
[124.215658] [036/133] (894s left) api_intel_bb (purge-bb)
[124.264811] Starting subtest: purge-bb
[124.267039] Subtest purge-bb: SUCCESS (0.004s)
[124.370748] [037/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[124.461480] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[131.674343] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.217s)
[131.810820] [038/133] (887s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[131.904467] Starting subtest: psr-rgb565-draw-render
[138.941682] Subtest psr-rgb565-draw-render: SUCCESS (7.040s)
[139.062620] [039/133] (880s left) perf (create-destroy-userspace-config)
[139.183779] Starting subtest: create-destroy-userspace-config
[139.204538] Subtest create-destroy-userspace-config: SUCCESS (0.019s)
[139.242326] [040/133] (880s left) perf (missing-sample-flags)
[139.333385] Starting subtest: missing-sample-flags
[139.335699] Subtest missing-sample-flags: SUCCESS (0.000s)
[139.372991] [041/133] (879s left) gem_exec_balancer (full-late-pulse)
[139.435254] Starting subtest: full-late-pulse
[143.835063] Subtest full-late-pulse: SUCCESS (4.399s)
[144.146421] [042/133] (875s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[144.252775] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[144.256830] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[144.327998] [043/133] (875s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[144.416320] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[144.420355] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[144.498646] [044/133] (874s left) sw_sync (alloc_merge_fence)
[144.538745] Starting subtest: alloc_merge_fence
[144.540993] Subtest alloc_merge_fence: SUCCESS (0.000s)
[144.585585] [045/133] (874s left) kms_plane_multiple (tiling-y)
[144.682157] Starting subtest: tiling-y
[144.686518] Subtest tiling-y: SKIP (0.000s)
[144.773619] [046/133] (874s left) gem_mmap_wc (write-gtt-read-wc)
[144.831685] Subtest write-gtt-read-wc: SKIP (0.000s)
[144.894819] [047/133] (874s left) perf (gen12-group-exclusive-stream-ctx-handle)
[144.989376] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[145.023942] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.033s)
[145.069777] [048/133] (874s left) gem_mmap_offset (isolation)
[146.873042] Starting subtest: isolation
[146.892143] Subtest isolation: SUCCESS (0.007s)
[146.985859] [049/133] (872s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[147.087687] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[147.091879] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[147.187709] [050/133] (872s left) gem_ctx_create (basic)
[147.252643] Starting subtest: basic
[147.255141] Subtest basic: SUCCESS (0.000s)
[147.447993] [051/133] (872s left) syncobj_wait (wait-any-interrupted)
[147.505236] Starting subtest: wait-any-interrupted
[147.607127] Subtest wait-any-interrupted: SUCCESS (0.102s)
[147.690962] [052/133] (872s left) gen9_exec_parse (bb-large)
[147.758718] Subtest bb-large: SKIP (0.000s)
[147.826526] [053/133] (872s left) syncobj_timeline (multi-wait-signaled)
[147.880970] Starting subtest: multi-wait-signaled
[147.883252] Subtest multi-wait-signaled: SUCCESS (0.000s)
[147.969223] [054/133] (871s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[148.116617] Starting subtest: multiplane-atomic-fence-wait
[148.436919] Subtest multiplane-atomic-fence-wait: SUCCESS (0.318s)
[149.615040] [055/133] (870s left) kms_invalid_mode (zero-vdisplay)
[149.707454] Starting subtest: zero-vdisplay
[149.709677] Starting dynamic subtest: pipe-A-eDP-1
[149.991857] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[150.000825] Starting dynamic subtest: pipe-B-eDP-1
[150.002760] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[150.010587] Starting dynamic subtest: pipe-C-eDP-1
[150.012893] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[150.020818] Starting dynamic subtest: pipe-D-eDP-1
[150.023065] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[150.025263] Subtest zero-vdisplay: SUCCESS (0.290s)
[150.834757] [056/133] (869s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[150.941666] Starting subtest: fbc-rgb101010-draw-blt
[155.558226] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.617s)
[156.747697] [057/133] (863s left) gen3_render_linear_blits
[156.872919] [058/133] (863s left) gem_exec_reloc (basic-concurrent0)
[156.927892] Subtest basic-concurrent0: SKIP (0.000s)
[156.997376] [059/133] (863s left) syncobj_wait (multi-wait-for-submit-signaled)
[157.054522] Starting subtest: multi-wait-for-submit-signaled
[157.056453] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[157.172381] [060/133] (862s left) kms_big_fb (4-tiled-addfb-size-overflow)
[157.272881] Starting subtest: 4-tiled-addfb-size-overflow
[157.275212] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[157.358167] [061/133] (862s left) sw_sync (alloc_fence)
[157.403253] Starting subtest: alloc_fence
[157.405471] Subtest alloc_fence: SUCCESS (0.000s)
[157.460285] [062/133] (862s left) kms_prime (d3hot)
[157.536472] Subtest D3hot: SKIP (0.000s)
[157.631662] [063/133] (862s left) perf_pmu (idle-no-semaphores)
[157.666534] Starting subtest: idle-no-semaphores
[157.668477] Starting dynamic subtest: rcs0
[158.207522] Dynamic subtest rcs0: SUCCESS (0.539s)
[158.216882] Starting dynamic subtest: bcs0
[158.727785] Dynamic subtest bcs0: SUCCESS (0.518s)
[158.736819] Starting dynamic subtest: vcs0
[159.243436] Dynamic subtest vcs0: SUCCESS (0.513s)
[159.254437] Starting dynamic subtest: vcs1
[159.757956] Dynamic subtest vcs1: SUCCESS (0.512s)
[159.768606] Starting dynamic subtest: vecs0
[160.281752] Dynamic subtest vecs0: SUCCESS (0.521s)
[160.292055] Starting dynamic subtest: ccs0
[160.805663] Dynamic subtest ccs0: SUCCESS (0.521s)
[160.808316] Subtest idle-no-semaphores: SUCCESS (3.139s)
[160.918709] [064/133] (859s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[161.012981] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[161.017313] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[161.080949] [065/133] (859s left) kms_pm_dc (dc9-dpms)
[162.179120] Starting subtest: dc9-dpms
[163.606872] Subtest dc9-dpms: SUCCESS (1.428s)
[163.667341] [066/133] (856s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[163.726671] Starting subtest: legacy-engines-hostile-preempt
[163.729090] Starting dynamic subtest: render
[163.797134] Dynamic subtest render: SUCCESS (0.069s)
[163.808210] Starting dynamic subtest: bsd1
[164.885219] Dynamic subtest bsd1: SUCCESS (1.085s)
[164.898585] Starting dynamic subtest: bsd2
[166.932177] Dynamic subtest bsd2: SUCCESS (2.043s)
[166.943606] Starting dynamic subtest: blt
[166.977763] Dynamic subtest blt: SUCCESS (0.044s)
[166.992978] Starting dynamic subtest: vebox
[168.916287] Dynamic subtest vebox: SUCCESS (1.935s)
[168.918893] Subtest legacy-engines-hostile-preempt: SUCCESS (5.189s)
[168.994629] [067/133] (851s left) gem_userptr_blits (create-destroy-sync)
[169.064074] Starting subtest: create-destroy-sync
[174.074300] Subtest create-destroy-sync: SUCCESS (5.011s)
[174.194374] [068/133] (846s left) kms_cursor_legacy (torture-move)
[174.312074] Starting subtest: torture-move
[174.314277] Starting dynamic subtest: pipe-A
[180.212148] Dynamic subtest pipe-A: SUCCESS (5.896s)
[180.223253] Starting dynamic subtest: pipe-B
[186.613235] Dynamic subtest pipe-B: SUCCESS (6.401s)
[186.624217] Starting dynamic subtest: pipe-C
[194.269766] Dynamic subtest pipe-C: SUCCESS (7.653s)
[194.285262] Starting dynamic subtest: pipe-D
[200.624673] Dynamic subtest pipe-D: SUCCESS (6.354s)
[200.639980] Starting dynamic subtest: all-pipes
[206.563961] Dynamic subtest all-pipes: SUCCESS (5.938s)
[206.566426] Subtest torture-move: SUCCESS (32.251s)
[206.731896] [069/133] (813s left) device_reset (cold-reset-bound)
[206.783387] Starting subtest: cold-reset-bound
[206.787811] Subtest cold-reset-bound: SKIP (0.000s)
[206.861537] [070/133] (813s left) syncobj_timeline (etime-multi-wait-submitted)
[206.905937] Starting subtest: etime-multi-wait-submitted
[207.010468] Subtest etime-multi-wait-submitted: SUCCESS (0.104s)
[207.105331] [071/133] (813s left) kms_async_flips (invalid-async-flip-atomic)
[207.203148] Starting subtest: invalid-async-flip-atomic
[207.582936] Starting dynamic subtest: pipe-A-eDP-1
[208.380491] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.797s)
[208.741463] Starting dynamic subtest: pipe-B-eDP-1
[209.595490] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.863s)
[209.968471] Starting dynamic subtest: pipe-C-eDP-1
[210.739333] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s)
[211.099984] Starting dynamic subtest: pipe-D-eDP-1
[211.869300] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.779s)
[211.871567] Subtest invalid-async-flip-atomic: SUCCESS (4.669s)
[213.009861] [072/133] (807s left) gem_exec_schedule (preempt-hang)
[213.186682] Starting subtest: preempt-hang
[213.189293] Starting dynamic subtest: rcs0
[213.424700] Dynamic subtest rcs0: SUCCESS (0.236s)
[213.432846] Starting dynamic subtest: bcs0
[213.655039] Dynamic subtest bcs0: SUCCESS (0.230s)
[213.665846] Starting dynamic subtest: vcs0
[213.879482] Dynamic subtest vcs0: SUCCESS (0.225s)
[213.889046] Starting dynamic subtest: vcs1
[214.103420] Dynamic subtest vcs1: SUCCESS (0.223s)
[214.112024] Starting dynamic subtest: vecs0
[214.328950] Dynamic subtest vecs0: SUCCESS (0.224s)
[214.339351] Starting dynamic subtest: ccs0
[214.558560] Dynamic subtest ccs0: SUCCESS (0.229s)
[214.560891] Subtest preempt-hang: SUCCESS (1.372s)
[215.033724] [073/133] (805s left) gem_mmap (basic-small-bo)
[215.085378] Subtest basic-small-bo: SKIP (0.000s)
[215.137836] [074/133] (805s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[215.243641] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[215.248049] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[215.340328] [075/133] (805s left) kms_plane (plane-position-covered)
[215.434766] Starting subtest: plane-position-covered
[215.948432] Starting dynamic subtest: pipe-A-plane-1
[217.221603] Dynamic subtest pipe-A-plane-1: SUCCESS (1.273s)
[217.230979] Starting dynamic subtest: pipe-A-plane-2
[218.535931] Dynamic subtest pipe-A-plane-2: SUCCESS (1.311s)
[218.545730] Starting dynamic subtest: pipe-A-plane-3
[219.783864] Dynamic subtest pipe-A-plane-3: SUCCESS (1.249s)
[219.793575] Starting dynamic subtest: pipe-A-plane-4
[221.122044] Dynamic subtest pipe-A-plane-4: SUCCESS (1.336s)
[221.130930] Starting dynamic subtest: pipe-A-plane-5
[221.150945] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[222.361796] Starting dynamic subtest: pipe-B-plane-1
[223.673091] Dynamic subtest pipe-B-plane-1: SUCCESS (1.318s)
[223.681582] Starting dynamic subtest: pipe-B-plane-2
[224.985827] Dynamic subtest pipe-B-plane-2: SUCCESS (1.313s)
[224.994537] Starting dynamic subtest: pipe-B-plane-3
[226.261729] Dynamic subtest pipe-B-plane-3: SUCCESS (1.275s)
[226.271238] Starting dynamic subtest: pipe-B-plane-4
[227.587397] Dynamic subtest pipe-B-plane-4: SUCCESS (1.324s)
[227.595569] Starting dynamic subtest: pipe-B-plane-5
[227.612922] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[227.615328] Subtest plane-position-covered: SUCCESS (12.178s)
[228.444572] [076/133] (792s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[228.537329] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[228.541361] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[228.637530] [077/133] (792s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[228.737854] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[228.740381] Starting dynamic subtest: pipe-A-eDP-1
[228.750084] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[228.769941] Starting dynamic subtest: pipe-B-eDP-1
[228.779699] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[228.799854] Starting dynamic subtest: pipe-C-eDP-1
[228.810604] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[228.829026] Starting dynamic subtest: pipe-D-eDP-1
[228.838135] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[228.842302] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.015s)
[231.012608] [078/133] (789s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[231.109143] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[231.111371] Starting dynamic subtest: pipe-A
[231.129312] Dynamic subtest pipe-A: SKIP (0.017s)
[231.138063] Starting dynamic subtest: pipe-B
[231.161251] Dynamic subtest pipe-B: SKIP (0.030s)
[231.169806] Starting dynamic subtest: pipe-C
[231.190330] Dynamic subtest pipe-C: SKIP (0.030s)
[231.198402] Starting dynamic subtest: pipe-D
[231.221270] Dynamic subtest pipe-D: SKIP (0.029s)
[231.225226] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.109s)
[231.317398] [079/133] (789s left) kms_color (deep-color)
[231.415966] Starting subtest: deep-color
[232.467091] Starting dynamic subtest: pipe-A-eDP-1-gamma
[233.208562] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.741s)
[233.220135] Starting dynamic subtest: pipe-A-eDP-1-degamma
[234.654350] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.445s)
[234.663936] Starting dynamic subtest: pipe-A-eDP-1-ctm
[236.103271] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.445s)
[236.879065] Starting dynamic subtest: pipe-B-eDP-1-gamma
[237.582941] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.712s)
[237.591723] Starting dynamic subtest: pipe-B-eDP-1-degamma
[239.049614] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.461s)
[239.058609] Starting dynamic subtest: pipe-B-eDP-1-ctm
[240.487942] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.441s)
[241.268066] Starting dynamic subtest: pipe-C-eDP-1-gamma
[241.954194] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.693s)
[241.963503] Starting dynamic subtest: pipe-C-eDP-1-degamma
[243.323556] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.365s)
[243.331914] Starting dynamic subtest: pipe-C-eDP-1-ctm
[244.760951] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.437s)
[245.552019] Starting dynamic subtest: pipe-D-eDP-1-gamma
[246.231107] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.685s)
[246.239972] Starting dynamic subtest: pipe-D-eDP-1-degamma
[247.601046] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.370s)
[247.610508] Starting dynamic subtest: pipe-D-eDP-1-ctm
[249.023693] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.423s)
[249.026086] Subtest deep-color: SUCCESS (17.610s)
[249.887794] [080/133] (771s left) kms_atomic_transition (plane-all-transition-nonblocking)
[249.989277] Starting subtest: plane-all-transition-nonblocking
[249.991552] Starting dynamic subtest: pipe-A-eDP-1
[252.481989] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[252.787589] Starting dynamic subtest: pipe-B-eDP-1
[256.025514] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.246s)
[256.323935] Subtest plane-all-transition-nonblocking: SUCCESS (6.334s)
[257.141657] [081/133] (763s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[257.231099] Starting subtest: psr-2p-primscrn-cur-indfb-move
[257.235488] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[257.330215] [082/133] (763s left) i915_query (engine-info-invalid)
[257.381086] Starting subtest: engine-info-invalid
[257.382978] Subtest engine-info-invalid: SUCCESS (0.000s)
[257.486137] [083/133] (763s left) kms_rotation_crc (sprite-rotation-90)
[257.582919] Starting subtest: sprite-rotation-90
[257.587345] Subtest sprite-rotation-90: SKIP (0.001s)
[257.669419] [084/133] (763s left) gem_userptr_blits (coherency-sync)
[257.735991] Starting subtest: coherency-sync
[258.061120] Subtest coherency-sync: SKIP (0.289s)
[258.177694] [085/133] (762s left) api_intel_allocator (default-alignment)
[258.271074] Starting subtest: default-alignment
[258.273232] Subtest default-alignment: SUCCESS (0.003s)
[258.378887] [086/133] (762s left) kms_psr (pr-cursor-render)
[258.471662] Starting subtest: pr-cursor-render
[258.475579] Subtest pr-cursor-render: SKIP (0.000s)
[258.542714] [087/133] (762s left) gem_exec_flush (basic-wb-pro-default)
[258.594772] Starting subtest: basic-wb-pro-default
[264.058445] Subtest basic-wb-pro-default: SUCCESS (5.462s)
[264.249317] [088/133] (757s left) gem_eio (kms)
[264.535880] Starting subtest: kms
[282.216067] Subtest kms: SUCCESS (17.677s)
[283.383576] [089/133] (737s left) template (a)
[283.448836] Starting subtest: A
[283.450949] Subtest A: SUCCESS (0.000s)
[283.562165] [090/133] (737s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[283.660392] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[283.662754] Starting dynamic subtest: pipe-A-default-mode
[286.405650] Dynamic subtest pipe-A-default-mode: SUCCESS (2.744s)
[286.407774] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.746s)
[287.286796] [091/133] (734s left) gem_exec_schedule (semaphore-noskip)
[287.360795] Starting subtest: semaphore-noskip
[287.788040] Subtest semaphore-noskip: SUCCESS (0.434s)
[288.122718] [092/133] (733s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[288.233018] Starting subtest: basic-flip-before-cursor-legacy
[289.152370] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.918s)
[290.001707] [093/133] (731s left) fbdev (write)
[290.039063] Starting subtest: write
[290.398668] Subtest write: SUCCESS (0.357s)
[290.462913] [094/133] (731s left) kms_flip (2x-blocking-absolute-wf_vblank)
[290.561382] Starting subtest: 2x-blocking-absolute-wf_vblank
[290.572338] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[290.656998] [095/133] (730s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[290.717781] Starting subtest: multi-wait-for-submit-unsubmitted
[290.825921] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[290.902360] [096/133] (730s left) kms_big_fb (x-tiled-addfb)
[291.003651] Starting subtest: x-tiled-addfb
[291.006049] Subtest x-tiled-addfb: SUCCESS (0.000s)
[291.101319] [097/133] (730s left) kms_selftest (drm_cmdline_parser)
[291.147670] Starting subtest: drm_cmdline_parser
[291.167987] Starting dynamic subtest: drm_test_cmdline_force_d_only
[291.270063] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.101s)
[291.280593] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[291.352620] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.080s)
[291.362749] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[291.464309] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.109s)
[291.474327] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[291.552400] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.086s)
[291.563117] Starting dynamic subtest: drm_test_cmdline_force_e_only
[291.654201] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.099s)
[291.664604] Starting dynamic subtest: drm_test_cmdline_res
[291.762609] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.108s)
[291.772096] Starting dynamic subtest: drm_test_cmdline_res_vesa
[291.846477] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.083s)
[291.856580] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[291.943476] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.097s)
[291.951653] Starting dynamic subtest: drm_test_cmdline_res_rblank
[292.044655] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.101s)
[292.052660] Starting dynamic subtest: drm_test_cmdline_res_bpp
[292.145485] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.100s)
[292.155311] Starting dynamic subtest: drm_test_cmdline_res_refresh
[292.257555] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.111s)
[292.267555] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[292.357344] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.099s)
[292.367267] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[292.469593] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.112s)
[292.480526] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[292.569927] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.096s)
[292.580902] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[292.680611] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.110s)
[292.691472] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[292.775382] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.095s)
[292.784809] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[292.930991] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.152s)
[292.939890] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[293.036555] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.104s)
[293.046200] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[293.132626] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.094s)
[293.143146] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[293.262321] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.125s)
[293.273916] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[293.361524] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.099s)
[293.372108] Starting dynamic subtest: drm_test_cmdline_name
[293.473827] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.111s)
[293.484853] Starting dynamic subtest: drm_test_cmdline_name_bpp
[293.575267] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.096s)
[293.584696] Starting dynamic subtest: drm_test_cmdline_name_option
[293.694339] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.118s)
[293.704454] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[293.784429] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.091s)
[293.793629] Starting dynamic subtest: drm_test_cmdline_rotate_0
[293.882666] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.097s)
[293.897179] Starting dynamic subtest: drm_test_cmdline_rotate_90
[293.972558] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.088s)
[293.983066] Starting dynamic subtest: drm_test_cmdline_rotate_180
[294.060660] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.087s)
[294.074972] Starting dynamic subtest: drm_test_cmdline_rotate_270
[294.152140] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.092s)
[294.162420] Starting dynamic subtest: drm_test_cmdline_hmirror
[294.265513] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.111s)
[294.277301] Starting dynamic subtest: drm_test_cmdline_vmirror
[294.359121] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.092s)
[294.370109] Starting dynamic subtest: drm_test_cmdline_margin_options
[294.466265] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.105s)
[294.476959] Starting dynamic subtest: drm_test_cmdline_multiple_options
[294.573473] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.105s)
[294.588590] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[294.677199] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.103s)
[294.687689] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[294.785097] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.108s)
[294.796089] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[294.892488] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.106s)
[294.902942] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[295.004177] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.112s)
[295.013889] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[295.112115] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.107s)
[295.121911] Starting dynamic subtest: drm_test_cmdline_invalid
[295.218497] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.106s)
[295.227835] Starting dynamic subtest: drm_test_cmdline_tv_options
[295.326099] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.108s)
[295.327844] Subtest drm_cmdline_parser: SUCCESS (4.180s)
[295.482340] [098/133] (726s left) gem_exec_balancer (sequential)
[295.549324] Starting subtest: sequential
[298.654173] Subtest sequential: SUCCESS (3.104s)
[298.983738] [099/133] (722s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[299.073114] Starting subtest: fbc-psr2-sprite-mmap-cpu
[299.075301] Starting dynamic subtest: eDP-1
[299.079570] Dynamic subtest eDP-1: SKIP (0.000s)
[299.083777] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[299.151010] [100/133] (722s left) gem_exec_fence (nb-await)
[299.319539] Starting subtest: nb-await
[299.321848] Starting dynamic subtest: rcs0
[299.387248] Dynamic subtest rcs0: SUCCESS (0.066s)
[299.399569] Starting dynamic subtest: bcs0
[299.445795] Dynamic subtest bcs0: SUCCESS (0.056s)
[299.456323] Starting dynamic subtest: vcs0
[299.506361] Dynamic subtest vcs0: SUCCESS (0.058s)
[299.518056] Starting dynamic subtest: vcs1
[299.567398] Dynamic subtest vcs1: SUCCESS (0.058s)
[299.579078] Starting dynamic subtest: vecs0
[299.627780] Dynamic subtest vecs0: SUCCESS (0.057s)
[299.639977] Starting dynamic subtest: ccs0
[299.687044] Dynamic subtest ccs0: SUCCESS (0.056s)
[299.689870] Subtest nb-await: SUCCESS (0.368s)
[300.968016] [101/133] (720s left) sysfs_timeslice_duration (idempotent)
[301.031939] Starting subtest: idempotent
[301.034189] Starting dynamic subtest: vecs0
[301.036510] Dynamic subtest vecs0: SUCCESS (0.000s)
[301.046508] Starting dynamic subtest: ccs0
[301.048348] Dynamic subtest ccs0: SUCCESS (0.000s)
[301.056737] Starting dynamic subtest: vcs0
[301.058595] Dynamic subtest vcs0: SUCCESS (0.000s)
[301.067253] Starting dynamic subtest: bcs0
[301.069279] Dynamic subtest bcs0: SUCCESS (0.000s)
[301.078167] Starting dynamic subtest: rcs0
[301.079997] Dynamic subtest rcs0: SUCCESS (0.000s)
[301.088223] Starting dynamic subtest: vcs1
[301.090032] Dynamic subtest vcs1: SUCCESS (0.000s)
[301.091827] Subtest idempotent: SUCCESS (0.007s)
[301.128589] [102/133] (720s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[301.226178] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[301.230143] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[301.306758] [103/133] (720s left) gem_exec_store (basic)
[301.366875] Starting subtest: basic
[301.464547] Subtest basic: SUCCESS (0.100s)
[301.649403] [104/133] (720s left) intel_hwmon (hwmon-read)
[301.705689] Subtest hwmon-read: SKIP (0.000s)
[301.759058] [105/133] (720s left) i915_getparams_basic (basic-eu-total)
[301.805474] Starting subtest: basic-eu-total
[301.809860] Subtest basic-eu-total: SUCCESS (0.000s)
[301.891740] [106/133] (720s left) kms_big_fb (linear-16bpp-rotate-90)
[301.990434] Starting subtest: linear-16bpp-rotate-90
[302.010843] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[302.111501] [107/133] (719s left) kms_vblank (query-forked-busy)
[302.206179] Starting subtest: query-forked-busy
[302.208357] Starting dynamic subtest: pipe-A-eDP-1
[304.100236] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s)
[304.114262] Starting dynamic subtest: pipe-D-eDP-1
[306.672015] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.567s)
[306.673916] Subtest query-forked-busy: SUCCESS (4.466s)
[307.469978] [108/133] (714s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[307.570474] Starting subtest: nonblocking-crc-frame-sequence
[307.572387] Starting dynamic subtest: pipe-A-eDP-1
[308.298068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.728s)
[308.310670] Starting dynamic subtest: pipe-B-eDP-1
[309.669853] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s)
[309.680438] Starting dynamic subtest: pipe-C-eDP-1
[311.052917] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[311.068832] Starting dynamic subtest: pipe-D-eDP-1
[312.414706] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.357s)
[312.416942] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.844s)
[313.311449] [109/133] (708s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[313.418417] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[313.420744] Starting dynamic subtest: pipe-A-eDP-1
[319.257685] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.846s)
[319.267716] Starting dynamic subtest: pipe-B-eDP-1
[325.903468] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.642s)
[325.905788] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.490s)
[326.774430] [110/133] (695s left) kms_flip (2x-plain-flip-interruptible)
[326.866842] Starting subtest: 2x-plain-flip-interruptible
[326.878800] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[326.958252] [111/133] (695s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[327.060679] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[327.062988] Starting dynamic subtest: pipe-A-eDP-1
[338.051586] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.993s)
[338.062234] Starting dynamic subtest: pipe-B-eDP-1
[349.783345] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.729s)
[349.785747] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.726s)
[350.642166] [112/133] (671s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[350.743353] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[350.745728] Starting dynamic subtest: pipe-A-eDP-1
[351.197926] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.428s)
[351.209358] Starting dynamic subtest: pipe-B-eDP-1
[352.645191] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.444s)
[352.656603] Starting dynamic subtest: pipe-C-eDP-1
[354.047215] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.403s)
[354.058808] Starting dynamic subtest: pipe-D-eDP-1
[355.391728] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[355.393676] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.625s)
[356.559825] [113/133] (665s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[356.676506] Starting subtest: cursorB-vs-flipA-varying-size
[356.681264] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[356.821159] [114/133] (665s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[356.917368] Starting subtest: pipe-fbc-rte
[356.924142] Starting dynamic subtest: pipe-B-eDP-1
[362.424655] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.511s)
[362.432460] Subtest pipe-fbc-rte: SUCCESS (5.513s)
[364.695433] [115/133] (657s left) syncobj_timeline (invalid-query-bad-pad)
[364.751214] Starting subtest: invalid-query-bad-pad
[364.753486] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[364.843151] [116/133] (657s left) gem_exercise_blt (fast-copy-emit)
[364.899611] Starting subtest: fast-copy-emit
[364.902033] Starting dynamic subtest: linear-smem-smem-emit
[364.921633] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s)
[364.932463] Starting dynamic subtest: xmajor-smem-smem-emit
[364.940996] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.019s)
[364.949801] Starting dynamic subtest: tile4-smem-smem-emit
[364.958915] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[364.969801] Starting dynamic subtest: tile64-smem-smem-emit
[365.002700] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.043s)
[365.005144] Subtest fast-copy-emit: SUCCESS (0.104s)
[365.116170] [117/133] (657s left) gem_ctx_persistence (engines-queued)
[365.177153] Starting subtest: engines-queued
[365.179401] Starting dynamic subtest: rcs0
[365.220739] Dynamic subtest rcs0: SUCCESS (0.046s)
[365.232440] Starting dynamic subtest: bcs0
[365.324938] Dynamic subtest bcs0: SUCCESS (0.103s)
[365.336077] Starting dynamic subtest: vcs0
[366.902596] Dynamic subtest vcs0: SUCCESS (1.574s)
[366.914931] Starting dynamic subtest: vcs1
[368.884221] Dynamic subtest vcs1: SUCCESS (1.978s)
[368.896908] Starting dynamic subtest: vecs0
[370.868466] Dynamic subtest vecs0: SUCCESS (1.981s)
[370.880947] Starting dynamic subtest: ccs0
[371.053873] Dynamic subtest ccs0: SUCCESS (0.184s)
[371.056368] Subtest engines-queued: SUCCESS (5.880s)
[371.169625] [118/133] (651s left) kms_big_fb (y-tiled-addfb)
[371.299618] Starting subtest: y-tiled-addfb
[371.304320] Subtest y-tiled-addfb: SKIP (0.000s)
[371.414086] [119/133] (651s left) gem_partial_pwrite_pread (write-display)
[371.479044] Subtest write-display: SKIP (0.000s)
[371.550642] [120/133] (651s left) kms_psr (psr2-sprite-plane-move)
[371.641239] Starting subtest: psr2-sprite-plane-move
[371.643559] Starting dynamic subtest: eDP-1
[373.413235] Dynamic subtest eDP-1: SUCCESS (1.772s)
[373.415538] Subtest psr2-sprite-plane-move: SUCCESS (1.773s)
[374.245734] [121/133] (648s left) gem_close_race (multigpu-basic-threads)
[374.300181] Starting subtest: multigpu-basic-threads
[374.304567] Subtest multigpu-basic-threads: SKIP (0.000s)
[374.520787] [122/133] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[374.614197] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[374.618137] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[374.739719] [123/133] (647s left) kms_content_protection (dp-mst-type-0)
[374.885084] Starting subtest: dp-mst-type-0
[374.889615] Subtest dp-mst-type-0: SKIP (0.000s)
[375.000335] [124/133] (647s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[375.100770] Starting subtest: fbcpsr-stridechange
[381.282292] Subtest fbcpsr-stridechange: SUCCESS (6.184s)
[381.424737] [125/133] (641s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[381.535636] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[381.540143] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[381.632520] [126/133] (641s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[381.724112] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[381.726399] Starting dynamic subtest: pipe-A-eDP-1
[382.498063] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.768s)
[382.507885] Starting dynamic subtest: pipe-B-eDP-1
[384.041611] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.539s)
[384.051854] Starting dynamic subtest: pipe-C-eDP-1
[385.523414] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.481s)
[385.532475] Starting dynamic subtest: pipe-D-eDP-1
[387.026299] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.500s)
[387.028196] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.296s)
[388.216643] [127/133] (634s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[388.314359] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[388.318344] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[388.416886] [128/133] (634s left) kms_psr (psr-sprite-render)
[388.512202] Starting subtest: psr-sprite-render
[388.514290] Starting dynamic subtest: eDP-1
[390.246113] Dynamic subtest eDP-1: SUCCESS (1.734s)
[390.248428] Subtest psr-sprite-render: SUCCESS (1.735s)
[391.074904] [129/133] (631s left) syncobj_wait (wait-all-for-submit-complex)
[391.133879] Starting subtest: wait-all-for-submit-complex
[391.349039] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[391.440916] [130/133] (631s left) gem_ctx_param (invalid-param-get)
[391.489397] Starting subtest: invalid-param-get
[391.491695] Subtest invalid-param-get: SUCCESS (0.001s)
[391.621130] [131/133] (631s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[391.742381] Starting subtest: basic-flip-before-cursor-varying-size
[392.670417] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.926s)
[393.496156] [132/133] (629s left) kms_chamelium_color (ctm-0-50)
[393.588125] Subtest ctm-0-50: SKIP (0.000s)
[393.632264] [133/133] (629s left) gem_ctx_param (invalid-ctx-get)
[393.676880] Starting subtest: invalid-ctx-get
[393.679178] Subtest invalid-ctx-get: SUCCESS (0.000s)
[393.744362] 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.