[57.113662] Initializing watchdogs
[57.113811]   /dev/watchdog0
[57.128115] [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.132342] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.134505] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.137811] [001/134] (960s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[57.296143] Starting subtest: flip-vs-cursor-atomic-transitions
[64.792462] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.537s)
[65.668818] [002/134] (952s left) kms_universal_plane (cursor-fb-leak)
[65.764162] Starting subtest: cursor-fb-leak
[65.766578] Starting dynamic subtest: pipe-A-eDP-1
[66.095428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.333s)
[66.104843] Starting dynamic subtest: pipe-B-eDP-1
[67.490821] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.397s)
[67.503568] Starting dynamic subtest: pipe-C-eDP-1
[68.876668] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.386s)
[68.886953] Starting dynamic subtest: pipe-D-eDP-1
[70.209034] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[70.211458] Subtest cursor-fb-leak: SUCCESS (4.456s)
[71.369692] [003/134] (946s left) kms_vrr (seamless-rr-switch-drrs)
[71.461410] Starting subtest: seamless-rr-switch-drrs
[71.468399] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[71.544576] [004/134] (946s left) syncobj_timeline (invalid-transfer-illegal-handle)
[71.606887] Starting subtest: invalid-transfer-illegal-handle
[71.609188] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[71.735393] [005/134] (946s left) gem_mmap_gtt (medium-copy)
[71.789089] Subtest medium-copy: SKIP (0.000s)
[71.862488] [006/134] (945s left) gem_mmap_wc (write-cpu-read-wc)
[71.913152] Subtest write-cpu-read-wc: SKIP (0.000s)
[71.975204] [007/134] (945s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[72.076122] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[72.080461] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[72.189273] [008/134] (945s left) kms_plane (pixel-format-linear-modifier)
[72.288976] Starting subtest: pixel-format-linear-modifier
[72.313945] Starting dynamic subtest: pipe-A-plane-0
[75.888818] Dynamic subtest pipe-A-plane-0: SUCCESS (3.578s)
[75.896892] Starting dynamic subtest: pipe-A-plane-3
[77.532323] Dynamic subtest pipe-A-plane-3: SUCCESS (1.644s)
[77.540953] Starting dynamic subtest: pipe-A-plane-5
[77.742841] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[78.847956] Starting dynamic subtest: pipe-B-plane-0
[82.519274] Dynamic subtest pipe-B-plane-0: SUCCESS (3.678s)
[82.528073] Starting dynamic subtest: pipe-B-plane-3
[84.231127] Dynamic subtest pipe-B-plane-3: SUCCESS (1.711s)
[84.239398] Starting dynamic subtest: pipe-B-plane-5
[84.453193] Dynamic subtest pipe-B-plane-5: SUCCESS (0.222s)
[84.765245] Subtest pixel-format-linear-modifier: SUCCESS (12.480s)
[85.642673] [009/134] (932s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[85.755580] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[90.383766] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.630s)
[91.547246] [010/134] (926s left) gem_mmap_wc (write-read-distinct)
[91.602463] Subtest write-read-distinct: SKIP (0.000s)
[91.670466] [011/134] (926s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[91.766616] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[95.712908] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.950s)
[96.838885] [012/134] (921s left) syncobj_timeline (32bits-limit)
[96.900274] Starting subtest: 32bits-limit
[96.902807] Subtest 32bits-limit: SUCCESS (0.001s)
[97.029287] [013/134] (921s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[97.106884] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[97.271860] [014/134] (920s left) gem_flink_race (flink_name)
[97.305528] Starting subtest: flink_name
[102.727304] Subtest flink_name: SUCCESS (5.399s)
[102.873118] [015/134] (915s left) kms_flip (dpms-vs-vblank-race-interruptible)
[102.969371] Starting subtest: dpms-vs-vblank-race-interruptible
[102.971823] Starting dynamic subtest: A-eDP1
[107.897678] Dynamic subtest A-eDP1: SUCCESS (4.926s)
[107.907331] Starting dynamic subtest: B-eDP1
[111.427630] Dynamic subtest B-eDP1: SUCCESS (3.529s)
[111.434849] Starting dynamic subtest: C-eDP1
[116.036874] Dynamic subtest C-eDP1: SUCCESS (4.608s)
[116.045185] Starting dynamic subtest: D-eDP1
[120.672079] Dynamic subtest D-eDP1: SUCCESS (4.631s)
[120.674488] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.703s)
[121.563354] [016/134] (896s left) gem_userptr_blits (forbidden-operations)
[121.638059] Starting subtest: forbidden-operations
[121.642469] Subtest forbidden-operations: SKIP (0.000s)
[121.799760] [017/134] (896s left) kms_cursor_crc (cursor-offscreen-128x128)
[122.006991] Starting subtest: cursor-offscreen-128x128
[122.011769] Starting dynamic subtest: pipe-A-eDP-1
[123.963253] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.952s)
[123.990068] Starting dynamic subtest: pipe-D-eDP-1
[126.587221] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.602s)
[126.589567] Subtest cursor-offscreen-128x128: SUCCESS (4.579s)
[127.430071] [018/134] (890s left) sw_sync (sync_random_merge)
[127.464824] Starting subtest: sync_random_merge
[127.499951] Subtest sync_random_merge: SUCCESS (0.037s)
[127.570571] [019/134] (890s left) gem_exec_fence (keep-in-fence)
[127.748473] Starting subtest: keep-in-fence
[127.750895] Starting dynamic subtest: rcs0
[127.817886] Dynamic subtest rcs0: SUCCESS (0.069s)
[127.827591] Starting dynamic subtest: bcs0
[127.870588] Dynamic subtest bcs0: SUCCESS (0.052s)
[127.880029] Starting dynamic subtest: vcs0
[129.943596] Dynamic subtest vcs0: SUCCESS (2.071s)
[129.953413] Starting dynamic subtest: vcs1
[131.924909] Dynamic subtest vcs1: SUCCESS (1.978s)
[131.935117] Starting dynamic subtest: vecs0
[133.909829] Dynamic subtest vecs0: SUCCESS (1.982s)
[133.927805] Starting dynamic subtest: ccs0
[134.151054] Dynamic subtest ccs0: SUCCESS (0.241s)
[134.153808] Subtest keep-in-fence: SUCCESS (6.402s)
[135.964803] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[135.968023] [020/134] (882s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[136.064991] Starting subtest: fbc-pr-sprite-mmap-gtt
[136.069301] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[136.147791] [021/134] (882s left) gem_ccs (block-copy-uncompressed)
[136.210274] Starting subtest: block-copy-uncompressed
[136.212691] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[136.232300] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[136.241976] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[136.248792] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[136.256052] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[136.265556] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[136.272752] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[136.282260] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[136.284531] Subtest block-copy-uncompressed: SUCCESS (0.073s)
[136.424171] [022/134] (882s left) gem_readwrite (beyond-eob)
[136.489219] Subtest beyond-EOB: SKIP (0.000s)
[136.556763] [023/134] (881s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[136.643361] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[136.645802] Starting dynamic subtest: pipe-A-eDP-1
[136.703045] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[136.711185] Starting dynamic subtest: pipe-B-eDP-1
[136.767915] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[136.776677] Starting dynamic subtest: pipe-C-eDP-1
[136.833136] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[136.841884] Starting dynamic subtest: pipe-D-eDP-1
[136.900447] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[136.904184] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[138.821677] [024/134] (879s left) gem_exec_fence (basic-await)
[139.013834] Starting subtest: basic-await
[139.016305] Starting dynamic subtest: rcs0
[139.092468] Dynamic subtest rcs0: SUCCESS (0.078s)
[139.103685] Starting dynamic subtest: bcs0
[139.166231] Dynamic subtest bcs0: SUCCESS (0.073s)
[139.176893] Starting dynamic subtest: vcs0
[139.239431] Dynamic subtest vcs0: SUCCESS (0.072s)
[139.248955] Starting dynamic subtest: vcs1
[139.316325] Dynamic subtest vcs1: SUCCESS (0.075s)
[139.326221] Starting dynamic subtest: vecs0
[139.388761] Dynamic subtest vecs0: SUCCESS (0.071s)
[139.398750] Starting dynamic subtest: ccs0
[139.459155] Dynamic subtest ccs0: SUCCESS (0.070s)
[139.461522] Subtest basic-await: SUCCESS (0.446s)
[140.954263] [025/134] (877s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[141.052221] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[141.439344] Starting dynamic subtest: pipe-A-eDP-1
[144.185418] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.745s)
[144.549611] Starting dynamic subtest: pipe-B-eDP-1
[147.314071] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.771s)
[147.685931] Starting dynamic subtest: pipe-C-eDP-1
[150.447580] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[150.816858] Starting dynamic subtest: pipe-D-eDP-1
[153.577076] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s)
[153.579713] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.526s)
[154.772387] [026/134] (863s left) kms_chamelium_hpd (hdmi-hpd-storm)
[155.167968] Subtest hdmi-hpd-storm: SKIP (0.000s)
[155.974783] [027/134] (862s left) prime_busy (after)
[156.031316] Starting subtest: after
[156.033762] Starting dynamic subtest: rcs0
[156.076606] Dynamic subtest rcs0: SUCCESS (0.045s)
[156.086557] Starting dynamic subtest: bcs0
[156.127435] Dynamic subtest bcs0: SUCCESS (0.050s)
[156.136705] Starting dynamic subtest: vcs0
[156.167779] Dynamic subtest vcs0: SUCCESS (0.040s)
[156.176208] Starting dynamic subtest: vcs1
[156.209239] Dynamic subtest vcs1: SUCCESS (0.041s)
[156.217665] Starting dynamic subtest: vecs0
[156.249231] Dynamic subtest vecs0: SUCCESS (0.039s)
[156.257718] Starting dynamic subtest: ccs0
[156.289298] Dynamic subtest ccs0: SUCCESS (0.039s)
[156.397720] Subtest after: SUCCESS (0.367s)
[156.493087] [028/134] (862s left) vgem_basic (create)
[156.533985] Starting subtest: create
[156.536416] Subtest create: SUCCESS (0.000s)
[156.601615] [029/134] (862s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[156.690999] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[156.693391] Starting dynamic subtest: pipe-A
[156.753539] Dynamic subtest pipe-A: SUCCESS (0.065s)
[156.762889] Starting dynamic subtest: pipe-B
[157.915615] Dynamic subtest pipe-B: SUCCESS (1.161s)
[157.925532] Starting dynamic subtest: pipe-C
[159.043364] Dynamic subtest pipe-C: SUCCESS (1.127s)
[159.052434] Starting dynamic subtest: pipe-D
[160.167488] Dynamic subtest pipe-D: SUCCESS (1.123s)
[160.169877] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.479s)
[161.345614] [030/134] (857s left) kms_cursor_crc (cursor-sliding-64x21)
[161.529635] Starting subtest: cursor-sliding-64x21
[161.577221] Subtest cursor-sliding-64x21: SKIP (0.042s)
[161.848958] [031/134] (856s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[161.916254] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[162.008008] [032/134] (856s left) kms_prop_blob (blob-prop-lifetime)
[162.080440] Starting subtest: blob-prop-lifetime
[162.082781] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[162.218570] [033/134] (856s left) kms_flip (2x-plain-flip-ts-check)
[162.311268] Starting subtest: 2x-plain-flip-ts-check
[162.320210] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[162.408767] [034/134] (856s left) i915_pm_freq_mult (media-freq)
[162.470834] Starting subtest: media-freq
[162.472890] Starting dynamic subtest: gt0
[162.476836] Dynamic subtest gt0: SKIP (0.000s)
[162.486054] Starting dynamic subtest: gt1
[162.489434] Dynamic subtest gt1: SKIP (0.000s)
[162.492893] Subtest media-freq: SKIP (0.001s)
[162.593773] [035/134] (856s left) kms_psr (psr2-primary-page-flip)
[162.681465] Starting subtest: psr2-primary-page-flip
[162.683357] Starting dynamic subtest: eDP-1
[164.413946] Dynamic subtest eDP-1: SUCCESS (1.732s)
[164.416241] Subtest psr2-primary-page-flip: SUCCESS (1.733s)
[165.230674] [036/134] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[165.339999] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[165.344401] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[165.441870] [037/134] (853s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[165.532135] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[173.021356] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.490s)
[173.177838] [038/134] (845s left) gem_softpin (32b-excludes-last-page)
[173.233580] Starting subtest: 32b-excludes-last-page
[173.238822] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[173.394027] [039/134] (845s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[173.504783] Starting subtest: yf-tiled-16bpp-rotate-0
[173.509185] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[173.625865] [040/134] (845s left) gem_ctx_param (invalid-get-engines)
[173.679907] Starting subtest: invalid-get-engines
[173.682356] Subtest invalid-get-engines: SUCCESS (0.001s)
[173.800485] [041/134] (845s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[173.890658] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[173.894801] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[174.012678] [042/134] (845s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[179.014447] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[179.019099] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[179.890186] [043/134] (839s left) gem_lmem_swapping (heavy-multi)
[179.939708] Subtest heavy-multi: SKIP (0.000s)
[179.981131] [044/134] (839s left) gem_ctx_persistence (heartbeat-stop)
[180.043159] Starting subtest: heartbeat-stop
[180.047795] Subtest heartbeat-stop: SKIP (0.000s)
[180.194355] [045/134] (839s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[180.311088] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[180.315092] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[180.442638] [046/134] (838s left) gem_unfence_active_buffers
[180.631938] [047/134] (838s left) gem_lmem_swapping (random-engines)
[180.686280] Subtest random-engines: SKIP (0.000s)
[180.732707] [048/134] (838s left) gem_compute (compute-square)
[180.798977] Starting subtest: compute-square
[180.804723] Subtest compute-square: SUCCESS (0.007s)
[180.956324] [049/134] (838s left) perf (oa-formats)
[181.092539] Starting subtest: oa-formats
[181.094465] Starting dynamic subtest: 0-rcs0
[181.109798] Dynamic subtest 0-rcs0: SUCCESS (0.019s)
[181.117020] Starting dynamic subtest: 1-vecs0
[181.132664] Dynamic subtest 1-vecs0: SUCCESS (0.022s)
[181.134613] Subtest oa-formats: SUCCESS (0.043s)
[181.180344] [050/134] (838s left) kms_dsc (dsc-with-formats)
[181.282474] Starting subtest: dsc-with-formats
[181.315359] Subtest dsc-with-formats: SKIP (0.001s)
[181.374559] [051/134] (838s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[181.442584] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[181.444698] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[181.559216] [052/134] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[181.662249] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[181.665809] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[181.795521] [053/134] (837s left) kms_atomic (atomic-plane-damage)
[181.895719] Starting subtest: atomic-plane-damage
[181.947437] Starting dynamic subtest: pipe-A-eDP-1
[182.533732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[182.536063] Subtest atomic-plane-damage: SUCCESS (0.637s)
[183.433555] [054/134] (836s left) kms_cursor_crc (cursor-random-512x170)
[183.721171] Starting subtest: cursor-random-512x170
[183.725657] Subtest cursor-random-512x170: SKIP (0.001s)
[183.893970] [055/134] (835s left) gem_mmap_offset (isolation)
[183.957110] Starting subtest: isolation
[183.974534] Subtest isolation: SUCCESS (0.006s)
[184.103406] [056/134] (835s left) gem_exec_suspend (basic-s0)
[184.163397] Starting subtest: basic-S0
[184.165733] Starting dynamic subtest: smem
[204.933125] Dynamic subtest smem: SUCCESS (6.811s)
[204.935797] Subtest basic-S0: SUCCESS (6.813s)
[205.125927] [057/134] (814s left) drm_read (invalid-buffer)
[205.283194] Starting subtest: invalid-buffer
[205.285584] Subtest invalid-buffer: SUCCESS (0.000s)
[205.477242] [058/134] (814s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[205.577176] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[205.581159] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[205.688904] [059/134] (814s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[205.775695] Starting subtest: x-tiled-16bpp-rotate-90
[205.794990] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[205.942495] [060/134] (814s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[206.037059] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[206.040492] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[206.168088] [061/134] (813s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[206.266310] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[206.268207] Starting dynamic subtest: pipe-A-eDP-1
[206.286732] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[206.296475] Starting dynamic subtest: pipe-B-eDP-1
[206.313322] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[206.320602] Starting dynamic subtest: pipe-C-eDP-1
[206.337721] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[206.344982] Starting dynamic subtest: pipe-D-eDP-1
[206.362327] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[206.365816] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[208.492014] [062/134] (811s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[208.587898] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[208.589822] Starting dynamic subtest: pipe-A-eDP-1
[209.304557] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[209.313849] Starting dynamic subtest: pipe-B-eDP-1
[211.035895] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.755s)
[211.044058] Starting dynamic subtest: pipe-C-eDP-1
[212.772647] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.755s)
[212.780543] Starting dynamic subtest: pipe-D-eDP-1
[214.593959] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.837s)
[214.595784] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.073s)
[215.730211] [063/134] (804s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[215.861177] Starting subtest: basic-flip-before-cursor-varying-size
[216.790487] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.936s)
[217.633235] [064/134] (802s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[217.730447] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[217.734506] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[217.851192] [065/134] (802s left) kms_content_protection (lic-type-0-hdcp14)
[217.983868] Starting subtest: lic-type-0-hdcp14
[217.988322] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[218.146896] [066/134] (802s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[218.255458] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[218.259566] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[218.379741] [067/134] (801s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[218.487793] Starting subtest: y-tiled-8bpp-rotate-90
[218.492206] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[218.595455] [068/134] (801s left) gem_exec_schedule (u-lateslice)
[218.673830] Starting subtest: u-lateslice
[218.675555] Starting dynamic subtest: rcs0
[218.686991] Dynamic subtest rcs0: SUCCESS (0.021s)
[218.696694] Starting dynamic subtest: bcs0
[218.704636] Dynamic subtest bcs0: SUCCESS (0.017s)
[218.712683] Starting dynamic subtest: vcs0
[218.722136] Dynamic subtest vcs0: SUCCESS (0.017s)
[218.730698] Starting dynamic subtest: vcs1
[218.742632] Dynamic subtest vcs1: SUCCESS (0.020s)
[218.750371] Starting dynamic subtest: vecs0
[218.760438] Dynamic subtest vecs0: SUCCESS (0.017s)
[218.768102] Starting dynamic subtest: ccs0
[218.776823] Dynamic subtest ccs0: SUCCESS (0.015s)
[218.778661] Subtest u-lateslice: SUCCESS (0.112s)
[220.052750] [069/134] (800s left) sw_sync (timeline_closed)
[220.092060] Starting subtest: timeline_closed
[220.094369] Subtest timeline_closed: SUCCESS (0.000s)
[220.151697] [070/134] (800s left) kms_frontbuffer_tracking (fbc-suspend)
[220.236040] Starting subtest: fbc-suspend
[258.468415] Subtest fbc-suspend: SUCCESS (7.466s)
[259.645079] [071/134] (760s left) kms_color (ctm-green-to-red)
[259.748423] Starting subtest: ctm-green-to-red
[259.750664] Starting dynamic subtest: pipe-A-eDP-1
[260.434899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s)
[260.444028] Starting dynamic subtest: pipe-B-eDP-1
[261.784115] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.372s)
[261.793487] Starting dynamic subtest: pipe-C-eDP-1
[263.235416] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.467s)
[263.244920] Starting dynamic subtest: pipe-D-eDP-1
[264.565446] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.348s)
[264.567782] Subtest ctm-green-to-red: SUCCESS (4.891s)
[265.393561] [072/134] (755s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[265.490518] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[265.494795] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[265.617412] [073/134] (754s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[265.711630] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[265.715964] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[265.835595] [074/134] (754s left) sw_sync (alloc_fence)
[265.870498] Starting subtest: alloc_fence
[265.872826] Subtest alloc_fence: SUCCESS (0.000s)
[265.938081] [075/134] (754s left) kms_getfb (getfb-reject-nv12)
[266.026472] Starting subtest: getfb-reject-nv12
[266.028808] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[266.197454] [076/134] (754s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[271.210266] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[271.212568] Starting dynamic subtest: pipe-A-eDP-1
[277.830603] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.639s)
[277.840091] Starting dynamic subtest: pipe-B-eDP-1
[284.482850] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.662s)
[284.485183] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.306s)
[285.375654] [077/134] (735s left) api_intel_bb (purge-bb)
[285.446747] Starting subtest: purge-bb
[285.449137] Subtest purge-bb: SUCCESS (0.004s)
[285.597825] [078/134] (735s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[285.701322] Starting subtest: crc-primary-basic-yf-tiled-ccs
[285.703487] Starting dynamic subtest: pipe-A-eDP-1
[285.726492] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[285.736945] Starting dynamic subtest: pipe-B-eDP-1
[285.757165] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[285.767394] Starting dynamic subtest: pipe-C-eDP-1
[285.789802] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[285.799278] Starting dynamic subtest: pipe-D-eDP-1
[285.821169] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[285.825502] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[288.023399] [079/134] (732s left) gem_userptr_blits (input-checking)
[288.088071] Starting subtest: input-checking
[288.090039] Subtest input-checking: SUCCESS (0.000s)
[288.236370] [080/134] (732s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[288.331953] Starting subtest: psr-rgb565-draw-render
[295.419251] Subtest psr-rgb565-draw-render: SUCCESS (7.085s)
[295.581588] [081/134] (725s left) syncobj_timeline (transfer-timeline-point)
[295.652786] Starting subtest: transfer-timeline-point
[295.655202] Subtest transfer-timeline-point: SUCCESS (0.001s)
[295.798663] [082/134] (725s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[295.864928] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[295.869473] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[296.074867] [083/134] (724s left) kms_scaling_modes (scaling-mode-full)
[296.176512] Starting subtest: scaling-mode-full
[296.178821] Starting dynamic subtest: pipe-A-eDP-1
[296.269858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[296.279589] Starting dynamic subtest: pipe-B-eDP-1
[297.461955] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.190s)
[297.472348] Starting dynamic subtest: pipe-C-eDP-1
[298.575957] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[298.584606] Starting dynamic subtest: pipe-D-eDP-1
[299.712748] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[299.715065] Subtest scaling-mode-full: SUCCESS (3.537s)
[300.889481] [084/134] (720s left) kms_invalid_mode (bad-htotal)
[301.002695] Starting subtest: bad-htotal
[301.004981] Starting dynamic subtest: pipe-A-eDP-1
[301.288676] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[301.297751] Starting dynamic subtest: pipe-B-eDP-1
[301.299964] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[301.308324] Starting dynamic subtest: pipe-C-eDP-1
[301.310659] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[301.318741] Starting dynamic subtest: pipe-D-eDP-1
[301.320668] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[301.322603] Subtest bad-htotal: SUCCESS (0.292s)
[302.123932] [085/134] (718s left) syncobj_wait (invalid-wait-illegal-handle)
[302.181239] Starting subtest: invalid-wait-illegal-handle
[302.183416] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[302.292646] [086/134] (718s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[302.358926] Starting subtest: etime-multi-wait-for-submit-submitted
[302.463406] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[302.564492] [087/134] (718s left) gem_pxp (reject-modify-context-protection-off-1)
[302.692936] Starting subtest: reject-modify-context-protection-off-1
[302.695422] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[302.829762] [088/134] (718s left) sysfs_heartbeat_interval (idempotent)
[302.897832] Starting subtest: idempotent
[302.900176] Starting dynamic subtest: vecs0
[302.902596] Dynamic subtest vecs0: SUCCESS (0.001s)
[302.913264] Starting dynamic subtest: ccs0
[302.915094] Dynamic subtest ccs0: SUCCESS (0.001s)
[302.923249] Starting dynamic subtest: vcs0
[302.925038] Dynamic subtest vcs0: SUCCESS (0.000s)
[302.932783] Starting dynamic subtest: bcs0
[302.934622] Dynamic subtest bcs0: SUCCESS (0.001s)
[302.942292] Starting dynamic subtest: rcs0
[302.944183] Dynamic subtest rcs0: SUCCESS (0.001s)
[302.951887] Starting dynamic subtest: vcs1
[302.953749] Dynamic subtest vcs1: SUCCESS (0.000s)
[302.955836] Subtest idempotent: SUCCESS (0.009s)
[303.029123] [089/134] (718s left) gem_exec_schedule (implicit-write-read)
[303.105815] Starting subtest: implicit-write-read
[303.108122] Starting dynamic subtest: rcs0
[303.197913] Dynamic subtest rcs0: SUCCESS (0.102s)
[303.209840] Starting dynamic subtest: vcs0
[303.275654] Dynamic subtest vcs0: SUCCESS (0.077s)
[303.287398] Starting dynamic subtest: vcs1
[303.352810] Dynamic subtest vcs1: SUCCESS (0.076s)
[303.364631] Starting dynamic subtest: vecs0
[303.425220] Dynamic subtest vecs0: SUCCESS (0.072s)
[303.436526] Starting dynamic subtest: ccs0
[303.504430] Dynamic subtest ccs0: SUCCESS (0.078s)
[303.506538] Subtest implicit-write-read: SUCCESS (0.410s)
[304.937257] [090/134] (716s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[305.037218] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[305.039511] Starting dynamic subtest: pipe-A-default-mode
[305.327952] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[305.332624] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.288s)
[306.146124] [091/134] (715s left) kms_plane_lowres (tiling-y)
[306.252390] Starting subtest: tiling-y
[306.256692] Subtest tiling-y: SKIP (0.000s)
[306.351590] [092/134] (715s left) gem_exec_balancer (parallel)
[306.615396] Starting subtest: parallel
[307.500263] Subtest parallel: SUCCESS (0.884s)
[307.865068] [093/134] (713s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[307.964141] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[307.968610] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[308.082707] [094/134] (713s left) kms_addfb_basic (clobberred-modifier)
[308.144334] Starting subtest: clobberred-modifier
[308.149070] Subtest clobberred-modifier: SKIP (0.000s)
[308.330922] [095/134] (713s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[308.434882] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[308.439513] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[308.540523] [096/134] (713s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[308.648232] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[308.650579] Starting dynamic subtest: pipe-A-eDP-1
[325.277239] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.416s)
[325.286729] Starting dynamic subtest: pipe-B-eDP-1
[342.238060] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.452s)
[342.248300] Starting dynamic subtest: pipe-C-eDP-1
[359.211628] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.445s)
[359.221116] Starting dynamic subtest: pipe-D-eDP-1
[376.191940] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.361s)
[376.194248] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.679s)
[377.430540] [097/134] (644s left) kms_atomic_interruptible (legacy-cursor)
[377.533808] Starting subtest: legacy-cursor
[377.536046] Starting dynamic subtest: pipe-A-eDP-1
[384.899075] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.493s)
[384.901205] Subtest legacy-cursor: SUCCESS (7.494s)
[385.765109] [098/134] (635s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[385.877054] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[385.881174] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[385.980945] [099/134] (635s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[386.090121] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[386.218985] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.132s)
[386.352378] [100/134] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[386.437924] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[386.442108] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[386.545795] [101/134] (635s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[386.633517] Starting subtest: fbc-psr-cursor-mmap-gtt
[386.635756] Starting dynamic subtest: eDP-1
[386.639994] Dynamic subtest eDP-1: SKIP (0.000s)
[386.644154] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[386.718583] [102/134] (635s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[386.833669] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[387.788584] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.959s)
[388.652452] [103/134] (633s left) kms_flip (wf_vblank-ts-check-interruptible)
[388.746503] Starting subtest: wf_vblank-ts-check-interruptible
[388.748767] Starting dynamic subtest: A-eDP1
[397.648079] Dynamic subtest A-eDP1: SUCCESS (8.935s)
[397.659951] Starting dynamic subtest: B-eDP1
[406.557692] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[406.571574] Starting dynamic subtest: C-eDP1
[415.475073] Dynamic subtest C-eDP1: SUCCESS (8.906s)
[415.485229] Starting dynamic subtest: D-eDP1
[424.320120] Dynamic subtest D-eDP1: SUCCESS (8.840s)
[424.322383] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.614s)
[425.547086] [104/134] (596s left) kms_lease (lease-invalid-connector)
[425.643456] Starting subtest: lease-invalid-connector
[425.645823] Starting dynamic subtest: pipe-A-eDP-1
[425.648086] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[425.657144] Starting dynamic subtest: pipe-B-eDP-1
[425.659321] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[425.667845] Starting dynamic subtest: pipe-C-eDP-1
[425.669730] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[425.678115] Starting dynamic subtest: pipe-D-eDP-1
[425.680283] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[425.682503] Subtest lease-invalid-connector: SUCCESS (0.008s)
[425.745549] [105/134] (596s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[425.806942] Subtest writes-after-reads-snoop: SKIP (0.000s)
[425.891277] [106/134] (596s left) kms_dp_link_training (uhbr-mst)
[425.980633] Starting subtest: uhbr-mst
[425.989141] Subtest uhbr-mst: SKIP (0.000s)
[426.065437] [107/134] (595s left) syncobj_wait (multi-wait-for-submit-submitted)
[426.118181] Starting subtest: multi-wait-for-submit-submitted
[426.223825] Subtest multi-wait-for-submit-submitted: SUCCESS (0.106s)
[426.310533] [108/134] (595s left) gem_ctx_sseu (engines)
[426.363476] Subtest engines: SKIP (0.000s)
[426.440050] [109/134] (595s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[426.534515] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[426.536679] Starting dynamic subtest: pipe-A
[427.650149] Dynamic subtest pipe-A: SUCCESS (1.118s)
[427.659238] Starting dynamic subtest: pipe-B
[429.834239] Dynamic subtest pipe-B: SUCCESS (2.183s)
[429.842807] Starting dynamic subtest: pipe-C
[431.040812] Dynamic subtest pipe-C: SUCCESS (1.205s)
[431.050270] Starting dynamic subtest: pipe-D
[432.255852] Dynamic subtest pipe-D: SUCCESS (1.214s)
[432.258159] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.724s)
[433.480805] [110/134] (588s left) syncobj_wait (invalid-single-wait-unsubmitted)
[433.553223] Starting subtest: invalid-single-wait-unsubmitted
[433.555651] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[433.679894] [111/134] (588s left) gen9_exec_parse (bb-large)
[433.744675] Subtest bb-large: SKIP (0.000s)
[433.828707] [112/134] (588s left) kms_pm_backlight (fade-with-suspend)
[433.927616] Starting subtest: fade-with-suspend
[450.066893] Starting dynamic subtest: eDP-1
[452.728925] Dynamic subtest eDP-1: SUCCESS (2.728s)
[452.731127] Subtest fade-with-suspend: SUCCESS (4.001s)
[453.532570] [113/134] (568s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[453.945083] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[454.711956] [114/134] (567s left) kms_big_fb (linear-32bpp-rotate-180)
[454.820331] Starting subtest: linear-32bpp-rotate-180
[456.351035] Subtest linear-32bpp-rotate-180: SUCCESS (1.556s)
[456.504497] [115/134] (565s left) api_intel_allocator (fork-simple-stress)
[456.553634] Starting subtest: fork-simple-stress
[461.890812] Subtest fork-simple-stress: SUCCESS (5.394s)
[462.060696] [116/134] (560s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[462.183778] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[462.814533] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s)
[463.077112] [117/134] (559s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[463.193774] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[470.510550] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.351s)
[470.648775] [118/134] (551s left) i915_module_load (reload)
[470.684308] Starting subtest: reload
[475.679055] Subtest reload: SUCCESS (5.006s)
[475.725817] [119/134] (546s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[482.691556] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[482.696188] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s)
[483.563837] [120/134] (539s left) gem_userptr_blits (readonly-unsync)
[483.640775] Subtest readonly-unsync: SKIP (0.000s)
[483.808465] [121/134] (538s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[483.906320] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[483.908643] Starting dynamic subtest: pipe-A-default-mode
[486.605621] Dynamic subtest pipe-A-default-mode: SUCCESS (2.698s)
[486.607991] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.700s)
[487.484301] [122/134] (535s left) kms_flip (2x-flip-vs-wf_vblank)
[487.587124] Starting subtest: 2x-flip-vs-wf_vblank
[487.595489] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[487.730323] [123/134] (535s left) i915_drm_fdinfo (memory-info-active)
[487.775412] Starting subtest: memory-info-active
[487.777795] Starting dynamic subtest: smem0
[490.327840] Dynamic subtest smem0: SUCCESS (2.553s)
[490.329937] Subtest memory-info-active: SUCCESS (2.554s)
[490.412318] [124/134] (532s left) gem_exec_gttfill (multigpu-basic)
[490.583548] Starting subtest: multigpu-basic
[507.567907] Subtest multigpu-basic: SUCCESS (16.989s)
[507.621437] [125/134] (515s left) perf (enable-disable)
[507.797885] Starting subtest: enable-disable
[507.800282] Starting dynamic subtest: 0-rcs0
[510.068777] Dynamic subtest 0-rcs0: SUCCESS (2.270s)
[510.078060] Starting dynamic subtest: 1-vecs0
[514.511761] Dynamic subtest 1-vecs0: SUCCESS (4.444s)
[514.514364] Subtest enable-disable: SUCCESS (6.716s)
[514.560520] [126/134] (508s left) i915_query (query-regions-sanity-check)
[514.616854] Starting subtest: query-regions-sanity-check
[514.629182] Subtest query-regions-sanity-check: SUCCESS (0.013s)
[514.785202] [127/134] (508s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[514.895993] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[514.898346] Starting dynamic subtest: A-eDP1
[518.492902] Dynamic subtest A-eDP1: SUCCESS (3.594s)
[518.501979] Starting dynamic subtest: B-eDP1
[521.683192] Dynamic subtest B-eDP1: SUCCESS (3.188s)
[521.693176] Starting dynamic subtest: C-eDP1
[524.809532] Dynamic subtest C-eDP1: SUCCESS (3.126s)
[524.818749] Starting dynamic subtest: D-eDP1
[527.905579] Dynamic subtest D-eDP1: SUCCESS (3.092s)
[527.907980] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.011s)
[528.715443] [128/134] (494s left) core_setmaster (master-drop-set-user)
[528.822683] Starting subtest: master-drop-set-user
[528.850732] Subtest master-drop-set-user: SUCCESS (0.030s)
[528.887207] [129/134] (494s left) kms_pipe_crc_basic (read-crc)
[528.978090] Starting subtest: read-crc
[528.980333] Starting dynamic subtest: pipe-A-eDP-1
[529.687413] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[529.698858] Starting dynamic subtest: pipe-B-eDP-1
[531.069827] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.378s)
[531.079264] Starting dynamic subtest: pipe-C-eDP-1
[532.371842] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.301s)
[532.380992] Starting dynamic subtest: pipe-D-eDP-1
[533.692901] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.316s)
[533.694899] Subtest read-crc: SUCCESS (4.714s)
[534.542708] [130/134] (488s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[534.647451] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[541.503116] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.859s)
[541.681716] [131/134] (481s left) gem_ctx_param (basic-default)
[541.736731] Starting subtest: basic-default
[541.738590] Subtest basic-default: SUCCESS (0.000s)
[541.831231] [132/134] (481s left) kms_psr (pr-primary-render)
[541.928760] Starting subtest: pr-primary-render
[541.933127] Subtest pr-primary-render: SKIP (0.000s)
[542.010362] [133/134] (481s left) kms_vrr (flip-suspend)
[542.110132] Starting subtest: flip-suspend
[542.116586] Subtest flip-suspend: SKIP (0.000s)
[542.193120] [134/134] (480s left) perf_pmu (semaphore-wait-idle)
[542.241285] Starting subtest: semaphore-wait-idle
[542.243225] Starting dynamic subtest: rcs0
[542.753629] Dynamic subtest rcs0: SUCCESS (0.513s)
[542.769990] Starting dynamic subtest: bcs0
[543.267576] Dynamic subtest bcs0: SUCCESS (0.512s)
[543.279888] Starting dynamic subtest: vcs0
[543.781525] Dynamic subtest vcs0: SUCCESS (0.510s)
[543.793223] Starting dynamic subtest: vcs1
[544.293796] Dynamic subtest vcs1: SUCCESS (0.510s)
[544.306707] Starting dynamic subtest: vecs0
[544.809725] Dynamic subtest vecs0: SUCCESS (0.513s)
[544.822552] Starting dynamic subtest: ccs0
[545.327174] Dynamic subtest ccs0: SUCCESS (0.514s)
[545.330349] Subtest semaphore-wait-idle: SUCCESS (3.090s)
[545.800582] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_universal_plane
results: parsing output: 2/ for test: kms_vrr
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: gem_mmap_wc
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: gem_flink_race
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: sw_sync
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_ccs
results: parsing output: 21/ for test: gem_readwrite
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: kms_async_flips
results: parsing output: 25/ for test: kms_chamelium_hpd
results: parsing output: 26/ for test: prime_busy
results: parsing output: 27/ for test: vgem_basic
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: kms_prop_blob
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: i915_pm_freq_mult
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_softpin
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_ctx_param
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_unfence_active_buffers
results: parsing output: 46/ for test: gem_lmem_swapping
results: parsing output: 47/ for test: gem_compute
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_dsc
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_atomic
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: gem_mmap_offset
results: parsing output: 55/ for test: gem_exec_suspend
results: parsing output: 56/ for test: drm_read
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_content_protection
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: sw_sync
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_color
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: sw_sync
results: parsing output: 74/ for test: kms_getfb
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_scaling_modes
results: parsing output: 83/ for test: kms_invalid_mode
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_pxp
results: parsing output: 87/ for test: sysfs_heartbeat_interval
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: kms_plane_lowres
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_atomic_interruptible
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: kms_lease
results: parsing output: 104/ for test: gem_partial_pwrite_pread
results: parsing output: 105/ for test: kms_dp_link_training
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: gem_ctx_sseu
results: parsing output: 108/ for test: kms_plane_scaling
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_pm_backlight
results: parsing output: 112/ for test: kms_chamelium_edid
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: api_intel_allocator
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: i915_module_load
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: gem_exec_gttfill
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: core_setmaster
results: parsing output: 128/ for test: kms_pipe_crc_basic
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_ctx_param
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_vrr
results: parsing output: 133/ for test: perf_pmu
Done.