[62.013046] Initializing watchdogs
[62.013140]   /dev/watchdog0
[62.027104] [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]
[62.031322] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.033481] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.036813] [001/133] (960s left) api_intel_allocator (gem-pool)
[62.115193] Starting subtest: gem-pool
[62.130933] Subtest gem-pool: SUCCESS (0.017s)
[62.252612] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[62.350178] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[62.354564] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[62.441990] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[62.548460] Starting subtest: read-crc-frame-sequence
[62.550797] Starting dynamic subtest: pipe-A-eDP-1
[63.260575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[63.269091] Starting dynamic subtest: pipe-B-eDP-1
[64.655062] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s)
[64.663856] Starting dynamic subtest: pipe-C-eDP-1
[65.940556] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.288s)
[65.947885] Starting dynamic subtest: pipe-D-eDP-1
[67.277363] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[67.279834] Subtest read-crc-frame-sequence: SUCCESS (4.746s)
[68.121711] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[68.191145] Starting subtest: invalid-query-one-illegal-handle
[68.193513] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s)
[68.311166] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[68.376787] Starting subtest: invalid-signal-zero-handles
[68.378788] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[68.494228] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[68.598921] Starting subtest: fbcpsr-rgb565-draw-render
[75.616963] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.032s)
[75.785269] [007/133] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[75.840848] Starting subtest: wait-for-submit-snapshot
[75.922194] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[76.015137] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[76.109110] Starting subtest: psr-rgb565-draw-blt
[83.095959] Subtest psr-rgb565-draw-blt: SUCCESS (6.989s)
[83.242062] [009/133] (939s left) kms_cursor_crc (cursor-onscreen-32x10)
[83.406057] Starting subtest: cursor-onscreen-32x10
[83.448846] Subtest cursor-onscreen-32x10: SKIP (0.038s)
[83.748798] [010/133] (939s left) syncobj_wait (invalid-signal-illegal-handle)
[83.810963] Starting subtest: invalid-signal-illegal-handle
[83.812915] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[83.946341] [011/133] (938s left) testdisplay
[84.288427] [012/133] (938s left) prime_mmap (test_map_unmap)
[84.354240] Starting subtest: test_map_unmap
[84.355930] Starting dynamic subtest: test_map_unmap-smem
[84.383080] Dynamic subtest test_map_unmap-smem: SUCCESS (0.029s)
[84.385172] Subtest test_map_unmap: SUCCESS (0.030s)
[84.504221] [013/133] (938s left) gem_exec_fence (syncobj-timeline-signal)
[85.067875] Starting subtest: syncobj-timeline-signal
[85.074455] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[87.020507] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[87.023631] [014/133] (936s left) syncobj_timeline (signal-point-0)
[87.095071] Starting subtest: signal-point-0
[87.097321] Subtest signal-point-0: SUCCESS (0.000s)
[87.205246] [015/133] (935s left) kms_psr (psr2-suspend)
[87.308636] Starting subtest: psr2-suspend
[87.310907] Starting dynamic subtest: eDP-1
[105.414842] Dynamic subtest eDP-1: SUCCESS (2.964s)
[105.417188] Subtest psr2-suspend: SUCCESS (2.965s)
[106.215959] [016/133] (916s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[106.326905] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[106.339397] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[106.407849] [017/133] (916s left) gem_softpin (reverse)
[106.480523] Starting subtest: reverse
[106.487312] Subtest reverse: SUCCESS (0.007s)
[106.614611] [018/133] (916s left) gem_exec_balancer (parallel-contexts)
[106.858937] Starting subtest: parallel-contexts
[109.264722] Subtest parallel-contexts: SUCCESS (2.474s)
[110.161372] [019/133] (913s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[110.272372] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[110.274761] Starting dynamic subtest: pipe-A-eDP-1
[112.364834] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.130s)
[112.373315] Starting dynamic subtest: pipe-B-eDP-1
[114.514307] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.177s)
[114.522750] Starting dynamic subtest: pipe-C-eDP-1
[116.565403] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.071s)
[116.573850] Starting dynamic subtest: pipe-D-eDP-1
[118.633158] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.086s)
[118.635418] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.468s)
[119.825984] [020/133] (903s left) kms_lease (lease-unleased-connector)
[119.935393] Starting subtest: lease-unleased-connector
[119.937754] Starting dynamic subtest: pipe-A-eDP-1
[119.943080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.008s)
[119.954284] Starting dynamic subtest: pipe-B-eDP-1
[119.956561] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[119.965014] Starting dynamic subtest: pipe-C-eDP-1
[119.967314] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[119.976127] Starting dynamic subtest: pipe-D-eDP-1
[119.978287] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[119.980403] Subtest lease-unleased-connector: SUCCESS (0.041s)
[120.106195] [021/133] (903s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[120.221251] Starting subtest: cursor-vs-flip-atomic-transitions
[150.014421] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.831s)
[150.813063] [022/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[150.921085] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[150.923412] Starting dynamic subtest: pipe-A-default-mode
[153.683184] Dynamic subtest pipe-A-default-mode: SUCCESS (2.762s)
[153.685498] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.763s)
[154.522897] [023/133] (868s left) kms_addfb_basic (legacy-format)
[154.592620] Starting subtest: legacy-format
[154.612532] Subtest legacy-format: SUCCESS (0.017s)
[154.776231] [024/133] (868s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[154.874627] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[154.878446] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[155.015900] [025/133] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[155.112279] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[155.115992] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[155.255457] [026/133] (868s left) kms_vblank (query-busy)
[155.356204] Starting subtest: query-busy
[155.358058] Starting dynamic subtest: pipe-A-eDP-1
[157.231744] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[157.245704] Starting dynamic subtest: pipe-D-eDP-1
[159.757760] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.525s)
[159.759974] Subtest query-busy: SUCCESS (4.402s)
[160.575323] [027/133] (862s left) gem_wait (invalid-flags)
[160.636135] Starting subtest: invalid-flags
[160.638511] Subtest invalid-flags: SUCCESS (0.000s)
[160.891401] [028/133] (862s left) kms_properties (invalid-properties-atomic)
[160.980198] Starting subtest: invalid-properties-atomic
[161.286446] Subtest invalid-properties-atomic: SUCCESS (0.306s)
[161.387939] [029/133] (862s left) gem_exec_flush (basic-wb-ro-before-default)
[161.461562] Starting subtest: basic-wb-ro-before-default
[166.921674] Subtest basic-wb-ro-before-default: SUCCESS (5.462s)
[167.119389] [030/133] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[167.232497] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[167.236634] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[167.348031] [031/133] (856s left) kms_psr (pr-primary-blt)
[167.456084] Starting subtest: pr-primary-blt
[167.460497] Subtest pr-primary-blt: SKIP (0.000s)
[167.541558] [032/133] (856s left) kms_flip (2x-flip-vs-dpms-on-nop)
[167.650164] Starting subtest: 2x-flip-vs-dpms-on-nop
[167.661582] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[167.792983] [033/133] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[167.894940] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[167.899115] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[168.007875] [034/133] (855s left) kms_chamelium_edid (dp-mode-timings)
[168.408468] Subtest dp-mode-timings: SKIP (0.000s)
[169.178641] [035/133] (854s left) kms_flip (flip-vs-panning-interruptible)
[169.277222] Starting subtest: flip-vs-panning-interruptible
[169.279547] Starting dynamic subtest: A-eDP1
[178.002588] Dynamic subtest A-eDP1: SUCCESS (8.727s)
[178.011782] Starting dynamic subtest: B-eDP1
[186.734046] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[186.748125] Starting dynamic subtest: C-eDP1
[195.452082] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[195.461380] Starting dynamic subtest: D-eDP1
[204.185651] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[204.189842] Subtest flip-vs-panning-interruptible: SUCCESS (34.919s)
[205.460607] [036/133] (818s left) kms_pm_dc (dc5-psr)
[206.560899] Starting subtest: dc5-psr
[209.459484] Subtest dc5-psr: SUCCESS (2.895s)
[210.329362] [037/133] (813s left) gem_userptr_blits (process-exit)
[210.407022] Starting subtest: process-exit
[210.413777] Subtest process-exit: SUCCESS (0.007s)
[210.577940] [038/133] (813s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[210.674174] Starting subtest: plane-lut1d-post-ctm3x4
[210.686708] Starting dynamic subtest: pipe-A-eDP-1
[211.351330] Dynamic subtest pipe-A-eDP-1: FAIL (0.315s)
[212.060889] Starting dynamic subtest: pipe-B-eDP-1
[212.864530] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[213.398305] Starting dynamic subtest: pipe-C-eDP-1
[214.244787] Dynamic subtest pipe-C-eDP-1: FAIL (0.271s)
[214.729477] Starting dynamic subtest: pipe-D-eDP-1
[215.560555] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[215.562857] Subtest plane-lut1d-post-ctm3x4: FAIL (4.588s)
[216.124266] [039/133] (807s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[216.188623] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[216.293187] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[216.367660] [040/133] (807s left) gem_mmap_offset (partial-remap)
[216.421942] Starting subtest: partial-remap
[216.423773] Starting dynamic subtest: smem0
[216.432597] Dynamic subtest smem0: SUCCESS (0.004s)
[216.434741] Subtest partial-remap: SUCCESS (0.004s)
[216.566247] [041/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[216.670238] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[216.674071] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[216.789248] [042/133] (807s left) gem_userptr_blits (dmabuf-unsync)
[216.866663] Subtest dmabuf-unsync: SKIP (0.000s)
[217.034190] [043/133] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[217.142691] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[217.146786] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[217.275095] [044/133] (806s left) gem_close_race (multigpu-basic-threads)
[217.351468] Starting subtest: multigpu-basic-threads
[217.355036] Subtest multigpu-basic-threads: SKIP (0.000s)
[217.599992] [045/133] (806s left) gem_exec_schedule (preempt)
[217.683061] Starting subtest: preempt
[217.685171] Starting dynamic subtest: rcs0
[217.697350] Dynamic subtest rcs0: SUCCESS (0.024s)
[217.708323] Starting dynamic subtest: bcs0
[217.716953] Dynamic subtest bcs0: SUCCESS (0.019s)
[217.724896] Starting dynamic subtest: vcs0
[217.738466] Dynamic subtest vcs0: SUCCESS (0.021s)
[217.746341] Starting dynamic subtest: vcs1
[217.761651] Dynamic subtest vcs1: SUCCESS (0.022s)
[217.769673] Starting dynamic subtest: vecs0
[217.782937] Dynamic subtest vecs0: SUCCESS (0.020s)
[217.793417] Starting dynamic subtest: ccs0
[217.807167] Dynamic subtest ccs0: SUCCESS (0.023s)
[217.811590] Subtest preempt: SUCCESS (0.135s)
[219.187006] [046/133] (805s left) i915_module_load (reload)
[219.224544] Starting subtest: reload
[224.096204] Subtest reload: SUCCESS (4.870s)
[224.132623] [047/133] (800s left) gem_exec_reloc (basic-wc-cpu-active)
[226.021813] Subtest basic-wc-cpu-active: SKIP (0.000s)
[226.120900] [048/133] (798s left) gen9_exec_parse (valid-registers)
[226.194135] Subtest valid-registers: SKIP (0.000s)
[226.271461] [049/133] (798s left) kms_cursor_edge_walk (64x64-left-edge)
[226.353039] Starting subtest: 64x64-left-edge
[226.355218] Starting dynamic subtest: pipe-A-eDP-1
[229.797621] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s)
[229.805905] Starting dynamic subtest: pipe-D-eDP-1
[232.913591] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s)
[232.915504] Subtest 64x64-left-edge: SUCCESS (6.560s)
[233.772280] [050/133] (790s left) gem_render_copy_redux (flink)
[233.838325] Starting subtest: flink
[234.554872] Subtest flink: SUCCESS (0.716s)
[234.715133] [051/133] (789s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[234.822068] Starting subtest: psr-2p-primscrn-spr-indfb-move
[234.825428] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[234.936334] [052/133] (789s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[235.042042] Starting subtest: bo-too-small-due-to-tiling
[235.045835] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[235.162970] [053/133] (789s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[235.266245] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[241.884839] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.619s)
[242.048720] [054/133] (782s left) gem_exec_reloc (basic-write-wc-active)
[242.112556] Subtest basic-write-wc-active: SKIP (0.000s)
[242.190704] [055/133] (782s left) gem_fenced_exec_thrash (2-spare-fences)
[242.241260] Subtest 2-spare-fences: SKIP (0.000s)
[242.326413] [056/133] (782s left) kms_hdr (static-toggle-dpms)
[242.410189] Starting subtest: static-toggle-dpms
[242.416794] Subtest static-toggle-dpms: SKIP (0.000s)
[242.495297] [057/133] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[242.608610] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[249.600781] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.996s)
[249.756602] [058/133] (775s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[249.865410] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[253.622533] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.761s)
[254.806261] [059/133] (770s left) gem_lmem_swapping (parallel-random-verify)
[254.847156] Subtest parallel-random-verify: SKIP (0.000s)
[254.888227] [060/133] (770s left) kms_psr (fbc-pr-sprite-plane-move)
[254.995176] Starting subtest: fbc-pr-sprite-plane-move
[254.999547] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[255.080590] [061/133] (769s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[255.468481] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[256.283471] [062/133] (768s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[256.381165] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[256.383401] Starting dynamic subtest: pipe-A-eDP-1
[256.407653] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[256.417790] Starting dynamic subtest: pipe-B-eDP-1
[256.440799] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[256.448462] Starting dynamic subtest: pipe-C-eDP-1
[256.471414] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[256.479066] Starting dynamic subtest: pipe-D-eDP-1
[256.502079] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[256.505870] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[258.667677] [063/133] (766s left) i915_pm_rpm (gem-evict-pwrite)
[260.187091] Starting subtest: gem-evict-pwrite
[260.192259] Subtest gem-evict-pwrite: SKIP (0.000s)
[260.909926] [064/133] (764s left) gem_exec_whisper (basic-sync)
[260.980954] Starting subtest: basic-sync
[267.720360] Subtest basic-sync: SUCCESS (6.740s)
[267.919323] [065/133] (757s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[268.032355] Starting subtest: short-busy-flip-before-cursor-toggle
[268.036671] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[268.197562] [066/133] (756s left) i915_query (hwconfig_table)
[268.258340] Starting subtest: hwconfig_table
[268.551910] Subtest hwconfig_table: SUCCESS (0.001s)
[268.590149] [067/133] (756s left) kms_vrr (flipline)
[268.675209] Starting subtest: flipline
[268.681248] Subtest flipline: SKIP (0.000s)
[268.758277] [068/133] (756s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[268.868009] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[273.153963] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.289s)
[274.301976] [069/133] (750s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[274.415529] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[274.428609] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[274.514637] [070/133] (750s left) kms_prop_blob (invalid-set-prop)
[274.576434] Starting subtest: invalid-set-prop
[274.578376] Subtest invalid-set-prop: SUCCESS (0.000s)
[274.688345] [071/133] (750s left) kms_properties (crtc-properties-legacy)
[274.787257] Starting subtest: crtc-properties-legacy
[274.790310] Starting dynamic subtest: pipe-A-eDP-1
[275.229995] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[275.241218] Starting dynamic subtest: pipe-B-eDP-1
[276.425752] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.196s)
[276.435564] Starting dynamic subtest: pipe-C-eDP-1
[277.545493] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[277.553830] Starting dynamic subtest: pipe-D-eDP-1
[278.674590] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[278.676986] Subtest crtc-properties-legacy: SUCCESS (3.889s)
[279.507105] [072/133] (745s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[279.609632] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[286.434967] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.829s)
[286.594134] [073/133] (738s left) kms_psr (fbc-pr-cursor-render)
[286.692197] Starting subtest: fbc-pr-cursor-render
[286.696319] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[286.775780] [074/133] (738s left) gem_userptr_blits (huge-split)
[286.847601] Starting subtest: huge-split
[286.853991] Subtest huge-split: SUCCESS (0.007s)
[286.976963] [075/133] (738s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[287.242056] Starting subtest: cursor-rapid-movement-256x85
[287.285978] Subtest cursor-rapid-movement-256x85: SKIP (0.042s)
[287.512174] [076/133] (738s left) gem_unref_active_buffers
[287.757918] [077/133] (737s left) gem_caching (reads)
[287.817848] Subtest reads: SKIP (0.000s)
[287.907250] [078/133] (737s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[287.970612] Starting subtest: invalid-multi-wait-all-unsubmitted
[287.972874] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[288.068003] [079/133] (737s left) gem_exec_create (basic)
[288.141226] Starting subtest: basic
[288.143288] Starting dynamic subtest: smem
[292.025998] Dynamic subtest smem: SUCCESS (3.884s)
[292.029165] Subtest basic: SUCCESS (3.885s)
[292.221256] [080/133] (733s left) kms_content_protection (atomic-dpms-hdcp14)
[292.384526] Starting subtest: atomic-dpms-hdcp14
[292.389165] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[292.562592] [081/133] (733s left) sw_sync (timeline_closed)
[292.594115] Starting subtest: timeline_closed
[292.596463] Subtest timeline_closed: SUCCESS (0.000s)
[292.676720] [082/133] (733s left) perf (oa-exponents)
[292.821674] Starting subtest: oa-exponents
[292.823761] Starting dynamic subtest: 0-rcs0
[294.587322] Dynamic subtest 0-rcs0: SUCCESS (1.766s)
[294.596445] Starting dynamic subtest: 1-vcs0
[296.416443] Dynamic subtest 1-vcs0: SUCCESS (1.829s)
[296.418880] Subtest oa-exponents: SUCCESS (3.597s)
[296.463681] [083/133] (729s left) kms_feature_discovery (display-2x)
[296.571895] Starting subtest: display-2x
[296.576177] Subtest display-2x: SKIP (0.000s)
[296.657922] [084/133] (729s left) core_setmaster (master-drop-set-root)
[296.725815] Starting subtest: master-drop-set-root
[296.739416] Subtest master-drop-set-root: SUCCESS (0.014s)
[296.788809] [085/133] (729s left) kms_pm_rpm (i2c)
[298.301381] Starting subtest: i2c
[303.692238] Subtest i2c: SUCCESS (5.393s)
[303.793479] [086/133] (722s left) kms_busy (basic-hang)
[303.883728] Starting subtest: basic-hang
[303.886046] Starting dynamic subtest: flip-pipe-A
[304.475155] Dynamic subtest flip-pipe-A: SUCCESS (0.590s)
[304.484329] Starting dynamic subtest: modeset-pipe-A
[307.873396] Dynamic subtest modeset-pipe-A: SUCCESS (3.398s)
[307.883032] Starting dynamic subtest: flip-pipe-D
[309.069341] Dynamic subtest flip-pipe-D: SUCCESS (1.195s)
[309.078599] Starting dynamic subtest: modeset-pipe-D
[312.497944] Dynamic subtest modeset-pipe-D: SUCCESS (3.429s)
[312.500301] Subtest basic-hang: SUCCESS (8.619s)
[313.318013] [087/133] (712s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[313.414383] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[313.418255] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[313.537080] [088/133] (712s left) kms_flip (nonblocking-read)
[313.627309] Starting subtest: nonblocking-read
[313.629193] Subtest nonblocking-read: SUCCESS (0.000s)
[313.759330] [089/133] (712s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[313.860430] Starting subtest: yf-tiled-16bpp-rotate-270
[313.864282] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[313.985068] [090/133] (712s left) gem_mmap_wc (write-read-distinct)
[314.044137] Subtest write-read-distinct: SKIP (0.000s)
[314.105866] [091/133] (712s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[314.161013] Starting subtest: multi-wait-for-submit-submitted-signaled
[314.163210] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[314.277709] [092/133] (711s left) kms_flip (blocking-wf_vblank)
[314.360525] Starting subtest: blocking-wf_vblank
[314.362167] Starting dynamic subtest: A-eDP1
[323.250306] Dynamic subtest A-eDP1: SUCCESS (8.892s)
[323.262787] Starting dynamic subtest: B-eDP1
[332.175173] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[332.184184] Starting dynamic subtest: C-eDP1
[341.097605] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[341.112167] Starting dynamic subtest: D-eDP1
[350.030888] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[350.033264] Subtest blocking-wf_vblank: SUCCESS (35.672s)
[351.265022] [093/133] (674s left) gem_exec_alignment (pi)
[351.330838] Starting subtest: pi
[401.410320] Subtest pi: SUCCESS (50.074s)
[402.651662] [094/133] (623s left) kms_getfb (getfb-repeated-different-handles)
[402.790734] Starting subtest: getfb-repeated-different-handles
[402.792838] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[402.920514] [095/133] (623s left) syncobj_timeline (etime-multi-wait-submitted)
[402.996305] Starting subtest: etime-multi-wait-submitted
[403.101325] Subtest etime-multi-wait-submitted: SUCCESS (0.107s)
[403.201310] [096/133] (623s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[403.322183] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[404.328448] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.005s)
[405.202007] [097/133] (621s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[405.294844] Starting subtest: primary-yf-tiled-reflect-x-0
[405.357131] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[405.474145] [098/133] (620s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[405.547295] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[405.636256] [099/133] (620s left) perf_pmu (rc6)
[405.679757] Starting subtest: rc6
[405.681722] Starting dynamic subtest: gt0
[412.042182] Dynamic subtest gt0: SUCCESS (6.364s)
[412.054887] Starting dynamic subtest: runtime-pm-gt0
[419.821550] Dynamic subtest runtime-pm-gt0: SUCCESS (7.778s)
[419.833978] Starting dynamic subtest: runtime-pm-long-gt0
[432.244205] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.421s)
[432.255937] Starting dynamic subtest: other-idle-gt0
[438.586768] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[438.597687] Starting dynamic subtest: gt1
[444.927407] Dynamic subtest gt1: SUCCESS (6.339s)
[444.939279] Starting dynamic subtest: runtime-pm-gt1
[452.404042] Dynamic subtest runtime-pm-gt1: SUCCESS (7.475s)
[452.416263] Starting dynamic subtest: runtime-pm-long-gt1
[464.839700] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.435s)
[464.849190] Starting dynamic subtest: other-idle-gt1
[471.181394] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[471.184047] Subtest rc6: SUCCESS (65.511s)
[472.328525] [100/133] (554s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[472.433937] Starting subtest: y-tiled-16bpp-rotate-0
[472.438264] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[472.499200] [101/133] (554s left) kms_flip_tiling (flip-change-tiling)
[472.596413] Starting subtest: flip-change-tiling
[472.598174] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[472.759414] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.164s)
[472.775158] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[472.905760] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.143s)
[472.917691] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[473.039130] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[473.050589] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[473.236894] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.196s)
[473.248765] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[473.379900] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[473.392826] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[473.513164] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.131s)
[473.527472] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[473.646892] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[473.658375] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[473.758196] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[473.769843] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[473.892917] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[473.904044] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[474.036503] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[474.051199] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[474.179837] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[474.192251] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[474.324165] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[474.338999] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[474.458316] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[474.470948] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[474.592799] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[474.605322] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[474.702915] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[474.713247] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[474.846936] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[474.858693] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[474.991141] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[475.002705] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[475.124141] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.131s)
[475.138484] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[475.257851] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[475.269771] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[475.391829] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s)
[475.404159] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[475.536015] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[475.548228] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[475.657431] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[475.669143] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[475.802557] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.143s)
[475.813742] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[475.969398] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.164s)
[475.980994] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[476.113646] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[476.128345] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[476.284802] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.168s)
[476.298917] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[476.429019] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.143s)
[476.444381] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[476.573646] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[476.588653] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[476.696185] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[476.707676] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[476.840640] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[476.851560] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[476.984590] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[476.996597] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[477.117657] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.131s)
[477.129249] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[477.262930] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[477.274634] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[477.406606] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[477.420537] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[477.562455] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.153s)
[477.575141] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[477.684950] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[477.737758] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[478.925334] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.194s)
[478.937398] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[479.059585] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[479.072417] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[479.192439] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[479.205317] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[479.335987] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[479.348295] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[479.479905] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[479.491715] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[479.624498] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[479.635857] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[479.758480] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[479.769705] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[479.869184] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[479.880156] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[480.003527] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[480.016320] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[480.147287] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[480.167827] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[480.290809] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[480.303123] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[480.435339] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[480.447913] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[480.569417] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[480.581948] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[480.703574] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[480.715577] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[480.813720] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[480.824502] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[480.958152] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[480.970744] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[481.090681] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.131s)
[481.101890] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[481.224155] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.131s)
[481.235358] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[481.357542] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[481.369793] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[481.502303] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[481.514921] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[481.635874] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.131s)
[481.648700] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[481.757715] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[481.769464] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[481.901436] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[481.915143] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[482.073093] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.169s)
[482.087643] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[482.217880] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[482.232389] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[482.362274] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[482.376182] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[482.506610] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[482.519126] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[482.651161] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[482.663152] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[482.773769] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[482.785663] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[482.929424] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.153s)
[482.941762] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[483.072880] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[483.087490] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[483.206229] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.131s)
[483.221172] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[483.350898] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[483.365253] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[483.495154] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[483.509141] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[483.640466] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[483.652801] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[483.762619] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[483.814963] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[485.068734] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.260s)
[485.081506] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[485.219405] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.147s)
[485.230894] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[485.318380] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[485.330739] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[485.418216] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.099s)
[485.430276] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[485.529272] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[485.544459] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[485.650824] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.120s)
[485.662907] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[485.751663] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[485.764691] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[485.851437] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[485.862093] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[485.962017] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[485.977447] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[486.073634] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.108s)
[486.089034] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[486.194962] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.120s)
[486.207634] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[486.316817] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.120s)
[486.328583] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[486.417785] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[486.430135] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[486.517640] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[486.529789] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[486.617155] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[486.629133] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[486.728697] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[486.740640] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[486.838978] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[486.850848] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[486.961160] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.121s)
[486.972492] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[487.061828] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[487.073637] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[487.161960] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[487.174013] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[487.273154] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[487.285780] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[487.384077] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[487.396345] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[487.494324] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.110s)
[487.506008] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[487.605635] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[487.617366] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[487.716580] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[487.728405] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[487.827823] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[487.837400] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[487.927900] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[487.941488] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[488.039261] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[488.049773] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[488.150178] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[488.162133] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[488.261739] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[488.274577] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[488.372487] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[488.384231] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[488.472056] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.098s)
[488.484022] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[488.583785] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[488.597888] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[488.746352] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.160s)
[488.760588] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[488.858149] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[488.870475] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[488.969396] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[489.018317] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[490.209677] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.204s)
[490.221350] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[490.309674] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[490.325633] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[490.409454] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[490.422327] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[490.520802] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[490.533200] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[490.631259] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[490.645446] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[490.742411] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.108s)
[490.754661] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[490.842965] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[490.854871] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[490.942422] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[490.954328] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[491.042352] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[491.053505] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[491.153196] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[491.164750] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[491.264191] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[491.276219] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[491.375180] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[491.385416] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[491.475496] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[491.485435] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[491.575467] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[491.585894] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[491.675546] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[491.685523] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[491.786516] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[491.796944] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[491.897444] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[491.908481] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[492.008814] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[492.024969] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[492.119502] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[492.134170] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[492.231446] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[492.243482] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[492.331086] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[492.343335] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[492.442027] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[492.453817] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[492.552930] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[492.564575] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[492.663956] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s)
[492.675239] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[492.763948] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.098s)
[492.775773] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[492.863971] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[492.875617] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[492.974810] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[492.986176] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[493.086123] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[493.098051] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[493.197622] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[493.212895] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[493.308368] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[493.320213] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[493.408234] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s)
[493.419658] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[493.508294] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.099s)
[493.520767] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[493.619293] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[493.633359] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[493.730310] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[493.744722] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[493.841543] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[493.853441] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[493.953325] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[493.985891] Subtest flip-change-tiling: SUCCESS (21.394s)
[495.174985] [102/133] (531s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[495.280591] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[495.284590] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[495.373209] [103/133] (531s left) gem_exec_fence (submit-chain)
[495.562053] Starting subtest: submit-chain
[495.579611] Subtest submit-chain: SUCCESS (0.018s)
[497.112520] [104/133] (529s left) gem_ringfill (engines-basic)
[503.038333] Starting subtest: engines-basic
[503.040832] Starting dynamic subtest: rcs0
[503.123129] Dynamic subtest rcs0: SUCCESS (0.085s)
[503.135754] Starting dynamic subtest: bcs0
[503.167784] Dynamic subtest bcs0: SUCCESS (0.043s)
[503.178540] Starting dynamic subtest: vcs0
[503.211169] Dynamic subtest vcs0: SUCCESS (0.042s)
[503.221708] Starting dynamic subtest: vcs1
[503.254995] Dynamic subtest vcs1: SUCCESS (0.042s)
[503.266141] Starting dynamic subtest: vecs0
[503.296721] Dynamic subtest vecs0: SUCCESS (0.040s)
[503.307558] Starting dynamic subtest: ccs0
[503.342841] Dynamic subtest ccs0: SUCCESS (0.044s)
[503.345205] Subtest engines-basic: SUCCESS (0.307s)
[503.399309] [105/133] (523s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[503.506681] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[503.508916] Starting dynamic subtest: pipe-A-eDP-1
[503.528261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[503.538155] Starting dynamic subtest: pipe-B-eDP-1
[503.556247] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[503.564722] Starting dynamic subtest: pipe-C-eDP-1
[503.583490] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[503.592192] Starting dynamic subtest: pipe-D-eDP-1
[503.611001] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[503.612832] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[505.723760] [106/133] (521s left) perf_pmu (busy-check-all)
[505.761595] Starting subtest: busy-check-all
[505.763569] Starting dynamic subtest: rcs0
[506.332054] Dynamic subtest rcs0: SUCCESS (0.571s)
[506.344947] Starting dynamic subtest: bcs0
[506.881820] Dynamic subtest bcs0: SUCCESS (0.548s)
[506.894485] Starting dynamic subtest: vcs0
[508.025728] Dynamic subtest vcs0: SUCCESS (1.140s)
[508.038284] Starting dynamic subtest: vcs1
[510.073973] Dynamic subtest vcs1: SUCCESS (2.045s)
[510.087178] Starting dynamic subtest: vecs0
[512.057990] Dynamic subtest vecs0: SUCCESS (1.981s)
[512.071139] Starting dynamic subtest: ccs0
[512.613421] Dynamic subtest ccs0: SUCCESS (0.554s)
[512.615939] Subtest busy-check-all: SUCCESS (6.855s)
[512.706867] [107/133] (514s left) gem_exec_schedule (submit-early-slice)
[512.786389] Starting subtest: submit-early-slice
[512.788751] Starting dynamic subtest: rcs0
[512.841067] Dynamic subtest rcs0: SUCCESS (0.060s)
[512.855292] Starting dynamic subtest: bcs0
[512.890842] Dynamic subtest bcs0: SUCCESS (0.048s)
[512.903866] Starting dynamic subtest: vcs0
[512.945657] Dynamic subtest vcs0: SUCCESS (0.055s)
[512.958890] Starting dynamic subtest: vcs1
[512.988310] Dynamic subtest vcs1: SUCCESS (0.042s)
[513.000346] Starting dynamic subtest: vecs0
[513.036811] Dynamic subtest vecs0: SUCCESS (0.048s)
[513.054400] Starting dynamic subtest: ccs0
[513.087278] Dynamic subtest ccs0: SUCCESS (0.050s)
[513.089638] Subtest submit-early-slice: SUCCESS (0.308s)
[514.135202] [108/133] (512s left) gem_exec_balancer (parallel-bb-first)
[514.393885] Starting subtest: parallel-bb-first
[515.275305] Subtest parallel-bb-first: SUCCESS (0.881s)
[516.042868] [109/133] (510s left) gen9_exec_parse (bb-large)
[516.123411] Subtest bb-large: SKIP (0.000s)
[516.236728] [110/133] (510s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[516.341963] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[516.344160] Starting dynamic subtest: pipe-A-eDP-1
[516.400377] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[516.409580] Starting dynamic subtest: pipe-B-eDP-1
[516.467716] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[516.478870] Starting dynamic subtest: pipe-C-eDP-1
[516.535732] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[516.546386] Starting dynamic subtest: pipe-D-eDP-1
[516.604211] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[516.608294] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[518.577979] [111/133] (508s left) api_intel_bb (simple-bb-ctx)
[518.649752] Starting subtest: simple-bb-ctx
[518.658222] Subtest simple-bb-ctx: SUCCESS (0.008s)
[518.776479] [112/133] (508s left) gem_ctx_isolation (preservation-s3)
[518.832200] Starting subtest: preservation-S3
[518.834587] Starting dynamic subtest: rcs0
[535.032384] Dynamic subtest rcs0: SUCCESS (1.304s)
[535.043644] Starting dynamic subtest: bcs0
[551.040870] Dynamic subtest bcs0: SUCCESS (1.330s)
[551.052568] Starting dynamic subtest: vcs0
[567.047159] Dynamic subtest vcs0: SUCCESS (2.602s)
[567.057146] Starting dynamic subtest: vcs1
[585.029340] Dynamic subtest vcs1: SUCCESS (5.173s)
[585.040294] Starting dynamic subtest: vecs0
[603.026297] Dynamic subtest vecs0: SUCCESS (5.112s)
[603.036138] Starting dynamic subtest: ccs0
[621.032670] Dynamic subtest ccs0: SUCCESS (3.248s)
[621.034976] Subtest preservation-S3: SUCCESS (18.775s)
[621.251078] [113/133] (405s left) sriov_basic (enable-vfs-autoprobe-on)
[621.319000] Starting subtest: enable-vfs-autoprobe-on
[621.321676] Starting dynamic subtest: numvfs-1
[621.409489] Dynamic subtest numvfs-1: FAIL (0.029s)
[621.418866] Starting dynamic subtest: numvfs-2
[621.498970] Dynamic subtest numvfs-2: FAIL (0.004s)
[621.509205] Starting dynamic subtest: numvfs-3
[621.593713] Dynamic subtest numvfs-3: FAIL (0.004s)
[621.602962] Starting dynamic subtest: numvfs-4
[621.686883] Dynamic subtest numvfs-4: FAIL (0.008s)
[621.697720] Starting dynamic subtest: numvfs-5
[621.779373] Dynamic subtest numvfs-5: FAIL (0.004s)
[621.790415] Starting dynamic subtest: numvfs-6
[621.872464] Dynamic subtest numvfs-6: FAIL (0.004s)
[621.882556] Starting dynamic subtest: numvfs-7
[621.964594] Dynamic subtest numvfs-7: FAIL (0.004s)
[621.975015] Starting dynamic subtest: numvfs-random
[622.045200] Dynamic subtest numvfs-random: FAIL (0.003s)
[622.055227] Starting dynamic subtest: numvfs-all
[622.122290] Dynamic subtest numvfs-all: FAIL (0.589s)
[622.124348] Subtest enable-vfs-autoprobe-on: FAIL (0.656s)
[622.166903] [114/133] (404s left) perf_pmu (gt-awake)
[622.215978] Starting subtest: gt-awake
[630.849901] Subtest gt-awake: SUCCESS (8.799s)
[630.941238] [115/133] (396s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[631.098107] Subtest no-spare-fences-busy: SKIP (0.000s)
[631.181091] [116/133] (396s left) kms_rotation_crc (primary-rotation-90)
[631.286973] Starting subtest: primary-rotation-90
[631.292501] Subtest primary-rotation-90: SKIP (0.001s)
[631.336949] [117/133] (395s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[631.437121] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[632.231696] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.803s)
[632.371525] [118/133] (394s left) gem_mmap_wc (write-prefaulted)
[632.448961] Subtest write-prefaulted: SKIP (0.000s)
[632.522053] [119/133] (394s left) gem_pxp (reject-modify-context-protection-off-1)
[632.648608] Starting subtest: reject-modify-context-protection-off-1
[632.651353] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[632.733698] [120/133] (394s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[632.834309] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[632.836171] Starting dynamic subtest: pipe-A-eDP-1
[632.858393] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[632.869895] Starting dynamic subtest: pipe-B-eDP-1
[632.892979] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[632.903079] Starting dynamic subtest: pipe-C-eDP-1
[632.926536] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[632.936681] Starting dynamic subtest: pipe-D-eDP-1
[632.958654] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[632.960752] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[635.069792] [121/133] (392s left) kms_plane_lowres (tiling-x)
[635.163320] Starting subtest: tiling-x
[635.165680] Starting dynamic subtest: pipe-A-eDP-1
[635.170459] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[635.461829] Starting dynamic subtest: pipe-B-eDP-1
[635.466487] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[635.476188] Starting dynamic subtest: pipe-C-eDP-1
[635.481657] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[635.492843] Starting dynamic subtest: pipe-D-eDP-1
[635.497808] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[635.502688] Subtest tiling-x: SKIP (0.299s)
[636.272834] [122/133] (391s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[636.371717] Starting subtest: multiplane-rotation-cropping-top
[653.905482] Subtest multiplane-rotation-cropping-top: SUCCESS (17.571s)
[654.022201] [123/133] (373s left) gem_mmap_gtt (basic-write-read-distinct)
[654.094011] Subtest basic-write-read-distinct: SKIP (0.000s)
[654.166835] [124/133] (373s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[654.262789] Starting subtest: fbc-psr2-sprite-mmap-gtt
[654.264977] Starting dynamic subtest: eDP-1
[654.269147] Dynamic subtest eDP-1: SKIP (0.000s)
[654.272535] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[654.308582] [125/133] (373s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[654.410748] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[654.415310] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[654.454320] [126/133] (373s left) gem_tiled_partial_pwrite_pread (writes)
[654.522855] Subtest writes: SKIP (0.000s)
[654.609712] [127/133] (373s left) kms_atomic (crtc-invalid-params-fence)
[654.708648] Starting subtest: crtc-invalid-params-fence
[654.710524] Starting dynamic subtest: pipe-A-eDP-1
[655.111287] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.403s)
[655.113873] Subtest crtc-invalid-params-fence: SUCCESS (0.404s)
[655.967070] [128/133] (371s left) gem_busy (parallel)
[656.161990] Starting subtest: parallel
[656.164858] Starting dynamic subtest: rcs0
[657.856296] Dynamic subtest rcs0: SUCCESS (1.692s)
[657.868618] Starting dynamic subtest: bcs0
[659.840964] Dynamic subtest bcs0: SUCCESS (1.980s)
[659.853816] Starting dynamic subtest: vcs0
[661.824499] Dynamic subtest vcs0: SUCCESS (1.980s)
[661.836732] Starting dynamic subtest: vcs1
[663.809446] Dynamic subtest vcs1: SUCCESS (1.981s)
[663.821960] Starting dynamic subtest: vecs0
[665.856690] Dynamic subtest vecs0: SUCCESS (2.044s)
[665.868692] Starting dynamic subtest: ccs0
[667.864560] Dynamic subtest ccs0: SUCCESS (1.980s)
[667.868954] Subtest parallel: SUCCESS (11.673s)
[668.079647] [129/133] (359s left) gem_ctx_persistence (processes)
[668.145706] Starting subtest: processes
[669.793157] Subtest processes: SUCCESS (1.647s)
[669.855394] [130/133] (357s left) kms_big_fb (4-tiled-addfb-size-overflow)
[669.951665] Starting subtest: 4-tiled-addfb-size-overflow
[669.954179] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[670.027109] [131/133] (357s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[670.132689] Starting subtest: x-tiled-64bpp-rotate-270
[670.155817] Subtest x-tiled-64bpp-rotate-270: SKIP (0.022s)
[670.283735] [132/133] (357s left) kms_plane_scaling (planes-scaler-unity-scaling)
[670.378545] Starting subtest: planes-scaler-unity-scaling
[670.380771] Starting dynamic subtest: pipe-A
[670.441983] Dynamic subtest pipe-A: SUCCESS (0.065s)
[670.455624] Starting dynamic subtest: pipe-B
[671.611998] Dynamic subtest pipe-B: SUCCESS (1.168s)
[671.624279] Starting dynamic subtest: pipe-C
[672.719886] Dynamic subtest pipe-C: SUCCESS (1.107s)
[672.730996] Starting dynamic subtest: pipe-D
[673.848353] Dynamic subtest pipe-D: SUCCESS (1.128s)
[673.850904] Subtest planes-scaler-unity-scaling: SUCCESS (3.472s)
[674.994755] [133/133] (352s left) gem_exec_whisper (basic-contexts)
[675.061881] Starting subtest: basic-contexts
[680.904992] Subtest basic-contexts: SUCCESS (5.845s)
[681.069702] Closing watchdogs
results: parsing output: 0/ for test: api_intel_allocator
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_pipe_crc_basic
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: testdisplay
results: parsing output: 11/ for test: prime_mmap
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: gem_softpin
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_lease
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_vblank
results: parsing output: 26/ for test: gem_wait
results: parsing output: 27/ for test: kms_properties
results: parsing output: 28/ for test: gem_exec_flush
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_chamelium_edid
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_pm_dc
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_color_pipeline
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_mmap_offset
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_close_race
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: i915_module_load
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: gen9_exec_parse
results: parsing output: 48/ for test: kms_cursor_edge_walk
results: parsing output: 49/ for test: gem_render_copy_redux
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: gem_fenced_exec_thrash
results: parsing output: 55/ for test: kms_hdr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_lmem_swapping
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_chamelium_hpd
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: i915_pm_rpm
results: parsing output: 63/ for test: gem_exec_whisper
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: i915_query
results: parsing output: 66/ for test: kms_vrr
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_prop_blob
results: parsing output: 70/ for test: kms_properties
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: gem_unref_active_buffers
results: parsing output: 76/ for test: gem_caching
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: gem_exec_create
results: parsing output: 79/ for test: kms_content_protection
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: kms_feature_discovery
results: parsing output: 83/ for test: core_setmaster
results: parsing output: 84/ for test: kms_pm_rpm
results: parsing output: 85/ for test: kms_busy
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_mmap_wc
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_exec_alignment
results: parsing output: 93/ for test: kms_getfb
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_flip_tiling
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: gem_ringfill
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: gem_ctx_isolation
results: parsing output: 112/ for test: sriov_basic
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: gem_fenced_exec_thrash
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_mmap_wc
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_plane_lowres
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 126/ for test: kms_atomic
results: parsing output: 127/ for test: gem_busy
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: gem_exec_whisper
Done.