[57.463134] Initializing watchdogs
[57.463307]   /dev/watchdog0
[57.478497] [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.483151] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.485372] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.488720] [001/134] (960s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[57.612892] Starting subtest: fbc-pr-sprite-mmap-gtt
[57.617210] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[57.724758] [002/134] (960s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[57.834203] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[57.838189] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[57.941834] [003/134] (960s left) kms_plane_scaling (planes-upscale-20x20)
[58.045616] Starting subtest: planes-upscale-20x20
[58.047925] Starting dynamic subtest: pipe-A
[58.128777] Dynamic subtest pipe-A: SUCCESS (0.085s)
[58.136070] Starting dynamic subtest: pipe-B
[59.295382] Dynamic subtest pipe-B: SUCCESS (1.165s)
[59.304322] Starting dynamic subtest: pipe-C
[60.394059] Dynamic subtest pipe-C: SUCCESS (1.098s)
[60.402581] Starting dynamic subtest: pipe-D
[61.532456] Dynamic subtest pipe-D: SUCCESS (1.138s)
[61.534853] Subtest planes-upscale-20x20: SUCCESS (3.488s)
[62.686904] [004/134] (955s left) gem_lmem_swapping (verify-ccs)
[62.735082] Subtest verify-ccs: SKIP (0.000s)
[62.789200] [005/134] (955s left) gem_exec_balancer (sequential)
[62.855998] Starting subtest: sequential
[65.908244] Subtest sequential: SUCCESS (3.052s)
[66.255507] [006/134] (951s left) kms_lease (possible-crtcs-filtering)
[66.349843] Starting subtest: possible-crtcs-filtering
[66.354599] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[66.465365] [007/134] (951s left) gem_ctx_param (invalid-ctx-get)
[66.519080] Starting subtest: invalid-ctx-get
[66.521413] Subtest invalid-ctx-get: SUCCESS (0.000s)
[66.604121] [008/134] (951s left) kms_cursor_crc (cursor-onscreen-max-size)
[66.939745] Starting subtest: cursor-onscreen-max-size
[66.946435] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[67.418871] [009/134] (950s left) gem_partial_pwrite_pread (reads-display)
[67.530675] Subtest reads-display: SKIP (0.000s)
[67.700345] [010/134] (950s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[67.840542] Starting subtest: crc-primary-basic-y-tiled-ccs
[67.843066] Starting dynamic subtest: pipe-A-eDP-1
[67.866792] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[67.875690] Starting dynamic subtest: pipe-B-eDP-1
[67.897262] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s)
[67.904203] Starting dynamic subtest: pipe-C-eDP-1
[67.924760] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[67.931161] Starting dynamic subtest: pipe-D-eDP-1
[67.953179] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[67.957132] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.016s)
[70.171809] [011/134] (948s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[70.269068] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[70.273369] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[70.386521] [012/134] (948s left) perf (invalid-oa-metric-set-id)
[70.515908] Starting subtest: invalid-oa-metric-set-id
[70.526931] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[70.568441] [013/134] (947s left) dumb_buffer (map-uaf)
[70.626618] Starting subtest: map-uaf
[70.631087] Subtest map-uaf: SUCCESS (0.004s)
[70.755021] [014/134] (947s left) sw_sync (alloc_fence_invalid_timeline)
[70.790478] Starting subtest: alloc_fence_invalid_timeline
[70.792356] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[70.853055] [015/134] (947s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[70.949248] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[70.953640] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[71.063217] [016/134] (947s left) kms_psr (psr2-suspend)
[71.166979] Starting subtest: psr2-suspend
[71.169044] Starting dynamic subtest: eDP-1
[88.893211] Dynamic subtest eDP-1: SUCCESS (2.974s)
[88.895480] Subtest psr2-suspend: SUCCESS (2.975s)
[89.698908] [017/134] (928s left) gen9_exec_parse (bb-start-cmd)
[89.793167] Subtest bb-start-cmd: SKIP (0.000s)
[89.903907] [018/134] (928s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[89.963921] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[90.027328] [019/134] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[90.137731] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[97.623241] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.486s)
[97.803532] [020/134] (920s left) gem_pxp (create-regular-buffer)
[97.936529] Starting subtest: create-regular-buffer
[97.938894] Subtest create-regular-buffer: SUCCESS (0.000s)
[98.058356] [021/134] (920s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[98.156911] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[98.159154] Starting dynamic subtest: pipe-A-eDP-1
[98.181605] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.189672] Starting dynamic subtest: pipe-B-eDP-1
[98.211033] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.218199] Starting dynamic subtest: pipe-C-eDP-1
[98.241353] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.252097] Starting dynamic subtest: pipe-D-eDP-1
[98.278306] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.282387] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[100.390963] [022/134] (918s left) kms_flip (flip-vs-absolute-wf_vblank)
[100.511602] Starting subtest: flip-vs-absolute-wf_vblank
[100.513508] Starting dynamic subtest: A-eDP1
[109.429846] Dynamic subtest A-eDP1: SUCCESS (8.916s)
[109.438988] Starting dynamic subtest: B-eDP1
[118.364839] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[118.372189] Starting dynamic subtest: C-eDP1
[127.294212] Dynamic subtest C-eDP1: SUCCESS (8.926s)
[127.302141] Starting dynamic subtest: D-eDP1
[136.232977] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[136.235280] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.722s)
[137.482414] [023/134] (881s left) perf_pmu (event-wait)
[137.526935] Starting subtest: event-wait
[137.529350] Starting dynamic subtest: rcs0
[137.533929] Dynamic subtest rcs0: SKIP (0.000s)
[137.538554] Subtest event-wait: SKIP (0.000s)
[137.659683] [024/134] (881s left) gem_spin_batch (spin-all)
[137.722471] Starting subtest: spin-all
[137.734717] Subtest spin-all: SUCCESS (0.011s)
[139.683980] [025/134] (879s left) gem_exec_whisper (basic-fds-priority-all)
[139.768147] Starting subtest: basic-fds-priority-all
[163.608715] Subtest basic-fds-priority-all: SUCCESS (23.835s)
[163.815795] [026/134] (855s left) gem_exec_async (forked-writes)
[163.890711] Starting subtest: forked-writes
[163.893143] Starting dynamic subtest: rcs0
[163.926685] Dynamic subtest rcs0: SUCCESS (0.036s)
[163.937714] Starting dynamic subtest: bcs0
[163.954260] Dynamic subtest bcs0: SUCCESS (0.027s)
[163.963826] Starting dynamic subtest: vcs0
[163.979029] Dynamic subtest vcs0: SUCCESS (0.024s)
[163.987733] Starting dynamic subtest: vcs1
[164.001297] Dynamic subtest vcs1: SUCCESS (0.022s)
[164.010375] Starting dynamic subtest: vecs0
[164.025619] Dynamic subtest vecs0: SUCCESS (0.024s)
[164.033888] Starting dynamic subtest: ccs0
[164.051388] Dynamic subtest ccs0: SUCCESS (0.025s)
[164.053704] Subtest forked-writes: SUCCESS (0.161s)
[164.317938] [027/134] (854s left) gem_eio (create-ext)
[164.544658] Starting subtest: create-ext
[164.895281] Subtest create-ext: SUCCESS (0.351s)
[165.026332] [028/134] (854s left) api_intel_bb (render)
[165.078353] Starting subtest: render
[165.080337] Starting dynamic subtest: render-none-512
[165.178965] Dynamic subtest render-none-512: SUCCESS (0.103s)
[165.190248] Starting dynamic subtest: render-none-1024
[165.561582] Dynamic subtest render-none-1024: SUCCESS (0.381s)
[165.572185] Starting dynamic subtest: render-x-512
[165.645731] Dynamic subtest render-x-512: SUCCESS (0.085s)
[165.656867] Starting dynamic subtest: render-x-1024
[165.979213] Dynamic subtest render-x-1024: SUCCESS (0.334s)
[165.987917] Starting dynamic subtest: render-y-512
[166.064824] Dynamic subtest render-y-512: SUCCESS (0.084s)
[166.075096] Starting dynamic subtest: render-y-1024
[166.658392] Dynamic subtest render-y-1024: SUCCESS (0.592s)
[166.661174] Subtest render: SUCCESS (1.581s)
[166.801607] [029/134] (852s left) syncobj_timeline (multi-wait-all-signaled)
[166.864183] Starting subtest: multi-wait-all-signaled
[166.866775] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[166.983700] [030/134] (852s left) kms_psr (fbc-psr-sprite-blt)
[167.087370] Starting subtest: fbc-psr-sprite-blt
[167.089611] Starting dynamic subtest: eDP-1
[167.093875] Dynamic subtest eDP-1: SKIP (0.000s)
[167.098190] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[167.182029] [031/134] (852s left) kms_pm_rpm (pm-caching)
[168.806428] Starting subtest: pm-caching
[168.811163] Subtest pm-caching: SKIP (0.000s)
[169.418344] [032/134] (849s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[169.534233] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[187.048192] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.513s)
[187.859455] [033/134] (831s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[187.977626] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[194.921175] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.944s)
[195.058482] [034/134] (824s left) kms_plane_multiple (2x-tiling-yf)
[195.159050] Starting subtest: 2x-tiling-yf
[195.163405] Subtest 2x-tiling-yf: SKIP (0.000s)
[195.243796] [035/134] (824s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[195.340932] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[195.345449] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[195.473809] [036/134] (823s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[195.577776] Starting subtest: x-tiled-8bpp-rotate-90
[195.599021] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[195.735120] [037/134] (823s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[195.801034] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[195.880007] [038/134] (823s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[195.976196] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[195.979800] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[196.085918] [039/134] (823s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[196.188757] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[196.192335] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[196.303345] [040/134] (823s left) syncobj_timeline (host-signal-ordered)
[196.357915] Starting subtest: host-signal-ordered
[196.359786] Subtest host-signal-ordered: SUCCESS (0.000s)
[196.466713] [041/134] (823s left) tools_test (sysfs_l3_parity)
[196.515901] Starting subtest: sysfs_l3_parity
[196.579700] Subtest sysfs_l3_parity: SKIP (0.076s)
[196.677643] [042/134] (822s left) kms_vblank (wait-busy)
[196.774554] Starting subtest: wait-busy
[196.776225] Starting dynamic subtest: pipe-A-eDP-1
[198.654475] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[198.668666] Starting dynamic subtest: pipe-D-eDP-1
[201.236894] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.575s)
[201.239089] Subtest wait-busy: SUCCESS (4.461s)
[202.032753] [043/134] (817s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[202.094848] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[202.201960] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[202.288169] [044/134] (817s left) gem_exec_flush (basic-wb-ro-before-default)
[202.353866] Starting subtest: basic-wb-ro-before-default
[207.802078] Subtest basic-wb-ro-before-default: SUCCESS (5.448s)
[207.996832] [045/134] (811s left) kms_addfb_basic (bad-pitch-63)
[208.051885] Starting subtest: bad-pitch-63
[208.053951] Subtest bad-pitch-63: SUCCESS (0.000s)
[208.227148] [046/134] (811s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[208.288648] Subtest writes-after-reads-uncached: SKIP (0.000s)
[208.369621] [047/134] (811s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[208.760996] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[209.552436] [048/134] (810s left) kms_psr (fbc-pr-primary-page-flip)
[209.663114] Starting subtest: fbc-pr-primary-page-flip
[209.667507] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[209.756567] [049/134] (810s left) gem_pxp (reject-modify-context-protection-off-3)
[209.871779] Starting subtest: reject-modify-context-protection-off-3
[209.874096] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[210.006101] [050/134] (809s left) core_getstats (basic)
[210.068106] Starting subtest: basic
[210.070345] Subtest basic: SUCCESS (0.000s)
[210.197546] [051/134] (809s left) prime_self_import (basic-llseek-size)
[210.235508] Starting subtest: basic-llseek-size
[210.258472] Subtest basic-llseek-size: SUCCESS (0.029s)
[210.371096] [052/134] (809s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[210.437722] Starting subtest: basic-batch-kernel-default-cmd
[210.441669] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[210.630186] [053/134] (809s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[210.729722] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[217.852747] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.126s)
[217.998242] [054/134] (802s left) perf (gen12-invalid-class-instance)
[218.100811] Starting subtest: gen12-invalid-class-instance
[218.107624] Subtest gen12-invalid-class-instance: SUCCESS (0.007s)
[218.152240] [055/134] (802s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[218.251318] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[219.230383] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.978s)
[219.377188] [056/134] (800s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[219.446840] Starting subtest: single-wait-for-submit-available-signaled
[219.449307] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[219.550297] [057/134] (800s left) gem_lmem_evict (dontneed-evict-race)
[219.589812] Subtest dontneed-evict-race: SKIP (0.000s)
[219.626240] [058/134] (800s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[219.730694] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[219.734149] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[219.813856] [059/134] (800s left) kms_debugfs (display-on-read-all)
[219.903573] Starting subtest: display-on-read-all
[220.070531] Subtest display-on-read-all: SUCCESS (0.165s)
[220.213203] [060/134] (800s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[220.311382] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[220.314766] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[220.400516] [061/134] (800s left) i915_drm_fdinfo (memory-info-purgeable)
[220.435087] Starting subtest: memory-info-purgeable
[220.436896] Starting dynamic subtest: smem0
[223.026246] Dynamic subtest smem0: SUCCESS (2.591s)
[223.028596] Subtest memory-info-purgeable: SUCCESS (2.592s)
[223.124397] [062/134] (797s left) gem_mmap_offset (partial-mmap)
[223.194057] Starting subtest: partial-mmap
[223.195980] Starting dynamic subtest: smem0
[223.200228] Dynamic subtest smem0: SUCCESS (0.007s)
[223.202260] Subtest partial-mmap: SUCCESS (0.007s)
[223.343809] [063/134] (797s left) vgem_basic (dmabuf-export)
[223.491688] Starting subtest: dmabuf-export
[223.538886] Subtest dmabuf-export: SUCCESS (0.048s)
[223.657975] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[223.660498] [064/134] (796s left) kms_chamelium_edid (dp-edid-read)
[224.054459] Subtest dp-edid-read: SKIP (0.000s)
[224.830761] [065/134] (795s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[224.937635] Starting subtest: addfb25-yf-tiled-legacy
[224.939975] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[225.059738] [066/134] (795s left) i915_module_load (reload-no-display)
[225.096844] Starting subtest: reload-no-display
[231.407782] Subtest reload-no-display: SUCCESS (6.309s)
[231.435811] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[231.436666] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[231.439844] [067/134] (789s left) gem_exec_reloc (basic-write-wc)
[232.974761] Subtest basic-write-wc: SKIP (0.000s)
[233.058268] [FACT gem_exec_reloc (basic-write-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[233.059490] [FACT gem_exec_reloc (basic-write-wc)] new: kernel.kmod_is_loaded.i915: true
[233.063238] [068/134] (787s left) kms_sequence (get-busy)
[233.171579] Starting subtest: get-busy
[233.173402] Starting dynamic subtest: pipe-A-eDP-1
[235.131030] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.959s)
[235.139402] Starting dynamic subtest: pipe-B-eDP-1
[237.737939] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.606s)
[237.746456] Starting dynamic subtest: pipe-C-eDP-1
[240.355592] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.617s)
[240.363510] Starting dynamic subtest: pipe-D-eDP-1
[242.977259] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.618s)
[242.979489] Subtest get-busy: SUCCESS (9.805s)
[243.771388] [069/134] (776s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[243.860486] Starting subtest: primary-y-tiled-reflect-x-270
[243.864886] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[243.941112] [070/134] (776s left) prime_self_import (reimport-vs-gem_close-race)
[243.976764] Starting subtest: reimport-vs-gem_close-race
[249.075699] Subtest reimport-vs-gem_close-race: SUCCESS (5.099s)
[249.162772] [071/134] (771s left) syncobj_eventfd (invalid-bad-pad)
[249.222715] Starting subtest: invalid-bad-pad
[249.225023] Subtest invalid-bad-pad: SUCCESS (0.000s)
[249.351936] [072/134] (771s left) perf (sysctl-defaults)
[249.434118] Starting subtest: sysctl-defaults
[249.436382] Subtest sysctl-defaults: SUCCESS (0.000s)
[249.528069] [073/134] (771s left) kms_pm_dc (dc3co-vpb-simulation)
[250.640057] Starting subtest: dc3co-vpb-simulation
[259.192589] Subtest dc3co-vpb-simulation: SKIP (8.549s)
[259.335037] [074/134] (761s left) kms_scaling_modes (scaling-mode-full-aspect)
[259.427437] Starting subtest: scaling-mode-full-aspect
[259.429770] Starting dynamic subtest: pipe-A-eDP-1
[259.524269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.098s)
[259.533204] Starting dynamic subtest: pipe-B-eDP-1
[260.698971] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.173s)
[260.708079] Starting dynamic subtest: pipe-C-eDP-1
[261.817040] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[261.827965] Starting dynamic subtest: pipe-D-eDP-1
[262.951104] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[262.953443] Subtest scaling-mode-full-aspect: SUCCESS (3.526s)
[264.125412] [075/134] (756s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[264.221190] Starting subtest: fbc-tiling-linear
[267.944156] Subtest fbc-tiling-linear: SUCCESS (3.728s)
[269.128989] [076/134] (751s left) i915_pm_rps (thresholds-idle-park)
[269.199053] Starting subtest: thresholds-idle-park
[269.203704] Subtest thresholds-idle-park: SKIP (0.001s)
[269.319710] [077/134] (751s left) gem_wait (write-busy)
[269.396574] Starting subtest: write-busy
[269.399038] Starting dynamic subtest: all-engines
[270.010046] Dynamic subtest all-engines: SUCCESS (0.613s)
[270.026339] Starting dynamic subtest: rcs0
[270.560862] Dynamic subtest rcs0: SUCCESS (0.548s)
[270.575804] Starting dynamic subtest: bcs0
[271.107871] Dynamic subtest bcs0: SUCCESS (0.546s)
[271.122381] Starting dynamic subtest: vcs0
[272.692338] Dynamic subtest vcs0: SUCCESS (1.582s)
[272.707350] Starting dynamic subtest: vcs1
[274.676151] Dynamic subtest vcs1: SUCCESS (1.981s)
[274.691351] Starting dynamic subtest: vecs0
[276.660251] Dynamic subtest vecs0: SUCCESS (1.981s)
[276.675080] Starting dynamic subtest: ccs0
[277.209624] Dynamic subtest ccs0: SUCCESS (0.548s)
[277.212062] Subtest write-busy: SUCCESS (7.813s)
[277.416555] [078/134] (743s left) kms_cursor_crc (cursor-random-256x256)
[277.664811] Starting subtest: cursor-random-256x256
[277.669716] Starting dynamic subtest: pipe-A-eDP-1
[281.014786] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.344s)
[281.040438] Starting dynamic subtest: pipe-D-eDP-1
[285.020557] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.987s)
[285.022726] Subtest cursor-random-256x256: SUCCESS (7.356s)
[285.891109] [079/134] (735s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[285.985065] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[285.987477] Starting dynamic subtest: pipe-A
[286.363656] Dynamic subtest pipe-A: SUCCESS (0.379s)
[286.372882] Starting dynamic subtest: pipe-B
[287.842985] Dynamic subtest pipe-B: SUCCESS (1.479s)
[287.851737] Starting dynamic subtest: pipe-C
[289.323869] Dynamic subtest pipe-C: SUCCESS (1.480s)
[289.333131] Starting dynamic subtest: pipe-D
[290.740742] Dynamic subtest pipe-D: SUCCESS (1.416s)
[290.743120] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.756s)
[291.905450] [080/134] (729s left) gem_exec_reloc (basic-cpu-wc)
[291.964037] Subtest basic-cpu-wc: SKIP (0.000s)
[292.039258] [081/134] (729s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[292.143978] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[293.245384] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.101s)
[293.379655] [082/134] (727s left) gem_softpin (evict-active-interruptible)
[293.431836] Starting subtest: evict-active-interruptible
[293.437959] Subtest evict-active-interruptible: SUCCESS (0.006s)
[293.588387] [083/134] (727s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[293.682771] Starting subtest: 4-tiled-32bpp-rotate-180
[295.151123] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.467s)
[295.304402] [084/134] (725s left) kms_async_flips (invalid-async-flip-atomic)
[295.391667] Starting subtest: invalid-async-flip-atomic
[295.763357] Starting dynamic subtest: pipe-A-eDP-1
[296.609654] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s)
[296.968226] Starting dynamic subtest: pipe-B-eDP-1
[297.744025] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s)
[298.100186] Starting dynamic subtest: pipe-C-eDP-1
[298.869038] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.777s)
[299.225391] Starting dynamic subtest: pipe-D-eDP-1
[299.995455] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s)
[299.997728] Subtest invalid-async-flip-atomic: SUCCESS (4.606s)
[301.156868] [085/134] (720s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[301.264094] Starting subtest: y-tiled-16bpp-rotate-90
[301.268496] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[301.371061] [086/134] (720s left) gem_exec_fence (syncobj-signal)
[301.809459] Starting subtest: syncobj-signal
[301.814287] Subtest syncobj-signal: SUCCESS (0.004s)
[303.757508] [087/134] (717s left) kms_color (legacy-gamma-reset)
[303.862413] Starting subtest: legacy-gamma-reset
[303.864279] Starting dynamic subtest: pipe-A-eDP-1
[304.235643] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.374s)
[304.244361] Starting dynamic subtest: pipe-B-eDP-1
[304.246628] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[304.254656] Starting dynamic subtest: pipe-C-eDP-1
[304.259738] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[304.268295] Starting dynamic subtest: pipe-D-eDP-1
[304.270934] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[304.273477] Subtest legacy-gamma-reset: SUCCESS (0.410s)
[305.079835] [088/134] (716s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[305.180136] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[305.206903] Starting dynamic subtest: pipe-A-plane-0
[305.628708] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[305.637581] Starting dynamic subtest: pipe-A-plane-3
[305.895393] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[305.904544] Starting dynamic subtest: pipe-A-plane-5
[305.908703] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[306.973566] Starting dynamic subtest: pipe-B-plane-0
[307.398174] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[307.408902] Starting dynamic subtest: pipe-B-plane-3
[307.653681] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[307.664742] Starting dynamic subtest: pipe-B-plane-5
[307.669284] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[307.963848] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.783s)
[308.878654] [089/134] (712s left) gem_exec_schedule (preempt-queue-contexts-chain)
[308.961826] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[309.257201] [090/134] (712s left) kms_flip (bo-too-big)
[309.352709] Starting subtest: bo-too-big
[309.354889] Starting dynamic subtest: A-eDP1
[310.697665] Dynamic subtest A-eDP1: SUCCESS (1.346s)
[310.706999] Starting dynamic subtest: B-eDP1
[312.029535] Dynamic subtest B-eDP1: SUCCESS (1.331s)
[312.040097] Starting dynamic subtest: C-eDP1
[313.361931] Dynamic subtest C-eDP1: SUCCESS (1.332s)
[313.370452] Starting dynamic subtest: D-eDP1
[314.684129] Dynamic subtest D-eDP1: SUCCESS (1.322s)
[314.688791] Subtest bo-too-big: SUCCESS (5.339s)
[315.952909] [091/134] (705s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[316.058896] Starting subtest: psr-rgb101010-draw-mmap-cpu
[323.064946] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.009s)
[323.204357] [092/134] (698s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[323.308940] Starting subtest: plane-all-transition-nonblocking-fencing
[323.311294] Starting dynamic subtest: pipe-A-eDP-1
[325.804714] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[326.113281] Starting dynamic subtest: pipe-B-eDP-1
[329.357270] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.252s)
[329.669775] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.359s)
[330.501342] [093/134] (691s left) kms_fb_coherency (memset-crc)
[330.604361] Starting subtest: memset-crc
[330.606665] Starting dynamic subtest: mmap-offset-wc
[330.980256] Dynamic subtest mmap-offset-wc: SUCCESS (0.377s)
[331.276729] Starting dynamic subtest: mmap-offset-uc
[337.360766] Dynamic subtest mmap-offset-uc: SUCCESS (6.091s)
[337.646707] Subtest memset-crc: SUCCESS (7.043s)
[338.452027] [094/134] (683s left) kms_flip (2x-flip-vs-suspend-interruptible)
[338.560620] Starting subtest: 2x-flip-vs-suspend-interruptible
[338.572279] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s)
[338.708938] [095/134] (683s left) gem_mmap_wc (copy)
[338.776045] Subtest copy: SKIP (0.000s)
[338.844259] [096/134] (683s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[338.936269] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[338.938510] Starting dynamic subtest: pipe-A-eDP-1
[338.961421] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[338.971664] Starting dynamic subtest: pipe-B-eDP-1
[338.994034] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[339.002932] Starting dynamic subtest: pipe-C-eDP-1
[339.025332] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[339.034105] Starting dynamic subtest: pipe-D-eDP-1
[339.057406] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[339.061616] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[341.201610] [097/134] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[341.312618] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[341.317038] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[341.438574] [098/134] (680s left) gem_exec_params (readonly)
[341.499346] Starting subtest: readonly
[341.501665] Subtest readonly: SUCCESS (0.002s)
[341.623729] [099/134] (680s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[341.718264] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[341.720604] Starting dynamic subtest: pipe-A-eDP-1
[341.780721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[342.087374] Starting dynamic subtest: pipe-B-eDP-1
[342.888645] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.810s)
[343.187858] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.468s)
[344.054703] [100/134] (677s left) kms_cursor_crc (cursor-sliding-256x256)
[344.288930] Starting subtest: cursor-sliding-256x256
[344.293656] Starting dynamic subtest: pipe-A-eDP-1
[347.515641] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.221s)
[347.543960] Starting dynamic subtest: pipe-D-eDP-1
[351.474082] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.936s)
[351.476204] Subtest cursor-sliding-256x256: SUCCESS (7.183s)
[352.338029] [101/134] (669s left) i915_pm_rc6_residency (rc6-idle)
[352.402907] Starting subtest: rc6-idle
[352.436911] Starting dynamic subtest: gt0-rcs0
[376.703140] Dynamic subtest gt0-rcs0: SUCCESS (24.266s)
[376.713340] Starting dynamic subtest: gt0-bcs0
[400.984983] Dynamic subtest gt0-bcs0: SUCCESS (24.280s)
[400.992663] Starting dynamic subtest: gt0-ccs0
[425.247669] Dynamic subtest gt0-ccs0: SUCCESS (24.261s)
[425.258520] Starting dynamic subtest: gt1-vcs0
[431.421221] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[431.430062] Starting dynamic subtest: gt1-vecs0
[437.592788] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[437.595543] Subtest rc6-idle: SUCCESS (85.191s)
[437.684622] [102/134] (584s left) syncobj_wait (invalid-wait-bad-flags)
[437.745191] Starting subtest: invalid-wait-bad-flags
[437.747528] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[437.855419] [103/134] (584s left) sw_sync (sync_multi_producer_single_consumer)
[437.889396] Starting subtest: sync_multi_producer_single_consumer
[438.965769] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[439.030256] [104/134] (583s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[439.130808] Starting subtest: yf-tiled-8bpp-rotate-180
[439.135062] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[439.265876] [105/134] (582s left) gem_mmap_gtt (medium-copy)
[439.329991] Subtest medium-copy: SKIP (0.000s)
[439.397637] [106/134] (582s left) gem_ctx_exec (basic-close-race)
[439.455791] Starting subtest: basic-close-race
[445.061485] Subtest basic-close-race: SUCCESS (5.603s)
[445.207472] [107/134] (577s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[445.327216] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[454.555582] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.230s)
[454.714463] [108/134] (567s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[459.765508] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[459.767841] Starting dynamic subtest: pipe-A-eDP-1
[471.490680] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.725s)
[471.502452] Starting dynamic subtest: pipe-B-eDP-1
[483.225824] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.733s)
[483.228215] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.462s)
[484.111940] [109/134] (538s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[484.205548] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[484.207865] Starting dynamic subtest: pipe-A-eDP-1
[484.216640] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[484.227649] Starting dynamic subtest: pipe-B-eDP-1
[484.236202] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[484.244948] Starting dynamic subtest: pipe-C-eDP-1
[484.252951] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[484.260788] Starting dynamic subtest: pipe-D-eDP-1
[484.269029] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[484.273054] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[486.486357] [110/134] (535s left) kms_plane_cursor (viewport)
[486.590076] Starting subtest: viewport
[486.594654] Starting dynamic subtest: pipe-A-eDP-1-size-64
[489.139448] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.546s)
[489.198408] Starting dynamic subtest: pipe-A-eDP-1-size-128
[491.684326] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.493s)
[491.744599] Starting dynamic subtest: pipe-A-eDP-1-size-256
[494.252918] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.516s)
[494.599974] Starting dynamic subtest: pipe-B-eDP-1-size-64
[497.878478] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.287s)
[497.938417] Starting dynamic subtest: pipe-B-eDP-1-size-128
[500.400404] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.471s)
[500.459834] Starting dynamic subtest: pipe-B-eDP-1-size-256
[502.936266] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.484s)
[503.287670] Starting dynamic subtest: pipe-C-eDP-1-size-64
[506.155417] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.882s)
[506.193430] Starting dynamic subtest: pipe-C-eDP-1-size-128
[508.366365] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[508.403866] Starting dynamic subtest: pipe-C-eDP-1-size-256
[510.533732] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.136s)
[510.865215] Starting dynamic subtest: pipe-D-eDP-1-size-64
[513.700501] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.846s)
[513.737455] Starting dynamic subtest: pipe-D-eDP-1-size-128
[515.844772] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.114s)
[515.882908] Starting dynamic subtest: pipe-D-eDP-1-size-256
[518.011851] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.135s)
[518.327861] Subtest viewport: SUCCESS (31.736s)
[519.188771] [111/134] (503s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[524.162234] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[524.164623] Starting dynamic subtest: pipe-A-eDP-1
[524.962097] Dynamic subtest pipe-A-eDP-1: SKIP (0.797s)
[524.970884] Starting dynamic subtest: pipe-B-eDP-1
[526.094706] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[526.099238] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.930s)
[527.291275] [112/134] (495s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[527.421631] Starting subtest: cursorA-vs-flipB-toggle
[527.425931] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[527.592501] [113/134] (494s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[527.691037] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[531.430560] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.745s)
[532.602942] [114/134] (490s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[532.710942] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[539.964522] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.256s)
[540.132678] [115/134] (482s left) gem_fence_thrash (bo-write-verify-threaded-x)
[540.168219] Starting subtest: bo-write-verify-threaded-x
[540.196023] Subtest bo-write-verify-threaded-x: SKIP (0.025s)
[540.264395] [116/134] (482s left) kms_psr (pr-sprite-blt)
[540.357970] Starting subtest: pr-sprite-blt
[540.362282] Subtest pr-sprite-blt: SKIP (0.000s)
[540.443552] [117/134] (482s left) kms_content_protection (dp-mst-type-0-hdcp14)
[540.606850] Starting subtest: dp-mst-type-0-hdcp14
[540.610989] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[540.757074] [118/134] (482s left) gem_ctx_isolation (preservation-reset)
[540.927535] Starting subtest: preservation-reset
[540.930349] Starting dynamic subtest: rcs0
[541.206425] Dynamic subtest rcs0: SUCCESS (0.279s)
[541.218177] Starting dynamic subtest: bcs0
[541.526880] Dynamic subtest bcs0: SUCCESS (0.320s)
[541.537923] Starting dynamic subtest: vcs0
[541.862566] Dynamic subtest vcs0: SUCCESS (0.334s)
[541.874169] Starting dynamic subtest: vcs1
[542.938356] Dynamic subtest vcs1: SUCCESS (1.075s)
[542.949916] Starting dynamic subtest: vecs0
[545.024580] Dynamic subtest vecs0: SUCCESS (2.085s)
[545.035691] Starting dynamic subtest: ccs0
[546.999024] Dynamic subtest ccs0: SUCCESS (1.973s)
[547.001474] Subtest preservation-reset: SUCCESS (6.074s)
[547.150872] [119/134] (475s left) api_intel_allocator (gem-pool)
[547.195208] Starting subtest: gem-pool
[547.199665] Subtest gem-pool: SUCCESS (0.006s)
[547.302450] [120/134] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[547.402827] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[547.406935] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[547.505962] [121/134] (475s left) kms_getfb (getfb2-accept-nv12)
[547.597272] Starting subtest: getfb2-accept-nv12
[547.599589] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[547.721960] [122/134] (475s left) gem_userptr_blits (unsync-overlap)
[547.795640] Subtest unsync-overlap: SKIP (0.000s)
[547.952864] [123/134] (475s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[548.061783] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[548.065496] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[548.187498] [124/134] (474s left) sw_sync (sync_busy_fork_unixsocket)
[548.219989] Starting subtest: sync_busy_fork_unixsocket
[548.225839] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[548.308590] [125/134] (474s left) gem_exec_schedule (pi-shared-iova)
[548.478038] Starting subtest: pi-shared-iova
[548.480019] Starting dynamic subtest: rcs0
[548.549954] Dynamic subtest rcs0: SUCCESS (0.075s)
[548.563773] Starting dynamic subtest: vcs0
[548.604255] Dynamic subtest vcs0: SUCCESS (0.053s)
[548.615750] Starting dynamic subtest: vcs1
[548.661449] Dynamic subtest vcs1: SUCCESS (0.056s)
[548.676644] Starting dynamic subtest: vecs0
[548.715818] Dynamic subtest vecs0: SUCCESS (0.051s)
[548.724550] Starting dynamic subtest: ccs0
[548.780977] Dynamic subtest ccs0: SUCCESS (0.064s)
[548.783382] Subtest pi-shared-iova: SUCCESS (0.306s)
[549.823561] [126/134] (473s left) gem_ctx_persistence (legacy-engines-hostile)
[549.886521] Starting subtest: legacy-engines-hostile
[549.888803] Starting dynamic subtest: render
[549.957342] Dynamic subtest render: SUCCESS (0.070s)
[549.971392] Starting dynamic subtest: bsd1
[550.066622] Dynamic subtest bsd1: SUCCESS (0.105s)
[550.078398] Starting dynamic subtest: bsd2
[550.183776] Dynamic subtest bsd2: SUCCESS (0.114s)
[550.195431] Starting dynamic subtest: blt
[550.266042] Dynamic subtest blt: SUCCESS (0.080s)
[550.281799] Starting dynamic subtest: vebox
[550.421241] Dynamic subtest vebox: SUCCESS (0.153s)
[550.423822] Subtest legacy-engines-hostile: SUCCESS (0.536s)
[550.513108] [127/134] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[550.616634] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[550.620506] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[550.737723] [128/134] (472s left) syncobj_timeline (reset-multiple-signaled)
[550.784852] Starting subtest: reset-multiple-signaled
[550.786779] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[550.911002] [129/134] (472s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[550.969044] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[550.973356] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[551.167714] [130/134] (472s left) gem_exec_params (no-blt)
[551.224867] Starting subtest: no-blt
[551.230291] Subtest no-blt: SUCCESS (0.003s)
[551.389090] [131/134] (471s left) syncobj_eventfd (invalid-bad-flags)
[551.441281] Starting subtest: invalid-bad-flags
[551.443501] Subtest invalid-bad-flags: SUCCESS (0.000s)
[551.547337] [132/134] (471s left) kms_invalid_mode (bad-htotal)
[551.631827] Starting subtest: bad-htotal
[551.634184] Starting dynamic subtest: pipe-A-eDP-1
[551.924534] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[551.934220] Starting dynamic subtest: pipe-B-eDP-1
[551.936516] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[551.945131] Starting dynamic subtest: pipe-C-eDP-1
[551.947466] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[551.956350] Starting dynamic subtest: pipe-D-eDP-1
[551.958596] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[551.960816] Subtest bad-htotal: SUCCESS (0.297s)
[552.736782] [133/134] (470s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[552.821096] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[552.823360] Starting dynamic subtest: pipe-A-eDP-1
[552.848738] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[552.859572] Starting dynamic subtest: pipe-B-eDP-1
[552.883253] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[552.892493] Starting dynamic subtest: pipe-C-eDP-1
[552.916672] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[552.926667] Starting dynamic subtest: pipe-D-eDP-1
[552.950374] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[552.954638] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[555.014385] [134/134] (468s left) sysfs_timeslice_duration (timeout)
[555.087490] Starting subtest: timeout
[555.089805] Starting dynamic subtest: vecs0
[564.677814] Dynamic subtest vecs0: SUCCESS (9.586s)
[564.689287] Starting dynamic subtest: ccs0
[566.112818] Dynamic subtest ccs0: SUCCESS (1.433s)
[566.124837] Starting dynamic subtest: vcs0
[575.680373] Dynamic subtest vcs0: SUCCESS (9.564s)
[575.690653] Starting dynamic subtest: bcs0
[576.399262] Dynamic subtest bcs0: SUCCESS (0.719s)
[576.410821] Starting dynamic subtest: rcs0
[577.775586] Dynamic subtest rcs0: SUCCESS (1.373s)
[577.787454] Starting dynamic subtest: vcs1
[587.654365] Dynamic subtest vcs1: SUCCESS (9.874s)
[587.657307] Subtest timeout: SUCCESS (32.564s)
[587.740999] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: kms_lease
results: parsing output: 6/ for test: gem_ctx_param
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: gem_partial_pwrite_pread
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: dumb_buffer
results: parsing output: 13/ for test: sw_sync
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gen9_exec_parse
results: parsing output: 17/ for test: gem_mmap_wc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: gem_spin_batch
results: parsing output: 24/ for test: gem_exec_whisper
results: parsing output: 25/ for test: gem_exec_async
results: parsing output: 26/ for test: gem_eio
results: parsing output: 27/ for test: api_intel_bb
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_pm_rpm
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_plane_multiple
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: tools_test
results: parsing output: 41/ for test: kms_vblank
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: gem_exec_flush
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: gem_partial_pwrite_pread
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_pxp
results: parsing output: 49/ for test: core_getstats
results: parsing output: 50/ for test: prime_self_import
results: parsing output: 51/ for test: gem_exec_flush
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_lmem_evict
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: kms_debugfs
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: i915_drm_fdinfo
results: parsing output: 61/ for test: gem_mmap_offset
results: parsing output: 62/ for test: vgem_basic
results: parsing output: 63/ for test: kms_chamelium_edid
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: i915_module_load
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: kms_sequence
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: prime_self_import
results: parsing output: 70/ for test: syncobj_eventfd
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: kms_pm_dc
results: parsing output: 73/ for test: kms_scaling_modes
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: i915_pm_rps
results: parsing output: 76/ for test: gem_wait
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_softpin
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_async_flips
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: kms_color
results: parsing output: 87/ for test: kms_plane
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_atomic_transition
results: parsing output: 92/ for test: kms_fb_coherency
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: gem_mmap_wc
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: kms_atomic_transition
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: i915_pm_rc6_residency
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: sw_sync
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: gem_ctx_exec
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_plane_cursor
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_fence_thrash
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: gem_ctx_isolation
results: parsing output: 118/ for test: api_intel_allocator
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_getfb
results: parsing output: 121/ for test: gem_userptr_blits
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: sw_sync
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: syncobj_eventfd
results: parsing output: 131/ for test: kms_invalid_mode
results: parsing output: 132/ for test: kms_ccs
results: parsing output: 133/ for test: sysfs_timeslice_duration
Done.