[58.184790] Initializing watchdogs
[58.184840]   /dev/watchdog0
[58.200253] [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]
[58.205569] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.208087] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.211646] [001/133] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[58.349000] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[58.351366] Starting dynamic subtest: pipe-A-eDP-1
[58.409638] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[58.418158] Starting dynamic subtest: pipe-B-eDP-1
[58.471778] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s)
[58.479981] Starting dynamic subtest: pipe-C-eDP-1
[58.539814] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.067s)
[58.549947] Starting dynamic subtest: pipe-D-eDP-1
[58.601708] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[58.603973] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.255s)
[60.884811] [002/133] (957s left) gem_softpin (zero)
[60.941367] Starting subtest: zero
[60.947657] Subtest zero: SUCCESS (0.006s)
[61.063855] [003/133] (957s left) kms_joiner (invalid-modeset-ultra-joiner)
[61.169370] Starting subtest: invalid-modeset-ultra-joiner
[61.173685] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[61.234206] [004/133] (957s left) gem_unfence_active_buffers
[61.386265] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[61.498353] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[61.502359] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[61.603642] [006/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[61.701572] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[61.705805] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[61.797559] [007/133] (957s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[61.914050] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[61.918069] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[62.074367] [008/133] (956s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[62.161104] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[62.162910] Starting dynamic subtest: pipe-A-eDP-1
[62.179952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[62.187790] Starting dynamic subtest: pipe-B-eDP-1
[62.204052] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[62.210803] Starting dynamic subtest: pipe-C-eDP-1
[62.227161] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[62.234479] Starting dynamic subtest: pipe-D-eDP-1
[62.250173] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[62.251964] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[64.430826] [009/133] (954s left) syncobj_basic (bad-flags-fd-to-handle)
[64.496815] Starting subtest: bad-flags-fd-to-handle
[64.499081] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[64.601568] [010/133] (954s left) gem_userptr_blits (set-cache-level)
[64.669925] Starting subtest: set-cache-level
[64.674210] Subtest set-cache-level: SKIP (0.000s)
[64.785062] [011/133] (954s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[65.168181] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[65.948804] [012/133] (953s left) kms_flip (modeset-vs-vblank-race)
[66.041243] Starting subtest: modeset-vs-vblank-race
[66.043459] Starting dynamic subtest: A-eDP1
[70.792430] Dynamic subtest A-eDP1: SUCCESS (4.749s)
[70.800885] Starting dynamic subtest: B-eDP1
[75.540610] Dynamic subtest B-eDP1: SUCCESS (4.746s)
[75.550404] Starting dynamic subtest: C-eDP1
[80.245486] Dynamic subtest C-eDP1: SUCCESS (4.703s)
[80.253251] Starting dynamic subtest: D-eDP1
[84.881595] Dynamic subtest D-eDP1: SUCCESS (4.634s)
[84.886419] Subtest modeset-vs-vblank-race: SUCCESS (18.843s)
[86.044816] [013/133] (933s left) gem_pxp (display-protected-crc)
[86.181334] Starting subtest: display-protected-crc
[87.837052] Subtest display-protected-crc: SUCCESS (1.658s)
[87.941229] [014/133] (931s left) kms_cursor_crc (cursor-sliding-max-size)
[88.237072] Starting subtest: cursor-sliding-max-size
[88.244101] Subtest cursor-sliding-max-size: SKIP (0.000s)
[88.353157] [015/133] (930s left) prime_vgem (wait)
[88.465746] Starting subtest: wait
[88.468119] Starting dynamic subtest: rcs0
[88.503414] Dynamic subtest rcs0: SUCCESS (0.038s)
[88.511111] Starting dynamic subtest: bcs0
[88.560806] Dynamic subtest bcs0: SUCCESS (0.057s)
[88.568352] Starting dynamic subtest: vcs0
[88.606958] Dynamic subtest vcs0: SUCCESS (0.045s)
[88.614487] Starting dynamic subtest: vcs1
[88.652750] Dynamic subtest vcs1: SUCCESS (0.046s)
[88.660747] Starting dynamic subtest: vecs0
[88.696092] Dynamic subtest vecs0: SUCCESS (0.043s)
[88.703339] Starting dynamic subtest: ccs0
[88.742892] Dynamic subtest ccs0: SUCCESS (0.046s)
[88.744829] Subtest wait: SUCCESS (0.279s)
[88.861864] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[88.864607] [016/133] (930s left) kms_fence_pin_leak
[89.027575] [017/133] (930s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[89.129766] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[89.133050] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[89.219341] [018/133] (930s left) kms_chamelium_frames (dp-frame-dump)
[89.600565] Subtest dp-frame-dump: SKIP (0.000s)
[90.452241] [019/133] (928s left) gem_mmap (bad-offset)
[90.518253] Subtest bad-offset: SKIP (0.000s)
[90.578020] [020/133] (928s left) kms_cursor_crc (cursor-random-128x42)
[90.811657] Starting subtest: cursor-random-128x42
[90.860291] Subtest cursor-random-128x42: SKIP (0.043s)
[91.045744] [021/133] (928s left) kms_flip (flip-vs-fences)
[91.148995] Starting subtest: flip-vs-fences
[91.153407] Subtest flip-vs-fences: SKIP (0.000s)
[91.260081] [022/133] (928s left) kms_psr (fbc-pr-sprite-plane-move)
[91.359161] Starting subtest: fbc-pr-sprite-plane-move
[91.363474] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[91.431430] [023/133] (928s left) i915_drm_fdinfo (isolation)
[91.476910] Starting subtest: isolation
[91.478683] Starting dynamic subtest: rcs0
[91.499087] Dynamic subtest rcs0: SKIP (0.021s)
[91.507264] Starting dynamic subtest: bcs0
[91.510508] Dynamic subtest bcs0: SKIP (0.000s)
[91.517906] Starting dynamic subtest: vcs0
[91.521507] Dynamic subtest vcs0: SKIP (0.000s)
[91.528712] Starting dynamic subtest: vcs1
[91.532064] Dynamic subtest vcs1: SKIP (0.000s)
[91.538720] Starting dynamic subtest: vecs0
[91.542078] Dynamic subtest vecs0: SKIP (0.000s)
[91.548694] Starting dynamic subtest: ccs0
[91.552054] Dynamic subtest ccs0: SKIP (0.000s)
[91.555450] Subtest isolation: SKIP (0.024s)
[91.589452] [024/133] (928s left) gem_pxp (reject-modify-context-protection-off-1)
[91.647749] Starting subtest: reject-modify-context-protection-off-1
[91.649832] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[91.741902] [025/133] (927s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[91.809074] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[91.812725] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[91.992615] [026/133] (927s left) i915_pm_rpm (debugfs-forcewake-user)
[94.120936] Starting subtest: debugfs-forcewake-user
[105.518404] Subtest debugfs-forcewake-user: SUCCESS (11.401s)
[105.896938] [027/133] (913s left) syncobj_timeline (wait-all-for-submit-snapshot)
[105.957971] Starting subtest: wait-all-for-submit-snapshot
[106.040598] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[106.116967] [028/133] (913s left) kms_hdr (bpc-switch)
[106.207276] Starting subtest: bpc-switch
[107.263305] Starting dynamic subtest: pipe-A-eDP-1
[110.763710] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.501s)
[110.765917] Subtest bpc-switch: SUCCESS (4.557s)
[110.876841] [029/133] (908s left) gem_userptr_blits (unsync-unmap)
[110.935663] Subtest unsync-unmap: SKIP (0.000s)
[111.073125] [030/133] (908s left) kms_cursor_crc (cursor-onscreen-256x256)
[111.306282] Starting subtest: cursor-onscreen-256x256
[111.311238] Starting dynamic subtest: pipe-A-eDP-1
[113.415427] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.105s)
[113.447343] Starting dynamic subtest: pipe-D-eDP-1
[116.190497] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.748s)
[116.192514] Subtest cursor-onscreen-256x256: SUCCESS (4.882s)
[116.987847] [031/133] (902s left) syncobj_timeline (device-submit-unordered)
[117.049468] Starting subtest: device-submit-unordered
[117.051896] Subtest device-submit-unordered: SUCCESS (0.001s)
[117.142147] [032/133] (902s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[117.248450] Starting subtest: fbcpsr-rgb101010-draw-blt
[123.988943] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.744s)
[124.107072] [033/133] (895s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[124.206067] Starting subtest: fbc-pr-cursor-plane-update-sf
[124.210214] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[124.279790] [034/133] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[124.380081] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[124.384292] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[124.468224] [035/133] (895s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[124.559388] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[125.194347] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[125.361960] [036/133] (894s left) api_intel_bb (purge-bb)
[125.422740] Starting subtest: purge-bb
[125.427715] Subtest purge-bb: SUCCESS (0.004s)
[125.562984] [037/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[125.658901] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[132.922140] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.266s)
[133.059414] [038/133] (887s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[133.157356] Starting subtest: psr-rgb565-draw-render
[140.104993] Subtest psr-rgb565-draw-render: SUCCESS (6.951s)
[140.225372] [039/133] (880s left) perf (create-destroy-userspace-config)
[140.385128] Starting subtest: create-destroy-userspace-config
[140.403764] Subtest create-destroy-userspace-config: SUCCESS (0.018s)
[140.451255] [040/133] (879s left) perf (missing-sample-flags)
[140.534585] Starting subtest: missing-sample-flags
[140.537043] Subtest missing-sample-flags: SUCCESS (0.000s)
[140.578879] [041/133] (879s left) gem_exec_balancer (full-late-pulse)
[140.638197] Starting subtest: full-late-pulse
[145.795688] Subtest full-late-pulse: SUCCESS (5.156s)
[146.112368] [042/133] (874s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[146.209946] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[146.213981] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[146.297929] [043/133] (874s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[146.401663] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[146.405814] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[146.509576] [044/133] (873s left) sw_sync (alloc_merge_fence)
[146.545698] Starting subtest: alloc_merge_fence
[146.548056] Subtest alloc_merge_fence: SUCCESS (0.000s)
[146.605446] [045/133] (873s left) kms_plane_multiple (tiling-y)
[146.692803] Starting subtest: tiling-y
[146.697664] Subtest tiling-y: SKIP (0.000s)
[146.782964] [046/133] (873s left) gem_mmap_wc (write-gtt-read-wc)
[146.849069] Subtest write-gtt-read-wc: SKIP (0.000s)
[146.915336] [047/133] (873s left) perf (gen12-group-exclusive-stream-ctx-handle)
[146.987681] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[147.020095] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.031s)
[147.068972] [048/133] (873s left) gem_mmap_offset (isolation)
[148.859210] Starting subtest: isolation
[148.877827] Subtest isolation: SUCCESS (0.011s)
[148.988799] [049/133] (871s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[149.082726] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[149.086844] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[149.191079] [050/133] (871s left) gem_ctx_create (basic)
[149.267272] Starting subtest: basic
[149.269666] Subtest basic: SUCCESS (0.000s)
[149.458445] [051/133] (871s left) syncobj_wait (wait-any-interrupted)
[149.518071] Starting subtest: wait-any-interrupted
[149.619303] Subtest wait-any-interrupted: SUCCESS (0.102s)
[149.695653] [052/133] (871s left) gen9_exec_parse (bb-large)
[149.763114] Subtest bb-large: SKIP (0.000s)
[149.830692] [053/133] (870s left) syncobj_timeline (multi-wait-signaled)
[149.885264] Starting subtest: multi-wait-signaled
[149.887529] Subtest multi-wait-signaled: SUCCESS (0.000s)
[150.005320] [054/133] (870s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[150.136930] Starting subtest: multiplane-atomic-fence-wait
[150.457393] Subtest multiplane-atomic-fence-wait: SUCCESS (0.320s)
[151.599828] [055/133] (869s left) kms_invalid_mode (zero-vdisplay)
[151.695102] Starting subtest: zero-vdisplay
[151.697296] Starting dynamic subtest: pipe-A-eDP-1
[151.979671] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[151.990199] Starting dynamic subtest: pipe-B-eDP-1
[151.992136] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[152.000741] Starting dynamic subtest: pipe-C-eDP-1
[152.003084] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[152.011624] Starting dynamic subtest: pipe-D-eDP-1
[152.013816] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[152.016128] Subtest zero-vdisplay: SUCCESS (0.290s)
[152.823180] [056/133] (868s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[152.923784] Starting subtest: fbc-rgb101010-draw-blt
[157.557066] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.635s)
[158.725726] [057/133] (862s left) gen3_render_linear_blits
[158.850754] [058/133] (862s left) gem_exec_reloc (basic-concurrent0)
[158.902658] Subtest basic-concurrent0: SKIP (0.000s)
[158.966817] [059/133] (862s left) syncobj_wait (multi-wait-for-submit-signaled)
[159.024773] Starting subtest: multi-wait-for-submit-signaled
[159.027075] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[159.140433] [060/133] (861s left) kms_big_fb (4-tiled-addfb-size-overflow)
[159.239834] Starting subtest: 4-tiled-addfb-size-overflow
[159.242055] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[159.350418] [061/133] (861s left) sw_sync (alloc_fence)
[159.393268] Starting subtest: alloc_fence
[159.395394] Subtest alloc_fence: SUCCESS (0.000s)
[159.444612] [062/133] (861s left) kms_prime (d3hot)
[159.525635] Subtest D3hot: SKIP (0.000s)
[159.629062] [063/133] (861s left) perf_pmu (idle-no-semaphores)
[159.671536] Starting subtest: idle-no-semaphores
[159.673148] Starting dynamic subtest: rcs0
[160.222443] Dynamic subtest rcs0: SUCCESS (0.550s)
[160.234194] Starting dynamic subtest: bcs0
[160.744469] Dynamic subtest bcs0: SUCCESS (0.519s)
[160.755570] Starting dynamic subtest: vcs0
[161.265650] Dynamic subtest vcs0: SUCCESS (0.518s)
[161.277301] Starting dynamic subtest: vcs1
[161.784750] Dynamic subtest vcs1: SUCCESS (0.516s)
[161.795985] Starting dynamic subtest: vecs0
[162.307452] Dynamic subtest vecs0: SUCCESS (0.520s)
[162.318640] Starting dynamic subtest: ccs0
[162.833073] Dynamic subtest ccs0: SUCCESS (0.523s)
[162.835956] Subtest idle-no-semaphores: SUCCESS (3.163s)
[162.948175] [064/133] (858s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[163.041780] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[163.046158] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[163.114256] [065/133] (858s left) kms_pm_dc (dc9-dpms)
[164.221771] Starting subtest: dc9-dpms
[165.648699] Subtest dc9-dpms: SUCCESS (1.427s)
[165.721119] [066/133] (855s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[165.773777] Starting subtest: legacy-engines-hostile-preempt
[165.776066] Starting dynamic subtest: render
[165.829916] Dynamic subtest render: SUCCESS (0.055s)
[165.840679] Starting dynamic subtest: bsd1
[167.870219] Dynamic subtest bsd1: SUCCESS (2.038s)
[167.881596] Starting dynamic subtest: bsd2
[169.855043] Dynamic subtest bsd2: SUCCESS (1.981s)
[169.866400] Starting dynamic subtest: blt
[169.935849] Dynamic subtest blt: SUCCESS (0.080s)
[169.946669] Starting dynamic subtest: vebox
[171.923671] Dynamic subtest vebox: SUCCESS (1.984s)
[171.926430] Subtest legacy-engines-hostile-preempt: SUCCESS (6.149s)
[172.005742] [067/133] (849s left) gem_userptr_blits (create-destroy-sync)
[172.070670] Starting subtest: create-destroy-sync
[177.081252] Subtest create-destroy-sync: SUCCESS (5.009s)
[177.199717] [068/133] (844s left) kms_cursor_legacy (torture-move)
[177.341466] Starting subtest: torture-move
[177.343776] Starting dynamic subtest: pipe-A
[183.848714] Dynamic subtest pipe-A: SUCCESS (6.503s)
[183.864790] Starting dynamic subtest: pipe-B
[190.805601] Dynamic subtest pipe-B: SUCCESS (6.957s)
[190.816618] Starting dynamic subtest: pipe-C
[197.572770] Dynamic subtest pipe-C: SUCCESS (6.766s)
[197.583640] Starting dynamic subtest: pipe-D
[204.065969] Dynamic subtest pipe-D: SUCCESS (6.491s)
[204.081593] Starting dynamic subtest: all-pipes
[211.387602] Dynamic subtest all-pipes: SUCCESS (7.321s)
[211.390111] Subtest torture-move: SUCCESS (34.045s)
[211.551408] [069/133] (809s left) device_reset (cold-reset-bound)
[211.604677] Starting subtest: cold-reset-bound
[211.609191] Subtest cold-reset-bound: SKIP (0.000s)
[211.677956] [070/133] (809s left) syncobj_timeline (etime-multi-wait-submitted)
[211.734531] Starting subtest: etime-multi-wait-submitted
[211.836374] Subtest etime-multi-wait-submitted: SUCCESS (0.103s)
[211.925694] [071/133] (809s left) kms_async_flips (invalid-async-flip-atomic)
[212.019758] Starting subtest: invalid-async-flip-atomic
[212.396123] Starting dynamic subtest: pipe-A-eDP-1
[213.206745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s)
[213.576063] Starting dynamic subtest: pipe-B-eDP-1
[214.359037] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.790s)
[214.728978] Starting dynamic subtest: pipe-C-eDP-1
[215.496344] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.774s)
[215.853482] Starting dynamic subtest: pipe-D-eDP-1
[216.625486] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.779s)
[216.627905] Subtest invalid-async-flip-atomic: SUCCESS (4.608s)
[217.770354] [072/133] (803s left) gem_exec_schedule (preempt-hang)
[217.948767] Starting subtest: preempt-hang
[217.951079] Starting dynamic subtest: rcs0
[218.186442] Dynamic subtest rcs0: SUCCESS (0.238s)
[218.196811] Starting dynamic subtest: bcs0
[218.417476] Dynamic subtest bcs0: SUCCESS (0.230s)
[218.428285] Starting dynamic subtest: vcs0
[218.648612] Dynamic subtest vcs0: SUCCESS (0.230s)
[218.658307] Starting dynamic subtest: vcs1
[218.876428] Dynamic subtest vcs1: SUCCESS (0.227s)
[218.885210] Starting dynamic subtest: vecs0
[219.105166] Dynamic subtest vecs0: SUCCESS (0.227s)
[219.114887] Starting dynamic subtest: ccs0
[219.338725] Dynamic subtest ccs0: SUCCESS (0.233s)
[219.340646] Subtest preempt-hang: SUCCESS (1.392s)
[220.009189] [073/133] (801s left) gem_mmap (basic-small-bo)
[220.075128] Subtest basic-small-bo: SKIP (0.000s)
[220.147335] [074/133] (801s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[220.258201] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[220.262367] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[220.361424] [075/133] (801s left) kms_plane (plane-position-covered)
[220.452056] Starting subtest: plane-position-covered
[220.976805] Starting dynamic subtest: pipe-A-plane-1
[222.307057] Dynamic subtest pipe-A-plane-1: SUCCESS (1.331s)
[222.315857] Starting dynamic subtest: pipe-A-plane-2
[223.580896] Dynamic subtest pipe-A-plane-2: SUCCESS (1.270s)
[223.590540] Starting dynamic subtest: pipe-A-plane-3
[224.856808] Dynamic subtest pipe-A-plane-3: SUCCESS (1.276s)
[224.866389] Starting dynamic subtest: pipe-A-plane-4
[226.168335] Dynamic subtest pipe-A-plane-4: SUCCESS (1.312s)
[226.177568] Starting dynamic subtest: pipe-A-plane-5
[226.193051] Dynamic subtest pipe-A-plane-5: SUCCESS (0.022s)
[227.348372] Starting dynamic subtest: pipe-B-plane-1
[228.695788] Dynamic subtest pipe-B-plane-1: SUCCESS (1.354s)
[228.705434] Starting dynamic subtest: pipe-B-plane-2
[229.956758] Dynamic subtest pipe-B-plane-2: SUCCESS (1.262s)
[229.966967] Starting dynamic subtest: pipe-B-plane-3
[231.221173] Dynamic subtest pipe-B-plane-3: SUCCESS (1.262s)
[231.230243] Starting dynamic subtest: pipe-B-plane-4
[232.464639] Dynamic subtest pipe-B-plane-4: SUCCESS (1.245s)
[232.474557] Starting dynamic subtest: pipe-B-plane-5
[232.490787] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[232.493045] Subtest plane-position-covered: SUCCESS (12.039s)
[233.358620] [076/133] (788s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[233.453367] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[233.457772] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[233.539696] [077/133] (788s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[233.626193] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[233.628479] Starting dynamic subtest: pipe-A-eDP-1
[233.637370] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[233.651952] Starting dynamic subtest: pipe-B-eDP-1
[233.660900] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[233.669429] Starting dynamic subtest: pipe-C-eDP-1
[233.677982] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[233.686242] Starting dynamic subtest: pipe-D-eDP-1
[233.694694] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[233.699053] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[235.937998] [078/133] (785s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[236.022249] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[236.024613] Starting dynamic subtest: pipe-A
[236.045526] Dynamic subtest pipe-A: SKIP (0.018s)
[236.054742] Starting dynamic subtest: pipe-B
[236.075746] Dynamic subtest pipe-B: SKIP (0.032s)
[236.084753] Starting dynamic subtest: pipe-C
[236.109298] Dynamic subtest pipe-C: SKIP (0.032s)
[236.121784] Starting dynamic subtest: pipe-D
[236.140894] Dynamic subtest pipe-D: SKIP (0.031s)
[236.145266] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.116s)
[236.250108] [079/133] (785s left) kms_color (deep-color)
[236.350162] Starting subtest: deep-color
[237.402729] Starting dynamic subtest: pipe-A-eDP-1-gamma
[238.121941] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.721s)
[238.132195] Starting dynamic subtest: pipe-A-eDP-1-degamma
[239.585466] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.463s)
[239.595286] Starting dynamic subtest: pipe-A-eDP-1-ctm
[241.032177] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.445s)
[241.785842] Starting dynamic subtest: pipe-B-eDP-1-gamma
[242.496572] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.719s)
[242.506323] Starting dynamic subtest: pipe-B-eDP-1-degamma
[243.990523] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.492s)
[243.999917] Starting dynamic subtest: pipe-B-eDP-1-ctm
[245.408890] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.417s)
[246.170856] Starting dynamic subtest: pipe-C-eDP-1-gamma
[246.843416] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.681s)
[246.853153] Starting dynamic subtest: pipe-C-eDP-1-degamma
[248.222656] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.377s)
[248.231370] Starting dynamic subtest: pipe-C-eDP-1-ctm
[249.649964] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.427s)
[250.464577] Starting dynamic subtest: pipe-D-eDP-1-gamma
[251.165209] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.705s)
[251.174364] Starting dynamic subtest: pipe-D-eDP-1-degamma
[252.625830] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.459s)
[252.635906] Starting dynamic subtest: pipe-D-eDP-1-ctm
[254.058611] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.434s)
[254.060905] Subtest deep-color: SUCCESS (17.708s)
[254.910964] [080/133] (767s left) kms_atomic_transition (plane-all-transition-nonblocking)
[255.012328] Starting subtest: plane-all-transition-nonblocking
[255.014625] Starting dynamic subtest: pipe-A-eDP-1
[257.506210] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[257.821732] Starting dynamic subtest: pipe-B-eDP-1
[261.062496] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.249s)
[261.358207] Subtest plane-all-transition-nonblocking: SUCCESS (6.347s)
[262.220279] [081/133] (759s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[262.319368] Starting subtest: psr-2p-primscrn-cur-indfb-move
[262.323629] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[262.405121] [082/133] (759s left) i915_query (engine-info-invalid)
[262.458038] Starting subtest: engine-info-invalid
[262.460293] Subtest engine-info-invalid: SUCCESS (0.000s)
[262.551472] [083/133] (759s left) kms_rotation_crc (sprite-rotation-90)
[262.645240] Starting subtest: sprite-rotation-90
[262.649489] Subtest sprite-rotation-90: SKIP (0.001s)
[262.719482] [084/133] (759s left) gem_userptr_blits (coherency-sync)
[262.783651] Starting subtest: coherency-sync
[263.190486] Subtest coherency-sync: SKIP (0.369s)
[263.281475] [085/133] (758s left) api_intel_allocator (default-alignment)
[263.385519] Starting subtest: default-alignment
[263.387751] Subtest default-alignment: SUCCESS (0.003s)
[263.501900] [086/133] (758s left) kms_psr (pr-cursor-render)
[263.599256] Starting subtest: pr-cursor-render
[263.603572] Subtest pr-cursor-render: SKIP (0.000s)
[263.675430] [087/133] (758s left) gem_exec_flush (basic-wb-pro-default)
[263.748819] Starting subtest: basic-wb-pro-default
[269.218396] Subtest basic-wb-pro-default: SUCCESS (5.469s)
[269.410633] [088/133] (752s left) gem_eio (kms)
[269.699772] Starting subtest: kms
[287.303086] Subtest kms: SUCCESS (17.602s)
[288.483657] [089/133] (733s left) template (a)
[288.539724] Starting subtest: A
[288.542134] Subtest A: SUCCESS (0.000s)
[288.633850] [090/133] (733s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[288.730116] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[288.732321] Starting dynamic subtest: pipe-A-default-mode
[291.493076] Dynamic subtest pipe-A-default-mode: SUCCESS (2.762s)
[291.495335] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.764s)
[292.355712] [091/133] (730s left) gem_exec_schedule (semaphore-noskip)
[292.434302] Starting subtest: semaphore-noskip
[292.860410] Subtest semaphore-noskip: SUCCESS (0.433s)
[293.200534] [092/133] (729s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[293.320821] Starting subtest: basic-flip-before-cursor-legacy
[294.247130] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.923s)
[295.069201] [093/133] (727s left) fbdev (write)
[295.120273] Starting subtest: write
[295.486272] Subtest write: SUCCESS (0.364s)
[295.550259] [094/133] (727s left) kms_flip (2x-blocking-absolute-wf_vblank)
[295.646167] Starting subtest: 2x-blocking-absolute-wf_vblank
[295.655852] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[295.737592] [095/133] (726s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[295.802473] Starting subtest: multi-wait-for-submit-unsubmitted
[295.909169] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[295.991604] [096/133] (726s left) kms_big_fb (x-tiled-addfb)
[296.109444] Starting subtest: x-tiled-addfb
[296.111688] Subtest x-tiled-addfb: SUCCESS (0.000s)
[296.211563] [097/133] (726s left) kms_selftest (drm_cmdline_parser)
[296.253797] Starting subtest: drm_cmdline_parser
[296.267948] Starting dynamic subtest: drm_test_cmdline_force_d_only
[296.371272] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.102s)
[296.381867] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[296.475117] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.103s)
[296.486306] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[296.590472] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.114s)
[296.606189] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[296.688525] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.097s)
[296.698624] Starting dynamic subtest: drm_test_cmdline_force_e_only
[296.778380] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.089s)
[296.789541] Starting dynamic subtest: drm_test_cmdline_res
[296.864299] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.086s)
[296.873579] Starting dynamic subtest: drm_test_cmdline_res_vesa
[296.955857] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.092s)
[296.964849] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[297.046769] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.090s)
[297.055459] Starting dynamic subtest: drm_test_cmdline_res_rblank
[297.133053] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.086s)
[297.142222] Starting dynamic subtest: drm_test_cmdline_res_bpp
[297.242595] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.108s)
[297.251740] Starting dynamic subtest: drm_test_cmdline_res_refresh
[297.332700] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.086s)
[297.341668] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[297.411720] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.080s)
[297.421813] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[297.503060] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.090s)
[297.511596] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[297.597964] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.094s)
[297.607104] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[297.689875] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.090s)
[297.699024] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[297.785742] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.092s)
[297.796520] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[297.880571] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.094s)
[297.890880] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[297.971465] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.090s)
[297.981687] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[298.060300] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.088s)
[298.070804] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[298.152483] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.091s)
[298.162802] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[298.239772] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.087s)
[298.249065] Starting dynamic subtest: drm_test_cmdline_name
[298.333304] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.091s)
[298.342248] Starting dynamic subtest: drm_test_cmdline_name_bpp
[298.424145] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.090s)
[298.432928] Starting dynamic subtest: drm_test_cmdline_name_option
[298.512199] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.087s)
[298.521165] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[298.603128] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.090s)
[298.612226] Starting dynamic subtest: drm_test_cmdline_rotate_0
[298.692548] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.088s)
[298.701543] Starting dynamic subtest: drm_test_cmdline_rotate_90
[298.791595] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.098s)
[298.800693] Starting dynamic subtest: drm_test_cmdline_rotate_180
[298.884534] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.092s)
[298.894776] Starting dynamic subtest: drm_test_cmdline_rotate_270
[298.979605] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.094s)
[298.990266] Starting dynamic subtest: drm_test_cmdline_hmirror
[299.064858] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.087s)
[299.073971] Starting dynamic subtest: drm_test_cmdline_vmirror
[299.155419] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.087s)
[299.166316] Starting dynamic subtest: drm_test_cmdline_margin_options
[299.236477] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.081s)
[299.247092] Starting dynamic subtest: drm_test_cmdline_multiple_options
[299.326840] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.091s)
[299.335991] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[299.418876] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.087s)
[299.429064] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[299.506944] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.088s)
[299.516486] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[299.589772] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.082s)
[299.598759] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[299.679742] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.088s)
[299.688953] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[299.761762] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.082s)
[299.770618] Starting dynamic subtest: drm_test_cmdline_invalid
[299.851135] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.089s)
[299.860396] Starting dynamic subtest: drm_test_cmdline_tv_options
[299.939134] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.087s)
[299.940665] Subtest drm_cmdline_parser: SUCCESS (3.684s)
[300.099116] [098/133] (722s left) gem_exec_balancer (sequential)
[300.170980] Starting subtest: sequential
[303.277922] Subtest sequential: SUCCESS (3.106s)
[303.569595] [099/133] (719s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[303.670073] Starting subtest: fbc-psr2-sprite-mmap-cpu
[303.672237] Starting dynamic subtest: eDP-1
[303.676318] Dynamic subtest eDP-1: SKIP (0.000s)
[303.680445] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[303.745505] [100/133] (719s left) gem_exec_fence (nb-await)
[303.912921] Starting subtest: nb-await
[303.915220] Starting dynamic subtest: rcs0
[303.979309] Dynamic subtest rcs0: SUCCESS (0.067s)
[303.991974] Starting dynamic subtest: bcs0
[304.039405] Dynamic subtest bcs0: SUCCESS (0.058s)
[304.051630] Starting dynamic subtest: vcs0
[304.098600] Dynamic subtest vcs0: SUCCESS (0.057s)
[304.111772] Starting dynamic subtest: vcs1
[304.157753] Dynamic subtest vcs1: SUCCESS (0.057s)
[304.169945] Starting dynamic subtest: vecs0
[304.217752] Dynamic subtest vecs0: SUCCESS (0.057s)
[304.232075] Starting dynamic subtest: ccs0
[304.277270] Dynamic subtest ccs0: SUCCESS (0.057s)
[304.280194] Subtest nb-await: SUCCESS (0.366s)
[306.039412] [101/133] (716s left) sysfs_timeslice_duration (idempotent)
[306.099746] Starting subtest: idempotent
[306.102377] Starting dynamic subtest: vecs0
[306.105181] Dynamic subtest vecs0: SUCCESS (0.000s)
[306.117905] Starting dynamic subtest: ccs0
[306.120111] Dynamic subtest ccs0: SUCCESS (0.000s)
[306.129134] Starting dynamic subtest: vcs0
[306.131443] Dynamic subtest vcs0: SUCCESS (0.000s)
[306.140688] Starting dynamic subtest: bcs0
[306.142847] Dynamic subtest bcs0: SUCCESS (0.000s)
[306.152169] Starting dynamic subtest: rcs0
[306.154308] Dynamic subtest rcs0: SUCCESS (0.000s)
[306.164259] Starting dynamic subtest: vcs1
[306.166480] Dynamic subtest vcs1: SUCCESS (0.000s)
[306.168409] Subtest idempotent: SUCCESS (0.007s)
[306.206912] [102/133] (716s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[306.307287] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[306.311309] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[306.415452] [103/133] (716s left) gem_exec_store (basic)
[306.471677] Starting subtest: basic
[306.567966] Subtest basic: SUCCESS (0.098s)
[306.766094] [104/133] (716s left) intel_hwmon (hwmon-read)
[306.818654] Subtest hwmon-read: SKIP (0.000s)
[306.882778] [105/133] (716s left) i915_getparams_basic (basic-eu-total)
[306.927517] Starting subtest: basic-eu-total
[306.931975] Subtest basic-eu-total: SUCCESS (0.000s)
[307.027418] [106/133] (716s left) kms_big_fb (linear-16bpp-rotate-90)
[307.127156] Starting subtest: linear-16bpp-rotate-90
[307.150337] Subtest linear-16bpp-rotate-90: SKIP (0.022s)
[307.267898] [107/133] (715s left) kms_vblank (query-forked-busy)
[307.363054] Starting subtest: query-forked-busy
[307.364950] Starting dynamic subtest: pipe-A-eDP-1
[309.236416] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[309.251488] Starting dynamic subtest: pipe-D-eDP-1
[311.825771] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.583s)
[311.828063] Subtest query-forked-busy: SUCCESS (4.462s)
[312.631269] [108/133] (710s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[312.723474] Starting subtest: nonblocking-crc-frame-sequence
[312.725700] Starting dynamic subtest: pipe-A-eDP-1
[313.466905] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[313.478612] Starting dynamic subtest: pipe-B-eDP-1
[314.864148] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s)
[314.874372] Starting dynamic subtest: pipe-C-eDP-1
[316.248582] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.385s)
[316.259260] Starting dynamic subtest: pipe-D-eDP-1
[317.671083] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.419s)
[317.673294] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.947s)
[318.481065] [109/133] (704s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[318.584345] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[318.586722] Starting dynamic subtest: pipe-A-eDP-1
[324.478774] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.900s)
[324.489864] Starting dynamic subtest: pipe-B-eDP-1
[331.145676] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.664s)
[331.147877] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.567s)
[332.022908] [110/133] (691s left) kms_flip (2x-plain-flip-interruptible)
[332.132287] Starting subtest: 2x-plain-flip-interruptible
[332.144760] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[332.221785] [111/133] (691s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[332.321046] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[332.323286] Starting dynamic subtest: pipe-A-eDP-1
[343.311421] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.995s)
[343.322323] Starting dynamic subtest: pipe-B-eDP-1
[355.028019] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.713s)
[355.030380] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.711s)
[355.898120] [112/133] (667s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[355.991047] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[355.993191] Starting dynamic subtest: pipe-A-eDP-1
[356.514218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.494s)
[356.536647] Starting dynamic subtest: pipe-B-eDP-1
[357.986061] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.472s)
[357.997705] Starting dynamic subtest: pipe-C-eDP-1
[359.396476] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.409s)
[359.408706] Starting dynamic subtest: pipe-D-eDP-1
[360.741646] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[360.743508] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.724s)
[361.920830] [113/133] (661s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[362.043748] Starting subtest: cursorB-vs-flipA-varying-size
[362.048152] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[362.186495] [114/133] (661s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[362.279728] Starting subtest: pipe-fbc-rte
[362.286088] Starting dynamic subtest: pipe-B-eDP-1
[367.710018] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.435s)
[367.717642] Subtest pipe-fbc-rte: SUCCESS (5.437s)
[369.991917] [115/133] (653s left) syncobj_timeline (invalid-query-bad-pad)
[370.049863] Starting subtest: invalid-query-bad-pad
[370.052267] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[370.152668] [116/133] (653s left) gem_exercise_blt (fast-copy-emit)
[370.208035] Starting subtest: fast-copy-emit
[370.210336] Starting dynamic subtest: linear-smem-smem-emit
[370.230373] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s)
[370.242070] Starting dynamic subtest: xmajor-smem-smem-emit
[370.247816] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[370.257216] Starting dynamic subtest: tile4-smem-smem-emit
[370.265214] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[370.274409] Starting dynamic subtest: tile64-smem-smem-emit
[370.281915] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[370.284174] Subtest fast-copy-emit: SUCCESS (0.075s)
[370.390149] [117/133] (653s left) gem_ctx_persistence (engines-queued)
[370.444261] Starting subtest: engines-queued
[370.446448] Starting dynamic subtest: rcs0
[370.521922] Dynamic subtest rcs0: SUCCESS (0.077s)
[370.534402] Starting dynamic subtest: bcs0
[370.553223] Dynamic subtest bcs0: SUCCESS (0.030s)
[370.562559] Starting dynamic subtest: vcs0
[371.897393] Dynamic subtest vcs0: SUCCESS (1.341s)
[371.910065] Starting dynamic subtest: vcs1
[373.879261] Dynamic subtest vcs1: SUCCESS (1.978s)
[373.891905] Starting dynamic subtest: vecs0
[375.863069] Dynamic subtest vecs0: SUCCESS (1.981s)
[375.875694] Starting dynamic subtest: ccs0
[376.036722] Dynamic subtest ccs0: SUCCESS (0.172s)
[376.039212] Subtest engines-queued: SUCCESS (5.593s)
[376.159810] [118/133] (647s left) kms_big_fb (y-tiled-addfb)
[376.268452] Starting subtest: y-tiled-addfb
[376.272793] Subtest y-tiled-addfb: SKIP (0.000s)
[376.372368] [119/133] (647s left) gem_partial_pwrite_pread (write-display)
[376.426750] Subtest write-display: SKIP (0.000s)
[376.488415] [120/133] (647s left) kms_psr (psr2-sprite-plane-move)
[376.573588] Starting subtest: psr2-sprite-plane-move
[376.575742] Starting dynamic subtest: eDP-1
[378.300056] Dynamic subtest eDP-1: SUCCESS (1.728s)
[378.302251] Subtest psr2-sprite-plane-move: SUCCESS (1.729s)
[379.142722] [121/133] (644s left) gem_close_race (multigpu-basic-threads)
[379.209705] Starting subtest: multigpu-basic-threads
[379.214053] Subtest multigpu-basic-threads: SKIP (0.000s)
[379.446688] [122/133] (644s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[379.540467] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[379.544546] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[379.632031] [123/133] (644s left) kms_content_protection (dp-mst-type-0)
[379.779792] Starting subtest: dp-mst-type-0
[379.784437] Subtest dp-mst-type-0: SKIP (0.000s)
[379.922818] [124/133] (643s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[380.025304] Starting subtest: fbcpsr-stridechange
[386.243459] Subtest fbcpsr-stridechange: SUCCESS (6.221s)
[386.393614] [125/133] (637s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[386.502885] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[386.507437] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[386.606662] [126/133] (637s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[386.704142] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[386.706393] Starting dynamic subtest: pipe-A-eDP-1
[387.535884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.825s)
[387.546839] Starting dynamic subtest: pipe-B-eDP-1
[389.112639] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.573s)
[389.130366] Starting dynamic subtest: pipe-C-eDP-1
[390.579218] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.468s)
[390.589221] Starting dynamic subtest: pipe-D-eDP-1
[392.101826] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.521s)
[392.103957] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.392s)
[393.308991] [127/133] (630s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[393.404783] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[393.409195] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[393.491656] [128/133] (630s left) kms_psr (psr-sprite-render)
[393.592723] Starting subtest: psr-sprite-render
[393.594962] Starting dynamic subtest: eDP-1
[395.324682] Dynamic subtest eDP-1: SUCCESS (1.729s)
[395.326587] Subtest psr-sprite-render: SUCCESS (1.731s)
[396.161028] [129/133] (627s left) syncobj_wait (wait-all-for-submit-complex)
[396.219904] Starting subtest: wait-all-for-submit-complex
[396.432753] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[396.522448] [130/133] (627s left) gem_ctx_param (invalid-param-get)
[396.573516] Starting subtest: invalid-param-get
[396.575815] Subtest invalid-param-get: SUCCESS (0.001s)
[396.678959] [131/133] (627s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[396.793598] Starting subtest: basic-flip-before-cursor-varying-size
[397.725065] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.929s)
[398.593220] [132/133] (625s left) kms_chamelium_color (ctm-0-50)
[398.692102] Subtest ctm-0-50: SKIP (0.000s)
[398.740803] [133/133] (625s left) gem_ctx_param (invalid-ctx-get)
[398.808387] Starting subtest: invalid-ctx-get
[398.810813] Subtest invalid-ctx-get: SUCCESS (0.000s)
[398.884747] 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.