[59.053050] Initializing watchdogs
[59.053143]   /dev/watchdog0
[59.067248] [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]
[59.071394] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.073523] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.077033] [001/133] (960s left) api_intel_allocator (gem-pool)
[59.160256] Starting subtest: gem-pool
[59.171501] Subtest gem-pool: SUCCESS (0.012s)
[59.281394] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[59.385255] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[59.389160] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[59.503533] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[59.585378] Starting subtest: read-crc-frame-sequence
[59.587734] Starting dynamic subtest: pipe-A-eDP-1
[60.303940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[60.312397] Starting dynamic subtest: pipe-B-eDP-1
[61.637874] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.338s)
[61.644691] Starting dynamic subtest: pipe-C-eDP-1
[62.910845] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.277s)
[62.920071] Starting dynamic subtest: pipe-D-eDP-1
[64.240406] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[64.242784] Subtest read-crc-frame-sequence: SUCCESS (4.675s)
[65.095176] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[65.153015] Starting subtest: invalid-query-one-illegal-handle
[65.155388] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[65.266893] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[65.316594] Starting subtest: invalid-signal-zero-handles
[65.319135] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[65.421544] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[65.514449] Starting subtest: fbcpsr-rgb565-draw-render
[72.588722] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.089s)
[72.756181] [007/133] (947s left) syncobj_timeline (wait-for-submit-snapshot)
[72.825886] Starting subtest: wait-for-submit-snapshot
[72.908257] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[72.992187] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[73.094702] Starting subtest: psr-rgb565-draw-blt
[80.124894] Subtest psr-rgb565-draw-blt: SUCCESS (7.037s)
[80.307553] [009/133] (939s left) kms_cursor_crc (cursor-onscreen-32x10)
[80.489566] Starting subtest: cursor-onscreen-32x10
[80.531455] Subtest cursor-onscreen-32x10: SKIP (0.039s)
[80.814790] [010/133] (939s left) syncobj_wait (invalid-signal-illegal-handle)
[80.879301] Starting subtest: invalid-signal-illegal-handle
[80.881908] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[80.968812] [011/133] (938s left) testdisplay
[81.326429] [012/133] (938s left) prime_mmap (test_map_unmap)
[81.371258] Starting subtest: test_map_unmap
[81.373117] Starting dynamic subtest: test_map_unmap-smem
[81.398117] Dynamic subtest test_map_unmap-smem: SUCCESS (0.029s)
[81.400050] Subtest test_map_unmap: SUCCESS (0.029s)
[81.522733] [013/133] (938s left) gem_exec_fence (syncobj-timeline-signal)
[82.068464] Starting subtest: syncobj-timeline-signal
[82.074928] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[84.004848] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[84.008815] [014/133] (936s left) syncobj_timeline (signal-point-0)
[84.070730] Starting subtest: signal-point-0
[84.073071] Subtest signal-point-0: SUCCESS (0.000s)
[84.205682] [015/133] (935s left) kms_psr (psr2-suspend)
[84.296600] Starting subtest: psr2-suspend
[84.298783] Starting dynamic subtest: eDP-1
[102.335228] Dynamic subtest eDP-1: SUCCESS (3.048s)
[102.337414] Subtest psr2-suspend: SUCCESS (3.049s)
[103.204144] [016/133] (916s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[103.309834] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[103.322012] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[103.392020] [017/133] (916s left) gem_softpin (reverse)
[103.447631] Starting subtest: reverse
[103.454153] Subtest reverse: SUCCESS (0.007s)
[103.612159] [018/133] (916s left) gem_exec_balancer (parallel-contexts)
[103.865639] Starting subtest: parallel-contexts
[106.273196] Subtest parallel-contexts: SUCCESS (2.485s)
[106.399393] [019/133] (913s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[106.489752] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[106.491824] Starting dynamic subtest: pipe-A-eDP-1
[108.476599] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.034s)
[108.488653] Starting dynamic subtest: pipe-B-eDP-1
[110.684787] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.245s)
[110.692692] Starting dynamic subtest: pipe-C-eDP-1
[112.699113] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.038s)
[112.707833] Starting dynamic subtest: pipe-D-eDP-1
[114.714788] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.037s)
[114.717136] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.359s)
[115.961571] [020/133] (904s left) kms_lease (lease-unleased-connector)
[116.052125] Starting subtest: lease-unleased-connector
[116.054511] Starting dynamic subtest: pipe-A-eDP-1
[116.059886] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[116.070055] Starting dynamic subtest: pipe-B-eDP-1
[116.072375] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[116.089797] Starting dynamic subtest: pipe-C-eDP-1
[116.091943] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[116.099897] Starting dynamic subtest: pipe-D-eDP-1
[116.102143] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[116.104333] Subtest lease-unleased-connector: SUCCESS (0.033s)
[116.210854] [021/133] (904s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[116.352808] Starting subtest: cursor-vs-flip-atomic-transitions
[146.033959] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.728s)
[146.845534] [022/133] (873s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[146.955694] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[146.957968] Starting dynamic subtest: pipe-A-default-mode
[149.697234] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[149.699416] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.742s)
[150.545897] [023/133] (869s left) kms_addfb_basic (legacy-format)
[150.613499] Starting subtest: legacy-format
[150.632126] Subtest legacy-format: SUCCESS (0.017s)
[150.816743] [024/133] (869s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[150.924929] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[150.929559] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[151.069134] [025/133] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[151.168321] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[151.172818] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[151.309769] [026/133] (869s left) kms_vblank (query-busy)
[151.411199] Starting subtest: query-busy
[151.413467] Starting dynamic subtest: pipe-A-eDP-1
[153.284696] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[153.299797] Starting dynamic subtest: pipe-D-eDP-1
[155.900409] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.614s)
[155.902632] Subtest query-busy: SUCCESS (4.492s)
[156.699339] [027/133] (863s left) gem_wait (invalid-flags)
[156.763788] Starting subtest: invalid-flags
[156.766183] Subtest invalid-flags: SUCCESS (0.000s)
[157.020971] [028/133] (863s left) kms_properties (invalid-properties-atomic)
[157.111431] Starting subtest: invalid-properties-atomic
[157.437970] Subtest invalid-properties-atomic: SUCCESS (0.327s)
[157.524855] [029/133] (863s left) gem_exec_flush (basic-wb-ro-before-default)
[157.589089] Starting subtest: basic-wb-ro-before-default
[163.040317] Subtest basic-wb-ro-before-default: SUCCESS (5.453s)
[163.223400] [030/133] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[163.319383] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[163.323412] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[163.423359] [031/133] (857s left) kms_psr (pr-primary-blt)
[163.523041] Starting subtest: pr-primary-blt
[163.527108] Subtest pr-primary-blt: SKIP (0.000s)
[163.606823] [032/133] (857s left) kms_flip (2x-flip-vs-dpms-on-nop)
[163.704421] Starting subtest: 2x-flip-vs-dpms-on-nop
[163.715157] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[163.838412] [033/133] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[163.939686] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[163.944120] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[164.082439] [034/133] (856s left) kms_chamelium_edid (dp-mode-timings)
[164.464572] Subtest dp-mode-timings: SKIP (0.000s)
[165.287552] [035/133] (855s left) kms_flip (flip-vs-panning-interruptible)
[165.386708] Starting subtest: flip-vs-panning-interruptible
[165.389179] Starting dynamic subtest: A-eDP1
[174.113029] Dynamic subtest A-eDP1: SUCCESS (8.728s)
[174.122503] Starting dynamic subtest: B-eDP1
[182.840507] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[182.853530] Starting dynamic subtest: C-eDP1
[191.554653] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[191.566481] Starting dynamic subtest: D-eDP1
[200.188176] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[200.192077] Subtest flip-vs-panning-interruptible: SUCCESS (34.814s)
[201.454037] [036/133] (819s left) kms_pm_dc (dc5-psr)
[202.563061] Starting subtest: dc5-psr
[205.439409] Subtest dc5-psr: SUCCESS (2.873s)
[206.286553] [037/133] (814s left) gem_userptr_blits (process-exit)
[206.352134] Starting subtest: process-exit
[206.359609] Subtest process-exit: SUCCESS (0.009s)
[206.490432] [038/133] (814s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[206.591143] Starting subtest: plane-lut1d-post-ctm3x4
[206.604284] Starting dynamic subtest: pipe-A-eDP-1
[207.306043] Dynamic subtest pipe-A-eDP-1: FAIL (0.334s)
[208.049165] Starting dynamic subtest: pipe-B-eDP-1
[208.841517] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s)
[209.383288] Starting dynamic subtest: pipe-C-eDP-1
[210.245699] Dynamic subtest pipe-C-eDP-1: FAIL (0.278s)
[210.725162] Starting dynamic subtest: pipe-D-eDP-1
[211.548210] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[211.550243] Subtest plane-lut1d-post-ctm3x4: FAIL (4.651s)
[212.132482] [039/133] (808s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[212.183403] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[212.285064] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[212.374596] [040/133] (808s left) gem_mmap_offset (partial-remap)
[212.437642] Starting subtest: partial-remap
[212.440191] Starting dynamic subtest: smem0
[212.449062] Dynamic subtest smem0: SUCCESS (0.004s)
[212.451229] Subtest partial-remap: SUCCESS (0.005s)
[212.578062] [041/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[212.685103] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[212.693242] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[212.788545] [042/133] (808s left) gem_userptr_blits (dmabuf-unsync)
[212.861735] Subtest dmabuf-unsync: SKIP (0.000s)
[213.007200] [043/133] (808s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[213.109177] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[213.113151] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[213.242727] [044/133] (808s left) gem_close_race (multigpu-basic-threads)
[213.311012] Starting subtest: multigpu-basic-threads
[213.314876] Subtest multigpu-basic-threads: SKIP (0.000s)
[213.571370] [045/133] (807s left) gem_exec_schedule (preempt)
[213.654280] Starting subtest: preempt
[213.656346] Starting dynamic subtest: rcs0
[213.668630] Dynamic subtest rcs0: SUCCESS (0.023s)
[213.678910] Starting dynamic subtest: bcs0
[213.687222] Dynamic subtest bcs0: SUCCESS (0.018s)
[213.695058] Starting dynamic subtest: vcs0
[213.709141] Dynamic subtest vcs0: SUCCESS (0.021s)
[213.717279] Starting dynamic subtest: vcs1
[213.729247] Dynamic subtest vcs1: SUCCESS (0.020s)
[213.737198] Starting dynamic subtest: vecs0
[213.747458] Dynamic subtest vecs0: SUCCESS (0.018s)
[213.755390] Starting dynamic subtest: ccs0
[213.765951] Dynamic subtest ccs0: SUCCESS (0.018s)
[213.768309] Subtest preempt: SUCCESS (0.121s)
[214.995614] [046/133] (806s left) i915_module_load (reload)
[215.030770] Starting subtest: reload
[220.008966] Subtest reload: SUCCESS (4.980s)
[220.048047] [047/133] (801s left) gem_exec_reloc (basic-wc-cpu-active)
[221.906033] Subtest basic-wc-cpu-active: SKIP (0.000s)
[221.982389] [048/133] (799s left) gen9_exec_parse (valid-registers)
[222.045581] Subtest valid-registers: SKIP (0.000s)
[222.117644] [049/133] (799s left) kms_cursor_edge_walk (64x64-left-edge)
[222.213813] Starting subtest: 64x64-left-edge
[222.216049] Starting dynamic subtest: pipe-A-eDP-1
[225.694369] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s)
[225.703687] Starting dynamic subtest: pipe-D-eDP-1
[228.818917] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[228.820846] Subtest 64x64-left-edge: SUCCESS (6.603s)
[229.641558] [050/133] (791s left) gem_render_copy_redux (flink)
[229.711502] Starting subtest: flink
[230.453715] Subtest flink: SUCCESS (0.743s)
[230.643415] [051/133] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[230.750931] Starting subtest: psr-2p-primscrn-spr-indfb-move
[230.755431] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[230.871693] [052/133] (790s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[230.973928] Starting subtest: bo-too-small-due-to-tiling
[230.977807] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[231.088022] [053/133] (790s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[231.185853] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[237.673050] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.489s)
[237.796162] [054/133] (783s left) gem_exec_reloc (basic-write-wc-active)
[237.864668] Subtest basic-write-wc-active: SKIP (0.000s)
[237.941519] [055/133] (783s left) gem_fenced_exec_thrash (2-spare-fences)
[238.005428] Subtest 2-spare-fences: SKIP (0.000s)
[238.072376] [056/133] (783s left) kms_hdr (static-toggle-dpms)
[238.174079] Starting subtest: static-toggle-dpms
[238.180141] Subtest static-toggle-dpms: SKIP (0.000s)
[238.260504] [057/133] (783s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[238.359278] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[245.302051] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.945s)
[245.433636] [058/133] (776s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[245.532368] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[249.265496] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.737s)
[250.451861] [059/133] (771s left) gem_lmem_swapping (parallel-random-verify)
[250.492283] Subtest parallel-random-verify: SKIP (0.000s)
[250.537124] [060/133] (771s left) kms_psr (fbc-pr-sprite-plane-move)
[250.622094] Starting subtest: fbc-pr-sprite-plane-move
[250.626185] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[250.704199] [061/133] (771s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[251.086191] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[251.929398] [062/133] (770s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[252.036440] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[252.038788] Starting dynamic subtest: pipe-A-eDP-1
[252.064523] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[252.074653] Starting dynamic subtest: pipe-B-eDP-1
[252.098924] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[252.106442] Starting dynamic subtest: pipe-C-eDP-1
[252.129888] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[252.137620] Starting dynamic subtest: pipe-D-eDP-1
[252.161196] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[252.165504] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[254.320700] [063/133] (767s left) i915_pm_rpm (gem-evict-pwrite)
[256.058040] Starting subtest: gem-evict-pwrite
[256.063233] Subtest gem-evict-pwrite: SKIP (0.000s)
[256.565935] [064/133] (765s left) gem_exec_whisper (basic-sync)
[256.639031] Starting subtest: basic-sync
[263.421030] Subtest basic-sync: SUCCESS (6.784s)
[263.617147] [065/133] (758s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[263.735922] Starting subtest: short-busy-flip-before-cursor-toggle
[263.740428] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[263.886601] [066/133] (758s left) i915_query (hwconfig_table)
[263.941355] Starting subtest: hwconfig_table
[264.234503] Subtest hwconfig_table: SUCCESS (0.001s)
[264.273024] [067/133] (757s left) kms_vrr (flipline)
[264.368645] Starting subtest: flipline
[264.375090] Subtest flipline: SKIP (0.000s)
[264.448692] [068/133] (757s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[264.549281] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[268.761422] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.217s)
[269.945626] [069/133] (752s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[270.058174] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[270.071277] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[270.148470] [070/133] (752s left) kms_prop_blob (invalid-set-prop)
[270.218440] Starting subtest: invalid-set-prop
[270.220828] Subtest invalid-set-prop: SUCCESS (0.000s)
[270.349039] [071/133] (751s left) kms_properties (crtc-properties-legacy)
[270.431214] Starting subtest: crtc-properties-legacy
[270.433581] Starting dynamic subtest: pipe-A-eDP-1
[270.872308] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[270.890290] Starting dynamic subtest: pipe-B-eDP-1
[271.999695] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.125s)
[272.009442] Starting dynamic subtest: pipe-C-eDP-1
[273.126364] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[273.136462] Starting dynamic subtest: pipe-D-eDP-1
[274.268770] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.144s)
[274.271189] Subtest crtc-properties-legacy: SUCCESS (3.840s)
[275.078913] [072/133] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[275.185651] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[282.136993] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.955s)
[282.311249] [073/133] (740s left) kms_psr (fbc-pr-cursor-render)
[282.421278] Starting subtest: fbc-pr-cursor-render
[282.425585] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[282.503702] [074/133] (739s left) gem_userptr_blits (huge-split)
[282.589410] Starting subtest: huge-split
[282.594622] Subtest huge-split: SUCCESS (0.008s)
[282.762440] [075/133] (739s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[283.012881] Starting subtest: cursor-rapid-movement-256x85
[283.056870] Subtest cursor-rapid-movement-256x85: SKIP (0.041s)
[283.274953] [076/133] (739s left) gem_unref_active_buffers
[283.507015] [077/133] (739s left) gem_caching (reads)
[283.566200] Subtest reads: SKIP (0.000s)
[283.635070] [078/133] (738s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[283.701594] Starting subtest: invalid-multi-wait-all-unsubmitted
[283.703621] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[283.844538] [079/133] (738s left) gem_exec_create (basic)
[283.905436] Starting subtest: basic
[283.907475] Starting dynamic subtest: smem
[287.840944] Dynamic subtest smem: SUCCESS (3.934s)
[287.843524] Subtest basic: SUCCESS (3.936s)
[288.042664] [080/133] (734s left) kms_content_protection (atomic-dpms-hdcp14)
[288.190033] Starting subtest: atomic-dpms-hdcp14
[288.194628] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[288.336705] [081/133] (734s left) sw_sync (timeline_closed)
[288.376005] Starting subtest: timeline_closed
[288.378257] Subtest timeline_closed: SUCCESS (0.000s)
[288.433602] [082/133] (734s left) perf (oa-exponents)
[288.559847] Starting subtest: oa-exponents
[288.562079] Starting dynamic subtest: 0-rcs0
[290.309745] Dynamic subtest 0-rcs0: SUCCESS (1.752s)
[290.319293] Starting dynamic subtest: 1-vecs0
[292.111361] Dynamic subtest 1-vecs0: SUCCESS (1.801s)
[292.113731] Subtest oa-exponents: SUCCESS (3.555s)
[292.157379] [083/133] (730s left) kms_feature_discovery (display-2x)
[292.262758] Starting subtest: display-2x
[292.266908] Subtest display-2x: SKIP (0.000s)
[292.360316] [084/133] (730s left) core_setmaster (master-drop-set-root)
[292.427148] Starting subtest: master-drop-set-root
[292.441864] Subtest master-drop-set-root: SUCCESS (0.014s)
[292.489909] [085/133] (730s left) kms_pm_rpm (i2c)
[294.111472] Starting subtest: i2c
[299.695253] Subtest i2c: SUCCESS (5.587s)
[299.797343] [086/133] (723s left) kms_busy (basic-hang)
[299.905135] Starting subtest: basic-hang
[299.907242] Starting dynamic subtest: flip-pipe-A
[300.530892] Dynamic subtest flip-pipe-A: SUCCESS (0.627s)
[300.540428] Starting dynamic subtest: modeset-pipe-A
[304.006417] Dynamic subtest modeset-pipe-A: SUCCESS (3.475s)
[304.016774] Starting dynamic subtest: flip-pipe-D
[305.206182] Dynamic subtest flip-pipe-D: SUCCESS (1.198s)
[305.216568] Starting dynamic subtest: modeset-pipe-D
[308.617622] Dynamic subtest modeset-pipe-D: SUCCESS (3.409s)
[308.619942] Subtest basic-hang: SUCCESS (8.716s)
[309.436937] [087/133] (713s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[309.544638] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[309.548777] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[309.657183] [088/133] (713s left) kms_flip (nonblocking-read)
[309.756192] Starting subtest: nonblocking-read
[309.758092] Subtest nonblocking-read: SUCCESS (0.000s)
[309.891293] [089/133] (713s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[309.989198] Starting subtest: yf-tiled-16bpp-rotate-270
[309.993158] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[310.117344] [090/133] (712s left) gem_mmap_wc (write-read-distinct)
[310.176556] Subtest write-read-distinct: SKIP (0.000s)
[310.243059] [091/133] (712s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[310.300023] Starting subtest: multi-wait-for-submit-submitted-signaled
[310.302342] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[310.416146] [092/133] (712s left) kms_flip (blocking-wf_vblank)
[310.499437] Starting subtest: blocking-wf_vblank
[310.501464] Starting dynamic subtest: A-eDP1
[319.386639] Dynamic subtest A-eDP1: SUCCESS (8.888s)
[319.399936] Starting dynamic subtest: B-eDP1
[328.323018] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[328.331798] Starting dynamic subtest: C-eDP1
[337.260830] Dynamic subtest C-eDP1: SUCCESS (8.932s)
[337.269519] Starting dynamic subtest: D-eDP1
[346.198729] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[346.203781] Subtest blocking-wf_vblank: SUCCESS (35.699s)
[347.416359] [093/133] (675s left) gem_exec_alignment (pi)
[347.479603] Starting subtest: pi
[397.188919] Subtest pi: SUCCESS (49.700s)
[398.276357] [094/133] (624s left) kms_getfb (getfb-repeated-different-handles)
[398.415998] Starting subtest: getfb-repeated-different-handles
[398.418557] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[398.548529] [095/133] (624s left) syncobj_timeline (etime-multi-wait-submitted)
[398.613939] Starting subtest: etime-multi-wait-submitted
[398.716299] Subtest etime-multi-wait-submitted: SUCCESS (0.102s)
[398.807219] [096/133] (624s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[398.930678] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[399.934274] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.004s)
[400.772056] [097/133] (622s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[400.875172] Starting subtest: primary-yf-tiled-reflect-x-0
[400.934607] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[401.052299] [098/133] (622s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[401.112654] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[401.188213] [099/133] (622s left) perf_pmu (rc6)
[401.228858] Starting subtest: rc6
[401.231227] Starting dynamic subtest: gt0
[407.607057] Dynamic subtest gt0: SUCCESS (6.380s)
[407.619271] Starting dynamic subtest: runtime-pm-gt0
[415.322939] Dynamic subtest runtime-pm-gt0: SUCCESS (7.714s)
[415.335969] Starting dynamic subtest: runtime-pm-long-gt0
[427.744668] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.420s)
[427.757388] Starting dynamic subtest: other-idle-gt0
[434.087082] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[434.099614] Starting dynamic subtest: gt1
[440.429788] Dynamic subtest gt1: SUCCESS (6.341s)
[440.441617] Starting dynamic subtest: runtime-pm-gt1
[447.936359] Dynamic subtest runtime-pm-gt1: SUCCESS (7.504s)
[447.948488] Starting dynamic subtest: runtime-pm-long-gt1
[460.427386] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.490s)
[460.439723] Starting dynamic subtest: other-idle-gt1
[466.771278] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[466.774003] Subtest rc6: SUCCESS (65.550s)
[467.924715] [100/133] (555s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[468.036054] Starting subtest: y-tiled-16bpp-rotate-0
[468.040270] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[468.111569] [101/133] (555s left) kms_flip_tiling (flip-change-tiling)
[468.198973] Starting subtest: flip-change-tiling
[468.200818] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[468.394921] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.196s)
[468.407837] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[468.586358] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.188s)
[468.598134] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[468.719756] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[468.733887] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[468.862889] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[468.877582] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[469.018391] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.153s)
[469.029861] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[469.162645] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[469.173433] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[469.307505] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s)
[469.318917] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[469.418738] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[469.429887] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[469.574911] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.154s)
[469.589355] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[469.718944] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[469.730936] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[469.862602] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[469.875048] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[469.995873] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.131s)
[470.007657] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[470.129326] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[470.141285] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[470.264001] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[470.276172] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[470.374265] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[470.386645] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[470.567017] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.190s)
[470.577922] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[470.710172] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[470.722279] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[470.882083] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.170s)
[470.893159] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[471.015673] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[471.028040] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[471.149018] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s)
[471.161904] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[471.293404] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[471.305122] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[471.415604] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.119s)
[471.428432] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[471.570758] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.153s)
[471.582893] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[471.715380] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[471.726060] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[471.859216] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[471.874088] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[472.003898] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[472.015797] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[472.148029] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[472.162784] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[472.292789] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[472.304989] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[472.415047] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[472.428071] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[472.598012] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.181s)
[472.610917] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[472.743214] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[472.758652] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[472.875037] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.131s)
[472.888059] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[473.020369] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[473.032768] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[473.191460] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.170s)
[473.206037] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[473.336857] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[473.349541] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[473.458842] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[473.510941] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[474.698003] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.194s)
[474.710372] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[474.833865] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[474.845792] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[474.966339] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[474.979132] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[475.097802] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.131s)
[475.113285] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[475.242022] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.141s)
[475.254277] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[475.386521] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[475.398622] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[475.519720] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[475.532379] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[475.631455] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[475.644044] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[475.765957] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[475.777259] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[475.909054] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[475.921368] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[476.053389] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[476.069299] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[476.197209] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[476.209559] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[476.331485] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[476.343014] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[476.465680] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[476.480043] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[476.575527] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[476.586707] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[476.719882] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[476.731526] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[476.864117] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[476.876819] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[477.008363] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[477.020010] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[477.141718] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[477.154077] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[477.286971] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[477.299842] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[477.430880] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[477.443663] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[477.552923] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[477.567660] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[477.697097] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.141s)
[477.710175] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[477.841057] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[477.855181] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[477.985577] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[477.999833] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[478.130138] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[478.142815] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[478.274566] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[478.286504] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[478.418907] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[478.433195] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[478.552828] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.131s)
[478.568307] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[478.697255] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[478.710769] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[478.840900] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[478.856168] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[478.985571] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[478.999956] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[479.130103] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[479.143658] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[479.274227] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[479.287266] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[479.419648] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[479.432053] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[479.541654] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[479.594289] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[480.832139] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.245s)
[480.846961] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[480.931910] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[480.943648] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[481.031704] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[481.043299] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[481.142777] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[481.153350] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[481.292216] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.148s)
[481.304262] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[481.403216] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[481.414944] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[481.503549] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[481.515806] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[481.603692] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[481.615492] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[481.703368] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[481.715054] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[481.803145] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s)
[481.814377] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[481.913937] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[481.925319] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[482.025096] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[482.036367] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[482.125558] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[482.136895] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[482.225587] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[482.236885] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[482.325424] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[482.337467] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[482.425776] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.098s)
[482.438038] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[482.524919] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.098s)
[482.536444] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[482.636185] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[482.649089] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[482.748240] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[482.757478] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[482.870442] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.120s)
[482.882955] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[482.981570] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[482.993254] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[483.092106] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[483.104622] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[483.203189] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[483.219785] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[483.314125] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[483.326129] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[483.424838] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[483.436805] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[483.525253] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[483.535833] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[483.625476] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[483.635902] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[483.735948] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[483.747816] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[483.847558] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[483.858613] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[483.970179] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.120s)
[483.982445] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[484.080713] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[484.092280] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[484.180302] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.098s)
[484.192194] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[484.291650] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[484.303252] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[484.402496] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[484.414548] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[484.514509] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[484.526507] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[484.625444] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[484.678319] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[485.858770] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.187s)
[485.870619] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[485.958581] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.097s)
[485.970250] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[486.058467] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[486.070036] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[486.158334] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.098s)
[486.168966] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[486.258187] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.098s)
[486.269974] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[486.369565] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[486.380487] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[486.469333] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[486.480855] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[486.569757] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[486.580968] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[486.669832] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[486.681373] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[486.780541] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[486.792020] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[486.891184] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[486.901439] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[487.002261] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[487.013309] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[487.102234] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[487.115463] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[487.213808] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.108s)
[487.225581] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[487.324400] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[487.336119] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[487.435765] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[487.449450] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[487.546667] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.108s)
[487.558068] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[487.657499] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.108s)
[487.669554] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[487.768800] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[487.779771] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[487.869578] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[487.881071] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[487.969523] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[487.981500] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[488.080265] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[488.092169] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[488.191074] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[488.203043] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[488.301815] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[488.311389] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[488.402153] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s)
[488.411828] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[488.513377] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[488.523629] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[488.613013] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.098s)
[488.623043] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[488.724132] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[488.734464] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[488.835834] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[488.847758] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[488.946848] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[488.957201] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[489.057530] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[489.067886] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[489.168640] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[489.179457] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[489.268348] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.099s)
[489.280029] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[489.379800] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[489.391416] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[489.491700] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[489.504015] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[489.602489] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[489.635084] Subtest flip-change-tiling: SUCCESS (21.441s)
[490.835063] [102/133] (532s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[490.948716] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[490.953219] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[491.033552] [103/133] (532s left) gem_exec_fence (submit-chain)
[491.215298] Starting subtest: submit-chain
[491.232866] Subtest submit-chain: SUCCESS (0.018s)
[492.942833] [104/133] (530s left) gem_ringfill (engines-basic)
[498.917695] Starting subtest: engines-basic
[498.920210] Starting dynamic subtest: rcs0
[498.989595] Dynamic subtest rcs0: SUCCESS (0.072s)
[499.003561] Starting dynamic subtest: bcs0
[499.035866] Dynamic subtest bcs0: SUCCESS (0.044s)
[499.047796] Starting dynamic subtest: vcs0
[499.076849] Dynamic subtest vcs0: SUCCESS (0.040s)
[499.089020] Starting dynamic subtest: vcs1
[499.120131] Dynamic subtest vcs1: SUCCESS (0.041s)
[499.132681] Starting dynamic subtest: vecs0
[499.160850] Dynamic subtest vecs0: SUCCESS (0.040s)
[499.172948] Starting dynamic subtest: ccs0
[499.205612] Dynamic subtest ccs0: SUCCESS (0.043s)
[499.208058] Subtest engines-basic: SUCCESS (0.291s)
[499.261052] [105/133] (524s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[499.372251] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[499.374559] Starting dynamic subtest: pipe-A-eDP-1
[499.395014] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[499.407467] Starting dynamic subtest: pipe-B-eDP-1
[499.426389] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[499.435510] Starting dynamic subtest: pipe-C-eDP-1
[499.455177] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[499.464696] Starting dynamic subtest: pipe-D-eDP-1
[499.485133] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[499.487162] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[501.603318] [106/133] (522s left) perf_pmu (busy-check-all)
[501.647760] Starting subtest: busy-check-all
[501.650042] Starting dynamic subtest: rcs0
[502.212930] Dynamic subtest rcs0: SUCCESS (0.567s)
[502.226323] Starting dynamic subtest: bcs0
[502.763928] Dynamic subtest bcs0: SUCCESS (0.549s)
[502.776523] Starting dynamic subtest: vcs0
[503.906354] Dynamic subtest vcs0: SUCCESS (1.139s)
[503.918435] Starting dynamic subtest: vcs1
[505.889789] Dynamic subtest vcs1: SUCCESS (1.980s)
[505.902848] Starting dynamic subtest: vecs0
[507.873549] Dynamic subtest vecs0: SUCCESS (1.981s)
[507.886556] Starting dynamic subtest: ccs0
[508.425493] Dynamic subtest ccs0: SUCCESS (0.551s)
[508.427959] Subtest busy-check-all: SUCCESS (6.782s)
[508.518397] [107/133] (515s left) gem_exec_schedule (submit-early-slice)
[508.589611] Starting subtest: submit-early-slice
[508.591911] Starting dynamic subtest: rcs0
[508.640864] Dynamic subtest rcs0: SUCCESS (0.059s)
[508.655184] Starting dynamic subtest: bcs0
[508.686769] Dynamic subtest bcs0: SUCCESS (0.045s)
[508.699224] Starting dynamic subtest: vcs0
[508.742784] Dynamic subtest vcs0: SUCCESS (0.054s)
[508.757845] Starting dynamic subtest: vcs1
[508.810486] Dynamic subtest vcs1: SUCCESS (0.066s)
[508.833526] Starting dynamic subtest: vecs0
[508.853032] Dynamic subtest vecs0: SUCCESS (0.043s)
[508.868491] Starting dynamic subtest: ccs0
[508.899627] Dynamic subtest ccs0: SUCCESS (0.046s)
[508.902092] Subtest submit-early-slice: SUCCESS (0.318s)
[510.018071] [108/133] (513s left) gem_exec_balancer (parallel-bb-first)
[510.286540] Starting subtest: parallel-bb-first
[511.163004] Subtest parallel-bb-first: SUCCESS (0.880s)
[511.861410] [109/133] (511s left) gen9_exec_parse (bb-large)
[511.919426] Subtest bb-large: SKIP (0.000s)
[512.013323] [110/133] (511s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[512.122760] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[512.125053] Starting dynamic subtest: pipe-A-eDP-1
[512.181174] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[512.191104] Starting dynamic subtest: pipe-B-eDP-1
[512.247705] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[512.259088] Starting dynamic subtest: pipe-C-eDP-1
[512.316242] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[512.327895] Starting dynamic subtest: pipe-D-eDP-1
[512.388023] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[512.392338] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[514.269594] [111/133] (509s left) api_intel_bb (simple-bb-ctx)
[514.340339] Starting subtest: simple-bb-ctx
[514.350094] Subtest simple-bb-ctx: SUCCESS (0.010s)
[514.471319] [112/133] (509s left) gem_ctx_isolation (preservation-s3)
[514.542448] Starting subtest: preservation-S3
[514.544827] Starting dynamic subtest: rcs0
[530.949364] Dynamic subtest rcs0: SUCCESS (1.341s)
[530.959528] Starting dynamic subtest: bcs0
[546.941608] Dynamic subtest bcs0: SUCCESS (1.336s)
[546.951708] Starting dynamic subtest: vcs0
[562.936859] Dynamic subtest vcs0: SUCCESS (2.849s)
[562.947317] Starting dynamic subtest: vcs1
[580.939592] Dynamic subtest vcs1: SUCCESS (5.117s)
[580.949618] Starting dynamic subtest: vecs0
[598.944360] Dynamic subtest vecs0: SUCCESS (5.250s)
[598.955405] Starting dynamic subtest: ccs0
[616.940263] Dynamic subtest ccs0: SUCCESS (3.253s)
[616.943207] Subtest preservation-S3: SUCCESS (19.152s)
[617.165847] [113/133] (406s left) sriov_basic (enable-vfs-autoprobe-on)
[617.232567] Starting subtest: enable-vfs-autoprobe-on
[617.235716] Starting dynamic subtest: numvfs-1
[617.324726] Dynamic subtest numvfs-1: FAIL (0.025s)
[617.335970] Starting dynamic subtest: numvfs-2
[617.422336] Dynamic subtest numvfs-2: FAIL (0.004s)
[617.432236] Starting dynamic subtest: numvfs-3
[617.503311] Dynamic subtest numvfs-3: FAIL (0.004s)
[617.512219] Starting dynamic subtest: numvfs-4
[617.581652] Dynamic subtest numvfs-4: FAIL (0.004s)
[617.590276] Starting dynamic subtest: numvfs-5
[617.660716] Dynamic subtest numvfs-5: FAIL (0.003s)
[617.669412] Starting dynamic subtest: numvfs-6
[617.741373] Dynamic subtest numvfs-6: FAIL (0.003s)
[617.749939] Starting dynamic subtest: numvfs-7
[617.823778] Dynamic subtest numvfs-7: FAIL (0.003s)
[617.835286] Starting dynamic subtest: numvfs-random
[617.917166] Dynamic subtest numvfs-random: FAIL (0.003s)
[617.927149] Starting dynamic subtest: numvfs-all
[618.010237] Dynamic subtest numvfs-all: FAIL (0.536s)
[618.012740] Subtest enable-vfs-autoprobe-on: FAIL (0.593s)
[618.051816] [114/133] (405s left) perf_pmu (gt-awake)
[618.099296] Starting subtest: gt-awake
[626.678223] Subtest gt-awake: SUCCESS (8.766s)
[626.786347] [115/133] (397s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[626.856398] Subtest no-spare-fences-busy: SKIP (0.000s)
[626.929362] [116/133] (397s left) kms_rotation_crc (primary-rotation-90)
[627.027430] Starting subtest: primary-rotation-90
[627.032159] Subtest primary-rotation-90: SKIP (0.001s)
[627.075571] [117/133] (397s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[627.195174] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[627.945004] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.759s)
[628.097087] [118/133] (396s left) gem_mmap_wc (write-prefaulted)
[628.157913] Subtest write-prefaulted: SKIP (0.000s)
[628.223003] [119/133] (396s left) gem_pxp (reject-modify-context-protection-off-1)
[628.344371] Starting subtest: reject-modify-context-protection-off-1
[628.347753] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[628.444771] [120/133] (395s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[628.545208] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[628.547392] Starting dynamic subtest: pipe-A-eDP-1
[628.570471] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[628.581441] Starting dynamic subtest: pipe-B-eDP-1
[628.605420] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[628.622306] Starting dynamic subtest: pipe-C-eDP-1
[628.646002] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[628.660921] Starting dynamic subtest: pipe-D-eDP-1
[628.683172] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[628.685264] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[630.753750] [121/133] (393s left) kms_plane_lowres (tiling-x)
[630.849208] Starting subtest: tiling-x
[630.851772] Starting dynamic subtest: pipe-A-eDP-1
[630.856682] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[631.139238] Starting dynamic subtest: pipe-B-eDP-1
[631.144082] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[631.153652] Starting dynamic subtest: pipe-C-eDP-1
[631.158357] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[631.168235] Starting dynamic subtest: pipe-D-eDP-1
[631.173043] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[631.177440] Subtest tiling-x: SKIP (0.291s)
[631.980437] [122/133] (392s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[632.078108] Starting subtest: multiplane-rotation-cropping-top
[649.484078] Subtest multiplane-rotation-cropping-top: SUCCESS (17.449s)
[649.602967] [123/133] (374s left) gem_mmap_gtt (basic-write-read-distinct)
[649.656184] Subtest basic-write-read-distinct: SKIP (0.000s)
[649.727761] [124/133] (374s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[649.825021] Starting subtest: fbc-psr2-sprite-mmap-gtt
[649.827289] Starting dynamic subtest: eDP-1
[649.831730] Dynamic subtest eDP-1: SKIP (0.000s)
[649.835743] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[649.880649] [125/133] (374s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[649.979727] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[649.983981] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[650.022869] [126/133] (374s left) gem_tiled_partial_pwrite_pread (writes)
[650.087611] Subtest writes: SKIP (0.000s)
[650.201681] [127/133] (374s left) kms_atomic (crtc-invalid-params-fence)
[650.299918] Starting subtest: crtc-invalid-params-fence
[650.302201] Starting dynamic subtest: pipe-A-eDP-1
[650.698916] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.399s)
[650.701737] Subtest crtc-invalid-params-fence: SUCCESS (0.401s)
[651.486062] [128/133] (373s left) gem_busy (parallel)
[651.677379] Starting subtest: parallel
[651.680396] Starting dynamic subtest: rcs0
[653.685835] Dynamic subtest rcs0: SUCCESS (2.005s)
[653.699590] Starting dynamic subtest: bcs0
[655.670313] Dynamic subtest bcs0: SUCCESS (1.979s)
[655.683446] Starting dynamic subtest: vcs0
[657.718032] Dynamic subtest vcs0: SUCCESS (2.044s)
[657.731222] Starting dynamic subtest: vcs1
[659.702202] Dynamic subtest vcs1: SUCCESS (1.980s)
[659.715493] Starting dynamic subtest: vecs0
[661.687489] Dynamic subtest vecs0: SUCCESS (1.981s)
[661.701050] Starting dynamic subtest: ccs0
[663.670264] Dynamic subtest ccs0: SUCCESS (1.980s)
[663.673454] Subtest parallel: SUCCESS (11.986s)
[663.893224] [129/133] (360s left) gem_ctx_persistence (processes)
[663.965147] Starting subtest: processes
[665.749379] Subtest processes: SUCCESS (1.784s)
[665.804066] [130/133] (358s left) kms_big_fb (4-tiled-addfb-size-overflow)
[665.908477] Starting subtest: 4-tiled-addfb-size-overflow
[665.911287] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[666.004572] [131/133] (358s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[666.120369] Starting subtest: x-tiled-64bpp-rotate-270
[666.140713] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[666.256367] [132/133] (358s left) kms_plane_scaling (planes-scaler-unity-scaling)
[666.358913] Starting subtest: planes-scaler-unity-scaling
[666.361425] Starting dynamic subtest: pipe-A
[666.420226] Dynamic subtest pipe-A: SUCCESS (0.063s)
[666.431588] Starting dynamic subtest: pipe-B
[667.537313] Dynamic subtest pipe-B: SUCCESS (1.116s)
[667.547902] Starting dynamic subtest: pipe-C
[668.647470] Dynamic subtest pipe-C: SUCCESS (1.109s)
[668.661149] Starting dynamic subtest: pipe-D
[669.800069] Dynamic subtest pipe-D: SUCCESS (1.149s)
[669.802731] Subtest planes-scaler-unity-scaling: SUCCESS (3.443s)
[670.978212] [133/133] (353s left) gem_exec_whisper (basic-contexts)
[671.052727] Starting subtest: basic-contexts
[676.910955] Subtest basic-contexts: SUCCESS (5.857s)
[677.088034] 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.