[57.590380] Initializing watchdogs
[57.590426]   /dev/watchdog0
[57.604569] [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.608899] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.611167] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.614681] [001/134] (960s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[57.746029] Starting subtest: fbc-pr-sprite-mmap-gtt
[57.750244] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[57.827786] [002/134] (960s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[57.936802] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[57.941097] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[58.045101] [003/134] (960s left) kms_plane_scaling (planes-upscale-20x20)
[58.142770] Starting subtest: planes-upscale-20x20
[58.145147] Starting dynamic subtest: pipe-A
[58.226132] Dynamic subtest pipe-A: SUCCESS (0.085s)
[58.234718] Starting dynamic subtest: pipe-B
[59.367845] Dynamic subtest pipe-B: SUCCESS (1.143s)
[59.376164] Starting dynamic subtest: pipe-C
[60.478879] Dynamic subtest pipe-C: SUCCESS (1.113s)
[60.486209] Starting dynamic subtest: pipe-D
[61.602295] Dynamic subtest pipe-D: SUCCESS (1.124s)
[61.604674] Subtest planes-upscale-20x20: SUCCESS (3.467s)
[62.778383] [004/134] (955s left) gem_lmem_swapping (verify-ccs)
[62.819286] Subtest verify-ccs: SKIP (0.000s)
[62.864188] [005/134] (955s left) gem_exec_balancer (sequential)
[62.944684] Starting subtest: sequential
[66.007903] Subtest sequential: SUCCESS (3.068s)
[66.363359] [006/134] (951s left) kms_lease (possible-crtcs-filtering)
[66.462385] Starting subtest: possible-crtcs-filtering
[66.469638] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[66.595881] [007/134] (951s left) gem_ctx_param (invalid-ctx-get)
[66.650420] Starting subtest: invalid-ctx-get
[66.652875] Subtest invalid-ctx-get: SUCCESS (0.000s)
[66.735137] [008/134] (951s left) kms_cursor_crc (cursor-onscreen-max-size)
[67.277833] Starting subtest: cursor-onscreen-max-size
[67.284257] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[67.536406] [009/134] (950s left) gem_partial_pwrite_pread (reads-display)
[67.651664] Subtest reads-display: SKIP (0.000s)
[67.801732] [010/134] (950s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[67.935597] Starting subtest: crc-primary-basic-y-tiled-ccs
[67.937528] Starting dynamic subtest: pipe-A-eDP-1
[67.960111] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[67.969171] Starting dynamic subtest: pipe-B-eDP-1
[67.991082] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[67.998236] Starting dynamic subtest: pipe-C-eDP-1
[68.020354] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[68.027817] Starting dynamic subtest: pipe-D-eDP-1
[68.051124] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[68.055390] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.009s)
[70.229095] [011/134] (948s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[70.340259] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[70.344544] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[70.462976] [012/134] (948s left) perf (invalid-oa-metric-set-id)
[70.594333] Starting subtest: invalid-oa-metric-set-id
[70.606599] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[70.649058] [013/134] (947s left) dumb_buffer (map-uaf)
[70.703330] Starting subtest: map-uaf
[70.708102] Subtest map-uaf: SUCCESS (0.006s)
[70.832157] [014/134] (947s left) sw_sync (alloc_fence_invalid_timeline)
[70.862200] Starting subtest: alloc_fence_invalid_timeline
[70.864733] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[70.929363] [015/134] (947s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[71.033045] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[71.037224] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[71.162384] [016/134] (947s left) kms_psr (psr2-suspend)
[71.262373] Starting subtest: psr2-suspend
[71.264393] Starting dynamic subtest: eDP-1
[89.293953] Dynamic subtest eDP-1: SUCCESS (3.034s)
[89.296387] Subtest psr2-suspend: SUCCESS (3.034s)
[90.169645] [017/134] (928s left) gen9_exec_parse (bb-start-cmd)
[90.257833] Subtest bb-start-cmd: SKIP (0.000s)
[90.328774] [018/134] (928s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[90.385676] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[90.444552] [019/134] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[90.544236] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[98.113263] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.616s)
[98.302929] [020/134] (920s left) gem_pxp (create-regular-buffer)
[98.434894] Starting subtest: create-regular-buffer
[98.437280] Subtest create-regular-buffer: SUCCESS (0.000s)
[98.550060] [021/134] (920s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[98.648142] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[98.650296] Starting dynamic subtest: pipe-A-eDP-1
[98.672468] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.681926] Starting dynamic subtest: pipe-B-eDP-1
[98.703139] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.710917] Starting dynamic subtest: pipe-C-eDP-1
[98.731807] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.740037] Starting dynamic subtest: pipe-D-eDP-1
[98.763024] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.767219] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[100.899316] [022/134] (918s left) kms_flip (flip-vs-absolute-wf_vblank)
[100.997350] Starting subtest: flip-vs-absolute-wf_vblank
[100.999759] Starting dynamic subtest: A-eDP1
[109.911479] Dynamic subtest A-eDP1: SUCCESS (8.929s)
[109.920540] Starting dynamic subtest: B-eDP1
[118.831994] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[118.844793] Starting dynamic subtest: C-eDP1
[127.744786] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[127.753237] Starting dynamic subtest: D-eDP1
[136.678066] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[136.680275] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.706s)
[137.905336] [023/134] (881s left) perf_pmu (event-wait)
[137.947194] Starting subtest: event-wait
[137.949577] Starting dynamic subtest: rcs0
[137.953763] Dynamic subtest rcs0: SKIP (0.000s)
[137.958014] Subtest event-wait: SKIP (0.000s)
[138.073965] [024/134] (880s left) gem_spin_batch (spin-all)
[138.144886] Starting subtest: spin-all
[138.154326] Subtest spin-all: SUCCESS (0.012s)
[139.932623] [025/134] (879s left) gem_exec_whisper (basic-fds-priority-all)
[140.009507] Starting subtest: basic-fds-priority-all
[163.852053] Subtest basic-fds-priority-all: SUCCESS (23.845s)
[164.048534] [026/134] (855s left) gem_exec_async (forked-writes)
[164.114762] Starting subtest: forked-writes
[164.117064] Starting dynamic subtest: rcs0
[164.152482] Dynamic subtest rcs0: SUCCESS (0.037s)
[164.163407] Starting dynamic subtest: bcs0
[164.175714] Dynamic subtest bcs0: SUCCESS (0.023s)
[164.184586] Starting dynamic subtest: vcs0
[164.198732] Dynamic subtest vcs0: SUCCESS (0.023s)
[164.207724] Starting dynamic subtest: vcs1
[164.221563] Dynamic subtest vcs1: SUCCESS (0.022s)
[164.230289] Starting dynamic subtest: vecs0
[164.242822] Dynamic subtest vecs0: SUCCESS (0.021s)
[164.251737] Starting dynamic subtest: ccs0
[164.264837] Dynamic subtest ccs0: SUCCESS (0.021s)
[164.267134] Subtest forked-writes: SUCCESS (0.150s)
[164.535870] [027/134] (854s left) gem_eio (create-ext)
[164.768961] Starting subtest: create-ext
[165.103872] Subtest create-ext: SUCCESS (0.336s)
[165.274697] [028/134] (853s left) api_intel_bb (render)
[165.326574] Starting subtest: render
[165.328388] Starting dynamic subtest: render-none-512
[165.424857] Dynamic subtest render-none-512: SUCCESS (0.100s)
[165.436017] Starting dynamic subtest: render-none-1024
[165.809687] Dynamic subtest render-none-1024: SUCCESS (0.382s)
[165.820911] Starting dynamic subtest: render-x-512
[165.894512] Dynamic subtest render-x-512: SUCCESS (0.086s)
[165.905424] Starting dynamic subtest: render-x-1024
[166.237756] Dynamic subtest render-x-1024: SUCCESS (0.343s)
[166.248419] Starting dynamic subtest: render-y-512
[166.325203] Dynamic subtest render-y-512: SUCCESS (0.087s)
[166.335807] Starting dynamic subtest: render-y-1024
[166.675204] Dynamic subtest render-y-1024: SUCCESS (0.348s)
[166.678541] Subtest render: SUCCESS (1.349s)
[166.815558] [029/134] (852s left) syncobj_timeline (multi-wait-all-signaled)
[166.866083] Starting subtest: multi-wait-all-signaled
[166.868464] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[166.970904] [030/134] (852s left) kms_psr (fbc-psr-sprite-blt)
[167.077138] Starting subtest: fbc-psr-sprite-blt
[167.079361] Starting dynamic subtest: eDP-1
[167.083408] Dynamic subtest eDP-1: SKIP (0.000s)
[167.088063] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[167.173420] [031/134] (852s left) kms_pm_rpm (pm-caching)
[169.023365] Starting subtest: pm-caching
[169.028182] Subtest pm-caching: SKIP (0.000s)
[169.453642] [032/134] (849s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[169.570906] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[187.245703] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.676s)
[188.066529] [033/134] (831s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[188.170090] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[195.195118] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.025s)
[195.352732] [034/134] (824s left) kms_plane_multiple (2x-tiling-yf)
[195.451111] Starting subtest: 2x-tiling-yf
[195.455203] Subtest 2x-tiling-yf: SKIP (0.000s)
[195.535041] [035/134] (823s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[195.649135] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[195.653415] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[195.763739] [036/134] (823s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[195.858225] Starting subtest: x-tiled-8bpp-rotate-90
[195.882048] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[196.025314] [037/134] (823s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[196.090738] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[196.178035] [038/134] (823s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[196.271869] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[196.275581] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[196.423663] [039/134] (823s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[196.528467] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[196.532135] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[196.639802] [040/134] (823s left) syncobj_timeline (host-signal-ordered)
[196.694933] Starting subtest: host-signal-ordered
[196.696935] Subtest host-signal-ordered: SUCCESS (0.000s)
[196.817307] [041/134] (822s left) tools_test (sysfs_l3_parity)
[196.864070] Starting subtest: sysfs_l3_parity
[196.959860] Subtest sysfs_l3_parity: SKIP (0.102s)
[197.031918] [042/134] (822s left) kms_vblank (wait-busy)
[197.119256] Starting subtest: wait-busy
[197.120948] Starting dynamic subtest: pipe-A-eDP-1
[198.994172] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[199.007694] Starting dynamic subtest: pipe-D-eDP-1
[201.535450] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[201.537823] Subtest wait-busy: SUCCESS (4.418s)
[202.344368] [043/134] (817s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[202.414401] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[202.520072] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[202.607233] [044/134] (817s left) gem_exec_flush (basic-wb-ro-before-default)
[202.674633] Starting subtest: basic-wb-ro-before-default
[208.132758] Subtest basic-wb-ro-before-default: SUCCESS (5.458s)
[208.328148] [045/134] (811s left) kms_addfb_basic (bad-pitch-63)
[208.396235] Starting subtest: bad-pitch-63
[208.398617] Subtest bad-pitch-63: SUCCESS (0.000s)
[208.562696] [046/134] (811s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[208.623569] Subtest writes-after-reads-uncached: SKIP (0.000s)
[208.718135] [047/134] (811s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[209.104818] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[209.948509] [048/134] (810s left) kms_psr (fbc-pr-primary-page-flip)
[210.050106] Starting subtest: fbc-pr-primary-page-flip
[210.054374] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[210.144904] [049/134] (809s left) gem_pxp (reject-modify-context-protection-off-3)
[210.256477] Starting subtest: reject-modify-context-protection-off-3
[210.258748] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[210.408283] [050/134] (809s left) core_getstats (basic)
[210.465821] Starting subtest: basic
[210.468075] Subtest basic: SUCCESS (0.000s)
[210.586094] [051/134] (809s left) prime_self_import (basic-llseek-size)
[210.617356] Starting subtest: basic-llseek-size
[210.629036] Subtest basic-llseek-size: SUCCESS (0.013s)
[210.755180] [052/134] (809s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[210.821092] Starting subtest: basic-batch-kernel-default-cmd
[210.825563] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[211.022634] [053/134] (809s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[211.115136] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[218.236060] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.124s)
[218.394890] [054/134] (801s left) perf (gen12-invalid-class-instance)
[218.503874] Starting subtest: gen12-invalid-class-instance
[218.513805] Subtest gen12-invalid-class-instance: SUCCESS (0.008s)
[218.555742] [055/134] (801s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[218.654497] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[219.677382] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.024s)
[219.835225] [056/134] (800s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[219.899385] Starting subtest: single-wait-for-submit-available-signaled
[219.901839] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[220.033292] [057/134] (800s left) gem_lmem_evict (dontneed-evict-race)
[220.071760] Subtest dontneed-evict-race: SKIP (0.000s)
[220.104373] [058/134] (800s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[220.214370] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[220.218101] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[220.309468] [059/134] (800s left) kms_debugfs (display-on-read-all)
[220.404254] Starting subtest: display-on-read-all
[220.568647] Subtest display-on-read-all: SUCCESS (0.165s)
[220.743821] [060/134] (799s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[220.830505] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[220.833743] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[220.941503] [061/134] (799s left) i915_drm_fdinfo (memory-info-purgeable)
[220.987290] Starting subtest: memory-info-purgeable
[220.989181] Starting dynamic subtest: smem0
[223.510741] Dynamic subtest smem0: SUCCESS (2.523s)
[223.512818] Subtest memory-info-purgeable: SUCCESS (2.524s)
[223.593156] [062/134] (796s left) gem_mmap_offset (partial-mmap)
[223.651106] Starting subtest: partial-mmap
[223.652785] Starting dynamic subtest: smem0
[223.654560] Dynamic subtest smem0: SUCCESS (0.006s)
[223.656583] Subtest partial-mmap: SUCCESS (0.007s)
[223.797366] [063/134] (796s left) vgem_basic (dmabuf-export)
[223.934239] Starting subtest: dmabuf-export
[223.970378] Subtest dmabuf-export: SUCCESS (0.037s)
[224.076617] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[224.081456] [064/134] (796s left) kms_chamelium_edid (dp-edid-read)
[224.482963] Subtest dp-edid-read: SKIP (0.000s)
[225.321799] [065/134] (795s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[225.424328] Starting subtest: addfb25-yf-tiled-legacy
[225.426556] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[225.555244] [066/134] (795s left) i915_module_load (reload-no-display)
[225.590681] Starting subtest: reload-no-display
[231.838374] Subtest reload-no-display: SUCCESS (6.247s)
[231.867273] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[231.868025] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[231.871131] [067/134] (788s left) gem_exec_reloc (basic-write-wc)
[233.437300] Subtest basic-write-wc: SKIP (0.000s)
[233.520312] [FACT gem_exec_reloc (basic-write-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[233.521620] [FACT gem_exec_reloc (basic-write-wc)] new: kernel.kmod_is_loaded.i915: true
[233.525347] [068/134] (787s left) kms_sequence (get-busy)
[233.622765] Starting subtest: get-busy
[233.625047] Starting dynamic subtest: pipe-A-eDP-1
[235.588518] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.964s)
[235.596918] Starting dynamic subtest: pipe-B-eDP-1
[238.195551] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.605s)
[238.204762] Starting dynamic subtest: pipe-C-eDP-1
[240.807702] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[240.817682] Starting dynamic subtest: pipe-D-eDP-1
[243.439189] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.628s)
[243.441454] Subtest get-busy: SUCCESS (9.816s)
[244.248744] [069/134] (776s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[244.338024] Starting subtest: primary-y-tiled-reflect-x-270
[244.342470] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[244.428422] [070/134] (776s left) prime_self_import (reimport-vs-gem_close-race)
[244.462572] Starting subtest: reimport-vs-gem_close-race
[249.559405] Subtest reimport-vs-gem_close-race: SUCCESS (5.101s)
[249.659030] [071/134] (771s left) syncobj_eventfd (invalid-bad-pad)
[249.714103] Starting subtest: invalid-bad-pad
[249.716475] Subtest invalid-bad-pad: SUCCESS (0.000s)
[249.818552] [072/134] (771s left) perf (sysctl-defaults)
[249.900705] Starting subtest: sysctl-defaults
[249.903109] Subtest sysctl-defaults: SUCCESS (0.000s)
[249.993033] [073/134] (770s left) kms_pm_dc (dc3co-vpb-simulation)
[251.110199] Starting subtest: dc3co-vpb-simulation
[260.547825] Subtest dc3co-vpb-simulation: SKIP (9.436s)
[260.708684] [074/134] (760s left) kms_scaling_modes (scaling-mode-full-aspect)
[260.807628] Starting subtest: scaling-mode-full-aspect
[260.809542] Starting dynamic subtest: pipe-A-eDP-1
[260.903047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[260.911691] Starting dynamic subtest: pipe-B-eDP-1
[262.061838] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.158s)
[262.072031] Starting dynamic subtest: pipe-C-eDP-1
[263.178139] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[263.192837] Starting dynamic subtest: pipe-D-eDP-1
[264.309697] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[264.311868] Subtest scaling-mode-full-aspect: SUCCESS (3.505s)
[265.475961] [075/134] (755s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[265.590694] Starting subtest: fbc-tiling-linear
[269.321918] Subtest fbc-tiling-linear: SUCCESS (3.734s)
[270.487099] [076/134] (750s left) i915_pm_rps (thresholds-idle-park)
[270.547887] Starting subtest: thresholds-idle-park
[270.552357] Subtest thresholds-idle-park: SKIP (0.001s)
[270.667821] [077/134] (750s left) gem_wait (write-busy)
[270.738386] Starting subtest: write-busy
[270.740641] Starting dynamic subtest: all-engines
[271.338900] Dynamic subtest all-engines: SUCCESS (0.600s)
[271.356120] Starting dynamic subtest: rcs0
[271.888601] Dynamic subtest rcs0: SUCCESS (0.548s)
[271.904033] Starting dynamic subtest: bcs0
[272.435711] Dynamic subtest bcs0: SUCCESS (0.546s)
[272.450552] Starting dynamic subtest: vcs0
[273.898945] Dynamic subtest vcs0: SUCCESS (1.461s)
[273.913908] Starting dynamic subtest: vcs1
[275.882636] Dynamic subtest vcs1: SUCCESS (1.982s)
[275.898841] Starting dynamic subtest: vecs0
[277.866909] Dynamic subtest vecs0: SUCCESS (1.982s)
[277.883169] Starting dynamic subtest: ccs0
[278.417247] Dynamic subtest ccs0: SUCCESS (0.549s)
[278.419921] Subtest write-busy: SUCCESS (7.681s)
[278.624761] [078/134] (742s left) kms_cursor_crc (cursor-random-256x256)
[278.859096] Starting subtest: cursor-random-256x256
[278.864061] Starting dynamic subtest: pipe-A-eDP-1
[282.216941] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.354s)
[282.254429] Starting dynamic subtest: pipe-D-eDP-1
[286.257225] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.018s)
[286.259719] Subtest cursor-random-256x256: SUCCESS (7.399s)
[287.133034] [079/134] (734s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[287.232372] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[287.234729] Starting dynamic subtest: pipe-A
[287.583835] Dynamic subtest pipe-A: SUCCESS (0.354s)
[287.592593] Starting dynamic subtest: pipe-B
[289.066372] Dynamic subtest pipe-B: SUCCESS (1.482s)
[289.074975] Starting dynamic subtest: pipe-C
[290.500247] Dynamic subtest pipe-C: SUCCESS (1.433s)
[290.511265] Starting dynamic subtest: pipe-D
[291.890218] Dynamic subtest pipe-D: SUCCESS (1.390s)
[291.892557] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.662s)
[293.069507] [080/134] (728s left) gem_exec_reloc (basic-cpu-wc)
[293.128796] Subtest basic-cpu-wc: SKIP (0.000s)
[293.219048] [081/134] (728s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[293.327867] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[294.317630] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.990s)
[294.494223] [082/134] (726s left) gem_softpin (evict-active-interruptible)
[294.554855] Starting subtest: evict-active-interruptible
[294.561205] Subtest evict-active-interruptible: SUCCESS (0.006s)
[294.708993] [083/134] (726s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[294.812438] Starting subtest: 4-tiled-32bpp-rotate-180
[296.279596] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.467s)
[296.444933] [084/134] (724s left) kms_async_flips (invalid-async-flip-atomic)
[296.549266] Starting subtest: invalid-async-flip-atomic
[296.930379] Starting dynamic subtest: pipe-A-eDP-1
[297.773334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.843s)
[298.131364] Starting dynamic subtest: pipe-B-eDP-1
[298.901054] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.777s)
[299.265875] Starting dynamic subtest: pipe-C-eDP-1
[300.035824] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.779s)
[300.393293] Starting dynamic subtest: pipe-D-eDP-1
[301.169776] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.788s)
[301.172198] Subtest invalid-async-flip-atomic: SUCCESS (4.623s)
[302.319234] [085/134] (719s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[302.423420] Starting subtest: y-tiled-16bpp-rotate-90
[302.427569] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[302.543130] [086/134] (718s left) gem_exec_fence (syncobj-signal)
[302.979550] Starting subtest: syncobj-signal
[302.985024] Subtest syncobj-signal: SUCCESS (0.005s)
[304.981895] [087/134] (716s left) kms_color (legacy-gamma-reset)
[305.073791] Starting subtest: legacy-gamma-reset
[305.076052] Starting dynamic subtest: pipe-A-eDP-1
[305.454569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.383s)
[305.463484] Starting dynamic subtest: pipe-B-eDP-1
[305.468420] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[305.476847] Starting dynamic subtest: pipe-C-eDP-1
[305.479272] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[305.488076] Starting dynamic subtest: pipe-D-eDP-1
[305.493479] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[305.495755] Subtest legacy-gamma-reset: SUCCESS (0.422s)
[306.264503] [088/134] (715s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[306.370353] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[306.405288] Starting dynamic subtest: pipe-A-plane-0
[306.840660] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[306.850719] Starting dynamic subtest: pipe-A-plane-3
[307.096176] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[307.105613] Starting dynamic subtest: pipe-A-plane-5
[307.109898] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[308.228532] Starting dynamic subtest: pipe-B-plane-0
[308.654489] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[308.663367] Starting dynamic subtest: pipe-B-plane-3
[308.909675] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[308.919004] Starting dynamic subtest: pipe-B-plane-5
[308.923189] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[309.219772] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.851s)
[310.122249] [089/134] (711s left) gem_exec_schedule (preempt-queue-contexts-chain)
[310.201165] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[310.500175] [090/134] (711s left) kms_flip (bo-too-big)
[310.608636] Starting subtest: bo-too-big
[310.610750] Starting dynamic subtest: A-eDP1
[311.941618] Dynamic subtest A-eDP1: SUCCESS (1.335s)
[311.952883] Starting dynamic subtest: B-eDP1
[313.274799] Dynamic subtest B-eDP1: SUCCESS (1.331s)
[313.285819] Starting dynamic subtest: C-eDP1
[314.615519] Dynamic subtest C-eDP1: SUCCESS (1.337s)
[314.625342] Starting dynamic subtest: D-eDP1
[315.952344] Dynamic subtest D-eDP1: SUCCESS (1.336s)
[315.954739] Subtest bo-too-big: SUCCESS (5.349s)
[317.174353] [091/134] (704s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[317.278302] Starting subtest: psr-rgb101010-draw-mmap-cpu
[324.361058] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.085s)
[324.522584] [092/134] (697s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[324.630118] Starting subtest: plane-all-transition-nonblocking-fencing
[324.632411] Starting dynamic subtest: pipe-A-eDP-1
[327.125624] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[327.442570] Starting dynamic subtest: pipe-B-eDP-1
[330.632725] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.199s)
[330.935018] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.302s)
[331.775526] [093/134] (689s left) kms_fb_coherency (memset-crc)
[331.882190] Starting subtest: memset-crc
[331.884428] Starting dynamic subtest: mmap-offset-wc
[332.292391] Dynamic subtest mmap-offset-wc: SUCCESS (0.411s)
[332.592786] Starting dynamic subtest: mmap-offset-uc
[338.738454] Dynamic subtest mmap-offset-uc: SUCCESS (6.152s)
[339.018117] Subtest memset-crc: SUCCESS (7.133s)
[339.834879] [094/134] (681s left) kms_flip (2x-flip-vs-suspend-interruptible)
[339.934877] Starting subtest: 2x-flip-vs-suspend-interruptible
[339.952702] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.016s)
[340.053937] [095/134] (681s left) gem_mmap_wc (copy)
[340.112393] Subtest copy: SKIP (0.000s)
[340.179221] [096/134] (681s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[340.279857] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[340.282047] Starting dynamic subtest: pipe-A-eDP-1
[340.303695] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[340.314246] Starting dynamic subtest: pipe-B-eDP-1
[340.335440] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[340.344027] Starting dynamic subtest: pipe-C-eDP-1
[340.364719] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[340.373295] Starting dynamic subtest: pipe-D-eDP-1
[340.395059] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[340.399048] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[342.601561] [097/134] (679s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[342.707209] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[342.711152] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[342.830190] [098/134] (679s left) gem_exec_params (readonly)
[342.886693] Starting subtest: readonly
[342.892052] Subtest readonly: SUCCESS (0.002s)
[343.029219] [099/134] (678s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[343.126251] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[343.128407] Starting dynamic subtest: pipe-A-eDP-1
[343.187581] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[343.505968] Starting dynamic subtest: pipe-B-eDP-1
[344.290374] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.797s)
[344.590935] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.466s)
[345.465402] [100/134] (676s left) kms_cursor_crc (cursor-sliding-256x256)
[345.723947] Starting subtest: cursor-sliding-256x256
[345.729191] Starting dynamic subtest: pipe-A-eDP-1
[349.026709] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.295s)
[349.057475] Starting dynamic subtest: pipe-D-eDP-1
[352.978612] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.930s)
[352.980625] Subtest cursor-sliding-256x256: SUCCESS (7.254s)
[353.845520] [101/134] (668s left) i915_pm_rc6_residency (rc6-idle)
[353.913602] Starting subtest: rc6-idle
[353.943038] Starting dynamic subtest: gt0-rcs0
[378.277220] Dynamic subtest gt0-rcs0: SUCCESS (24.332s)
[378.286826] Starting dynamic subtest: gt0-bcs0
[402.548250] Dynamic subtest gt0-bcs0: SUCCESS (24.270s)
[402.557406] Starting dynamic subtest: gt0-ccs0
[426.900966] Dynamic subtest gt0-ccs0: SUCCESS (24.353s)
[426.911948] Starting dynamic subtest: gt1-vcs0
[433.075519] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[433.087737] Starting dynamic subtest: gt1-vecs0
[439.246942] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[439.249808] Subtest rc6-idle: SUCCESS (85.336s)
[439.338049] [102/134] (582s left) syncobj_wait (invalid-wait-bad-flags)
[439.401750] Starting subtest: invalid-wait-bad-flags
[439.404170] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[439.557132] [103/134] (582s left) sw_sync (sync_multi_producer_single_consumer)
[439.598903] Starting subtest: sync_multi_producer_single_consumer
[440.673738] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[440.748132] [104/134] (581s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[440.852247] Starting subtest: yf-tiled-8bpp-rotate-180
[440.856770] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[440.975224] [105/134] (581s left) gem_mmap_gtt (medium-copy)
[441.035109] Subtest medium-copy: SKIP (0.000s)
[441.104360] [106/134] (581s left) gem_ctx_exec (basic-close-race)
[441.153527] Starting subtest: basic-close-race
[447.177602] Subtest basic-close-race: SUCCESS (6.024s)
[447.311673] [107/134] (575s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[447.414569] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[456.958040] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.547s)
[457.099265] [108/134] (565s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[462.068398] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[462.070595] Starting dynamic subtest: pipe-A-eDP-1
[473.768629] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.700s)
[473.777952] Starting dynamic subtest: pipe-B-eDP-1
[485.493574] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.723s)
[485.495936] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.427s)
[486.370863] [109/134] (536s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[486.477153] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[486.479463] Starting dynamic subtest: pipe-A-eDP-1
[486.488500] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[486.498235] Starting dynamic subtest: pipe-B-eDP-1
[486.506915] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[486.518927] Starting dynamic subtest: pipe-C-eDP-1
[486.527300] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[486.535422] Starting dynamic subtest: pipe-D-eDP-1
[486.543807] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[486.548053] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[488.763476] [110/134] (533s left) kms_plane_cursor (viewport)
[488.869139] Starting subtest: viewport
[488.873522] Starting dynamic subtest: pipe-A-eDP-1-size-64
[491.442333] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.574s)
[491.502837] Starting dynamic subtest: pipe-A-eDP-1-size-128
[494.064930] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s)
[494.125721] Starting dynamic subtest: pipe-A-eDP-1-size-256
[496.690457] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.571s)
[497.043935] Starting dynamic subtest: pipe-B-eDP-1-size-64
[500.316223] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.291s)
[500.375017] Starting dynamic subtest: pipe-B-eDP-1-size-128
[502.971997] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.604s)
[503.030717] Starting dynamic subtest: pipe-B-eDP-1-size-256
[505.517697] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.493s)
[505.870698] Starting dynamic subtest: pipe-C-eDP-1-size-64
[508.771211] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.911s)
[508.809901] Starting dynamic subtest: pipe-C-eDP-1-size-128
[511.016299] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s)
[511.053253] Starting dynamic subtest: pipe-C-eDP-1-size-256
[513.282808] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.236s)
[513.622745] Starting dynamic subtest: pipe-D-eDP-1-size-64
[516.514432] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.903s)
[516.552302] Starting dynamic subtest: pipe-D-eDP-1-size-128
[518.781692] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.238s)
[518.817882] Starting dynamic subtest: pipe-D-eDP-1-size-256
[521.024544] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[521.344280] Subtest viewport: SUCCESS (32.480s)
[522.174162] [111/134] (500s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[527.340640] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[527.342918] Starting dynamic subtest: pipe-A-eDP-1
[528.136353] Dynamic subtest pipe-A-eDP-1: SKIP (0.793s)
[528.145814] Starting dynamic subtest: pipe-B-eDP-1
[529.263439] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[529.268059] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.923s)
[530.471247] [112/134] (492s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[530.602499] Starting subtest: cursorA-vs-flipB-toggle
[530.606998] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[530.769681] [113/134] (491s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[530.871624] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[534.576384] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.709s)
[535.783609] [114/134] (486s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[535.884946] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[543.318057] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.438s)
[543.498526] [115/134] (479s left) gem_fence_thrash (bo-write-verify-threaded-x)
[543.535770] Starting subtest: bo-write-verify-threaded-x
[543.555506] Subtest bo-write-verify-threaded-x: SKIP (0.020s)
[543.620617] [116/134] (479s left) kms_psr (pr-sprite-blt)
[543.704836] Starting subtest: pr-sprite-blt
[543.709064] Subtest pr-sprite-blt: SKIP (0.000s)
[543.801513] [117/134] (478s left) kms_content_protection (dp-mst-type-0-hdcp14)
[543.933587] Starting subtest: dp-mst-type-0-hdcp14
[543.938104] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[544.099285] [118/134] (478s left) gem_ctx_isolation (preservation-reset)
[544.271199] Starting subtest: preservation-reset
[544.273752] Starting dynamic subtest: rcs0
[544.549205] Dynamic subtest rcs0: SUCCESS (0.278s)
[544.560258] Starting dynamic subtest: bcs0
[544.889509] Dynamic subtest bcs0: SUCCESS (0.339s)
[544.901463] Starting dynamic subtest: vcs0
[545.238889] Dynamic subtest vcs0: SUCCESS (0.349s)
[545.250171] Starting dynamic subtest: vcs1
[547.265347] Dynamic subtest vcs1: SUCCESS (2.025s)
[547.276518] Starting dynamic subtest: vecs0
[549.224666] Dynamic subtest vecs0: SUCCESS (1.959s)
[549.236765] Starting dynamic subtest: ccs0
[551.230330] Dynamic subtest ccs0: SUCCESS (2.005s)
[551.232689] Subtest preservation-reset: SUCCESS (6.963s)
[551.408901] [119/134] (471s left) api_intel_allocator (gem-pool)
[551.466785] Starting subtest: gem-pool
[551.475291] Subtest gem-pool: SUCCESS (0.012s)
[551.631858] [120/134] (471s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[551.742872] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[551.747279] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[551.883977] [121/134] (471s left) kms_getfb (getfb2-accept-nv12)
[551.977628] Starting subtest: getfb2-accept-nv12
[551.979490] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[552.107955] [122/134] (470s left) gem_userptr_blits (unsync-overlap)
[552.169850] Subtest unsync-overlap: SKIP (0.000s)
[552.319868] [123/134] (470s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[552.417954] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[552.421841] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[552.533963] [124/134] (470s left) sw_sync (sync_busy_fork_unixsocket)
[552.570429] Starting subtest: sync_busy_fork_unixsocket
[552.577092] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[552.642367] [125/134] (470s left) gem_exec_schedule (pi-shared-iova)
[552.832570] Starting subtest: pi-shared-iova
[552.834719] Starting dynamic subtest: rcs0
[552.911649] Dynamic subtest rcs0: SUCCESS (0.081s)
[552.920705] Starting dynamic subtest: vcs0
[552.974257] Dynamic subtest vcs0: SUCCESS (0.060s)
[552.985342] Starting dynamic subtest: vcs1
[553.027687] Dynamic subtest vcs1: SUCCESS (0.053s)
[553.038506] Starting dynamic subtest: vecs0
[553.085215] Dynamic subtest vecs0: SUCCESS (0.057s)
[553.096639] Starting dynamic subtest: ccs0
[553.149790] Dynamic subtest ccs0: SUCCESS (0.064s)
[553.152606] Subtest pi-shared-iova: SUCCESS (0.321s)
[555.055924] [126/134] (468s left) gem_ctx_persistence (legacy-engines-hostile)
[555.131599] Starting subtest: legacy-engines-hostile
[555.134019] Starting dynamic subtest: render
[555.229738] Dynamic subtest render: SUCCESS (0.097s)
[555.243281] Starting dynamic subtest: bsd1
[555.349065] Dynamic subtest bsd1: SUCCESS (0.116s)
[555.361079] Starting dynamic subtest: bsd2
[555.476257] Dynamic subtest bsd2: SUCCESS (0.124s)
[555.488435] Starting dynamic subtest: blt
[555.593288] Dynamic subtest blt: SUCCESS (0.114s)
[555.604905] Starting dynamic subtest: vebox
[555.708956] Dynamic subtest vebox: SUCCESS (0.113s)
[555.711757] Subtest legacy-engines-hostile: SUCCESS (0.578s)
[555.802661] [127/134] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[555.913649] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[555.917641] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[556.024414] [128/134] (467s left) syncobj_timeline (reset-multiple-signaled)
[556.081475] Starting subtest: reset-multiple-signaled
[556.083301] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[556.189800] [129/134] (467s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[556.248689] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[556.252462] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[556.443451] [130/134] (466s left) gem_exec_params (no-blt)
[556.494694] Starting subtest: no-blt
[556.497075] Subtest no-blt: SUCCESS (0.002s)
[556.630647] [131/134] (466s left) syncobj_eventfd (invalid-bad-flags)
[556.676964] Starting subtest: invalid-bad-flags
[556.679281] Subtest invalid-bad-flags: SUCCESS (0.000s)
[556.801667] [132/134] (466s left) kms_invalid_mode (bad-htotal)
[556.907308] Starting subtest: bad-htotal
[556.909592] Starting dynamic subtest: pipe-A-eDP-1
[557.196532] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[557.206046] Starting dynamic subtest: pipe-B-eDP-1
[557.208206] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[557.216667] Starting dynamic subtest: pipe-C-eDP-1
[557.218904] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[557.227473] Starting dynamic subtest: pipe-D-eDP-1
[557.229359] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[557.231278] Subtest bad-htotal: SUCCESS (0.298s)
[558.017048] [133/134] (465s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[558.127125] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[558.129391] Starting dynamic subtest: pipe-A-eDP-1
[558.154396] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[558.165682] Starting dynamic subtest: pipe-B-eDP-1
[558.188134] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[558.196611] Starting dynamic subtest: pipe-C-eDP-1
[558.219225] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[558.227240] Starting dynamic subtest: pipe-D-eDP-1
[558.250077] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[558.254080] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[560.295827] [134/134] (463s left) sysfs_timeslice_duration (timeout)
[560.358412] Starting subtest: timeout
[560.360776] Starting dynamic subtest: vecs0
[569.901420] Dynamic subtest vecs0: SUCCESS (9.538s)
[569.913164] Starting dynamic subtest: ccs0
[571.341867] Dynamic subtest ccs0: SUCCESS (1.438s)
[571.353067] Starting dynamic subtest: vcs0
[580.925835] Dynamic subtest vcs0: SUCCESS (9.576s)
[580.937637] Starting dynamic subtest: bcs0
[581.654974] Dynamic subtest bcs0: SUCCESS (0.725s)
[581.666207] Starting dynamic subtest: rcs0
[583.036538] Dynamic subtest rcs0: SUCCESS (1.378s)
[583.049093] Starting dynamic subtest: vcs1
[592.936647] Dynamic subtest vcs1: SUCCESS (9.889s)
[592.939142] Subtest timeout: SUCCESS (32.558s)
[593.048076] 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.