[60.236015] Initializing watchdogs
[60.236098]   /dev/watchdog0
[60.250864] [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]
[60.255321] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.257541] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.260715] [001/133] (960s left) api_intel_allocator (gem-pool)
[60.343323] Starting subtest: gem-pool
[60.354394] Subtest gem-pool: SUCCESS (0.013s)
[60.493697] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[60.604453] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[60.608638] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[60.733319] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[60.830896] Starting subtest: read-crc-frame-sequence
[60.833192] Starting dynamic subtest: pipe-A-eDP-1
[61.583960] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.756s)
[61.592737] Starting dynamic subtest: pipe-B-eDP-1
[62.976015] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[62.987088] Starting dynamic subtest: pipe-C-eDP-1
[64.272436] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.302s)
[64.280607] Starting dynamic subtest: pipe-D-eDP-1
[65.589688] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[65.592040] Subtest read-crc-frame-sequence: SUCCESS (4.780s)
[66.417701] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[66.476869] Starting subtest: invalid-query-one-illegal-handle
[66.479204] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[66.580187] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[66.635201] Starting subtest: invalid-signal-zero-handles
[66.637596] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[66.767343] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[66.873607] Starting subtest: fbcpsr-rgb565-draw-render
[74.018574] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.156s)
[74.171732] [007/133] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[74.236869] Starting subtest: wait-for-submit-snapshot
[74.318238] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[74.415528] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[74.510497] Starting subtest: psr-rgb565-draw-blt
[81.569980] Subtest psr-rgb565-draw-blt: SUCCESS (7.064s)
[81.715788] [009/133] (939s left) kms_cursor_crc (cursor-onscreen-32x10)
[81.873995] Starting subtest: cursor-onscreen-32x10
[81.920631] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[82.224487] [010/133] (938s left) syncobj_wait (invalid-signal-illegal-handle)
[82.278048] Starting subtest: invalid-signal-illegal-handle
[82.280402] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[82.387409] [011/133] (938s left) testdisplay
[82.773229] [012/133] (938s left) prime_mmap (test_map_unmap)
[82.839177] Starting subtest: test_map_unmap
[82.841045] Starting dynamic subtest: test_map_unmap-smem
[82.871510] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[82.873563] Subtest test_map_unmap: SUCCESS (0.033s)
[82.974372] [013/133] (938s left) gem_exec_fence (syncobj-timeline-signal)
[83.528144] Starting subtest: syncobj-timeline-signal
[83.536543] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[84.987648] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[84.990900] [014/133] (936s left) syncobj_timeline (signal-point-0)
[85.039954] Starting subtest: signal-point-0
[85.041895] Subtest signal-point-0: SUCCESS (0.000s)
[85.147204] [015/133] (936s left) kms_psr (psr2-suspend)
[85.240778] Starting subtest: psr2-suspend
[85.243047] Starting dynamic subtest: eDP-1
[104.010858] Dynamic subtest eDP-1: SUCCESS (3.393s)
[104.013045] Subtest psr2-suspend: SUCCESS (3.394s)
[113.841395] [016/133] (916s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[113.952803] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[113.964903] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[114.031876] [017/133] (916s left) gem_softpin (reverse)
[114.094281] Starting subtest: reverse
[114.096571] Subtest reverse: SUCCESS (0.007s)
[114.252667] [018/133] (916s left) gem_exec_balancer (parallel-contexts)
[114.498283] Starting subtest: parallel-contexts
[116.955690] Subtest parallel-contexts: SUCCESS (2.539s)
[117.078949] [019/133] (913s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[117.171027] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[117.172967] Starting dynamic subtest: pipe-A-eDP-1
[119.312061] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.193s)
[119.321664] Starting dynamic subtest: pipe-B-eDP-1
[121.474457] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.199s)
[121.483189] Starting dynamic subtest: pipe-C-eDP-1
[123.536318] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.088s)
[123.545926] Starting dynamic subtest: pipe-D-eDP-1
[125.544378] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.027s)
[125.546661] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.511s)
[126.764106] [020/133] (903s left) kms_lease (lease-unleased-connector)
[126.864196] Starting subtest: lease-unleased-connector
[126.866542] Starting dynamic subtest: pipe-A-eDP-1
[126.871413] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[126.880639] Starting dynamic subtest: pipe-B-eDP-1
[126.882814] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[126.891423] Starting dynamic subtest: pipe-C-eDP-1
[126.893550] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[126.901942] Starting dynamic subtest: pipe-D-eDP-1
[126.904050] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[126.906231] Subtest lease-unleased-connector: SUCCESS (0.035s)
[127.040956] [021/133] (903s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[127.176699] Starting subtest: cursor-vs-flip-atomic-transitions
[156.992796] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.855s)
[157.842493] [022/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[157.940245] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[157.942563] Starting dynamic subtest: pipe-A-default-mode
[160.666345] Dynamic subtest pipe-A-default-mode: SUCCESS (2.725s)
[160.668548] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.726s)
[161.543356] [023/133] (869s left) kms_addfb_basic (legacy-format)
[161.598073] Starting subtest: legacy-format
[161.616340] Subtest legacy-format: SUCCESS (0.017s)
[161.779537] [024/133] (868s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[161.888974] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[161.892778] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[162.000697] [025/133] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[162.109070] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[162.112948] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[162.226210] [026/133] (868s left) kms_vblank (query-busy)
[162.321540] Starting subtest: query-busy
[162.323763] Starting dynamic subtest: pipe-A-eDP-1
[164.203494] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s)
[164.217422] Starting dynamic subtest: pipe-D-eDP-1
[166.794729] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.588s)
[166.796645] Subtest query-busy: SUCCESS (4.472s)
[167.612617] [027/133] (863s left) gem_wait (invalid-flags)
[167.679653] Starting subtest: invalid-flags
[167.682066] Subtest invalid-flags: SUCCESS (0.000s)
[167.895253] [028/133] (862s left) kms_properties (invalid-properties-atomic)
[167.981117] Starting subtest: invalid-properties-atomic
[168.295317] Subtest invalid-properties-atomic: SUCCESS (0.315s)
[168.392612] [029/133] (862s left) gem_exec_flush (basic-wb-ro-before-default)
[168.453686] Starting subtest: basic-wb-ro-before-default
[173.900993] Subtest basic-wb-ro-before-default: SUCCESS (5.448s)
[174.099664] [030/133] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[174.210921] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[174.214988] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[174.344683] [031/133] (856s left) kms_psr (pr-primary-blt)
[174.458242] Starting subtest: pr-primary-blt
[174.462603] Subtest pr-primary-blt: SKIP (0.000s)
[174.551194] [032/133] (856s left) kms_flip (2x-flip-vs-dpms-on-nop)
[174.652484] Starting subtest: 2x-flip-vs-dpms-on-nop
[174.665583] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.012s)
[174.758039] [033/133] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[174.857252] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[174.861312] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[174.985559] [034/133] (856s left) kms_chamelium_edid (dp-mode-timings)
[175.373649] Subtest dp-mode-timings: SKIP (0.000s)
[176.198708] [035/133] (854s left) kms_flip (flip-vs-panning-interruptible)
[176.308469] Starting subtest: flip-vs-panning-interruptible
[176.310739] Starting dynamic subtest: A-eDP1
[185.027990] Dynamic subtest A-eDP1: SUCCESS (8.720s)
[185.037888] Starting dynamic subtest: B-eDP1
[193.751727] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[193.763453] Starting dynamic subtest: C-eDP1
[202.473743] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[202.483873] Starting dynamic subtest: D-eDP1
[211.106757] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[211.111031] Subtest flip-vs-panning-interruptible: SUCCESS (34.808s)
[212.308100] [036/133] (818s left) kms_pm_dc (dc5-psr)
[213.412470] Starting subtest: dc5-psr
[216.289997] Subtest dc5-psr: SUCCESS (2.877s)
[217.125979] [037/133] (814s left) gem_userptr_blits (process-exit)
[217.194816] Starting subtest: process-exit
[217.203327] Subtest process-exit: SUCCESS (0.009s)
[217.357659] [038/133] (813s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[217.451922] Starting subtest: plane-lut1d-post-ctm3x4
[217.464982] Starting dynamic subtest: pipe-A-eDP-1
[218.173128] Dynamic subtest pipe-A-eDP-1: FAIL (0.349s)
[218.887458] Starting dynamic subtest: pipe-B-eDP-1
[219.700024] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[220.237825] Starting dynamic subtest: pipe-C-eDP-1
[221.090055] Dynamic subtest pipe-C-eDP-1: FAIL (0.280s)
[221.562088] Starting dynamic subtest: pipe-D-eDP-1
[222.397576] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[222.399918] Subtest plane-lut1d-post-ctm3x4: FAIL (4.659s)
[222.950580] [039/133] (808s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[223.014651] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[223.119625] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[223.207775] [040/133] (808s left) gem_mmap_offset (partial-remap)
[223.270443] Starting subtest: partial-remap
[223.272799] Starting dynamic subtest: smem0
[223.281316] Dynamic subtest smem0: SUCCESS (0.004s)
[223.283219] Subtest partial-remap: SUCCESS (0.005s)
[223.422816] [041/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[223.536982] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[223.541379] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[223.650190] [042/133] (807s left) gem_userptr_blits (dmabuf-unsync)
[223.717992] Subtest dmabuf-unsync: SKIP (0.000s)
[223.889480] [043/133] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[223.984755] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[223.988710] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[224.109409] [044/133] (807s left) gem_close_race (multigpu-basic-threads)
[224.174734] Starting subtest: multigpu-basic-threads
[224.178293] Subtest multigpu-basic-threads: SKIP (0.000s)
[224.417849] [045/133] (807s left) gem_exec_schedule (preempt)
[224.496464] Starting subtest: preempt
[224.498402] Starting dynamic subtest: rcs0
[224.514278] Dynamic subtest rcs0: SUCCESS (0.021s)
[224.525615] Starting dynamic subtest: bcs0
[224.532792] Dynamic subtest bcs0: SUCCESS (0.018s)
[224.540880] Starting dynamic subtest: vcs0
[224.551993] Dynamic subtest vcs0: SUCCESS (0.019s)
[224.560240] Starting dynamic subtest: vcs1
[224.573189] Dynamic subtest vcs1: SUCCESS (0.020s)
[224.581286] Starting dynamic subtest: vecs0
[224.593424] Dynamic subtest vecs0: SUCCESS (0.019s)
[224.601602] Starting dynamic subtest: ccs0
[224.613895] Dynamic subtest ccs0: SUCCESS (0.020s)
[224.616005] Subtest preempt: SUCCESS (0.122s)
[226.400210] [046/133] (805s left) i915_module_load (reload)
[226.430339] Starting subtest: reload
[231.396120] Subtest reload: SUCCESS (4.966s)
[231.436317] [047/133] (800s left) gem_exec_reloc (basic-wc-cpu-active)
[233.234970] Subtest basic-wc-cpu-active: SKIP (0.000s)
[233.357032] [048/133] (798s left) gen9_exec_parse (valid-registers)
[233.421587] Subtest valid-registers: SKIP (0.000s)
[233.511029] [049/133] (798s left) kms_cursor_edge_walk (64x64-left-edge)
[233.616228] Starting subtest: 64x64-left-edge
[233.618393] Starting dynamic subtest: pipe-A-eDP-1
[237.087439] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.472s)
[237.096708] Starting dynamic subtest: pipe-D-eDP-1
[240.216033] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[240.218801] Subtest 64x64-left-edge: SUCCESS (6.601s)
[241.051395] [050/133] (790s left) gem_render_copy_redux (flink)
[241.110730] Starting subtest: flink
[241.834058] Subtest flink: SUCCESS (0.723s)
[241.994839] [051/133] (789s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[242.098541] Starting subtest: psr-2p-primscrn-spr-indfb-move
[242.102017] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[242.236525] [052/133] (789s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[242.365103] Starting subtest: bo-too-small-due-to-tiling
[242.368473] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[242.503921] [053/133] (789s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[242.598272] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[249.240597] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.643s)
[249.407524] [054/133] (782s left) gem_exec_reloc (basic-write-wc-active)
[249.478483] Subtest basic-write-wc-active: SKIP (0.000s)
[249.553601] [055/133] (782s left) gem_fenced_exec_thrash (2-spare-fences)
[249.606427] Subtest 2-spare-fences: SKIP (0.000s)
[249.692214] [056/133] (782s left) kms_hdr (static-toggle-dpms)
[249.794157] Starting subtest: static-toggle-dpms
[249.800607] Subtest static-toggle-dpms: SKIP (0.000s)
[249.894139] [057/133] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[249.997555] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[257.028065] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.034s)
[257.177639] [058/133] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[257.283821] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[261.066271] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.786s)
[262.203255] [059/133] (769s left) gem_lmem_swapping (parallel-random-verify)
[262.248366] Subtest parallel-random-verify: SKIP (0.000s)
[262.290324] [060/133] (769s left) kms_psr (fbc-pr-sprite-plane-move)
[262.397440] Starting subtest: fbc-pr-sprite-plane-move
[262.401450] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[262.483590] [061/133] (769s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[262.880451] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[263.690301] [062/133] (768s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[263.792383] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[263.794712] Starting dynamic subtest: pipe-A-eDP-1
[263.820592] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[263.830675] Starting dynamic subtest: pipe-B-eDP-1
[263.854671] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[263.863677] Starting dynamic subtest: pipe-C-eDP-1
[263.888462] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[263.898432] Starting dynamic subtest: pipe-D-eDP-1
[263.922711] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[263.926863] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[265.996253] [063/133] (766s left) i915_pm_rpm (gem-evict-pwrite)
[267.533077] Starting subtest: gem-evict-pwrite
[267.538331] Subtest gem-evict-pwrite: SKIP (0.000s)
[268.258762] [064/133] (764s left) gem_exec_whisper (basic-sync)
[268.326226] Starting subtest: basic-sync
[274.992773] Subtest basic-sync: SUCCESS (6.667s)
[275.192089] [065/133] (757s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[275.319504] Starting subtest: short-busy-flip-before-cursor-toggle
[275.323856] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[275.478329] [066/133] (756s left) i915_query (hwconfig_table)
[275.542238] Starting subtest: hwconfig_table
[275.836873] Subtest hwconfig_table: SUCCESS (0.002s)
[275.876165] [067/133] (756s left) kms_vrr (flipline)
[275.976483] Starting subtest: flipline
[275.983049] Subtest flipline: SKIP (0.000s)
[276.061603] [068/133] (756s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[276.166345] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[280.388764] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.224s)
[281.543106] [069/133] (751s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[281.646524] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[281.659779] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[281.729092] [070/133] (750s left) kms_prop_blob (invalid-set-prop)
[281.781466] Starting subtest: invalid-set-prop
[281.783676] Subtest invalid-set-prop: SUCCESS (0.000s)
[281.914861] [071/133] (750s left) kms_properties (crtc-properties-legacy)
[282.007419] Starting subtest: crtc-properties-legacy
[282.009699] Starting dynamic subtest: pipe-A-eDP-1
[282.448656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[282.458688] Starting dynamic subtest: pipe-B-eDP-1
[283.577452] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.126s)
[283.589217] Starting dynamic subtest: pipe-C-eDP-1
[284.690902] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[284.699448] Starting dynamic subtest: pipe-D-eDP-1
[285.820785] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[285.823007] Subtest crtc-properties-legacy: SUCCESS (3.816s)
[286.652664] [072/133] (746s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[286.770046] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[293.680544] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.915s)
[293.867855] [073/133] (738s left) kms_psr (fbc-pr-cursor-render)
[293.968942] Starting subtest: fbc-pr-cursor-render
[293.972843] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[294.053165] [074/133] (738s left) gem_userptr_blits (huge-split)
[294.137157] Starting subtest: huge-split
[294.144211] Subtest huge-split: SUCCESS (0.007s)
[294.305517] [075/133] (738s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[294.556874] Starting subtest: cursor-rapid-movement-256x85
[294.603137] Subtest cursor-rapid-movement-256x85: SKIP (0.042s)
[294.789111] [076/133] (738s left) gem_unref_active_buffers
[295.023683] [077/133] (737s left) gem_caching (reads)
[295.099732] Subtest reads: SKIP (0.000s)
[295.175003] [078/133] (737s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[295.241056] Starting subtest: invalid-multi-wait-all-unsubmitted
[295.243029] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[295.362864] [079/133] (737s left) gem_exec_create (basic)
[295.427981] Starting subtest: basic
[295.430010] Starting dynamic subtest: smem
[299.299322] Dynamic subtest smem: SUCCESS (3.870s)
[299.302069] Subtest basic: SUCCESS (3.872s)
[299.498080] [080/133] (733s left) kms_content_protection (atomic-dpms-hdcp14)
[299.642741] Starting subtest: atomic-dpms-hdcp14
[299.647219] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[299.809510] [081/133] (733s left) sw_sync (timeline_closed)
[299.843110] Starting subtest: timeline_closed
[299.845335] Subtest timeline_closed: SUCCESS (0.000s)
[299.911738] [082/133] (733s left) perf (oa-exponents)
[300.062713] Starting subtest: oa-exponents
[300.064624] Starting dynamic subtest: 0-rcs0
[301.828057] Dynamic subtest 0-rcs0: SUCCESS (1.765s)
[301.837700] Starting dynamic subtest: 1-vcs1
[303.657793] Dynamic subtest 1-vcs1: SUCCESS (1.830s)
[303.660092] Subtest oa-exponents: SUCCESS (3.596s)
[303.707558] [083/133] (729s left) kms_feature_discovery (display-2x)
[303.800258] Starting subtest: display-2x
[303.804663] Subtest display-2x: SKIP (0.000s)
[303.885088] [084/133] (729s left) core_setmaster (master-drop-set-root)
[303.978543] Starting subtest: master-drop-set-root
[303.990300] Subtest master-drop-set-root: SUCCESS (0.012s)
[304.041113] [085/133] (729s left) kms_pm_rpm (i2c)
[305.555881] Starting subtest: i2c
[311.213989] Subtest i2c: SUCCESS (5.661s)
[311.333522] [086/133] (721s left) kms_busy (basic-hang)
[311.447387] Starting subtest: basic-hang
[311.449593] Starting dynamic subtest: flip-pipe-A
[312.050254] Dynamic subtest flip-pipe-A: SUCCESS (0.601s)
[312.059971] Starting dynamic subtest: modeset-pipe-A
[315.747845] Dynamic subtest modeset-pipe-A: SUCCESS (3.698s)
[315.760718] Starting dynamic subtest: flip-pipe-D
[316.939108] Dynamic subtest flip-pipe-D: SUCCESS (1.190s)
[316.948575] Starting dynamic subtest: modeset-pipe-D
[320.377816] Dynamic subtest modeset-pipe-D: SUCCESS (3.436s)
[320.380118] Subtest basic-hang: SUCCESS (8.933s)
[321.197015] [087/133] (712s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[321.300102] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[321.304301] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[321.446561] [088/133] (711s left) kms_flip (nonblocking-read)
[321.545904] Starting subtest: nonblocking-read
[321.550023] Subtest nonblocking-read: SUCCESS (0.000s)
[321.685981] [089/133] (711s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[321.793055] Starting subtest: yf-tiled-16bpp-rotate-270
[321.797512] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[321.933639] [090/133] (711s left) gem_mmap_wc (write-read-distinct)
[321.990837] Subtest write-read-distinct: SKIP (0.000s)
[322.061280] [091/133] (711s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[322.109521] Starting subtest: multi-wait-for-submit-submitted-signaled
[322.111496] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[322.237713] [092/133] (711s left) kms_flip (blocking-wf_vblank)
[322.330017] Starting subtest: blocking-wf_vblank
[322.332020] Starting dynamic subtest: A-eDP1
[331.231681] Dynamic subtest A-eDP1: SUCCESS (8.904s)
[331.240828] Starting dynamic subtest: B-eDP1
[340.160255] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[340.169090] Starting dynamic subtest: C-eDP1
[349.074189] Dynamic subtest C-eDP1: SUCCESS (8.907s)
[349.089192] Starting dynamic subtest: D-eDP1
[358.010986] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[358.016286] Subtest blocking-wf_vblank: SUCCESS (35.681s)
[359.240802] [093/133] (674s left) gem_exec_alignment (pi)
[359.317003] Starting subtest: pi
[410.735041] Subtest pi: SUCCESS (51.408s)
[411.889620] [094/133] (621s left) kms_getfb (getfb-repeated-different-handles)
[412.038042] Starting subtest: getfb-repeated-different-handles
[412.040303] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[412.160385] [095/133] (621s left) syncobj_timeline (etime-multi-wait-submitted)
[412.229113] Starting subtest: etime-multi-wait-submitted
[412.335593] Subtest etime-multi-wait-submitted: SUCCESS (0.107s)
[412.423346] [096/133] (621s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[412.551427] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[413.564914] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.010s)
[414.376145] [097/133] (619s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[414.479867] Starting subtest: primary-yf-tiled-reflect-x-0
[414.542414] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.062s)
[414.661774] [098/133] (619s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[414.730012] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[414.831138] [099/133] (619s left) perf_pmu (rc6)
[414.868032] Starting subtest: rc6
[414.870389] Starting dynamic subtest: gt0
[421.255405] Dynamic subtest gt0: SUCCESS (6.385s)
[421.268091] Starting dynamic subtest: runtime-pm-gt0
[429.045581] Dynamic subtest runtime-pm-gt0: SUCCESS (7.787s)
[429.058241] Starting dynamic subtest: runtime-pm-long-gt0
[441.526538] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.479s)
[441.537722] Starting dynamic subtest: other-idle-gt0
[447.871784] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[447.884521] Starting dynamic subtest: gt1
[454.212927] Dynamic subtest gt1: SUCCESS (6.339s)
[454.224123] Starting dynamic subtest: runtime-pm-gt1
[461.646060] Dynamic subtest runtime-pm-gt1: SUCCESS (7.431s)
[461.657226] Starting dynamic subtest: runtime-pm-long-gt1
[474.069651] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.422s)
[474.082214] Starting dynamic subtest: other-idle-gt1
[480.411094] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[480.413926] Subtest rc6: SUCCESS (65.544s)
[481.556659] [100/133] (552s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[481.668421] Starting subtest: y-tiled-16bpp-rotate-0
[481.672309] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[481.738034] [101/133] (552s left) kms_flip_tiling (flip-change-tiling)
[481.835608] Starting subtest: flip-change-tiling
[481.837610] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[482.008578] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.174s)
[482.024818] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[482.143532] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[482.155229] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[482.277144] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[482.289245] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[482.420380] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[482.433107] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[482.564087] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[482.576937] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[482.708473] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[482.720531] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[482.842740] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[482.855400] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[482.953187] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[482.965506] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[483.088199] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[483.100668] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[483.231872] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[483.244489] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[483.375390] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[483.388030] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[483.519590] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[483.531890] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[483.653614] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[483.669200] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[483.788136] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.130s)
[483.800266] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[483.898205] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[483.910668] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[484.043015] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[484.054246] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[484.186857] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[484.199353] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[484.330900] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[484.343297] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[484.476011] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[484.487733] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[484.620153] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[484.633211] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[484.764705] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[484.777721] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[484.886060] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[484.898702] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[485.030292] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[485.044951] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[485.175523] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[485.188211] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[485.319432] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[485.333287] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[485.463816] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[485.477682] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[485.608253] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[485.622682] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[485.752493] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[485.766606] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[485.874657] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[485.889156] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[486.019658] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[486.031206] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[486.163426] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[486.178475] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[486.307958] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[486.322581] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[486.453255] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[486.465480] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[486.596831] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[486.611922] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[486.741722] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[486.753903] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[486.891319] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.147s)
[486.944675] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[488.139828] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.202s)
[488.152237] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[488.273926] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[488.286141] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[488.407217] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[488.419835] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[488.550585] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[488.563096] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[488.694736] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[488.707014] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[488.839714] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[488.855262] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[488.984224] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s)
[488.996389] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[489.095473] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[489.107898] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[489.229164] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[489.241500] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[489.372898] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[489.385311] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[489.516577] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[489.528604] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[489.661113] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[489.672640] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[489.795129] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[489.805949] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[489.929412] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[489.940233] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[490.039814] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[490.051420] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[490.183673] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[490.200075] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[490.327653] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s)
[490.342835] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[490.472191] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[490.487656] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[490.605932] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[490.618260] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[490.739644] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s)
[490.752924] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[490.884072] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[490.896849] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[491.005605] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[491.017877] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[491.149639] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[491.163760] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[491.294360] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[491.305027] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[491.438681] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[491.452143] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[491.583146] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[491.598020] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[491.727485] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[491.739514] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[491.872027] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[491.883008] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[491.994494] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[492.006675] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[492.138926] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[492.151489] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[492.283063] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[492.297527] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[492.427482] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[492.439531] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[492.571953] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[492.586367] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[492.716206] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[492.729418] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[492.861329] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[492.872513] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[492.983382] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[493.035644] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[494.262717] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.234s)
[494.275250] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[494.362115] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[494.374533] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[494.462420] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[494.474198] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[494.573500] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.108s)
[494.586094] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[494.684251] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[494.695344] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[494.795461] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[494.807685] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[494.895446] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[494.907906] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[494.995720] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[495.007565] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[495.106779] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[495.116583] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[495.217405] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[495.229052] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[495.328289] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[495.340046] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[495.439452] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[495.450891] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[495.539232] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[495.552851] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[495.651050] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.109s)
[495.663500] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[495.751193] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[495.763390] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[495.850742] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.098s)
[495.863056] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[495.961407] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[495.972611] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[496.072734] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[496.084029] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[496.183585] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[496.197652] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[496.283859] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[496.295448] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[496.384000] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[496.395967] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[496.495020] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[496.508982] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[496.605900] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[496.617278] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[496.717011] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[496.731508] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[496.828282] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[496.839599] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[496.939033] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[496.950333] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[497.050126] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[497.064692] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[497.161420] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[497.172800] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[497.272313] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[497.285133] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[497.384038] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[497.396239] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[497.494489] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[497.509641] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[497.605851] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[497.618226] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[497.716947] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[497.731706] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[497.827887] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s)
[497.839641] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[497.939426] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[497.951795] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[498.050559] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[498.092402] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[499.287260] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.202s)
[499.298941] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[499.387248] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[499.399760] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[499.486925] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[499.499902] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[499.597640] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[499.610885] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[499.708691] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[499.720607] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[499.819636] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[499.831905] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[499.920120] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[499.932148] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[500.020164] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[500.032202] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[500.120424] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[500.131837] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[500.230729] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[500.242754] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[500.341315] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[500.355367] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[500.452637] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[500.464051] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[500.552376] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[500.564162] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[500.652710] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[500.663837] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[500.752714] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[500.763482] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[500.863879] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[500.874618] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[500.974859] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[500.986242] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[501.085725] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[501.096472] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[501.197105] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[501.211536] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[501.309261] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[501.328403] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[501.419590] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[501.431798] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[501.530662] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[501.545685] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[501.641093] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[501.653517] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[501.752366] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[501.764657] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[501.863504] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[501.875390] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[501.963318] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[501.975463] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[502.074509] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[502.086432] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[502.185593] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s)
[502.199216] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[502.296877] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[502.309118] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[502.408330] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[502.421295] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[502.519224] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[502.529631] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[502.630027] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[502.644213] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[502.741329] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[502.753400] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[502.852162] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s)
[502.866212] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[502.963570] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[502.976082] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[503.074836] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[503.107990] Subtest flip-change-tiling: SUCCESS (21.276s)
[504.266582] [102/133] (529s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[504.378205] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[504.382691] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[504.471945] [103/133] (529s left) gem_exec_fence (submit-chain)
[504.669582] Starting subtest: submit-chain
[504.685358] Subtest submit-chain: SUCCESS (0.019s)
[506.368356] [104/133] (527s left) gem_ringfill (engines-basic)
[512.295409] Starting subtest: engines-basic
[512.297910] Starting dynamic subtest: rcs0
[512.383239] Dynamic subtest rcs0: SUCCESS (0.088s)
[512.395573] Starting dynamic subtest: bcs0
[512.430505] Dynamic subtest bcs0: SUCCESS (0.046s)
[512.441822] Starting dynamic subtest: vcs0
[512.474065] Dynamic subtest vcs0: SUCCESS (0.042s)
[512.484978] Starting dynamic subtest: vcs1
[512.518085] Dynamic subtest vcs1: SUCCESS (0.042s)
[512.528825] Starting dynamic subtest: vecs0
[512.562117] Dynamic subtest vecs0: SUCCESS (0.042s)
[512.573067] Starting dynamic subtest: ccs0
[512.609144] Dynamic subtest ccs0: SUCCESS (0.045s)
[512.611473] Subtest engines-basic: SUCCESS (0.317s)
[512.668572] [105/133] (521s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[512.771873] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[512.774112] Starting dynamic subtest: pipe-A-eDP-1
[512.793296] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[512.803335] Starting dynamic subtest: pipe-B-eDP-1
[512.822085] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[512.831600] Starting dynamic subtest: pipe-C-eDP-1
[512.849900] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[512.858905] Starting dynamic subtest: pipe-D-eDP-1
[512.877247] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[512.879297] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[514.944849] [106/133] (519s left) perf_pmu (busy-check-all)
[514.984909] Starting subtest: busy-check-all
[514.986760] Starting dynamic subtest: rcs0
[515.532299] Dynamic subtest rcs0: SUCCESS (0.549s)
[515.545679] Starting dynamic subtest: bcs0
[516.083881] Dynamic subtest bcs0: SUCCESS (0.549s)
[516.096133] Starting dynamic subtest: vcs0
[517.283471] Dynamic subtest vcs0: SUCCESS (1.196s)
[517.295748] Starting dynamic subtest: vcs1
[519.267636] Dynamic subtest vcs1: SUCCESS (1.982s)
[519.280047] Starting dynamic subtest: vecs0
[521.253500] Dynamic subtest vecs0: SUCCESS (1.983s)
[521.265453] Starting dynamic subtest: ccs0
[521.808337] Dynamic subtest ccs0: SUCCESS (0.554s)
[521.810820] Subtest busy-check-all: SUCCESS (6.828s)
[521.902667] [107/133] (512s left) gem_exec_schedule (submit-early-slice)
[521.977223] Starting subtest: submit-early-slice
[521.979747] Starting dynamic subtest: rcs0
[522.034452] Dynamic subtest rcs0: SUCCESS (0.063s)
[522.048629] Starting dynamic subtest: bcs0
[522.082926] Dynamic subtest bcs0: SUCCESS (0.048s)
[522.092393] Starting dynamic subtest: vcs0
[522.137643] Dynamic subtest vcs0: SUCCESS (0.054s)
[522.147654] Starting dynamic subtest: vcs1
[522.191793] Dynamic subtest vcs1: SUCCESS (0.053s)
[522.204483] Starting dynamic subtest: vecs0
[522.237614] Dynamic subtest vecs0: SUCCESS (0.045s)
[522.249692] Starting dynamic subtest: ccs0
[522.290098] Dynamic subtest ccs0: SUCCESS (0.052s)
[522.292526] Subtest submit-early-slice: SUCCESS (0.320s)
[523.387998] [108/133] (510s left) gem_exec_balancer (parallel-bb-first)
[523.657895] Starting subtest: parallel-bb-first
[524.596548] Subtest parallel-bb-first: SUCCESS (0.938s)
[525.244676] [109/133] (509s left) gen9_exec_parse (bb-large)
[525.312094] Subtest bb-large: SKIP (0.000s)
[525.399021] [110/133] (508s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[525.514024] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[525.516320] Starting dynamic subtest: pipe-A-eDP-1
[525.574506] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[525.585839] Starting dynamic subtest: pipe-B-eDP-1
[525.642602] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[525.653943] Starting dynamic subtest: pipe-C-eDP-1
[525.710393] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[525.721148] Starting dynamic subtest: pipe-D-eDP-1
[525.778473] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[525.782678] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[527.803582] [111/133] (506s left) api_intel_bb (simple-bb-ctx)
[527.864361] Starting subtest: simple-bb-ctx
[527.870321] Subtest simple-bb-ctx: SUCCESS (0.007s)
[527.995798] [112/133] (506s left) gem_ctx_isolation (preservation-s3)
[528.071554] Starting subtest: preservation-S3
[528.073492] Starting dynamic subtest: rcs0
[544.627561] Dynamic subtest rcs0: SUCCESS (1.754s)
[544.638413] Starting dynamic subtest: bcs0
[561.626822] Dynamic subtest bcs0: SUCCESS (1.695s)
[561.636768] Starting dynamic subtest: vcs0
[578.627234] Dynamic subtest vcs0: SUCCESS (3.229s)
[578.637272] Starting dynamic subtest: vcs1
[596.624877] Dynamic subtest vcs1: SUCCESS (4.037s)
[596.635999] Starting dynamic subtest: vecs0
[614.612243] Dynamic subtest vecs0: SUCCESS (4.964s)
[614.622480] Starting dynamic subtest: ccs0
[632.624382] Dynamic subtest ccs0: SUCCESS (3.196s)
[632.626699] Subtest preservation-S3: SUCCESS (18.881s)
[644.872863] [113/133] (401s left) sriov_basic (enable-vfs-autoprobe-on)
[644.946274] Starting subtest: enable-vfs-autoprobe-on
[644.948169] Starting dynamic subtest: numvfs-1
[645.023041] Dynamic subtest numvfs-1: FAIL (0.027s)
[645.034679] Starting dynamic subtest: numvfs-2
[645.104539] Dynamic subtest numvfs-2: FAIL (0.004s)
[645.115297] Starting dynamic subtest: numvfs-3
[645.184854] Dynamic subtest numvfs-3: FAIL (0.004s)
[645.195632] Starting dynamic subtest: numvfs-4
[645.264138] Dynamic subtest numvfs-4: FAIL (0.004s)
[645.275442] Starting dynamic subtest: numvfs-5
[645.344609] Dynamic subtest numvfs-5: FAIL (0.004s)
[645.354940] Starting dynamic subtest: numvfs-6
[645.424493] Dynamic subtest numvfs-6: FAIL (0.004s)
[645.435378] Starting dynamic subtest: numvfs-7
[645.504433] Dynamic subtest numvfs-7: FAIL (0.004s)
[645.515109] Starting dynamic subtest: numvfs-random
[645.583069] Dynamic subtest numvfs-random: FAIL (0.004s)
[645.593681] Starting dynamic subtest: numvfs-all
[645.661932] Dynamic subtest numvfs-all: FAIL (0.513s)
[645.664315] Subtest enable-vfs-autoprobe-on: FAIL (0.572s)
[645.701610] [114/133] (400s left) perf_pmu (gt-awake)
[645.740284] Starting subtest: gt-awake
[653.969466] Subtest gt-awake: SUCCESS (8.402s)
[654.043616] [115/133] (392s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[654.100938] Subtest no-spare-fences-busy: SKIP (0.000s)
[654.176666] [116/133] (392s left) kms_rotation_crc (primary-rotation-90)
[654.272028] Starting subtest: primary-rotation-90
[654.276163] Subtest primary-rotation-90: SKIP (0.001s)
[654.322917] [117/133] (392s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[654.423690] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[655.195643] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.781s)
[655.383223] [118/133] (391s left) gem_mmap_wc (write-prefaulted)
[655.455402] Subtest write-prefaulted: SKIP (0.000s)
[655.533676] [119/133] (391s left) gem_pxp (reject-modify-context-protection-off-1)
[655.652183] Starting subtest: reject-modify-context-protection-off-1
[655.654692] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[655.759791] [120/133] (390s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[655.862274] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[655.864601] Starting dynamic subtest: pipe-A-eDP-1
[655.885124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[655.896376] Starting dynamic subtest: pipe-B-eDP-1
[655.916867] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[655.926854] Starting dynamic subtest: pipe-C-eDP-1
[655.946636] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[655.956517] Starting dynamic subtest: pipe-D-eDP-1
[655.977426] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[655.979672] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.095s)
[658.141680] [121/133] (388s left) kms_plane_lowres (tiling-x)
[658.231250] Starting subtest: tiling-x
[658.233600] Starting dynamic subtest: pipe-A-eDP-1
[658.238162] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[658.534934] Starting dynamic subtest: pipe-B-eDP-1
[658.540202] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[658.552611] Starting dynamic subtest: pipe-C-eDP-1
[658.557114] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[658.566387] Starting dynamic subtest: pipe-D-eDP-1
[658.570355] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[658.574220] Subtest tiling-x: SKIP (0.298s)
[659.363567] [122/133] (387s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[659.455737] Starting subtest: multiplane-rotation-cropping-top
[676.791882] Subtest multiplane-rotation-cropping-top: SUCCESS (17.382s)
[676.923617] [123/133] (369s left) gem_mmap_gtt (basic-write-read-distinct)
[676.977262] Subtest basic-write-read-distinct: SKIP (0.000s)
[677.042542] [124/133] (369s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[677.133991] Starting subtest: fbc-psr2-sprite-mmap-gtt
[677.135843] Starting dynamic subtest: eDP-1
[677.139156] Dynamic subtest eDP-1: SKIP (0.000s)
[677.142435] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[677.181995] [125/133] (369s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[677.286900] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[677.290346] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[677.330831] [126/133] (369s left) gem_tiled_partial_pwrite_pread (writes)
[677.381949] Subtest writes: SKIP (0.000s)
[677.474474] [127/133] (369s left) kms_atomic (crtc-invalid-params-fence)
[677.560186] Starting subtest: crtc-invalid-params-fence
[677.562363] Starting dynamic subtest: pipe-A-eDP-1
[677.970951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s)
[677.973159] Subtest crtc-invalid-params-fence: SUCCESS (0.412s)
[678.753002] [128/133] (368s left) gem_busy (parallel)
[678.942751] Starting subtest: parallel
[678.945343] Starting dynamic subtest: rcs0
[680.978570] Dynamic subtest rcs0: SUCCESS (2.033s)
[680.992807] Starting dynamic subtest: bcs0
[682.961382] Dynamic subtest bcs0: SUCCESS (1.979s)
[682.974961] Starting dynamic subtest: vcs0
[684.945345] Dynamic subtest vcs0: SUCCESS (1.981s)
[684.956880] Starting dynamic subtest: vcs1
[686.993385] Dynamic subtest vcs1: SUCCESS (2.044s)
[687.005351] Starting dynamic subtest: vecs0
[688.912805] Dynamic subtest vecs0: SUCCESS (1.916s)
[688.925361] Starting dynamic subtest: ccs0
[690.961947] Dynamic subtest ccs0: SUCCESS (2.046s)
[690.964777] Subtest parallel: SUCCESS (12.015s)
[691.202165] [129/133] (355s left) gem_ctx_persistence (processes)
[691.262469] Starting subtest: processes
[692.970879] Subtest processes: SUCCESS (1.708s)
[693.028172] [130/133] (354s left) kms_big_fb (4-tiled-addfb-size-overflow)
[693.158577] Starting subtest: 4-tiled-addfb-size-overflow
[693.160433] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[693.247838] [131/133] (353s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[693.367410] Starting subtest: x-tiled-64bpp-rotate-270
[693.388976] Subtest x-tiled-64bpp-rotate-270: SKIP (0.021s)
[693.481599] [132/133] (353s left) kms_plane_scaling (planes-scaler-unity-scaling)
[693.572114] Starting subtest: planes-scaler-unity-scaling
[693.574374] Starting dynamic subtest: pipe-A
[693.634259] Dynamic subtest pipe-A: SUCCESS (0.064s)
[693.647755] Starting dynamic subtest: pipe-B
[694.804123] Dynamic subtest pipe-B: SUCCESS (1.167s)
[694.817029] Starting dynamic subtest: pipe-C
[695.907668] Dynamic subtest pipe-C: SUCCESS (1.103s)
[695.920759] Starting dynamic subtest: pipe-D
[697.037455] Dynamic subtest pipe-D: SUCCESS (1.129s)
[697.039649] Subtest planes-scaler-unity-scaling: SUCCESS (3.468s)
[698.186424] [133/133] (349s left) gem_exec_whisper (basic-contexts)
[698.263140] Starting subtest: basic-contexts
[705.902510] Subtest basic-contexts: SUCCESS (7.638s)
[706.066005] 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.