[57.659259] Initializing watchdogs
[57.659307]   /dev/watchdog0
[57.673875] [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]
[57.678631] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.680767] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.683858] [001/133] (960s left) api_intel_allocator (gem-pool)
[57.748870] Starting subtest: gem-pool
[57.760561] Subtest gem-pool: SUCCESS (0.012s)
[57.870478] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[57.975100] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[57.979185] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[58.117655] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[58.199278] Starting subtest: read-crc-frame-sequence
[58.201587] Starting dynamic subtest: pipe-A-eDP-1
[58.936876] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[58.945324] Starting dynamic subtest: pipe-B-eDP-1
[60.303043] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.363s)
[60.311752] Starting dynamic subtest: pipe-C-eDP-1
[61.604443] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.303s)
[61.613870] Starting dynamic subtest: pipe-D-eDP-1
[62.923969] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[62.926215] Subtest read-crc-frame-sequence: SUCCESS (4.725s)
[63.777346] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[63.826506] Starting subtest: invalid-query-one-illegal-handle
[63.828586] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[63.944811] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[64.002619] Starting subtest: invalid-signal-zero-handles
[64.004995] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[64.121458] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[64.221417] Starting subtest: fbcpsr-rgb565-draw-render
[71.724798] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.507s)
[71.893223] [007/133] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[71.964207] Starting subtest: wait-for-submit-snapshot
[72.045171] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[72.143795] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[72.249472] Starting subtest: psr-rgb565-draw-blt
[79.219876] Subtest psr-rgb565-draw-blt: SUCCESS (6.975s)
[79.366971] [009/133] (939s left) kms_cursor_crc (cursor-onscreen-32x10)
[79.533655] Starting subtest: cursor-onscreen-32x10
[79.580194] Subtest cursor-onscreen-32x10: SKIP (0.041s)
[79.848818] [010/133] (938s left) syncobj_wait (invalid-signal-illegal-handle)
[79.912734] Starting subtest: invalid-signal-illegal-handle
[79.914688] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[80.031707] [011/133] (938s left) testdisplay
[80.373675] [012/133] (938s left) prime_mmap (test_map_unmap)
[80.432697] Starting subtest: test_map_unmap
[80.434640] Starting dynamic subtest: test_map_unmap-smem
[80.467060] Dynamic subtest test_map_unmap-smem: SUCCESS (0.034s)
[80.469050] Subtest test_map_unmap: SUCCESS (0.034s)
[80.601518] [013/133] (938s left) gem_exec_fence (syncobj-timeline-signal)
[81.165884] Starting subtest: syncobj-timeline-signal
[81.172899] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[83.014232] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[83.016977] [014/133] (935s left) syncobj_timeline (signal-point-0)
[83.087570] Starting subtest: signal-point-0
[83.089930] Subtest signal-point-0: SUCCESS (0.000s)
[83.221740] [015/133] (935s left) kms_psr (psr2-suspend)
[83.325692] Starting subtest: psr2-suspend
[83.328394] Starting dynamic subtest: eDP-1
[101.810451] Dynamic subtest eDP-1: SUCCESS (3.383s)
[101.812741] Subtest psr2-suspend: SUCCESS (3.384s)
[113.645129] [016/133] (916s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[113.759490] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[113.772329] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[113.842895] [017/133] (915s left) gem_softpin (reverse)
[113.900938] Starting subtest: reverse
[113.908418] Subtest reverse: SUCCESS (0.007s)
[114.059064] [018/133] (915s left) gem_exec_balancer (parallel-contexts)
[114.332620] Starting subtest: parallel-contexts
[116.919893] Subtest parallel-contexts: SUCCESS (2.586s)
[118.025647] [019/133] (911s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[118.124605] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[118.126868] Starting dynamic subtest: pipe-A-eDP-1
[120.342585] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.216s)
[120.352831] Starting dynamic subtest: pipe-B-eDP-1
[122.552834] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.208s)
[122.562143] Starting dynamic subtest: pipe-C-eDP-1
[124.665267] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.110s)
[124.673731] Starting dynamic subtest: pipe-D-eDP-1
[126.745247] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.076s)
[126.747544] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.615s)
[127.968066] [020/133] (901s left) kms_lease (lease-unleased-connector)
[128.070283] Starting subtest: lease-unleased-connector
[128.072409] Starting dynamic subtest: pipe-A-eDP-1
[128.077515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[128.088111] Starting dynamic subtest: pipe-B-eDP-1
[128.090326] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[128.099034] Starting dynamic subtest: pipe-C-eDP-1
[128.101268] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[128.109651] Starting dynamic subtest: pipe-D-eDP-1
[128.111516] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[128.113356] Subtest lease-unleased-connector: SUCCESS (0.034s)
[128.222261] [021/133] (901s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[128.344782] Starting subtest: cursor-vs-flip-atomic-transitions
[158.162793] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.813s)
[158.986801] [022/133] (871s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[159.091321] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[159.093648] Starting dynamic subtest: pipe-A-default-mode
[161.856905] Dynamic subtest pipe-A-default-mode: SUCCESS (2.766s)
[161.859375] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.767s)
[162.694161] [023/133] (867s left) kms_addfb_basic (legacy-format)
[162.752829] Starting subtest: legacy-format
[162.774912] Subtest legacy-format: SUCCESS (0.017s)
[162.949022] [024/133] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[163.053106] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[163.057570] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[163.187860] [025/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[163.285800] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[163.290063] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[163.403911] [026/133] (866s left) kms_vblank (query-busy)
[163.502291] Starting subtest: query-busy
[163.504351] Starting dynamic subtest: pipe-A-eDP-1
[165.376998] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[165.390444] Starting dynamic subtest: pipe-D-eDP-1
[167.951798] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.570s)
[167.953751] Subtest query-busy: SUCCESS (4.449s)
[168.756511] [027/133] (861s left) gem_wait (invalid-flags)
[168.823454] Starting subtest: invalid-flags
[168.825653] Subtest invalid-flags: SUCCESS (0.000s)
[169.072436] [028/133] (861s left) kms_properties (invalid-properties-atomic)
[169.173704] Starting subtest: invalid-properties-atomic
[169.478242] Subtest invalid-properties-atomic: SUCCESS (0.305s)
[169.571535] [029/133] (860s left) gem_exec_flush (basic-wb-ro-before-default)
[169.635134] Starting subtest: basic-wb-ro-before-default
[175.090533] Subtest basic-wb-ro-before-default: SUCCESS (5.455s)
[175.291308] [030/133] (855s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[175.408066] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[175.412508] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[175.548651] [031/133] (854s left) kms_psr (pr-primary-blt)
[175.650511] Starting subtest: pr-primary-blt
[175.654485] Subtest pr-primary-blt: SKIP (0.000s)
[175.737658] [032/133] (854s left) kms_flip (2x-flip-vs-dpms-on-nop)
[175.835687] Starting subtest: 2x-flip-vs-dpms-on-nop
[175.844676] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[175.948864] [033/133] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[176.054215] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[176.058452] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[176.162690] [034/133] (854s left) kms_chamelium_edid (dp-mode-timings)
[176.549157] Subtest dp-mode-timings: SKIP (0.000s)
[177.358563] [035/133] (853s left) kms_flip (flip-vs-panning-interruptible)
[177.463976] Starting subtest: flip-vs-panning-interruptible
[177.466350] Starting dynamic subtest: A-eDP1
[186.189780] Dynamic subtest A-eDP1: SUCCESS (8.724s)
[186.198782] Starting dynamic subtest: B-eDP1
[194.930796] Dynamic subtest B-eDP1: SUCCESS (8.739s)
[194.939386] Starting dynamic subtest: C-eDP1
[203.654748] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[203.663601] Starting dynamic subtest: D-eDP1
[212.305664] Dynamic subtest D-eDP1: SUCCESS (8.647s)
[212.309569] Subtest flip-vs-panning-interruptible: SUCCESS (34.841s)
[213.482164] [036/133] (817s left) kms_pm_dc (dc5-psr)
[214.585018] Starting subtest: dc5-psr
[217.465177] Subtest dc5-psr: SUCCESS (2.877s)
[218.317918] [037/133] (812s left) gem_userptr_blits (process-exit)
[218.391603] Starting subtest: process-exit
[218.400133] Subtest process-exit: SUCCESS (0.010s)
[218.554882] [038/133] (812s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[218.664219] Starting subtest: plane-lut1d-post-ctm3x4
[218.677437] Starting dynamic subtest: pipe-A-eDP-1
[219.370445] Dynamic subtest pipe-A-eDP-1: FAIL (0.337s)
[220.086363] Starting dynamic subtest: pipe-B-eDP-1
[220.887482] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[221.412709] Starting dynamic subtest: pipe-C-eDP-1
[222.245087] Dynamic subtest pipe-C-eDP-1: FAIL (0.256s)
[222.745441] Starting dynamic subtest: pipe-D-eDP-1
[223.596930] Dynamic subtest pipe-D-eDP-1: FAIL (0.268s)
[223.598992] Subtest plane-lut1d-post-ctm3x4: FAIL (4.637s)
[224.145984] [039/133] (806s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[224.195680] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[224.303328] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[224.391124] [040/133] (806s left) gem_mmap_offset (partial-remap)
[224.458022] Starting subtest: partial-remap
[224.460440] Starting dynamic subtest: smem0
[224.469469] Dynamic subtest smem0: SUCCESS (0.003s)
[224.471471] Subtest partial-remap: SUCCESS (0.004s)
[224.580210] [041/133] (806s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[224.685974] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[224.690214] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[224.822934] [042/133] (806s left) gem_userptr_blits (dmabuf-unsync)
[224.897053] Subtest dmabuf-unsync: SKIP (0.000s)
[225.044626] [043/133] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[225.143489] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[225.147440] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[225.262821] [044/133] (805s left) gem_close_race (multigpu-basic-threads)
[225.318749] Starting subtest: multigpu-basic-threads
[225.322654] Subtest multigpu-basic-threads: SKIP (0.000s)
[225.550466] [045/133] (805s left) gem_exec_schedule (preempt)
[225.620995] Starting subtest: preempt
[225.623190] Starting dynamic subtest: rcs0
[225.637474] Dynamic subtest rcs0: SUCCESS (0.024s)
[225.646179] Starting dynamic subtest: bcs0
[225.658660] Dynamic subtest bcs0: SUCCESS (0.019s)
[225.667343] Starting dynamic subtest: vcs0
[225.681369] Dynamic subtest vcs0: SUCCESS (0.022s)
[225.691105] Starting dynamic subtest: vcs1
[225.702612] Dynamic subtest vcs1: SUCCESS (0.020s)
[225.712221] Starting dynamic subtest: vecs0
[225.742386] Dynamic subtest vecs0: SUCCESS (0.039s)
[225.751059] Starting dynamic subtest: ccs0
[225.771475] Dynamic subtest ccs0: SUCCESS (0.027s)
[225.773751] Subtest preempt: SUCCESS (0.159s)
[227.148497] [046/133] (803s left) i915_module_load (reload)
[227.190620] Starting subtest: reload
[230.516121] Subtest reload: SUCCESS (3.328s)
[230.555608] [047/133] (800s left) gem_exec_reloc (basic-wc-cpu-active)
[231.998229] Subtest basic-wc-cpu-active: SKIP (0.000s)
[232.088533] [048/133] (799s left) gen9_exec_parse (valid-registers)
[232.158082] Subtest valid-registers: SKIP (0.000s)
[232.223140] [049/133] (798s left) kms_cursor_edge_walk (64x64-left-edge)
[232.321516] Starting subtest: 64x64-left-edge
[232.324020] Starting dynamic subtest: pipe-A-eDP-1
[235.828867] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.505s)
[235.837462] Starting dynamic subtest: pipe-D-eDP-1
[238.931028] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.100s)
[238.933381] Subtest 64x64-left-edge: SUCCESS (6.608s)
[239.766366] [050/133] (791s left) gem_render_copy_redux (flink)
[239.827164] Starting subtest: flink
[240.573736] Subtest flink: SUCCESS (0.746s)
[240.734528] [051/133] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[240.837437] Starting subtest: psr-2p-primscrn-spr-indfb-move
[240.840728] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[240.955788] [052/133] (790s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[241.044898] Starting subtest: bo-too-small-due-to-tiling
[241.048382] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[241.146855] [053/133] (790s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[241.252507] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[248.071267] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.819s)
[248.221228] [054/133] (783s left) gem_exec_reloc (basic-write-wc-active)
[248.289543] Subtest basic-write-wc-active: SKIP (0.000s)
[248.360068] [055/133] (783s left) gem_fenced_exec_thrash (2-spare-fences)
[248.424241] Subtest 2-spare-fences: SKIP (0.000s)
[248.502609] [056/133] (782s left) kms_hdr (static-toggle-dpms)
[248.600611] Starting subtest: static-toggle-dpms
[248.607128] Subtest static-toggle-dpms: SKIP (0.000s)
[248.684483] [057/133] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[248.785876] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[255.933830] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.150s)
[256.095860] [058/133] (775s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[256.217827] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[259.988904] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.774s)
[261.148998] [059/133] (770s left) gem_lmem_swapping (parallel-random-verify)
[261.198757] Subtest parallel-random-verify: SKIP (0.000s)
[261.245765] [060/133] (770s left) kms_psr (fbc-pr-sprite-plane-move)
[261.344168] Starting subtest: fbc-pr-sprite-plane-move
[261.348097] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[261.427348] [061/133] (770s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[261.818515] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[262.645108] [062/133] (769s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[262.740035] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[262.742436] Starting dynamic subtest: pipe-A-eDP-1
[262.767693] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.776063] Starting dynamic subtest: pipe-B-eDP-1
[262.798965] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.806713] Starting dynamic subtest: pipe-C-eDP-1
[262.829617] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.837405] Starting dynamic subtest: pipe-D-eDP-1
[262.861169] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.865533] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[265.037194] [063/133] (766s left) i915_pm_rpm (gem-evict-pwrite)
[267.191368] Starting subtest: gem-evict-pwrite
[267.196732] Subtest gem-evict-pwrite: SKIP (0.000s)
[267.608537] [064/133] (764s left) gem_exec_whisper (basic-sync)
[267.683114] Starting subtest: basic-sync
[274.580058] Subtest basic-sync: SUCCESS (6.896s)
[274.777666] [065/133] (757s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[274.897675] Starting subtest: short-busy-flip-before-cursor-toggle
[274.902040] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[275.054571] [066/133] (756s left) i915_query (hwconfig_table)
[275.125883] Starting subtest: hwconfig_table
[275.419177] Subtest hwconfig_table: SUCCESS (0.001s)
[275.457209] [067/133] (756s left) kms_vrr (flipline)
[275.548519] Starting subtest: flipline
[275.554910] Subtest flipline: SKIP (0.000s)
[275.638801] [068/133] (756s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[275.740359] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[280.031377] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.292s)
[281.170203] [069/133] (750s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[281.276575] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[281.289302] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[281.363220] [070/133] (750s left) kms_prop_blob (invalid-set-prop)
[281.424953] Starting subtest: invalid-set-prop
[281.427244] Subtest invalid-set-prop: SUCCESS (0.000s)
[281.554291] [071/133] (750s left) kms_properties (crtc-properties-legacy)
[281.659664] Starting subtest: crtc-properties-legacy
[281.662002] Starting dynamic subtest: pipe-A-eDP-1
[282.114924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[282.124545] Starting dynamic subtest: pipe-B-eDP-1
[283.308637] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.193s)
[283.317861] Starting dynamic subtest: pipe-C-eDP-1
[284.436620] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[284.450110] Starting dynamic subtest: pipe-D-eDP-1
[285.555608] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.115s)
[285.557510] Subtest crtc-properties-legacy: SUCCESS (3.896s)
[286.381296] [072/133] (745s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[286.488562] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[293.426950] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.934s)
[293.627713] [073/133] (738s left) kms_psr (fbc-pr-cursor-render)
[293.748799] Starting subtest: fbc-pr-cursor-render
[293.765984] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[293.865125] [074/133] (738s left) gem_userptr_blits (huge-split)
[293.989815] Starting subtest: huge-split
[293.999056] Subtest huge-split: SUCCESS (0.007s)
[294.165104] [075/133] (738s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[294.415471] Starting subtest: cursor-rapid-movement-256x85
[294.476989] Subtest cursor-rapid-movement-256x85: SKIP (0.043s)
[294.641904] [076/133] (737s left) gem_unref_active_buffers
[294.828574] [077/133] (737s left) gem_caching (reads)
[294.884145] Subtest reads: SKIP (0.000s)
[294.948243] [078/133] (737s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[295.004816] Starting subtest: invalid-multi-wait-all-unsubmitted
[295.006737] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[295.123335] [079/133] (737s left) gem_exec_create (basic)
[295.194611] Starting subtest: basic
[295.196595] Starting dynamic subtest: smem
[299.027463] Dynamic subtest smem: SUCCESS (3.829s)
[299.030334] Subtest basic: SUCCESS (3.832s)
[299.224796] [080/133] (733s left) kms_content_protection (atomic-dpms-hdcp14)
[299.373261] Starting subtest: atomic-dpms-hdcp14
[299.378043] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[299.529580] [081/133] (733s left) sw_sync (timeline_closed)
[299.562297] Starting subtest: timeline_closed
[299.564207] Subtest timeline_closed: SUCCESS (0.000s)
[299.644398] [082/133] (732s left) perf (oa-exponents)
[299.770532] Starting subtest: oa-exponents
[299.772696] Starting dynamic subtest: 0-rcs0
[301.521462] Dynamic subtest 0-rcs0: SUCCESS (1.751s)
[301.531751] Starting dynamic subtest: 1-vcs0
[303.326746] Dynamic subtest 1-vcs0: SUCCESS (1.805s)
[303.329079] Subtest oa-exponents: SUCCESS (3.558s)
[303.376641] [083/133] (729s left) kms_feature_discovery (display-2x)
[303.487496] Starting subtest: display-2x
[303.491957] Subtest display-2x: SKIP (0.000s)
[303.575215] [084/133] (729s left) core_setmaster (master-drop-set-root)
[303.653843] Starting subtest: master-drop-set-root
[303.666251] Subtest master-drop-set-root: SUCCESS (0.013s)
[303.716605] [085/133] (728s left) kms_pm_rpm (i2c)
[305.252946] Starting subtest: i2c
[310.941330] Subtest i2c: SUCCESS (5.691s)
[311.045152] [086/133] (721s left) kms_busy (basic-hang)
[311.145813] Starting subtest: basic-hang
[311.148158] Starting dynamic subtest: flip-pipe-A
[311.747107] Dynamic subtest flip-pipe-A: SUCCESS (0.601s)
[311.757795] Starting dynamic subtest: modeset-pipe-A
[315.156463] Dynamic subtest modeset-pipe-A: SUCCESS (3.410s)
[315.169364] Starting dynamic subtest: flip-pipe-D
[316.353439] Dynamic subtest flip-pipe-D: SUCCESS (1.193s)
[316.365585] Starting dynamic subtest: modeset-pipe-D
[319.793672] Dynamic subtest modeset-pipe-D: SUCCESS (3.437s)
[319.795949] Subtest basic-hang: SUCCESS (8.648s)
[320.606660] [087/133] (712s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[320.717037] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[320.721048] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[320.825406] [088/133] (712s left) kms_flip (nonblocking-read)
[320.917484] Starting subtest: nonblocking-read
[320.919315] Subtest nonblocking-read: SUCCESS (0.000s)
[321.057919] [089/133] (711s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[321.161699] Starting subtest: yf-tiled-16bpp-rotate-270
[321.165956] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[321.264622] [090/133] (711s left) gem_mmap_wc (write-read-distinct)
[321.332883] Subtest write-read-distinct: SKIP (0.000s)
[321.404485] [091/133] (711s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[321.466571] Starting subtest: multi-wait-for-submit-submitted-signaled
[321.468912] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[321.633294] [092/133] (711s left) kms_flip (blocking-wf_vblank)
[321.729592] Starting subtest: blocking-wf_vblank
[321.731335] Starting dynamic subtest: A-eDP1
[330.646931] Dynamic subtest A-eDP1: SUCCESS (8.914s)
[330.657445] Starting dynamic subtest: B-eDP1
[339.575654] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[339.590273] Starting dynamic subtest: C-eDP1
[348.494977] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[348.510336] Starting dynamic subtest: D-eDP1
[357.419260] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[357.425443] Subtest blocking-wf_vblank: SUCCESS (35.688s)
[358.654973] [093/133] (674s left) gem_exec_alignment (pi)
[358.713809] Starting subtest: pi
[412.605957] Subtest pi: SUCCESS (53.884s)
[413.754967] [094/133] (619s left) kms_getfb (getfb-repeated-different-handles)
[413.905113] Starting subtest: getfb-repeated-different-handles
[413.907235] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[414.027570] [095/133] (619s left) syncobj_timeline (etime-multi-wait-submitted)
[414.094955] Starting subtest: etime-multi-wait-submitted
[414.198713] Subtest etime-multi-wait-submitted: SUCCESS (0.102s)
[414.287770] [096/133] (618s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[414.415028] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[415.416844] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.000s)
[416.294609] [097/133] (616s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[416.386532] Starting subtest: primary-yf-tiled-reflect-x-0
[416.457008] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.070s)
[416.570744] [098/133] (616s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[416.632100] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[416.719653] [099/133] (616s left) perf_pmu (rc6)
[416.767626] Starting subtest: rc6
[416.769555] Starting dynamic subtest: gt0
[423.128604] Dynamic subtest gt0: SUCCESS (6.361s)
[423.140173] Starting dynamic subtest: runtime-pm-gt0
[430.842052] Dynamic subtest runtime-pm-gt0: SUCCESS (7.710s)
[430.854749] Starting dynamic subtest: runtime-pm-long-gt0
[443.335039] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.489s)
[443.347575] Starting dynamic subtest: other-idle-gt0
[449.678601] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[449.691257] Starting dynamic subtest: gt1
[456.019667] Dynamic subtest gt1: SUCCESS (6.338s)
[456.032379] Starting dynamic subtest: runtime-pm-gt1
[463.499439] Dynamic subtest runtime-pm-gt1: SUCCESS (7.476s)
[463.511080] Starting dynamic subtest: runtime-pm-long-gt1
[475.994480] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.490s)
[476.004566] Starting dynamic subtest: other-idle-gt1
[482.337853] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[482.340837] Subtest rc6: SUCCESS (65.563s)
[483.444193] [100/133] (549s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[483.553012] Starting subtest: y-tiled-16bpp-rotate-0
[483.557592] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[483.629375] [101/133] (549s left) kms_flip_tiling (flip-change-tiling)
[483.731937] Starting subtest: flip-change-tiling
[483.733791] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[483.907842] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.176s)
[483.920319] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[484.042469] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[484.057407] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[484.186888] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[484.202991] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[484.341242] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.154s)
[484.353301] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[484.485490] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[484.497783] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[484.630092] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[484.641442] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[484.763756] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[484.780724] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[484.885799] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.120s)
[484.898297] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[485.020478] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[485.031867] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[485.163933] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[485.175750] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[485.307679] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[485.320084] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[485.451960] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[485.463740] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[485.586430] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[485.598232] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[485.720923] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[485.733318] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[485.830666] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[485.841782] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[485.975016] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[485.987240] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[486.129778] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.153s)
[486.139828] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[486.274641] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[486.287518] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[486.408014] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[486.420584] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[486.553103] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[486.565360] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[486.697452] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[486.709477] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[486.818820] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[486.833597] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[486.963169] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[486.977602] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[487.107926] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[487.122530] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[487.252422] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[487.266960] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[487.396832] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[487.408566] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[487.540958] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[487.553553] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[487.685629] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[487.699925] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[487.807967] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.119s)
[487.818879] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[487.952774] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[487.964669] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[488.096759] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[488.110712] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[488.241282] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[488.254998] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[488.386232] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[488.399682] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[488.530156] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.141s)
[488.544763] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[488.675024] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[488.686946] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[488.808248] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.131s)
[488.861065] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[490.060125] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.205s)
[490.072239] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[490.194355] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[490.205887] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[490.327489] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[490.339467] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[490.470640] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[490.484237] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[490.614860] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[490.627181] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[490.759260] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[490.774130] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[490.893030] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[490.905772] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[491.004346] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[491.016619] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[491.138618] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[491.153688] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[491.282427] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[491.295147] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[491.425981] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[491.441032] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[491.570963] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[491.584018] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[491.704066] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[491.716295] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[491.850420] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s)
[491.861696] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[491.960843] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[491.973317] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[492.104440] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[492.121050] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[492.248282] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s)
[492.264819] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[492.393298] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[492.406090] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[492.538038] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[492.554399] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[492.682827] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[492.698787] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[492.827288] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[492.839147] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[492.948967] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[492.961434] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[493.092789] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[493.106512] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[493.237181] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[493.253051] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[493.382207] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[493.394423] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[493.525939] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[493.541163] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[493.670444] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[493.684834] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[493.815303] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[493.827309] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[493.938047] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[493.951763] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[494.082328] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[494.094878] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[494.226081] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[494.240368] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[494.370718] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[494.385468] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[494.515411] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[494.529006] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[494.659894] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[494.671140] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[494.804448] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[494.816867] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[494.954318] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.148s)
[495.006654] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[496.195240] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.195s)
[496.208105] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[496.295424] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[496.307627] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[496.395290] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[496.407560] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[496.517157] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.121s)
[496.529835] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[496.627796] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[496.639880] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[496.739042] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[496.751490] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[496.839638] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[496.852200] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[496.939682] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[496.952245] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[497.039548] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[497.051647] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[497.150436] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[497.162685] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[497.261439] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[497.273076] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[497.372437] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[497.384137] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[497.472496] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[497.484686] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[497.572944] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[497.584989] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[497.673105] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[497.685276] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[497.772715] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.098s)
[497.784801] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[497.883548] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[497.895621] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[497.994842] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[498.009419] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[498.106265] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[498.119062] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[498.216988] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[498.232959] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[498.328804] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[498.341280] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[498.439789] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[498.452313] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[498.550436] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[498.562521] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[498.661398] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[498.673113] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[498.772540] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[498.784292] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[498.883541] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[498.895364] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[498.994821] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[499.006312] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[499.105759] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[499.117546] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[499.217614] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[499.230099] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[499.328786] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[499.339858] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[499.439513] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[499.451321] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[499.550386] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[499.564913] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[499.661609] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[499.673411] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[499.772621] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s)
[499.784315] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[499.884590] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[499.897614] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[499.995428] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[500.036962] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[501.227070] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.197s)
[501.239286] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[501.338436] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[501.349056] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[501.438464] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[501.455779] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[501.549740] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[501.562237] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[501.659831] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[501.672102] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[501.771012] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[501.785967] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[501.882577] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s)
[501.898555] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[501.994085] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[502.005572] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[502.093323] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[502.104937] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[502.204519] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[502.214585] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[502.315547] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[502.327198] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[502.426519] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[502.437833] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[502.526751] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[502.538977] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[502.626506] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[502.638030] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[502.726958] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[502.738349] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[502.837930] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[502.847724] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[502.948592] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[502.960117] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[503.048821] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.098s)
[503.062428] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[503.160067] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[503.171725] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[503.260113] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[503.273868] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[503.371334] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[503.383067] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[503.482383] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[503.494467] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[503.593469] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[503.605326] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[503.715623] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.121s)
[503.726251] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[503.837934] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.120s)
[503.849603] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[503.948866] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[503.960555] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[504.059888] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[504.071763] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[504.171224] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s)
[504.185315] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[504.282627] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.108s)
[504.294688] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[504.393913] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[504.405807] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[504.504506] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[504.516143] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[504.615680] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[504.627293] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[504.726528] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[504.738506] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[504.837919] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[504.849323] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[504.949379] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[504.961738] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[505.060853] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[505.093203] Subtest flip-change-tiling: SUCCESS (21.360s)
[506.296462] [102/133] (527s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[506.415129] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[506.419678] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[506.494376] [103/133] (527s left) gem_exec_fence (submit-chain)
[506.674378] Starting subtest: submit-chain
[506.688573] Subtest submit-chain: SUCCESS (0.018s)
[508.080704] [104/133] (525s left) gem_ringfill (engines-basic)
[514.006335] Starting subtest: engines-basic
[514.008841] Starting dynamic subtest: rcs0
[514.090731] Dynamic subtest rcs0: SUCCESS (0.084s)
[514.103441] Starting dynamic subtest: bcs0
[514.136159] Dynamic subtest bcs0: SUCCESS (0.044s)
[514.146934] Starting dynamic subtest: vcs0
[514.177313] Dynamic subtest vcs0: SUCCESS (0.040s)
[514.188035] Starting dynamic subtest: vcs1
[514.221476] Dynamic subtest vcs1: SUCCESS (0.042s)
[514.232443] Starting dynamic subtest: vecs0
[514.264612] Dynamic subtest vecs0: SUCCESS (0.041s)
[514.275199] Starting dynamic subtest: ccs0
[514.309189] Dynamic subtest ccs0: SUCCESS (0.043s)
[514.311512] Subtest engines-basic: SUCCESS (0.305s)
[514.369470] [105/133] (519s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[514.489625] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[514.491937] Starting dynamic subtest: pipe-A-eDP-1
[514.512557] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[514.528125] Starting dynamic subtest: pipe-B-eDP-1
[514.547777] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[514.562449] Starting dynamic subtest: pipe-C-eDP-1
[514.582477] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[514.593141] Starting dynamic subtest: pipe-D-eDP-1
[514.612128] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[514.614003] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[516.768545] [106/133] (516s left) perf_pmu (busy-check-all)
[516.809945] Starting subtest: busy-check-all
[516.812119] Starting dynamic subtest: rcs0
[517.376154] Dynamic subtest rcs0: SUCCESS (0.566s)
[517.393366] Starting dynamic subtest: bcs0
[517.925910] Dynamic subtest bcs0: SUCCESS (0.547s)
[517.938702] Starting dynamic subtest: vcs0
[518.994825] Dynamic subtest vcs0: SUCCESS (1.065s)
[519.007476] Starting dynamic subtest: vcs1
[520.979827] Dynamic subtest vcs1: SUCCESS (1.982s)
[520.992188] Starting dynamic subtest: vecs0
[523.026879] Dynamic subtest vecs0: SUCCESS (2.044s)
[523.039656] Starting dynamic subtest: ccs0
[523.580752] Dynamic subtest ccs0: SUCCESS (0.552s)
[523.583285] Subtest busy-check-all: SUCCESS (6.772s)
[523.682953] [107/133] (509s left) gem_exec_schedule (submit-early-slice)
[523.755832] Starting subtest: submit-early-slice
[523.757730] Starting dynamic subtest: rcs0
[523.811721] Dynamic subtest rcs0: SUCCESS (0.060s)
[523.823996] Starting dynamic subtest: bcs0
[523.857968] Dynamic subtest bcs0: SUCCESS (0.046s)
[523.869356] Starting dynamic subtest: vcs0
[523.913871] Dynamic subtest vcs0: SUCCESS (0.055s)
[523.928099] Starting dynamic subtest: vcs1
[523.972970] Dynamic subtest vcs1: SUCCESS (0.058s)
[523.983066] Starting dynamic subtest: vecs0
[524.016664] Dynamic subtest vecs0: SUCCESS (0.043s)
[524.027544] Starting dynamic subtest: ccs0
[524.066704] Dynamic subtest ccs0: SUCCESS (0.049s)
[524.069052] Subtest submit-early-slice: SUCCESS (0.316s)
[525.082707] [108/133] (508s left) gem_exec_balancer (parallel-bb-first)
[525.337081] Starting subtest: parallel-bb-first
[526.264720] Subtest parallel-bb-first: SUCCESS (0.928s)
[527.011244] [109/133] (506s left) gen9_exec_parse (bb-large)
[527.073231] Subtest bb-large: SKIP (0.000s)
[527.159128] [110/133] (506s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[527.268442] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[527.270710] Starting dynamic subtest: pipe-A-eDP-1
[527.328559] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[527.342847] Starting dynamic subtest: pipe-B-eDP-1
[527.400798] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[527.410458] Starting dynamic subtest: pipe-C-eDP-1
[527.464629] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[527.473954] Starting dynamic subtest: pipe-D-eDP-1
[527.531369] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[527.535591] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[529.445998] [111/133] (504s left) api_intel_bb (simple-bb-ctx)
[529.510852] Starting subtest: simple-bb-ctx
[529.518902] Subtest simple-bb-ctx: SUCCESS (0.008s)
[529.641795] [112/133] (504s left) gem_ctx_isolation (preservation-s3)
[529.712411] Starting subtest: preservation-S3
[529.714581] Starting dynamic subtest: rcs0
[546.438673] Dynamic subtest rcs0: SUCCESS (1.798s)
[546.449198] Starting dynamic subtest: bcs0
[563.440369] Dynamic subtest bcs0: SUCCESS (1.728s)
[563.451768] Starting dynamic subtest: vcs0
[580.438707] Dynamic subtest vcs0: SUCCESS (3.239s)
[580.449067] Starting dynamic subtest: vcs1
[598.444060] Dynamic subtest vcs1: SUCCESS (4.982s)
[598.458806] Starting dynamic subtest: vecs0
[616.435748] Dynamic subtest vecs0: SUCCESS (5.002s)
[616.446672] Starting dynamic subtest: ccs0
[634.437571] Dynamic subtest ccs0: SUCCESS (3.170s)
[634.439938] Subtest preservation-S3: SUCCESS (19.925s)
[644.687019] [113/133] (399s left) sriov_basic (enable-vfs-autoprobe-on)
[644.759921] Starting subtest: enable-vfs-autoprobe-on
[644.762349] Starting dynamic subtest: numvfs-1
[644.841130] Dynamic subtest numvfs-1: FAIL (0.027s)
[644.852545] Starting dynamic subtest: numvfs-2
[644.924515] Dynamic subtest numvfs-2: FAIL (0.004s)
[644.935759] Starting dynamic subtest: numvfs-3
[645.007239] Dynamic subtest numvfs-3: FAIL (0.005s)
[645.018202] Starting dynamic subtest: numvfs-4
[645.092437] Dynamic subtest numvfs-4: FAIL (0.003s)
[645.103812] Starting dynamic subtest: numvfs-5
[645.177546] Dynamic subtest numvfs-5: FAIL (0.003s)
[645.188304] Starting dynamic subtest: numvfs-6
[645.260923] Dynamic subtest numvfs-6: FAIL (0.003s)
[645.272259] Starting dynamic subtest: numvfs-7
[645.344026] Dynamic subtest numvfs-7: FAIL (0.003s)
[645.353913] Starting dynamic subtest: numvfs-random
[645.425173] Dynamic subtest numvfs-random: FAIL (0.004s)
[645.436705] Starting dynamic subtest: numvfs-all
[645.508516] Dynamic subtest numvfs-all: FAIL (0.516s)
[645.510538] Subtest enable-vfs-autoprobe-on: FAIL (0.578s)
[645.550435] [114/133] (398s left) perf_pmu (gt-awake)
[645.593667] Starting subtest: gt-awake
[653.778279] Subtest gt-awake: SUCCESS (8.182s)
[653.881745] [115/133] (390s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[653.951435] Subtest no-spare-fences-busy: SKIP (0.000s)
[654.053772] [116/133] (390s left) kms_rotation_crc (primary-rotation-90)
[654.150297] Starting subtest: primary-rotation-90
[654.154841] Subtest primary-rotation-90: SKIP (0.001s)
[654.203467] [117/133] (389s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[654.296112] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[655.087109] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s)
[655.396635] [118/133] (388s left) gem_mmap_wc (write-prefaulted)
[655.466572] Subtest write-prefaulted: SKIP (0.000s)
[655.541928] [119/133] (388s left) gem_pxp (reject-modify-context-protection-off-1)
[655.667891] Starting subtest: reject-modify-context-protection-off-1
[655.670484] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[655.751011] [120/133] (388s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[655.854255] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[655.856167] Starting dynamic subtest: pipe-A-eDP-1
[655.876461] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[655.887982] Starting dynamic subtest: pipe-B-eDP-1
[655.908130] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[655.917986] Starting dynamic subtest: pipe-C-eDP-1
[655.938274] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[655.948080] Starting dynamic subtest: pipe-D-eDP-1
[655.968458] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[655.970757] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[658.115826] [121/133] (386s left) kms_plane_lowres (tiling-x)
[658.213016] Starting subtest: tiling-x
[658.215125] Starting dynamic subtest: pipe-A-eDP-1
[658.219459] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[658.515903] Starting dynamic subtest: pipe-B-eDP-1
[658.520584] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[658.530415] Starting dynamic subtest: pipe-C-eDP-1
[658.535469] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[658.545325] Starting dynamic subtest: pipe-D-eDP-1
[658.549579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[658.553799] Subtest tiling-x: SKIP (0.302s)
[659.339768] [122/133] (384s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[659.429138] Starting subtest: multiplane-rotation-cropping-top
[676.790977] Subtest multiplane-rotation-cropping-top: SUCCESS (17.349s)
[676.909931] [123/133] (367s left) gem_mmap_gtt (basic-write-read-distinct)
[676.976760] Subtest basic-write-read-distinct: SKIP (0.000s)
[677.047337] [124/133] (367s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[677.145218] Starting subtest: fbc-psr2-sprite-mmap-gtt
[677.147058] Starting dynamic subtest: eDP-1
[677.150291] Dynamic subtest eDP-1: SKIP (0.000s)
[677.153657] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[677.193256] [125/133] (367s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[677.283668] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[677.287070] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[677.328350] [126/133] (367s left) gem_tiled_partial_pwrite_pread (writes)
[677.385480] Subtest writes: SKIP (0.000s)
[677.461896] [127/133] (367s left) kms_atomic (crtc-invalid-params-fence)
[677.551032] Starting subtest: crtc-invalid-params-fence
[677.552789] Starting dynamic subtest: pipe-A-eDP-1
[677.972003] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[677.974215] Subtest crtc-invalid-params-fence: SUCCESS (0.422s)
[678.778249] [128/133] (365s left) gem_busy (parallel)
[678.969807] Starting subtest: parallel
[678.972232] Starting dynamic subtest: rcs0
[680.785879] Dynamic subtest rcs0: SUCCESS (1.811s)
[680.798767] Starting dynamic subtest: bcs0
[682.769629] Dynamic subtest bcs0: SUCCESS (1.979s)
[682.781150] Starting dynamic subtest: vcs0
[684.754230] Dynamic subtest vcs0: SUCCESS (1.980s)
[684.767947] Starting dynamic subtest: vcs1
[686.801921] Dynamic subtest vcs1: SUCCESS (2.043s)
[686.814694] Starting dynamic subtest: vecs0
[688.787277] Dynamic subtest vecs0: SUCCESS (1.981s)
[688.800537] Starting dynamic subtest: ccs0
[690.769377] Dynamic subtest ccs0: SUCCESS (1.978s)
[690.772016] Subtest parallel: SUCCESS (11.789s)
[691.000706] [129/133] (353s left) gem_ctx_persistence (processes)
[691.067937] Starting subtest: processes
[692.781661] Subtest processes: SUCCESS (1.712s)
[692.839862] [130/133] (351s left) kms_big_fb (4-tiled-addfb-size-overflow)
[692.944516] Starting subtest: 4-tiled-addfb-size-overflow
[692.946860] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[693.023246] [131/133] (351s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[693.125121] Starting subtest: x-tiled-64bpp-rotate-270
[693.144378] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[693.259166] [132/133] (351s left) kms_plane_scaling (planes-scaler-unity-scaling)
[693.358092] Starting subtest: planes-scaler-unity-scaling
[693.360344] Starting dynamic subtest: pipe-A
[693.420127] Dynamic subtest pipe-A: SUCCESS (0.064s)
[693.432584] Starting dynamic subtest: pipe-B
[694.522647] Dynamic subtest pipe-B: SUCCESS (1.101s)
[694.534885] Starting dynamic subtest: pipe-C
[695.622658] Dynamic subtest pipe-C: SUCCESS (1.098s)
[695.633901] Starting dynamic subtest: pipe-D
[696.752171] Dynamic subtest pipe-D: SUCCESS (1.127s)
[696.754517] Subtest planes-scaler-unity-scaling: SUCCESS (3.395s)
[697.893993] [133/133] (346s left) gem_exec_whisper (basic-contexts)
[697.959637] Starting subtest: basic-contexts
[704.065660] Subtest basic-contexts: SUCCESS (6.102s)
[704.226342] 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.