[59.220353] Initializing watchdogs
[59.220396]   /dev/watchdog0
[59.234800] [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.239068] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.241407] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.245206] [001/133] (960s left) api_intel_allocator (gem-pool)
[59.332914] Starting subtest: gem-pool
[59.345813] Subtest gem-pool: SUCCESS (0.014s)
[59.453773] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[59.573757] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[59.577976] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[59.700858] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[59.801966] Starting subtest: read-crc-frame-sequence
[59.803995] Starting dynamic subtest: pipe-A-eDP-1
[60.520231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[60.529740] Starting dynamic subtest: pipe-B-eDP-1
[61.904821] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[61.913446] Starting dynamic subtest: pipe-C-eDP-1
[63.209480] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s)
[63.218199] Starting dynamic subtest: pipe-D-eDP-1
[64.555958] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[64.558432] Subtest read-crc-frame-sequence: SUCCESS (4.738s)
[65.378286] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[65.441890] Starting subtest: invalid-query-one-illegal-handle
[65.444316] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[65.562582] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[65.618602] Starting subtest: invalid-signal-zero-handles
[65.620905] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[65.739856] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[65.841178] Starting subtest: fbcpsr-rgb565-draw-render
[72.909418] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.062s)
[73.065730] [007/133] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[73.131699] Starting subtest: wait-for-submit-snapshot
[73.212626] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[73.294536] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[73.397885] Starting subtest: psr-rgb565-draw-blt
[80.462332] Subtest psr-rgb565-draw-blt: SUCCESS (7.063s)
[80.626842] [009/133] (939s left) kms_cursor_crc (cursor-onscreen-32x10)
[80.786506] Starting subtest: cursor-onscreen-32x10
[80.831839] Subtest cursor-onscreen-32x10: SKIP (0.041s)
[81.105184] [010/133] (938s left) syncobj_wait (invalid-signal-illegal-handle)
[81.163696] Starting subtest: invalid-signal-illegal-handle
[81.166029] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[81.281242] [011/133] (938s left) testdisplay
[81.645748] [012/133] (938s left) prime_mmap (test_map_unmap)
[81.707998] Starting subtest: test_map_unmap
[81.709939] Starting dynamic subtest: test_map_unmap-smem
[81.739081] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[81.741287] Subtest test_map_unmap: SUCCESS (0.032s)
[81.878212] [013/133] (938s left) gem_exec_fence (syncobj-timeline-signal)
[82.440215] Starting subtest: syncobj-timeline-signal
[82.445314] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[84.002866] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[84.006198] [014/133] (936s left) syncobj_timeline (signal-point-0)
[84.061939] Starting subtest: signal-point-0
[84.064355] Subtest signal-point-0: SUCCESS (0.000s)
[84.187223] [015/133] (936s left) kms_psr (psr2-suspend)
[84.290064] Starting subtest: psr2-suspend
[84.292428] Starting dynamic subtest: eDP-1
[101.410996] Dynamic subtest eDP-1: SUCCESS (2.999s)
[101.413540] Subtest psr2-suspend: SUCCESS (3.000s)
[102.243201] [016/133] (918s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[102.368186] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[102.384127] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[102.454645] [017/133] (917s left) gem_softpin (reverse)
[102.523130] Starting subtest: reverse
[102.530539] Subtest reverse: SUCCESS (0.008s)
[102.681625] [018/133] (917s left) gem_exec_balancer (parallel-contexts)
[102.945522] Starting subtest: parallel-contexts
[105.540274] Subtest parallel-contexts: SUCCESS (2.539s)
[105.655718] [019/133] (914s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[105.761236] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[105.764275] Starting dynamic subtest: pipe-A-eDP-1
[107.863666] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.072s)
[107.872189] Starting dynamic subtest: pipe-B-eDP-1
[110.099454] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.209s)
[110.110272] Starting dynamic subtest: pipe-C-eDP-1
[112.119011] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.998s)
[112.128870] Starting dynamic subtest: pipe-D-eDP-1
[114.165097] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.033s)
[114.167673] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.317s)
[115.336491] [020/133] (905s left) kms_lease (lease-unleased-connector)
[115.433985] Starting subtest: lease-unleased-connector
[115.436537] Starting dynamic subtest: pipe-A-eDP-1
[115.439110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[115.448283] Starting dynamic subtest: pipe-B-eDP-1
[115.450739] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[115.459791] Starting dynamic subtest: pipe-C-eDP-1
[115.462124] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[115.470878] Starting dynamic subtest: pipe-D-eDP-1
[115.473360] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[115.476130] Subtest lease-unleased-connector: SUCCESS (0.035s)
[115.581685] [021/133] (904s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[115.706949] Starting subtest: cursor-vs-flip-atomic-transitions
[145.719522] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.970s)
[146.616695] [022/133] (873s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[146.722606] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[146.725023] Starting dynamic subtest: pipe-A-default-mode
[149.474067] Dynamic subtest pipe-A-default-mode: SUCCESS (2.751s)
[149.476671] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.752s)
[150.312572] [023/133] (870s left) kms_addfb_basic (legacy-format)
[150.379760] Starting subtest: legacy-format
[150.398273] Subtest legacy-format: SUCCESS (0.017s)
[150.547393] [024/133] (870s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[150.657133] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[150.661441] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[150.762560] [025/133] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[150.856888] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[150.861435] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[150.986702] [026/133] (869s left) kms_vblank (query-busy)
[151.083192] Starting subtest: query-busy
[151.085564] Starting dynamic subtest: pipe-A-eDP-1
[152.958942] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[152.973171] Starting dynamic subtest: pipe-D-eDP-1
[155.573322] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.612s)
[155.576309] Subtest query-busy: SUCCESS (4.490s)
[156.389756] [027/133] (864s left) gem_wait (invalid-flags)
[156.450946] Starting subtest: invalid-flags
[156.453261] Subtest invalid-flags: SUCCESS (0.000s)
[156.704618] [028/133] (864s left) kms_properties (invalid-properties-atomic)
[156.809303] Starting subtest: invalid-properties-atomic
[157.109888] Subtest invalid-properties-atomic: SUCCESS (0.301s)
[157.195912] [029/133] (863s left) gem_exec_flush (basic-wb-ro-before-default)
[157.257330] Starting subtest: basic-wb-ro-before-default
[162.719323] Subtest basic-wb-ro-before-default: SUCCESS (5.453s)
[162.920977] [030/133] (858s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[163.027078] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[163.032271] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[163.125057] [031/133] (857s left) kms_psr (pr-primary-blt)
[163.227875] Starting subtest: pr-primary-blt
[163.232788] Subtest pr-primary-blt: SKIP (0.000s)
[163.311312] [032/133] (857s left) kms_flip (2x-flip-vs-dpms-on-nop)
[163.407439] Starting subtest: 2x-flip-vs-dpms-on-nop
[163.418474] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[163.546398] [033/133] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[163.647190] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[163.652011] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[163.773118] [034/133] (857s left) kms_chamelium_edid (dp-mode-timings)
[164.160039] Subtest dp-mode-timings: SKIP (0.000s)
[165.000332] [035/133] (856s left) kms_flip (flip-vs-panning-interruptible)
[165.090798] Starting subtest: flip-vs-panning-interruptible
[165.093068] Starting dynamic subtest: A-eDP1
[173.834613] Dynamic subtest A-eDP1: SUCCESS (8.740s)
[173.844040] Starting dynamic subtest: B-eDP1
[182.580461] Dynamic subtest B-eDP1: SUCCESS (8.741s)
[182.589638] Starting dynamic subtest: C-eDP1
[191.295720] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[191.304281] Starting dynamic subtest: D-eDP1
[200.026668] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[200.032519] Subtest flip-vs-panning-interruptible: SUCCESS (34.931s)
[201.206809] [036/133] (819s left) kms_pm_dc (dc5-psr)
[202.330126] Starting subtest: dc5-psr
[205.225984] Subtest dc5-psr: SUCCESS (2.896s)
[206.035358] [037/133] (815s left) gem_userptr_blits (process-exit)
[206.108838] Starting subtest: process-exit
[206.114172] Subtest process-exit: SUCCESS (0.009s)
[206.267618] [038/133] (814s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[206.363099] Starting subtest: plane-lut1d-post-ctm3x4
[206.375911] Starting dynamic subtest: pipe-A-eDP-1
[207.133955] Dynamic subtest pipe-A-eDP-1: FAIL (0.313s)
[207.810155] Starting dynamic subtest: pipe-B-eDP-1
[208.663527] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[209.131061] Starting dynamic subtest: pipe-C-eDP-1
[210.045073] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[210.459254] Starting dynamic subtest: pipe-D-eDP-1
[211.423771] Dynamic subtest pipe-D-eDP-1: FAIL (0.256s)
[211.426286] Subtest plane-lut1d-post-ctm3x4: FAIL (4.640s)
[211.855009] [039/133] (809s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[211.919311] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[212.025262] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[212.115266] [040/133] (809s left) gem_mmap_offset (partial-remap)
[212.177501] Starting subtest: partial-remap
[212.179928] Starting dynamic subtest: smem0
[212.190159] Dynamic subtest smem0: SUCCESS (0.004s)
[212.192774] Subtest partial-remap: SUCCESS (0.005s)
[212.341385] [041/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[212.454431] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[212.459023] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[212.570468] [042/133] (808s left) gem_userptr_blits (dmabuf-unsync)
[212.647887] Subtest dmabuf-unsync: SKIP (0.000s)
[212.796804] [043/133] (808s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[212.907057] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[212.912055] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[213.034697] [044/133] (808s left) gem_close_race (multigpu-basic-threads)
[213.098952] Starting subtest: multigpu-basic-threads
[213.103572] Subtest multigpu-basic-threads: SKIP (0.000s)
[213.329547] [045/133] (808s left) gem_exec_schedule (preempt)
[213.403134] Starting subtest: preempt
[213.406119] Starting dynamic subtest: rcs0
[213.422739] Dynamic subtest rcs0: SUCCESS (0.026s)
[213.434747] Starting dynamic subtest: bcs0
[213.443580] Dynamic subtest bcs0: SUCCESS (0.020s)
[213.452282] Starting dynamic subtest: vcs0
[213.466277] Dynamic subtest vcs0: SUCCESS (0.023s)
[213.475282] Starting dynamic subtest: vcs1
[213.489667] Dynamic subtest vcs1: SUCCESS (0.022s)
[213.499151] Starting dynamic subtest: vecs0
[213.511140] Dynamic subtest vecs0: SUCCESS (0.021s)
[213.520762] Starting dynamic subtest: ccs0
[213.530315] Dynamic subtest ccs0: SUCCESS (0.019s)
[213.533072] Subtest preempt: SUCCESS (0.134s)
[215.151610] [046/133] (806s left) i915_module_load (reload)
[215.186128] Starting subtest: reload
[219.862268] Subtest reload: SUCCESS (4.681s)
[219.911342] [047/133] (801s left) gem_exec_reloc (basic-wc-cpu-active)
[220.969864] Subtest basic-wc-cpu-active: SKIP (0.000s)
[221.065551] [048/133] (800s left) gen9_exec_parse (valid-registers)
[221.128852] Subtest valid-registers: SKIP (0.000s)
[221.217619] [049/133] (800s left) kms_cursor_edge_walk (64x64-left-edge)
[221.325926] Starting subtest: 64x64-left-edge
[221.328424] Starting dynamic subtest: pipe-A-eDP-1
[224.754258] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.428s)
[224.764291] Starting dynamic subtest: pipe-D-eDP-1
[227.878107] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[227.881072] Subtest 64x64-left-edge: SUCCESS (6.551s)
[228.693078] [050/133] (793s left) gem_render_copy_redux (flink)
[228.771766] Starting subtest: flink
[229.492848] Subtest flink: SUCCESS (0.722s)
[229.639259] [051/133] (792s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[229.736919] Starting subtest: psr-2p-primscrn-spr-indfb-move
[229.740830] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[229.853153] [052/133] (791s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[229.945792] Starting subtest: bo-too-small-due-to-tiling
[229.950645] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[230.069916] [053/133] (791s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[230.176910] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[236.774087] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.598s)
[236.914864] [054/133] (785s left) gem_exec_reloc (basic-write-wc-active)
[236.977301] Subtest basic-write-wc-active: SKIP (0.000s)
[237.044530] [055/133] (784s left) gem_fenced_exec_thrash (2-spare-fences)
[237.104077] Subtest 2-spare-fences: SKIP (0.000s)
[237.171804] [056/133] (784s left) kms_hdr (static-toggle-dpms)
[237.263147] Starting subtest: static-toggle-dpms
[237.271183] Subtest static-toggle-dpms: SKIP (0.000s)
[237.350500] [057/133] (784s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[237.450253] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[244.427144] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.979s)
[244.562112] [058/133] (777s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[244.668117] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[248.406093] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.741s)
[249.552024] [059/133] (772s left) gem_lmem_swapping (parallel-random-verify)
[249.592406] Subtest parallel-random-verify: SKIP (0.000s)
[249.639596] [060/133] (772s left) kms_psr (fbc-pr-sprite-plane-move)
[249.737177] Starting subtest: fbc-pr-sprite-plane-move
[249.742259] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[249.823588] [061/133] (772s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[250.211057] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[251.043346] [062/133] (771s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[251.140879] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[251.143501] Starting dynamic subtest: pipe-A-eDP-1
[251.172756] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[251.183128] Starting dynamic subtest: pipe-B-eDP-1
[251.212271] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[251.220840] Starting dynamic subtest: pipe-C-eDP-1
[251.248543] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[251.257164] Starting dynamic subtest: pipe-D-eDP-1
[251.286038] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[251.290944] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[253.428822] [063/133] (768s left) i915_pm_rpm (gem-evict-pwrite)
[255.169183] Starting subtest: gem-evict-pwrite
[255.175123] Subtest gem-evict-pwrite: SKIP (0.000s)
[255.674976] [064/133] (766s left) gem_exec_whisper (basic-sync)
[255.742078] Starting subtest: basic-sync
[262.978187] Subtest basic-sync: SUCCESS (7.232s)
[263.175792] [065/133] (759s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[263.308750] Starting subtest: short-busy-flip-before-cursor-toggle
[263.313839] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[263.467645] [066/133] (758s left) i915_query (hwconfig_table)
[263.534281] Starting subtest: hwconfig_table
[263.882723] Subtest hwconfig_table: SUCCESS (0.001s)
[263.923500] [067/133] (758s left) kms_vrr (flipline)
[264.019970] Starting subtest: flipline
[264.028009] Subtest flipline: SKIP (0.000s)
[264.113638] [068/133] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[264.216921] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[268.445081] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.231s)
[269.598798] [069/133] (752s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[269.693492] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[269.707358] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[269.784650] [070/133] (752s left) kms_prop_blob (invalid-set-prop)
[269.852188] Starting subtest: invalid-set-prop
[269.855102] Subtest invalid-set-prop: SUCCESS (0.000s)
[269.980720] [071/133] (752s left) kms_properties (crtc-properties-legacy)
[270.084682] Starting subtest: crtc-properties-legacy
[270.087217] Starting dynamic subtest: pipe-A-eDP-1
[270.526125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.440s)
[270.542302] Starting dynamic subtest: pipe-B-eDP-1
[271.739305] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s)
[271.752158] Starting dynamic subtest: pipe-C-eDP-1
[272.856039] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[272.867117] Starting dynamic subtest: pipe-D-eDP-1
[273.980339] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[273.983186] Subtest crtc-properties-legacy: SUCCESS (3.893s)
[274.816276] [072/133] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[274.923485] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[281.906121] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.984s)
[282.067948] [073/133] (740s left) kms_psr (fbc-pr-cursor-render)
[282.180804] Starting subtest: fbc-pr-cursor-render
[282.185990] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[282.287158] [074/133] (740s left) gem_userptr_blits (huge-split)
[282.373132] Starting subtest: huge-split
[282.381884] Subtest huge-split: SUCCESS (0.009s)
[282.509682] [075/133] (740s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[282.758709] Starting subtest: cursor-rapid-movement-256x85
[282.805944] Subtest cursor-rapid-movement-256x85: SKIP (0.040s)
[283.016412] [076/133] (739s left) gem_unref_active_buffers
[283.257704] [077/133] (739s left) gem_caching (reads)
[283.323129] Subtest reads: SKIP (0.000s)
[283.412209] [078/133] (739s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[283.475132] Starting subtest: invalid-multi-wait-all-unsubmitted
[283.478015] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[283.613374] [079/133] (739s left) gem_exec_create (basic)
[283.690363] Starting subtest: basic
[283.692890] Starting dynamic subtest: smem
[286.973141] Dynamic subtest smem: SUCCESS (3.279s)
[286.976339] Subtest basic: SUCCESS (3.281s)
[287.174382] [080/133] (735s left) kms_content_protection (atomic-dpms-hdcp14)
[287.326547] Starting subtest: atomic-dpms-hdcp14
[287.332206] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[287.462873] [081/133] (735s left) sw_sync (timeline_closed)
[287.505012] Starting subtest: timeline_closed
[287.507248] Subtest timeline_closed: SUCCESS (0.000s)
[287.572109] [082/133] (735s left) perf (oa-exponents)
[287.715118] Starting subtest: oa-exponents
[287.717656] Starting dynamic subtest: 0-rcs0
[289.493516] Dynamic subtest 0-rcs0: SUCCESS (1.778s)
[289.503835] Starting dynamic subtest: 1-vecs0
[291.321681] Dynamic subtest 1-vecs0: SUCCESS (1.826s)
[291.324318] Subtest oa-exponents: SUCCESS (3.606s)
[291.372763] [083/133] (731s left) kms_feature_discovery (display-2x)
[291.484951] Starting subtest: display-2x
[291.489740] Subtest display-2x: SKIP (0.000s)
[291.568876] [084/133] (731s left) core_setmaster (master-drop-set-root)
[291.650905] Starting subtest: master-drop-set-root
[291.663954] Subtest master-drop-set-root: SUCCESS (0.013s)
[291.712603] [085/133] (731s left) kms_pm_rpm (i2c)
[293.236274] Starting subtest: i2c
[298.941629] Subtest i2c: SUCCESS (5.703s)
[299.081670] [086/133] (724s left) kms_busy (basic-hang)
[299.190587] Starting subtest: basic-hang
[299.192983] Starting dynamic subtest: flip-pipe-A
[299.771434] Dynamic subtest flip-pipe-A: SUCCESS (0.581s)
[299.781639] Starting dynamic subtest: modeset-pipe-A
[303.271119] Dynamic subtest modeset-pipe-A: SUCCESS (3.495s)
[303.280787] Starting dynamic subtest: flip-pipe-D
[304.451094] Dynamic subtest flip-pipe-D: SUCCESS (1.180s)
[304.462383] Starting dynamic subtest: modeset-pipe-D
[307.901027] Dynamic subtest modeset-pipe-D: SUCCESS (3.447s)
[307.903780] Subtest basic-hang: SUCCESS (8.711s)
[308.717083] [087/133] (714s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[308.819166] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[308.825170] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[308.940703] [088/133] (714s left) kms_flip (nonblocking-read)
[309.041723] Starting subtest: nonblocking-read
[309.043612] Subtest nonblocking-read: SUCCESS (0.000s)
[309.169590] [089/133] (714s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[309.267212] Starting subtest: yf-tiled-16bpp-rotate-270
[309.271853] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[309.376951] [090/133] (714s left) gem_mmap_wc (write-read-distinct)
[309.438108] Subtest write-read-distinct: SKIP (0.000s)
[309.498480] [091/133] (714s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[309.553253] Starting subtest: multi-wait-for-submit-submitted-signaled
[309.556088] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[309.661152] [092/133] (713s left) kms_flip (blocking-wf_vblank)
[309.764882] Starting subtest: blocking-wf_vblank
[309.766935] Starting dynamic subtest: A-eDP1
[318.647936] Dynamic subtest A-eDP1: SUCCESS (8.880s)
[318.662894] Starting dynamic subtest: B-eDP1
[327.573786] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[327.588389] Starting dynamic subtest: C-eDP1
[336.487990] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[336.504077] Starting dynamic subtest: D-eDP1
[345.423366] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[345.426029] Subtest blocking-wf_vblank: SUCCESS (35.665s)
[346.674926] [093/133] (676s left) gem_exec_alignment (pi)
[346.757848] Starting subtest: pi
[397.895194] Subtest pi: SUCCESS (51.134s)
[398.866443] [094/133] (624s left) kms_getfb (getfb-repeated-different-handles)
[399.028133] Starting subtest: getfb-repeated-different-handles
[399.031052] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[399.155814] [095/133] (624s left) syncobj_timeline (etime-multi-wait-submitted)
[399.213222] Starting subtest: etime-multi-wait-submitted
[399.320826] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[399.410408] [096/133] (624s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[399.528033] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[400.525454] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.996s)
[401.389795] [097/133] (622s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[401.496069] Starting subtest: primary-yf-tiled-reflect-x-0
[401.568533] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s)
[401.696836] [098/133] (622s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[401.784014] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[401.850719] [099/133] (622s left) perf_pmu (rc6)
[401.902133] Starting subtest: rc6
[401.905137] Starting dynamic subtest: gt0
[408.272624] Dynamic subtest gt0: SUCCESS (6.374s)
[408.286935] Starting dynamic subtest: runtime-pm-gt0
[416.015973] Dynamic subtest runtime-pm-gt0: SUCCESS (7.740s)
[416.026934] Starting dynamic subtest: runtime-pm-long-gt0
[428.469273] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.449s)
[428.482271] Starting dynamic subtest: other-idle-gt0
[434.813268] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[434.826262] Starting dynamic subtest: gt1
[441.155643] Dynamic subtest gt1: SUCCESS (6.338s)
[441.169174] Starting dynamic subtest: runtime-pm-gt1
[448.600593] Dynamic subtest runtime-pm-gt1: SUCCESS (7.441s)
[448.612270] Starting dynamic subtest: runtime-pm-long-gt1
[461.036392] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.431s)
[461.049322] Starting dynamic subtest: other-idle-gt1
[467.378548] Dynamic subtest other-idle-gt1: SUCCESS (6.339s)
[467.381602] Subtest rc6: SUCCESS (65.471s)
[468.676845] [100/133] (555s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[468.771525] Starting subtest: y-tiled-16bpp-rotate-0
[468.775928] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[468.862743] [101/133] (555s left) kms_flip_tiling (flip-change-tiling)
[468.957325] Starting subtest: flip-change-tiling
[468.959686] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[469.174207] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.218s)
[469.185970] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[469.320283] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[469.332567] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[469.464720] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[469.476878] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[469.608186] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[469.620586] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[469.751966] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[469.763398] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[469.896504] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[469.907218] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[470.030073] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[470.040884] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[470.141137] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[470.152131] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[470.276088] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[470.288524] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[470.419711] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.143s)
[470.436117] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[470.574526] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.153s)
[470.586883] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[470.719066] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.143s)
[470.731293] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[470.852377] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[470.865747] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[470.987499] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[470.999295] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[471.097414] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[471.110575] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[471.241713] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[471.254958] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[471.413818] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.170s)
[471.426865] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[471.558293] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[471.575815] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[471.702751] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[471.717041] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[471.847434] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[471.860931] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[471.991439] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[472.003301] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[472.113257] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[472.125646] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[472.258088] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.143s)
[472.270054] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[472.402557] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[472.414411] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[472.546874] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s)
[472.558981] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[472.690915] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[472.702122] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[472.835924] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[472.847980] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[473.010715] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.173s)
[473.022953] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[473.132760] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[473.144938] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[473.277187] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[473.287893] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[473.421635] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[473.433077] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[473.566270] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[473.577731] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[473.711263] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[473.723122] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[473.885258] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.172s)
[473.897674] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[474.041117] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.153s)
[474.053969] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[474.194992] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.152s)
[474.247917] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[475.424622] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.183s)
[475.437408] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[475.558733] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[475.571164] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[475.692595] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[475.705527] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[475.864309] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.169s)
[475.877412] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[476.007436] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[476.019879] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[476.179277] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.170s)
[476.192054] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[476.323265] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s)
[476.335421] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[476.434190] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[476.445953] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[476.569779] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[476.582279] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[476.712726] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[476.725826] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[476.857030] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[476.870018] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[477.001281] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[477.014209] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[477.146254] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.142s)
[477.159294] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[477.280821] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[477.293983] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[477.390678] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[477.402969] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[477.535273] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[477.547978] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[477.679757] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[477.693287] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[477.823991] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[477.838131] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[477.968605] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[477.981562] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[478.113032] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[478.124945] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[478.257314] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[478.269264] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[478.379273] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[478.392313] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[478.523757] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.143s)
[478.536171] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[478.668412] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[478.681261] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[478.813046] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.143s)
[478.825949] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[478.957038] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[478.969215] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[479.101915] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[479.113692] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[479.285822] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.181s)
[479.298686] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[479.418853] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.131s)
[479.430108] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[479.563135] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[479.574251] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[479.707835] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[479.719009] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[479.852184] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[479.864805] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[479.996881] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[480.009268] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[480.140850] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[480.153210] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[480.285873] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[480.298171] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[480.407901] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[480.460209] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[481.653866] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.200s)
[481.666264] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[481.753648] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[481.766273] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[481.853153] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[481.864843] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[481.964527] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[481.976614] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[482.075129] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[482.085857] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[482.186973] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[482.201939] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[482.297969] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.110s)
[482.310294] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[482.398012] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[482.408066] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[482.497773] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[482.507541] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[482.608854] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[482.618895] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[482.719423] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[482.729128] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[482.830405] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[482.839980] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[482.930957] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[482.940597] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[483.042264] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.109s)
[483.054902] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[483.153370] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s)
[483.163946] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[483.264758] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[483.276805] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[483.375616] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[483.386663] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[483.487012] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[483.497315] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[483.586682] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[483.599834] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[483.698595] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[483.710980] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[483.809102] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[483.819749] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[483.931681] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.121s)
[483.942922] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[484.042288] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[484.052106] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[484.153285] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[484.163997] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[484.264788] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[484.275876] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[484.375892] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[484.387005] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[484.486831] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[484.497863] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[484.598051] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[484.609050] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[484.709216] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[484.721176] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[484.820515] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.110s)
[484.832687] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[484.931682] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[484.942631] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[485.042910] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[485.053091] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[485.153817] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[485.164289] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[485.264953] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[485.276785] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[485.375970] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[485.387759] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[485.486987] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[485.518158] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[486.791931] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.281s)
[486.804250] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[486.903004] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[486.915538] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[487.002963] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[487.015147] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[487.153620] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.148s)
[487.165844] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[487.264273] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[487.276555] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[487.375112] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[487.387493] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[487.474815] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[487.487345] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[487.575047] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[487.587275] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[487.674967] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[487.686658] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[487.786275] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[487.797856] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[487.897052] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[487.909224] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[488.046784] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.148s)
[488.058274] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[488.158533] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.109s)
[488.170283] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[488.258094] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[488.270188] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[488.358026] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[488.370635] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[488.469169] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[488.481808] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[488.580452] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[488.591776] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[488.691217] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[488.703260] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[488.802423] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[488.815188] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[488.913912] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[488.926726] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[489.025076] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[489.037979] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[489.136151] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[489.148992] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[489.246897] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[489.258168] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[489.358275] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[489.370158] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[489.469557] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[489.481776] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[489.580713] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[489.592762] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[489.691285] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[489.703283] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[489.802711] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[489.814747] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[489.913664] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[489.924325] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[490.024616] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[490.034708] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[490.135997] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[490.146155] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[490.246869] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[490.259272] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[490.358419] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[490.370928] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[490.469784] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s)
[490.481909] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[490.580859] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[490.593749] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[490.691777] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.110s)
[490.724823] Subtest flip-change-tiling: SUCCESS (21.765s)
[491.959738] [102/133] (532s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[492.082141] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[492.087978] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[492.173813] [103/133] (531s left) gem_exec_fence (submit-chain)
[492.355081] Starting subtest: submit-chain
[492.383027] Subtest submit-chain: SUCCESS (0.028s)
[494.095224] [104/133] (530s left) gem_ringfill (engines-basic)
[500.032831] Starting subtest: engines-basic
[500.035855] Starting dynamic subtest: rcs0
[500.097605] Dynamic subtest rcs0: SUCCESS (0.065s)
[500.114224] Starting dynamic subtest: bcs0
[500.151780] Dynamic subtest bcs0: SUCCESS (0.050s)
[500.163672] Starting dynamic subtest: vcs0
[500.199284] Dynamic subtest vcs0: SUCCESS (0.046s)
[500.211127] Starting dynamic subtest: vcs1
[500.246891] Dynamic subtest vcs1: SUCCESS (0.046s)
[500.258025] Starting dynamic subtest: vecs0
[500.292841] Dynamic subtest vecs0: SUCCESS (0.044s)
[500.303148] Starting dynamic subtest: ccs0
[500.338919] Dynamic subtest ccs0: SUCCESS (0.044s)
[500.341268] Subtest engines-basic: SUCCESS (0.308s)
[500.395976] [105/133] (523s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[500.490044] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[500.492901] Starting dynamic subtest: pipe-A-eDP-1
[500.514801] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[500.525520] Starting dynamic subtest: pipe-B-eDP-1
[500.548467] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[500.558260] Starting dynamic subtest: pipe-C-eDP-1
[500.582605] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[500.592927] Starting dynamic subtest: pipe-D-eDP-1
[500.615914] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[500.618262] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[502.627586] [106/133] (521s left) perf_pmu (busy-check-all)
[502.672077] Starting subtest: busy-check-all
[502.674545] Starting dynamic subtest: rcs0
[503.228301] Dynamic subtest rcs0: SUCCESS (0.557s)
[503.242396] Starting dynamic subtest: bcs0
[503.778275] Dynamic subtest bcs0: SUCCESS (0.548s)
[503.791606] Starting dynamic subtest: vcs0
[505.020462] Dynamic subtest vcs0: SUCCESS (1.238s)
[505.033959] Starting dynamic subtest: vcs1
[507.005058] Dynamic subtest vcs1: SUCCESS (1.981s)
[507.017463] Starting dynamic subtest: vecs0
[509.053132] Dynamic subtest vecs0: SUCCESS (2.045s)
[509.065408] Starting dynamic subtest: ccs0
[509.608266] Dynamic subtest ccs0: SUCCESS (0.553s)
[509.611102] Subtest busy-check-all: SUCCESS (6.937s)
[509.692767] [107/133] (514s left) gem_exec_schedule (submit-early-slice)
[509.765408] Starting subtest: submit-early-slice
[509.768049] Starting dynamic subtest: rcs0
[509.809860] Dynamic subtest rcs0: SUCCESS (0.054s)
[509.822585] Starting dynamic subtest: bcs0
[509.866790] Dynamic subtest bcs0: SUCCESS (0.056s)
[509.877954] Starting dynamic subtest: vcs0
[509.926001] Dynamic subtest vcs0: SUCCESS (0.058s)
[509.939853] Starting dynamic subtest: vcs1
[509.991819] Dynamic subtest vcs1: SUCCESS (0.065s)
[510.004260] Starting dynamic subtest: vecs0
[510.058591] Dynamic subtest vecs0: SUCCESS (0.066s)
[510.075147] Starting dynamic subtest: ccs0
[510.117045] Dynamic subtest ccs0: SUCCESS (0.057s)
[510.120070] Subtest submit-early-slice: SUCCESS (0.362s)
[511.134048] [108/133] (513s left) gem_exec_balancer (parallel-bb-first)
[511.395266] Starting subtest: parallel-bb-first
[512.315293] Subtest parallel-bb-first: SUCCESS (0.923s)
[512.980140] [109/133] (511s left) gen9_exec_parse (bb-large)
[513.047106] Subtest bb-large: SKIP (0.000s)
[513.124757] [110/133] (511s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[513.216020] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[513.218636] Starting dynamic subtest: pipe-A-eDP-1
[513.288282] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[513.299272] Starting dynamic subtest: pipe-B-eDP-1
[513.370125] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[513.381565] Starting dynamic subtest: pipe-C-eDP-1
[513.452150] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[513.462979] Starting dynamic subtest: pipe-D-eDP-1
[513.532106] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[513.537270] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[515.480255] [111/133] (508s left) api_intel_bb (simple-bb-ctx)
[515.540777] Starting subtest: simple-bb-ctx
[515.548217] Subtest simple-bb-ctx: SUCCESS (0.008s)
[515.665639] [112/133] (508s left) gem_ctx_isolation (preservation-s3)
[515.735153] Starting subtest: preservation-S3
[515.737613] Starting dynamic subtest: rcs0
[532.050045] Dynamic subtest rcs0: SUCCESS (2.138s)
[532.061402] Starting dynamic subtest: bcs0
[548.071137] Dynamic subtest bcs0: SUCCESS (1.292s)
[548.082455] Starting dynamic subtest: vcs0
[564.058852] Dynamic subtest vcs0: SUCCESS (2.870s)
[564.069421] Starting dynamic subtest: vcs1
[582.071450] Dynamic subtest vcs1: SUCCESS (4.959s)
[582.082443] Starting dynamic subtest: vecs0
[600.069983] Dynamic subtest vecs0: SUCCESS (4.874s)
[600.081134] Starting dynamic subtest: ccs0
[618.071123] Dynamic subtest ccs0: SUCCESS (3.175s)
[618.073634] Subtest preservation-S3: SUCCESS (19.315s)
[618.309729] [113/133] (406s left) sriov_basic (enable-vfs-autoprobe-on)
[618.382808] Starting subtest: enable-vfs-autoprobe-on
[618.385192] Starting dynamic subtest: numvfs-1
[618.466603] Dynamic subtest numvfs-1: FAIL (0.026s)
[618.476561] Starting dynamic subtest: numvfs-2
[618.550522] Dynamic subtest numvfs-2: FAIL (0.004s)
[618.561581] Starting dynamic subtest: numvfs-3
[618.643076] Dynamic subtest numvfs-3: FAIL (0.004s)
[618.654891] Starting dynamic subtest: numvfs-4
[618.729122] Dynamic subtest numvfs-4: FAIL (0.004s)
[618.740640] Starting dynamic subtest: numvfs-5
[618.815434] Dynamic subtest numvfs-5: FAIL (0.004s)
[618.826439] Starting dynamic subtest: numvfs-6
[618.902659] Dynamic subtest numvfs-6: FAIL (0.004s)
[618.914684] Starting dynamic subtest: numvfs-7
[618.990410] Dynamic subtest numvfs-7: FAIL (0.004s)
[619.000681] Starting dynamic subtest: numvfs-random
[619.074927] Dynamic subtest numvfs-random: FAIL (0.004s)
[619.086570] Starting dynamic subtest: numvfs-all
[619.160890] Dynamic subtest numvfs-all: FAIL (0.521s)
[619.163248] Subtest enable-vfs-autoprobe-on: FAIL (0.581s)
[619.209052] [114/133] (405s left) perf_pmu (gt-awake)
[619.250696] Starting subtest: gt-awake
[627.738403] Subtest gt-awake: SUCCESS (8.349s)
[627.831695] [115/133] (396s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[627.898734] Subtest no-spare-fences-busy: SKIP (0.000s)
[627.990967] [116/133] (396s left) kms_rotation_crc (primary-rotation-90)
[628.091252] Starting subtest: primary-rotation-90
[628.095691] Subtest primary-rotation-90: SKIP (0.001s)
[628.142547] [117/133] (396s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[628.249864] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[629.024945] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.770s)
[629.181163] [118/133] (395s left) gem_mmap_wc (write-prefaulted)
[629.253701] Subtest write-prefaulted: SKIP (0.000s)
[629.335677] [119/133] (395s left) gem_pxp (reject-modify-context-protection-off-1)
[629.467309] Starting subtest: reject-modify-context-protection-off-1
[629.469821] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[629.560669] [120/133] (395s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[629.653612] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[629.655589] Starting dynamic subtest: pipe-A-eDP-1
[629.676647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[629.688859] Starting dynamic subtest: pipe-B-eDP-1
[629.709664] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[629.720184] Starting dynamic subtest: pipe-C-eDP-1
[629.740959] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[629.751217] Starting dynamic subtest: pipe-D-eDP-1
[629.772298] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[629.774737] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s)
[632.020826] [121/133] (392s left) kms_plane_lowres (tiling-x)
[632.129033] Starting subtest: tiling-x
[632.131412] Starting dynamic subtest: pipe-A-eDP-1
[632.136015] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[632.431342] Starting dynamic subtest: pipe-B-eDP-1
[632.436325] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[632.446102] Starting dynamic subtest: pipe-C-eDP-1
[632.450692] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[632.460281] Starting dynamic subtest: pipe-D-eDP-1
[632.464464] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[632.468706] Subtest tiling-x: SKIP (0.298s)
[633.250611] [122/133] (391s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[633.353202] Starting subtest: multiplane-rotation-cropping-top
[650.777090] Subtest multiplane-rotation-cropping-top: SUCCESS (17.393s)
[650.906933] [123/133] (374s left) gem_mmap_gtt (basic-write-read-distinct)
[650.973437] Subtest basic-write-read-distinct: SKIP (0.000s)
[651.042043] [124/133] (373s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[651.134858] Starting subtest: fbc-psr2-sprite-mmap-gtt
[651.136764] Starting dynamic subtest: eDP-1
[651.140140] Dynamic subtest eDP-1: SKIP (0.000s)
[651.143504] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[651.193138] [125/133] (373s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[651.289924] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[651.293334] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[651.338089] [126/133] (373s left) gem_tiled_partial_pwrite_pread (writes)
[651.401493] Subtest writes: SKIP (0.000s)
[651.500719] [127/133] (373s left) kms_atomic (crtc-invalid-params-fence)
[651.597589] Starting subtest: crtc-invalid-params-fence
[651.599346] Starting dynamic subtest: pipe-A-eDP-1
[652.013480] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.414s)
[652.015884] Subtest crtc-invalid-params-fence: SUCCESS (0.416s)
[652.815213] [128/133] (372s left) gem_busy (parallel)
[653.012611] Starting subtest: parallel
[653.014753] Starting dynamic subtest: rcs0
[654.745819] Dynamic subtest rcs0: SUCCESS (1.734s)
[654.760296] Starting dynamic subtest: bcs0
[656.729848] Dynamic subtest bcs0: SUCCESS (1.981s)
[656.743110] Starting dynamic subtest: vcs0
[658.777204] Dynamic subtest vcs0: SUCCESS (2.044s)
[658.790513] Starting dynamic subtest: vcs1
[660.761983] Dynamic subtest vcs1: SUCCESS (1.982s)
[660.775600] Starting dynamic subtest: vecs0
[662.746093] Dynamic subtest vecs0: SUCCESS (1.981s)
[662.759399] Starting dynamic subtest: ccs0
[664.729929] Dynamic subtest ccs0: SUCCESS (1.980s)
[664.732949] Subtest parallel: SUCCESS (11.719s)
[664.973892] [129/133] (360s left) gem_ctx_persistence (processes)
[665.052608] Starting subtest: processes
[666.703750] Subtest processes: SUCCESS (1.652s)
[666.778389] [130/133] (358s left) kms_big_fb (4-tiled-addfb-size-overflow)
[666.892647] Starting subtest: 4-tiled-addfb-size-overflow
[666.894959] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[666.979144] [131/133] (358s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[667.084482] Starting subtest: x-tiled-64bpp-rotate-270
[667.104104] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[667.220716] [132/133] (358s left) kms_plane_scaling (planes-scaler-unity-scaling)
[667.321535] Starting subtest: planes-scaler-unity-scaling
[667.323827] Starting dynamic subtest: pipe-A
[667.383555] Dynamic subtest pipe-A: SUCCESS (0.064s)
[667.396024] Starting dynamic subtest: pipe-B
[668.562940] Dynamic subtest pipe-B: SUCCESS (1.178s)
[668.575375] Starting dynamic subtest: pipe-C
[669.666877] Dynamic subtest pipe-C: SUCCESS (1.102s)
[669.680358] Starting dynamic subtest: pipe-D
[670.792147] Dynamic subtest pipe-D: SUCCESS (1.124s)
[670.794570] Subtest planes-scaler-unity-scaling: SUCCESS (3.472s)
[671.933586] [133/133] (353s left) gem_exec_whisper (basic-contexts)
[672.001372] Starting subtest: basic-contexts
[678.154858] Subtest basic-contexts: SUCCESS (6.148s)
[678.321857] 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.