[58.015172] Initializing watchdogs
[58.015286]   /dev/watchdog0
[58.030378] [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.034760] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.036985] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.040207] [001/133] (960s left) api_intel_allocator (gem-pool)
[58.104884] Starting subtest: gem-pool
[58.111753] Subtest gem-pool: SUCCESS (0.010s)
[58.212403] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[58.328518] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[58.332872] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[58.434372] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[58.528677] Starting subtest: read-crc-frame-sequence
[58.531169] Starting dynamic subtest: pipe-A-eDP-1
[59.258438] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.729s)
[59.265204] Starting dynamic subtest: pipe-B-eDP-1
[60.658642] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.404s)
[60.666988] Starting dynamic subtest: pipe-C-eDP-1
[61.956305] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.301s)
[61.963090] Starting dynamic subtest: pipe-D-eDP-1
[63.282064] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[63.284250] Subtest read-crc-frame-sequence: SUCCESS (4.765s)
[64.128919] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[64.192032] Starting subtest: invalid-query-one-illegal-handle
[64.194448] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[64.306831] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[64.348792] Starting subtest: invalid-signal-zero-handles
[64.351087] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[64.469929] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[64.580402] Starting subtest: fbcpsr-rgb565-draw-render
[72.287822] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.719s)
[72.467563] [007/133] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[72.544107] Starting subtest: wait-for-submit-snapshot
[72.625130] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[72.717177] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[72.827142] Starting subtest: psr-rgb565-draw-blt
[79.877845] Subtest psr-rgb565-draw-blt: SUCCESS (7.063s)
[80.044827] [009/133] (938s left) kms_cursor_crc (cursor-onscreen-32x10)
[80.207210] Starting subtest: cursor-onscreen-32x10
[80.253126] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[80.526535] [010/133] (938s left) syncobj_wait (invalid-signal-illegal-handle)
[80.597381] Starting subtest: invalid-signal-illegal-handle
[80.599746] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[80.722449] [011/133] (938s left) testdisplay
[81.050128] [012/133] (937s left) prime_mmap (test_map_unmap)
[81.103098] Starting subtest: test_map_unmap
[81.104777] Starting dynamic subtest: test_map_unmap-smem
[81.134229] Dynamic subtest test_map_unmap-smem: SUCCESS (0.032s)
[81.136397] Subtest test_map_unmap: SUCCESS (0.033s)
[81.242954] [013/133] (937s left) gem_exec_fence (syncobj-timeline-signal)
[81.785643] Starting subtest: syncobj-timeline-signal
[81.792251] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[82.973506] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[82.976561] [014/133] (936s left) syncobj_timeline (signal-point-0)
[83.037220] Starting subtest: signal-point-0
[83.039534] Subtest signal-point-0: SUCCESS (0.000s)
[83.155678] [015/133] (935s left) kms_psr (psr2-suspend)
[83.252050] Starting subtest: psr2-suspend
[83.254392] Starting dynamic subtest: eDP-1
[101.771262] Dynamic subtest eDP-1: SUCCESS (3.117s)
[101.773648] Subtest psr2-suspend: SUCCESS (3.118s)
[102.660301] [016/133] (916s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[102.791301] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[102.804259] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[102.874873] [017/133] (916s left) gem_softpin (reverse)
[102.930673] Starting subtest: reverse
[102.937272] Subtest reverse: SUCCESS (0.007s)
[103.070946] [018/133] (916s left) gem_exec_balancer (parallel-contexts)
[103.321410] Starting subtest: parallel-contexts
[105.803122] Subtest parallel-contexts: SUCCESS (2.517s)
[105.923194] [019/133] (913s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[106.020593] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[106.022732] Starting dynamic subtest: pipe-A-eDP-1
[108.169370] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.171s)
[108.181366] Starting dynamic subtest: pipe-B-eDP-1
[110.454355] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.301s)
[110.462254] Starting dynamic subtest: pipe-C-eDP-1
[112.567259] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.123s)
[112.576146] Starting dynamic subtest: pipe-D-eDP-1
[114.679371] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.120s)
[114.681347] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.719s)
[115.882908] [020/133] (903s left) kms_lease (lease-unleased-connector)
[115.986366] Starting subtest: lease-unleased-connector
[115.988649] Starting dynamic subtest: pipe-A-eDP-1
[115.993924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[116.005300] Starting dynamic subtest: pipe-B-eDP-1
[116.007592] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[116.016390] Starting dynamic subtest: pipe-C-eDP-1
[116.018828] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[116.027856] Starting dynamic subtest: pipe-D-eDP-1
[116.029772] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[116.031774] Subtest lease-unleased-connector: SUCCESS (0.036s)
[116.159824] [021/133] (903s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[116.277987] Starting subtest: cursor-vs-flip-atomic-transitions
[146.233554] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.981s)
[147.082063] [022/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[147.184128] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[147.186282] Starting dynamic subtest: pipe-A-default-mode
[149.909172] Dynamic subtest pipe-A-default-mode: SUCCESS (2.727s)
[149.911597] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.728s)
[150.761433] [023/133] (868s left) kms_addfb_basic (legacy-format)
[150.822010] Starting subtest: legacy-format
[150.838794] Subtest legacy-format: SUCCESS (0.017s)
[151.004101] [024/133] (868s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[151.100908] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[151.105432] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[151.227119] [025/133] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[151.324205] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[151.327993] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[151.475884] [026/133] (868s left) kms_vblank (query-busy)
[151.567175] Starting subtest: query-busy
[151.569025] Starting dynamic subtest: pipe-A-eDP-1
[153.464054] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.896s)
[153.479027] Starting dynamic subtest: pipe-D-eDP-1
[156.013909] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[156.016219] Subtest query-busy: SUCCESS (4.449s)
[156.837984] [027/133] (862s left) gem_wait (invalid-flags)
[156.907800] Starting subtest: invalid-flags
[156.910222] Subtest invalid-flags: SUCCESS (0.000s)
[157.162574] [028/133] (862s left) kms_properties (invalid-properties-atomic)
[157.265187] Starting subtest: invalid-properties-atomic
[157.572756] Subtest invalid-properties-atomic: SUCCESS (0.308s)
[157.682373] [029/133] (861s left) gem_exec_flush (basic-wb-ro-before-default)
[157.744500] Starting subtest: basic-wb-ro-before-default
[163.195801] Subtest basic-wb-ro-before-default: SUCCESS (5.454s)
[163.392861] [030/133] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[163.501722] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[163.506168] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[163.640824] [031/133] (856s left) kms_psr (pr-primary-blt)
[163.733564] Starting subtest: pr-primary-blt
[163.738139] Subtest pr-primary-blt: SKIP (0.000s)
[163.823179] [032/133] (855s left) kms_flip (2x-flip-vs-dpms-on-nop)
[163.921449] Starting subtest: 2x-flip-vs-dpms-on-nop
[163.930714] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[164.022237] [033/133] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[164.116467] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[164.120604] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[164.224677] [034/133] (855s left) kms_chamelium_edid (dp-mode-timings)
[164.604696] Subtest dp-mode-timings: SKIP (0.000s)
[165.421363] [035/133] (854s left) kms_flip (flip-vs-panning-interruptible)
[165.520768] Starting subtest: flip-vs-panning-interruptible
[165.523165] Starting dynamic subtest: A-eDP1
[174.251143] Dynamic subtest A-eDP1: SUCCESS (8.734s)
[174.260478] Starting dynamic subtest: B-eDP1
[182.978069] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[182.987573] Starting dynamic subtest: C-eDP1
[191.693940] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[191.703409] Starting dynamic subtest: D-eDP1
[200.340144] Dynamic subtest D-eDP1: SUCCESS (8.644s)
[200.344227] Subtest flip-vs-panning-interruptible: SUCCESS (34.834s)
[201.603040] [036/133] (818s left) kms_pm_dc (dc5-psr)
[202.711138] Starting subtest: dc5-psr
[205.601186] Subtest dc5-psr: SUCCESS (2.888s)
[206.447137] [037/133] (813s left) gem_userptr_blits (process-exit)
[206.524348] Starting subtest: process-exit
[206.533100] Subtest process-exit: SUCCESS (0.009s)
[206.694101] [038/133] (813s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[206.796930] Starting subtest: plane-lut1d-post-ctm3x4
[206.809597] Starting dynamic subtest: pipe-A-eDP-1
[207.517167] Dynamic subtest pipe-A-eDP-1: FAIL (0.348s)
[208.219838] Starting dynamic subtest: pipe-B-eDP-1
[209.011196] Dynamic subtest pipe-B-eDP-1: FAIL (0.279s)
[209.561310] Starting dynamic subtest: pipe-C-eDP-1
[210.378323] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[210.893029] Starting dynamic subtest: pipe-D-eDP-1
[211.698056] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[211.700432] Subtest plane-lut1d-post-ctm3x4: FAIL (4.621s)
[212.279598] [039/133] (807s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[212.347656] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[212.453377] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[212.543731] [040/133] (807s left) gem_mmap_offset (partial-remap)
[212.611245] Starting subtest: partial-remap
[212.613544] Starting dynamic subtest: smem0
[212.622198] Dynamic subtest smem0: SUCCESS (0.003s)
[212.624148] Subtest partial-remap: SUCCESS (0.004s)
[212.721483] [041/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[212.828624] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[212.832719] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[212.956136] [042/133] (807s left) gem_userptr_blits (dmabuf-unsync)
[213.014975] Subtest dmabuf-unsync: SKIP (0.000s)
[213.170347] [043/133] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[213.274776] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[213.278855] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[213.399462] [044/133] (806s left) gem_close_race (multigpu-basic-threads)
[213.472764] Starting subtest: multigpu-basic-threads
[213.476324] Subtest multigpu-basic-threads: SKIP (0.000s)
[213.727062] [045/133] (806s left) gem_exec_schedule (preempt)
[213.809737] Starting subtest: preempt
[213.811751] Starting dynamic subtest: rcs0
[213.826453] Dynamic subtest rcs0: SUCCESS (0.026s)
[213.837128] Starting dynamic subtest: bcs0
[213.844123] Dynamic subtest bcs0: SUCCESS (0.017s)
[213.852226] Starting dynamic subtest: vcs0
[213.867295] Dynamic subtest vcs0: SUCCESS (0.023s)
[213.875491] Starting dynamic subtest: vcs1
[213.888085] Dynamic subtest vcs1: SUCCESS (0.020s)
[213.898581] Starting dynamic subtest: vecs0
[213.908524] Dynamic subtest vecs0: SUCCESS (0.020s)
[213.916843] Starting dynamic subtest: ccs0
[213.931148] Dynamic subtest ccs0: SUCCESS (0.022s)
[213.933364] Subtest preempt: SUCCESS (0.131s)
[215.401074] [046/133] (804s left) i915_module_load (reload)
[215.437456] Starting subtest: reload
[220.529755] Subtest reload: SUCCESS (5.093s)
[220.568868] [047/133] (799s left) gem_exec_reloc (basic-wc-cpu-active)
[222.319288] Subtest basic-wc-cpu-active: SKIP (0.000s)
[222.439674] [048/133] (798s left) gen9_exec_parse (valid-registers)
[222.506293] Subtest valid-registers: SKIP (0.000s)
[222.592742] [049/133] (797s left) kms_cursor_edge_walk (64x64-left-edge)
[222.703199] Starting subtest: 64x64-left-edge
[222.705369] Starting dynamic subtest: pipe-A-eDP-1
[226.132843] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s)
[226.141499] Starting dynamic subtest: pipe-D-eDP-1
[229.264943] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[229.267279] Subtest 64x64-left-edge: SUCCESS (6.562s)
[230.081179] [050/133] (790s left) gem_render_copy_redux (flink)
[230.143517] Starting subtest: flink
[230.845079] Subtest flink: SUCCESS (0.702s)
[231.014408] [051/133] (789s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[231.118230] Starting subtest: psr-2p-primscrn-spr-indfb-move
[231.121573] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[231.252912] [052/133] (789s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[231.348608] Starting subtest: bo-too-small-due-to-tiling
[231.352322] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[231.477011] [053/133] (789s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[231.583385] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[238.176052] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.594s)
[238.314441] [054/133] (782s left) gem_exec_reloc (basic-write-wc-active)
[238.381225] Subtest basic-write-wc-active: SKIP (0.000s)
[238.469497] [055/133] (782s left) gem_fenced_exec_thrash (2-spare-fences)
[238.525194] Subtest 2-spare-fences: SKIP (0.000s)
[238.614113] [056/133] (782s left) kms_hdr (static-toggle-dpms)
[238.719567] Starting subtest: static-toggle-dpms
[238.726143] Subtest static-toggle-dpms: SKIP (0.000s)
[238.805358] [057/133] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[238.918309] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[245.971873] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.058s)
[246.128082] [058/133] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[246.242249] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[249.980640] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.742s)
[251.172054] [059/133] (769s left) gem_lmem_swapping (parallel-random-verify)
[251.224950] Subtest parallel-random-verify: SKIP (0.000s)
[251.272501] [060/133] (769s left) kms_psr (fbc-pr-sprite-plane-move)
[251.393311] Starting subtest: fbc-pr-sprite-plane-move
[251.397792] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[251.483049] [061/133] (769s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[251.866808] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[252.638288] [062/133] (768s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[252.742543] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[252.744736] Starting dynamic subtest: pipe-A-eDP-1
[252.769609] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[252.783034] Starting dynamic subtest: pipe-B-eDP-1
[252.806005] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[252.814151] Starting dynamic subtest: pipe-C-eDP-1
[252.836888] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[252.844543] Starting dynamic subtest: pipe-D-eDP-1
[252.867607] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[252.871673] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[255.016872] [063/133] (766s left) i915_pm_rpm (gem-evict-pwrite)
[256.566612] Starting subtest: gem-evict-pwrite
[256.571300] Subtest gem-evict-pwrite: SKIP (0.000s)
[257.357028] [064/133] (763s left) gem_exec_whisper (basic-sync)
[257.425604] Starting subtest: basic-sync
[264.118516] Subtest basic-sync: SUCCESS (6.693s)
[264.313157] [065/133] (756s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[264.444540] Starting subtest: short-busy-flip-before-cursor-toggle
[264.449058] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[264.613345] [066/133] (756s left) i915_query (hwconfig_table)
[264.682262] Starting subtest: hwconfig_table
[264.979571] Subtest hwconfig_table: SUCCESS (0.001s)
[265.020967] [067/133] (756s left) kms_vrr (flipline)
[265.123503] Starting subtest: flipline
[265.129714] Subtest flipline: SKIP (0.000s)
[265.220989] [068/133] (756s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[265.333557] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[269.599706] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.270s)
[270.770189] [069/133] (750s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[270.877362] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[270.890690] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[270.976231] [070/133] (750s left) kms_prop_blob (invalid-set-prop)
[271.035133] Starting subtest: invalid-set-prop
[271.037503] Subtest invalid-set-prop: SUCCESS (0.000s)
[271.170900] [071/133] (750s left) kms_properties (crtc-properties-legacy)
[271.267228] Starting subtest: crtc-properties-legacy
[271.269443] Starting dynamic subtest: pipe-A-eDP-1
[271.707640] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[271.720449] Starting dynamic subtest: pipe-B-eDP-1
[272.895709] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.189s)
[272.905871] Starting dynamic subtest: pipe-C-eDP-1
[274.022991] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[274.031878] Starting dynamic subtest: pipe-D-eDP-1
[275.154646] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[275.156748] Subtest crtc-properties-legacy: SUCCESS (3.889s)
[275.968665] [072/133] (745s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[276.069506] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[283.030288] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.963s)
[283.212694] [073/133] (738s left) kms_psr (fbc-pr-cursor-render)
[283.322004] Starting subtest: fbc-pr-cursor-render
[283.326464] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[283.403982] [074/133] (738s left) gem_userptr_blits (huge-split)
[283.492145] Starting subtest: huge-split
[283.500699] Subtest huge-split: SUCCESS (0.009s)
[283.659505] [075/133] (737s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[283.920827] Starting subtest: cursor-rapid-movement-256x85
[283.969726] Subtest cursor-rapid-movement-256x85: SKIP (0.043s)
[284.171229] [076/133] (737s left) gem_unref_active_buffers
[284.417675] [077/133] (737s left) gem_caching (reads)
[284.480512] Subtest reads: SKIP (0.000s)
[284.580637] [078/133] (737s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[284.641595] Starting subtest: invalid-multi-wait-all-unsubmitted
[284.643630] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[284.765759] [079/133] (737s left) gem_exec_create (basic)
[284.830546] Starting subtest: basic
[284.832531] Starting dynamic subtest: smem
[288.257470] Dynamic subtest smem: SUCCESS (3.425s)
[288.260154] Subtest basic: SUCCESS (3.427s)
[288.469166] [080/133] (733s left) kms_content_protection (atomic-dpms-hdcp14)
[288.624174] Starting subtest: atomic-dpms-hdcp14
[288.628541] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[288.756700] [081/133] (733s left) sw_sync (timeline_closed)
[288.795357] Starting subtest: timeline_closed
[288.797415] Subtest timeline_closed: SUCCESS (0.000s)
[288.862917] [082/133] (733s left) perf (oa-exponents)
[289.004138] Starting subtest: oa-exponents
[289.006434] Starting dynamic subtest: 0-rcs0
[290.779959] Dynamic subtest 0-rcs0: SUCCESS (1.775s)
[290.789757] Starting dynamic subtest: 1-vcs0
[292.608163] Dynamic subtest 1-vcs0: SUCCESS (1.828s)
[292.610700] Subtest oa-exponents: SUCCESS (3.605s)
[292.655953] [083/133] (729s left) kms_feature_discovery (display-2x)
[292.768676] Starting subtest: display-2x
[292.773340] Subtest display-2x: SKIP (0.000s)
[292.860519] [084/133] (729s left) core_setmaster (master-drop-set-root)
[292.925742] Starting subtest: master-drop-set-root
[292.939491] Subtest master-drop-set-root: SUCCESS (0.014s)
[292.990788] [085/133] (729s left) kms_pm_rpm (i2c)
[294.510616] Starting subtest: i2c
[300.177056] Subtest i2c: SUCCESS (5.671s)
[300.300969] [086/133] (721s left) kms_busy (basic-hang)
[300.398056] Starting subtest: basic-hang
[300.400316] Starting dynamic subtest: flip-pipe-A
[301.002637] Dynamic subtest flip-pipe-A: SUCCESS (0.602s)
[301.013390] Starting dynamic subtest: modeset-pipe-A
[304.404808] Dynamic subtest modeset-pipe-A: SUCCESS (3.405s)
[304.415472] Starting dynamic subtest: flip-pipe-D
[305.623426] Dynamic subtest flip-pipe-D: SUCCESS (1.215s)
[305.633516] Starting dynamic subtest: modeset-pipe-D
[309.013046] Dynamic subtest modeset-pipe-D: SUCCESS (3.391s)
[309.015448] Subtest basic-hang: SUCCESS (8.620s)
[309.824824] [087/133] (712s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[309.925224] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[309.929656] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[310.064481] [088/133] (712s left) kms_flip (nonblocking-read)
[310.171238] Starting subtest: nonblocking-read
[310.173120] Subtest nonblocking-read: SUCCESS (0.000s)
[310.293871] [089/133] (711s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[310.406159] Starting subtest: yf-tiled-16bpp-rotate-270
[310.410580] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[310.538154] [090/133] (711s left) gem_mmap_wc (write-read-distinct)
[310.604874] Subtest write-read-distinct: SKIP (0.000s)
[310.673510] [091/133] (711s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[310.742957] Starting subtest: multi-wait-for-submit-submitted-signaled
[310.744946] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[310.854194] [092/133] (711s left) kms_flip (blocking-wf_vblank)
[310.954561] Starting subtest: blocking-wf_vblank
[310.956473] Starting dynamic subtest: A-eDP1
[319.854642] Dynamic subtest A-eDP1: SUCCESS (8.904s)
[319.868759] Starting dynamic subtest: B-eDP1
[328.791191] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[328.800777] Starting dynamic subtest: C-eDP1
[337.719457] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[337.730367] Starting dynamic subtest: D-eDP1
[346.644519] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[346.646831] Subtest blocking-wf_vblank: SUCCESS (35.690s)
[347.881286] [093/133] (674s left) gem_exec_alignment (pi)
[347.957570] Starting subtest: pi
[398.202308] Subtest pi: SUCCESS (50.235s)
[399.302661] [094/133] (623s left) kms_getfb (getfb-repeated-different-handles)
[399.449924] Starting subtest: getfb-repeated-different-handles
[399.452161] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[399.581127] [095/133] (622s left) syncobj_timeline (etime-multi-wait-submitted)
[399.647182] Starting subtest: etime-multi-wait-submitted
[399.755606] Subtest etime-multi-wait-submitted: SUCCESS (0.108s)
[399.843986] [096/133] (622s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[399.976309] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[400.973443] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.995s)
[401.819263] [097/133] (620s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[401.915929] Starting subtest: primary-yf-tiled-reflect-x-0
[401.976409] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[402.092322] [098/133] (620s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[402.156281] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[402.249617] [099/133] (620s left) perf_pmu (rc6)
[402.287308] Starting subtest: rc6
[402.289435] Starting dynamic subtest: gt0
[408.653437] Dynamic subtest gt0: SUCCESS (6.365s)
[408.666370] Starting dynamic subtest: runtime-pm-gt0
[416.423675] Dynamic subtest runtime-pm-gt0: SUCCESS (7.768s)
[416.436397] Starting dynamic subtest: runtime-pm-long-gt0
[428.857305] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.432s)
[428.869961] Starting dynamic subtest: other-idle-gt0
[435.200531] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[435.212438] Starting dynamic subtest: gt1
[441.542585] Dynamic subtest gt1: SUCCESS (6.340s)
[441.555318] Starting dynamic subtest: runtime-pm-gt1
[448.963061] Dynamic subtest runtime-pm-gt1: SUCCESS (7.419s)
[448.974491] Starting dynamic subtest: runtime-pm-long-gt1
[461.408139] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.444s)
[461.419129] Starting dynamic subtest: other-idle-gt1
[467.752372] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[467.755445] Subtest rc6: SUCCESS (65.471s)
[468.874791] [100/133] (553s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[468.987910] Starting subtest: y-tiled-16bpp-rotate-0
[468.992371] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[469.061598] [101/133] (553s left) kms_flip_tiling (flip-change-tiling)
[469.164331] Starting subtest: flip-change-tiling
[469.166297] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[469.364756] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.200s)
[469.377121] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[469.499964] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[469.512572] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[469.633531] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[469.646191] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[469.776189] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.141s)
[469.794196] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[469.920560] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.141s)
[469.935966] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[470.064399] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[470.079792] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[470.198085] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[470.212785] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[470.309293] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.108s)
[470.321747] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[470.444363] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[470.457588] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[470.587387] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[470.600457] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[470.730924] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[470.746264] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[470.875662] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[470.888224] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[471.008857] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[471.021509] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[471.144316] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[471.157002] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[471.253820] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[471.265718] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[471.397972] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[471.411213] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[471.542254] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[471.557758] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[471.686566] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[471.698981] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[471.831301] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[471.842982] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[471.976045] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[471.989162] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[472.120699] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[472.134023] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[472.242421] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[472.255045] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[472.385930] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[472.401055] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[472.530546] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[472.542970] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[472.675026] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[472.687223] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[472.819232] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[472.834831] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[472.963913] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[472.976123] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[473.108025] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[473.120000] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[473.231196] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.121s)
[473.243618] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[473.375309] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[473.387840] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[473.519390] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[473.533789] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[473.674697] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.153s)
[473.689114] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[473.819960] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[473.830565] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[473.975326] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.153s)
[473.986708] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[474.119751] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[474.132665] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[474.241960] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[474.295797] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[475.480798] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.192s)
[475.493709] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[475.615721] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[475.628596] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[475.748742] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[475.761734] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[475.892212] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.141s)
[475.904921] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[476.035732] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[476.050995] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[476.180373] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[476.193152] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[476.313949] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[476.326976] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[476.425444] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[476.438833] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[476.559820] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[476.571029] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[476.702719] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[476.714154] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[476.847372] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[476.860033] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[476.991665] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[477.004056] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[477.125323] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[477.138285] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[477.270639] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s)
[477.283655] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[477.391713] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s)
[477.404207] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[477.536011] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[477.547506] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[477.680356] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[477.691848] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[477.824335] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[477.836413] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[477.969809] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[477.982525] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[478.113931] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[478.126700] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[478.258287] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[478.271309] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[478.379858] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[478.391732] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[478.523868] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[478.538563] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[478.668573] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[478.682525] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[478.812568] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[478.827463] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[478.946456] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.132s)
[478.959135] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[479.090894] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[479.103662] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[479.235179] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[479.247604] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[479.369023] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.131s)
[479.381745] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[479.513402] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[479.524331] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[479.657369] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[479.668536] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[479.802000] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[479.813793] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[479.946165] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[479.960802] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[480.090376] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[480.104739] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[480.235841] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[480.248330] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[480.357631] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[480.410518] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[481.606653] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.203s)
[481.619677] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[481.718174] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[481.730669] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[481.821992] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[481.834537] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[481.928996] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[481.941583] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[482.039190] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[482.051577] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[482.150379] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[482.162372] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[482.250867] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[482.264180] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[482.351135] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[482.367189] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[482.462011] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.108s)
[482.477678] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[482.572401] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[482.585126] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[482.683125] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[482.695129] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[482.794308] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[482.806416] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[482.894194] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[482.908842] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[482.994542] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[483.006263] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[483.094557] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[483.106392] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[483.205758] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[483.218434] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[483.316213] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[483.328009] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[483.427362] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[483.439533] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[483.527870] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[483.540499] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[483.639112] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[483.651872] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[483.750803] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[483.762948] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[483.861383] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[483.874257] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[483.971841] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[483.984484] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[484.082998] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[484.094170] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[484.193903] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[484.206138] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[484.305225] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[484.317113] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[484.416034] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[484.428240] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[484.527355] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[484.539513] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[484.638298] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[484.653571] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[484.749814] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[484.762375] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[484.860453] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[484.872619] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[484.971758] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[484.984884] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[485.083004] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[485.097860] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[485.193995] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s)
[485.206450] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[485.305306] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[485.317872] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[485.416468] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[485.460224] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[486.732162] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.280s)
[486.745568] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[486.832458] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[486.845239] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[486.932039] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[486.943612] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[487.043357] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[487.055358] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[487.153594] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[487.166349] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[487.264637] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[487.276748] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[487.365067] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[487.377942] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[487.465025] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[487.478020] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[487.565065] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[487.577834] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[487.675764] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[487.688132] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[487.786394] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[487.798387] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[487.946301] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.158s)
[487.960434] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[488.046144] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[488.056584] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[488.146524] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[488.158533] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[488.246638] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[488.258674] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[488.397616] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.148s)
[488.410304] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[488.507411] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[488.519977] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[488.618190] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[488.630994] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[488.730387] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[488.742306] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[488.841336] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[488.854329] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[488.952138] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[488.968694] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[489.104321] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.150s)
[489.117345] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[489.226121] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.120s)
[489.238740] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[489.375968] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.148s)
[489.388704] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[489.475345] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.098s)
[489.487885] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[489.575053] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[489.587159] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[489.686471] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[489.698392] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[489.797324] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s)
[489.809465] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[489.909127] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[489.921437] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[490.020006] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[490.032583] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[490.130868] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[490.143101] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[490.241919] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[490.254332] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[490.353302] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[490.370716] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[490.463842] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.108s)
[490.475793] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[490.575481] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[490.589963] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[490.697332] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.119s)
[490.730607] Subtest flip-change-tiling: SUCCESS (21.571s)
[491.911247] [102/133] (530s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[492.024135] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[492.028389] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[492.109108] [103/133] (530s left) gem_exec_fence (submit-chain)
[492.285059] Starting subtest: submit-chain
[492.302489] Subtest submit-chain: SUCCESS (0.018s)
[494.411777] [104/133] (528s left) gem_ringfill (engines-basic)
[500.291350] Starting subtest: engines-basic
[500.293871] Starting dynamic subtest: rcs0
[500.342905] Dynamic subtest rcs0: SUCCESS (0.051s)
[500.359410] Starting dynamic subtest: bcs0
[500.390466] Dynamic subtest bcs0: SUCCESS (0.045s)
[500.402697] Starting dynamic subtest: vcs0
[500.434437] Dynamic subtest vcs0: SUCCESS (0.042s)
[500.445410] Starting dynamic subtest: vcs1
[500.477187] Dynamic subtest vcs1: SUCCESS (0.041s)
[500.488115] Starting dynamic subtest: vecs0
[500.521127] Dynamic subtest vecs0: SUCCESS (0.042s)
[500.533344] Starting dynamic subtest: ccs0
[500.566978] Dynamic subtest ccs0: SUCCESS (0.044s)
[500.569406] Subtest engines-basic: SUCCESS (0.277s)
[500.622712] [105/133] (522s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[500.714967] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[500.717314] Starting dynamic subtest: pipe-A-eDP-1
[500.737683] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[500.750008] Starting dynamic subtest: pipe-B-eDP-1
[500.769153] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[500.778923] Starting dynamic subtest: pipe-C-eDP-1
[500.798780] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[500.809988] Starting dynamic subtest: pipe-D-eDP-1
[500.830293] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[500.832490] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[502.972456] [106/133] (519s left) perf_pmu (busy-check-all)
[503.017629] Starting subtest: busy-check-all
[503.019490] Starting dynamic subtest: rcs0
[503.582119] Dynamic subtest rcs0: SUCCESS (0.566s)
[503.597843] Starting dynamic subtest: bcs0
[504.136150] Dynamic subtest bcs0: SUCCESS (0.551s)
[504.149611] Starting dynamic subtest: vcs0
[505.280579] Dynamic subtest vcs0: SUCCESS (1.141s)
[505.294156] Starting dynamic subtest: vcs1
[507.329492] Dynamic subtest vcs1: SUCCESS (2.046s)
[507.342619] Starting dynamic subtest: vecs0
[509.313325] Dynamic subtest vecs0: SUCCESS (1.981s)
[509.326425] Starting dynamic subtest: ccs0
[509.870060] Dynamic subtest ccs0: SUCCESS (0.554s)
[509.873369] Subtest busy-check-all: SUCCESS (6.855s)
[509.976049] [107/133] (512s left) gem_exec_schedule (submit-early-slice)
[510.053293] Starting subtest: submit-early-slice
[510.055570] Starting dynamic subtest: rcs0
[510.120151] Dynamic subtest rcs0: SUCCESS (0.071s)
[510.134031] Starting dynamic subtest: bcs0
[510.176552] Dynamic subtest bcs0: SUCCESS (0.056s)
[510.189637] Starting dynamic subtest: vcs0
[510.229394] Dynamic subtest vcs0: SUCCESS (0.052s)
[510.239781] Starting dynamic subtest: vcs1
[510.282367] Dynamic subtest vcs1: SUCCESS (0.052s)
[510.294318] Starting dynamic subtest: vecs0
[510.328805] Dynamic subtest vecs0: SUCCESS (0.045s)
[510.339046] Starting dynamic subtest: ccs0
[510.391353] Dynamic subtest ccs0: SUCCESS (0.062s)
[510.393569] Subtest submit-early-slice: SUCCESS (0.343s)
[511.391874] [108/133] (511s left) gem_exec_balancer (parallel-bb-first)
[511.656418] Starting subtest: parallel-bb-first
[512.622000] Subtest parallel-bb-first: SUCCESS (0.969s)
[513.301643] [109/133] (509s left) gen9_exec_parse (bb-large)
[513.372763] Subtest bb-large: SKIP (0.000s)
[513.453617] [110/133] (509s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[513.547949] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[513.550116] Starting dynamic subtest: pipe-A-eDP-1
[513.608140] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[513.619618] Starting dynamic subtest: pipe-B-eDP-1
[513.676516] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[513.688268] Starting dynamic subtest: pipe-C-eDP-1
[513.746157] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[513.758343] Starting dynamic subtest: pipe-D-eDP-1
[513.814898] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[513.819116] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[515.840145] [111/133] (507s left) api_intel_bb (simple-bb-ctx)
[515.896186] Starting subtest: simple-bb-ctx
[515.903665] Subtest simple-bb-ctx: SUCCESS (0.009s)
[516.007125] [112/133] (507s left) gem_ctx_isolation (preservation-s3)
[516.078396] Starting subtest: preservation-S3
[516.080724] Starting dynamic subtest: rcs0
[532.249301] Dynamic subtest rcs0: SUCCESS (1.318s)
[532.259861] Starting dynamic subtest: bcs0
[548.255846] Dynamic subtest bcs0: SUCCESS (1.318s)
[548.267630] Starting dynamic subtest: vcs0
[564.242651] Dynamic subtest vcs0: SUCCESS (2.614s)
[564.255645] Starting dynamic subtest: vcs1
[582.259999] Dynamic subtest vcs1: SUCCESS (5.166s)
[582.270487] Starting dynamic subtest: vecs0
[600.250935] Dynamic subtest vecs0: SUCCESS (5.055s)
[600.267867] Starting dynamic subtest: ccs0
[618.242559] Dynamic subtest ccs0: SUCCESS (3.181s)
[618.245492] Subtest preservation-S3: SUCCESS (18.656s)
[618.479599] [113/133] (404s left) sriov_basic (enable-vfs-autoprobe-on)
[618.556862] Starting subtest: enable-vfs-autoprobe-on
[618.559249] Starting dynamic subtest: numvfs-1
[618.635204] Dynamic subtest numvfs-1: FAIL (0.026s)
[618.645357] Starting dynamic subtest: numvfs-2
[618.715769] Dynamic subtest numvfs-2: FAIL (0.004s)
[618.727793] Starting dynamic subtest: numvfs-3
[618.798511] Dynamic subtest numvfs-3: FAIL (0.004s)
[618.810299] Starting dynamic subtest: numvfs-4
[618.880248] Dynamic subtest numvfs-4: FAIL (0.004s)
[618.891848] Starting dynamic subtest: numvfs-5
[618.962913] Dynamic subtest numvfs-5: FAIL (0.004s)
[618.974878] Starting dynamic subtest: numvfs-6
[619.044716] Dynamic subtest numvfs-6: FAIL (0.004s)
[619.054749] Starting dynamic subtest: numvfs-7
[619.122905] Dynamic subtest numvfs-7: FAIL (0.004s)
[619.133430] Starting dynamic subtest: numvfs-random
[619.201619] Dynamic subtest numvfs-random: FAIL (0.004s)
[619.213189] Starting dynamic subtest: numvfs-all
[619.271975] Dynamic subtest numvfs-all: FAIL (0.509s)
[619.273929] Subtest enable-vfs-autoprobe-on: FAIL (0.569s)
[619.319439] [114/133] (403s left) perf_pmu (gt-awake)
[619.367773] Starting subtest: gt-awake
[628.048396] Subtest gt-awake: SUCCESS (8.759s)
[628.140851] [115/133] (395s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[628.219710] Subtest no-spare-fences-busy: SKIP (0.000s)
[628.319588] [116/133] (395s left) kms_rotation_crc (primary-rotation-90)
[628.419033] Starting subtest: primary-rotation-90
[628.423489] Subtest primary-rotation-90: SKIP (0.001s)
[628.468553] [117/133] (394s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[628.574323] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[629.339623] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.770s)
[629.470718] [118/133] (393s left) gem_mmap_wc (write-prefaulted)
[629.523248] Subtest write-prefaulted: SKIP (0.000s)
[629.624705] [119/133] (393s left) gem_pxp (reject-modify-context-protection-off-1)
[629.746712] Starting subtest: reject-modify-context-protection-off-1
[629.749397] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[629.829212] [120/133] (393s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[629.921366] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[629.923545] Starting dynamic subtest: pipe-A-eDP-1
[629.943798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[629.954475] Starting dynamic subtest: pipe-B-eDP-1
[629.974875] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[629.985284] Starting dynamic subtest: pipe-C-eDP-1
[630.005531] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[630.017441] Starting dynamic subtest: pipe-D-eDP-1
[630.038267] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[630.040653] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[632.231809] [121/133] (391s left) kms_plane_lowres (tiling-x)
[632.320917] Starting subtest: tiling-x
[632.323029] Starting dynamic subtest: pipe-A-eDP-1
[632.327262] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[632.625370] Starting dynamic subtest: pipe-B-eDP-1
[632.630583] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[632.646380] Starting dynamic subtest: pipe-C-eDP-1
[632.651196] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[632.662836] Starting dynamic subtest: pipe-D-eDP-1
[632.666803] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[632.670821] Subtest tiling-x: SKIP (0.302s)
[633.459974] [122/133] (390s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[633.558216] Starting subtest: multiplane-rotation-cropping-top
[650.928077] Subtest multiplane-rotation-cropping-top: SUCCESS (17.394s)
[651.046014] [123/133] (372s left) gem_mmap_gtt (basic-write-read-distinct)
[651.117990] Subtest basic-write-read-distinct: SKIP (0.000s)
[651.182956] [124/133] (372s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[651.275645] Starting subtest: fbc-psr2-sprite-mmap-gtt
[651.277527] Starting dynamic subtest: eDP-1
[651.280935] Dynamic subtest eDP-1: SKIP (0.000s)
[651.284365] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[651.327575] [125/133] (372s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[651.424914] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[651.428598] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[651.469268] [126/133] (372s left) gem_tiled_partial_pwrite_pread (writes)
[651.521839] Subtest writes: SKIP (0.000s)
[651.609735] [127/133] (372s left) kms_atomic (crtc-invalid-params-fence)
[651.703330] Starting subtest: crtc-invalid-params-fence
[651.705356] Starting dynamic subtest: pipe-A-eDP-1
[652.103370] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[652.105739] Subtest crtc-invalid-params-fence: SUCCESS (0.403s)
[652.965738] [128/133] (370s left) gem_busy (parallel)
[653.160035] Starting subtest: parallel
[653.162661] Starting dynamic subtest: rcs0
[655.055689] Dynamic subtest rcs0: SUCCESS (1.896s)
[655.070154] Starting dynamic subtest: bcs0
[657.039197] Dynamic subtest bcs0: SUCCESS (1.981s)
[657.052238] Starting dynamic subtest: vcs0
[659.023252] Dynamic subtest vcs0: SUCCESS (1.981s)
[659.036449] Starting dynamic subtest: vcs1
[661.007631] Dynamic subtest vcs1: SUCCESS (1.981s)
[661.020169] Starting dynamic subtest: vecs0
[663.054484] Dynamic subtest vecs0: SUCCESS (2.044s)
[663.067298] Starting dynamic subtest: ccs0
[665.039441] Dynamic subtest ccs0: SUCCESS (1.982s)
[665.042333] Subtest parallel: SUCCESS (11.881s)
[665.273335] [129/133] (358s left) gem_ctx_persistence (processes)
[665.347751] Starting subtest: processes
[667.054702] Subtest processes: SUCCESS (1.710s)
[667.114837] [130/133] (356s left) kms_big_fb (4-tiled-addfb-size-overflow)
[667.225524] Starting subtest: 4-tiled-addfb-size-overflow
[667.227394] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[667.299282] [131/133] (356s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[667.402047] Starting subtest: x-tiled-64bpp-rotate-270
[667.423694] Subtest x-tiled-64bpp-rotate-270: SKIP (0.021s)
[667.530178] [132/133] (356s left) kms_plane_scaling (planes-scaler-unity-scaling)
[667.626189] Starting subtest: planes-scaler-unity-scaling
[667.628484] Starting dynamic subtest: pipe-A
[667.688269] Dynamic subtest pipe-A: SUCCESS (0.064s)
[667.701661] Starting dynamic subtest: pipe-B
[668.812788] Dynamic subtest pipe-B: SUCCESS (1.122s)
[668.824796] Starting dynamic subtest: pipe-C
[669.921051] Dynamic subtest pipe-C: SUCCESS (1.106s)
[669.935375] Starting dynamic subtest: pipe-D
[671.046532] Dynamic subtest pipe-D: SUCCESS (1.123s)
[671.048800] Subtest planes-scaler-unity-scaling: SUCCESS (3.423s)
[672.192852] [133/133] (351s left) gem_exec_whisper (basic-contexts)
[672.277743] Starting subtest: basic-contexts
[679.983188] Subtest basic-contexts: SUCCESS (7.702s)
[680.141935] 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.