[57.242250] Initializing watchdogs
[57.242295]   /dev/watchdog0
[57.257222] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.261276] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.264096] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.267588] [001/133] (960s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[57.383359] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[57.385949] Starting dynamic subtest: pipe-A-eDP-1
[63.290195] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.918s)
[63.298526] Starting dynamic subtest: pipe-B-eDP-1
[69.945965] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.661s)
[69.948475] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.582s)
[70.819715] [002/133] (946s left) gem_ctx_freq (sysfs)
[70.893943] Starting subtest: sysfs
[70.896355] Starting dynamic subtest: gt0
[76.396133] Dynamic subtest gt0: SUCCESS (5.506s)
[76.405220] Starting dynamic subtest: gt1
[117.848602] Dynamic subtest gt1: SUCCESS (41.449s)
[117.851609] Subtest sysfs: SUCCESS (46.957s)
[117.964835] [003/133] (899s left) kms_invalid_mode (zero-vdisplay)
[118.045375] Starting subtest: zero-vdisplay
[118.047607] Starting dynamic subtest: pipe-A-eDP-1
[118.327217] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[118.337077] Starting dynamic subtest: pipe-B-eDP-1
[118.339302] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[118.346583] Starting dynamic subtest: pipe-C-eDP-1
[118.348738] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[118.355858] Starting dynamic subtest: pipe-D-eDP-1
[118.357700] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[118.360046] Subtest zero-vdisplay: SUCCESS (0.290s)
[119.166740] [004/133] (898s left) gem_wait (await)
[119.228762] Starting subtest: await
[119.231086] Starting dynamic subtest: all-engines
[120.360811] Dynamic subtest all-engines: SUCCESS (1.132s)
[120.376087] Starting dynamic subtest: rcs0
[121.414036] Dynamic subtest rcs0: SUCCESS (1.053s)
[121.430794] Starting dynamic subtest: bcs0
[122.470951] Dynamic subtest bcs0: SUCCESS (1.055s)
[122.487556] Starting dynamic subtest: vcs0
[123.525740] Dynamic subtest vcs0: SUCCESS (1.054s)
[123.541075] Starting dynamic subtest: vcs1
[124.580822] Dynamic subtest vcs1: SUCCESS (1.054s)
[124.598051] Starting dynamic subtest: vecs0
[125.635040] Dynamic subtest vecs0: SUCCESS (1.053s)
[125.650076] Starting dynamic subtest: ccs0
[126.691690] Dynamic subtest ccs0: SUCCESS (1.056s)
[126.694256] Subtest await: SUCCESS (7.463s)
[126.887449] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[126.890893] [005/133] (891s left) api_intel_allocator (reopen)
[126.955442] Starting subtest: reopen
[126.959827] Subtest reopen: SUCCESS (0.007s)
[127.079819] [006/133] (890s left) kms_hdmi_inject (inject-4k)
[127.133293] Subtest inject-4k: SKIP (0.000s)
[127.190239] [007/133] (890s left) gen9_exec_parse (secure-batches)
[127.248608] Subtest secure-batches: SKIP (0.000s)
[127.320226] [008/133] (890s left) kms_flip (flip-vs-fences)
[127.391169] Starting subtest: flip-vs-fences
[127.395606] Subtest flip-vs-fences: SKIP (0.000s)
[127.487593] [009/133] (890s left) syncobj_timeline (single-wait-available-submitted)
[127.544591] Starting subtest: single-wait-available-submitted
[127.546828] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[127.633638] [010/133] (890s left) gem_ctx_persistence (legacy-engines-hostile)
[127.689641] Starting subtest: legacy-engines-hostile
[127.691587] Starting dynamic subtest: render
[127.757549] Dynamic subtest render: SUCCESS (0.069s)
[127.768962] Starting dynamic subtest: bsd1
[127.855669] Dynamic subtest bsd1: SUCCESS (0.097s)
[127.872436] Starting dynamic subtest: bsd2
[127.950870] Dynamic subtest bsd2: SUCCESS (0.093s)
[127.959702] Starting dynamic subtest: blt
[128.049792] Dynamic subtest blt: SUCCESS (0.097s)
[128.060064] Starting dynamic subtest: vebox
[128.152859] Dynamic subtest vebox: SUCCESS (0.101s)
[128.155743] Subtest legacy-engines-hostile: SUCCESS (0.466s)
[128.237325] [011/133] (889s left) i915_drm_fdinfo (virtual-busy-all)
[128.288110] Starting subtest: virtual-busy-all
[128.291591] Subtest virtual-busy-all: SKIP (0.000s)
[128.366166] [012/133] (889s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[128.433083] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[128.436531] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[128.501401] [013/133] (889s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[128.560073] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[128.563765] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[128.746816] [014/133] (889s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[128.837029] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[128.841440] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[128.934747] [015/133] (889s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[129.002996] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[129.005446] Starting dynamic subtest: pipe-A-eDP-1
[129.883084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.874s)
[129.892333] Starting dynamic subtest: pipe-B-eDP-1
[131.394636] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.508s)
[131.404277] Starting dynamic subtest: pipe-C-eDP-1
[132.938496] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.544s)
[132.948221] Starting dynamic subtest: pipe-D-eDP-1
[134.419482] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.477s)
[134.421869] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.407s)
[135.604244] [016/133] (882s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[135.659629] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[135.764808] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[135.851300] [017/133] (882s left) perf_pmu (semaphore-wait-idle)
[135.889391] Starting subtest: semaphore-wait-idle
[135.891766] Starting dynamic subtest: rcs0
[136.403417] Dynamic subtest rcs0: SUCCESS (0.512s)
[136.413684] Starting dynamic subtest: bcs0
[136.915762] Dynamic subtest bcs0: SUCCESS (0.511s)
[136.927096] Starting dynamic subtest: vcs0
[137.430238] Dynamic subtest vcs0: SUCCESS (0.513s)
[137.441585] Starting dynamic subtest: vcs1
[137.950056] Dynamic subtest vcs1: SUCCESS (0.511s)
[137.959656] Starting dynamic subtest: vecs0
[138.457367] Dynamic subtest vecs0: SUCCESS (0.512s)
[138.467778] Starting dynamic subtest: ccs0
[138.971723] Dynamic subtest ccs0: SUCCESS (0.513s)
[138.975150] Subtest semaphore-wait-idle: SUCCESS (3.081s)
[139.089927] [018/133] (879s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[139.151049] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[139.251839] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[139.330139] [019/133] (879s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[139.427598] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[139.431663] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[139.532056] [020/133] (879s left) i915_drm_fdinfo (virtual-busy-idle-all)
[139.576788] Starting subtest: virtual-busy-idle-all
[139.581273] Subtest virtual-busy-idle-all: SKIP (0.000s)
[139.638151] [021/133] (878s left) gem_basic (create-fd-close)
[139.697065] Starting subtest: create-fd-close
[139.701390] Subtest create-fd-close: SUCCESS (0.000s)
[139.794553] [022/133] (878s left) kms_fbcon_fbt (psr-suspend)
[139.850017] Starting subtest: psr-suspend
[189.184822] Subtest psr-suspend: SUCCESS (19.995s)
[189.264148] [023/133] (829s left) i915_selftest (mock)
[190.960598] Starting subtest: mock
[190.963210] Starting dynamic subtest: sanitycheck
[191.621208] Dynamic subtest sanitycheck: SUCCESS (0.664s)
[191.631108] Starting dynamic subtest: shmem
[192.295241] Dynamic subtest shmem: SUCCESS (0.675s)
[192.304188] Starting dynamic subtest: fence
[200.374864] Dynamic subtest fence: SUCCESS (8.097s)
[200.386200] Starting dynamic subtest: scatterlist
[202.029708] Dynamic subtest scatterlist: SUCCESS (1.656s)
[202.039554] Starting dynamic subtest: syncmap
[205.193261] Dynamic subtest syncmap: SUCCESS (3.166s)
[205.202925] Starting dynamic subtest: uncore
[205.843327] Dynamic subtest uncore: SUCCESS (0.650s)
[205.853129] Starting dynamic subtest: ring
[206.501631] Dynamic subtest ring: SUCCESS (0.657s)
[206.513832] Starting dynamic subtest: engine
[207.177522] Dynamic subtest engine: SUCCESS (0.675s)
[207.187638] Starting dynamic subtest: timelines
[210.902301] Dynamic subtest timelines: SUCCESS (3.726s)
[210.912217] Starting dynamic subtest: requests
[214.548746] Dynamic subtest requests: SUCCESS (3.649s)
[214.564253] Starting dynamic subtest: objects
[215.286424] Dynamic subtest objects: SUCCESS (0.737s)
[215.294947] Starting dynamic subtest: phys
[216.028306] Dynamic subtest phys: SUCCESS (0.741s)
[216.037880] Starting dynamic subtest: dmabuf
[216.776290] Dynamic subtest dmabuf: SUCCESS (0.748s)
[216.785487] Starting dynamic subtest: vma
[222.338451] Dynamic subtest vma: SUCCESS (5.559s)
[222.348475] Starting dynamic subtest: evict
[223.710429] Dynamic subtest evict: SUCCESS (1.370s)
[223.719975] Starting dynamic subtest: gtt
[227.246212] Dynamic subtest gtt: SUCCESS (3.534s)
[227.256056] Starting dynamic subtest: hugepages
[228.164057] Dynamic subtest hugepages: SUCCESS (0.917s)
[228.174185] Starting dynamic subtest: memory_region
[230.584849] Dynamic subtest memory_region: SUCCESS (2.419s)
[230.587430] Subtest mock: SUCCESS (39.662s)
[230.617695] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[230.618476] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[230.621534] [024/133] (788s left) gem_pxp (create-regular-context-1)
[232.333682] Starting subtest: create-regular-context-1
[232.339246] Subtest create-regular-context-1: SUCCESS (0.006s)
[232.414645] [FACT gem_pxp (create-regular-context-1)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[232.415731] [FACT gem_pxp (create-regular-context-1)] new: kernel.kmod_is_loaded.i915: true
[232.419455] [025/133] (786s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[232.511436] Starting subtest: fbc-psr2-sprite-plane-onoff
[232.513752] Starting dynamic subtest: eDP-1
[232.517660] Dynamic subtest eDP-1: SKIP (0.000s)
[232.521811] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[232.604297] [026/133] (786s left) kms_color (ctm-0-50)
[232.675361] Starting subtest: ctm-0-50
[232.677643] Starting dynamic subtest: pipe-A-eDP-1
[236.102540] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[236.113734] Starting dynamic subtest: pipe-B-eDP-1
[240.303701] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.202s)
[240.313717] Starting dynamic subtest: pipe-C-eDP-1
[244.267958] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.963s)
[244.277165] Starting dynamic subtest: pipe-D-eDP-1
[248.243112] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.977s)
[248.245425] Subtest ctm-0-50: SUCCESS (15.571s)
[249.080684] [027/133] (769s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[249.178339] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[249.180782] Starting dynamic subtest: pipe-A-eDP-1
[249.277039] Dynamic subtest pipe-A-eDP-1: SKIP (0.102s)
[249.287651] Starting dynamic subtest: pipe-B-eDP-1
[250.460762] Dynamic subtest pipe-B-eDP-1: SKIP (1.182s)
[250.465192] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.286s)
[251.647119] [028/133] (767s left) kms_cdclk (plane-scaling)
[251.725631] Starting subtest: plane-scaling
[251.727959] Starting dynamic subtest: pipe-A-eDP-1
[252.012655] Dynamic subtest pipe-A-eDP-1: SKIP (0.285s)
[252.022635] Starting dynamic subtest: pipe-B-eDP-1
[252.027212] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[252.036134] Starting dynamic subtest: pipe-C-eDP-1
[252.040744] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[252.049298] Starting dynamic subtest: pipe-D-eDP-1
[252.053765] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[252.058141] Subtest plane-scaling: SKIP (0.292s)
[252.877573] [029/133] (766s left) kms_panel_fitting (atomic-fastset)
[252.942624] Starting subtest: atomic-fastset
[252.944995] Starting dynamic subtest: pipe-A-eDP-1
[253.082387] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[253.092195] Starting dynamic subtest: pipe-B-eDP-1
[254.347319] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.265s)
[254.359184] Starting dynamic subtest: pipe-C-eDP-1
[255.539421] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.192s)
[255.549041] Starting dynamic subtest: pipe-D-eDP-1
[256.681035] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[256.683274] Subtest atomic-fastset: SUCCESS (3.743s)
[257.837428] [030/133] (761s left) syncobj_timeline (multi-wait-signaled)
[257.915102] Starting subtest: multi-wait-signaled
[257.917485] Subtest multi-wait-signaled: SUCCESS (0.001s)
[258.011862] [031/133] (760s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[258.101078] Starting subtest: 4-tiled-16bpp-rotate-180
[259.447847] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.346s)
[259.557769] [032/133] (759s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[259.639536] Starting subtest: bad-pixel-format-y-tiled-ccs
[259.641495] Starting dynamic subtest: pipe-A-eDP-1
[259.660701] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[259.671010] Starting dynamic subtest: pipe-B-eDP-1
[259.688313] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[259.696777] Starting dynamic subtest: pipe-C-eDP-1
[259.714763] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[259.723300] Starting dynamic subtest: pipe-D-eDP-1
[259.742189] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[259.745855] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[261.905792] [033/133] (757s left) kms_psr (psr2-cursor-mmap-cpu)
[261.978502] Starting subtest: psr2-cursor-mmap-cpu
[261.980849] Starting dynamic subtest: eDP-1
[263.686839] Dynamic subtest eDP-1: SUCCESS (1.709s)
[263.689300] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.710s)
[264.558163] [034/133] (754s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[264.645832] Starting subtest: fbc-pr-sprite-mmap-gtt
[264.650238] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[264.734671] [035/133] (754s left) kms_universal_plane (universal-plane-functional)
[264.803646] Starting subtest: universal-plane-functional
[264.805582] Starting dynamic subtest: pipe-A-eDP-1
[268.717431] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.913s)
[268.726979] Starting dynamic subtest: pipe-B-eDP-1
[273.166397] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.449s)
[273.176537] Starting dynamic subtest: pipe-C-eDP-1
[277.544644] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.379s)
[277.554301] Starting dynamic subtest: pipe-D-eDP-1
[281.847120] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.301s)
[281.849495] Subtest universal-plane-functional: SUCCESS (17.049s)
[282.726901] [036/133] (736s left) gem_lmem_swapping (heavy-verify-multi)
[282.774732] Subtest heavy-verify-multi: SKIP (0.000s)
[282.818278] [037/133] (736s left) kms_getfb (getfb-reject-nv12)
[282.899162] Starting subtest: getfb-reject-nv12
[282.901304] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[283.003198] [038/133] (736s left) kms_flip (modeset-vs-vblank-race-interruptible)
[283.081193] Starting subtest: modeset-vs-vblank-race-interruptible
[283.083456] Starting dynamic subtest: A-eDP1
[287.747509] Dynamic subtest A-eDP1: SUCCESS (4.664s)
[287.758431] Starting dynamic subtest: B-eDP1
[292.392796] Dynamic subtest B-eDP1: SUCCESS (4.641s)
[292.404285] Starting dynamic subtest: C-eDP1
[296.998481] Dynamic subtest C-eDP1: SUCCESS (4.602s)
[297.010323] Starting dynamic subtest: D-eDP1
[301.529795] Dynamic subtest D-eDP1: SUCCESS (4.530s)
[301.532263] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.446s)
[302.688820] [039/133] (716s left) gem_fence_thrash (bo-write-verify-x)
[302.733927] Starting subtest: bo-write-verify-x
[302.757654] Subtest bo-write-verify-x: SKIP (0.020s)
[302.818826] [040/133] (716s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[302.897946] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[302.902127] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[302.988887] [041/133] (716s left) kms_prop_blob (basic)
[303.035782] Starting subtest: basic
[303.037748] Subtest basic: SUCCESS (0.000s)
[303.125829] [042/133] (716s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[303.206246] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[303.210647] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[303.321686] [043/133] (716s left) gem_create (create-ext-cpu-access-sanity-check)
[303.500455] Starting subtest: create-ext-cpu-access-sanity-check
[303.504987] Subtest create-ext-cpu-access-sanity-check: SKIP (0.002s)
[303.574364] [044/133] (715s left) kms_dsc (dsc-with-bpc-formats)
[303.644416] Starting subtest: dsc-with-bpc-formats
[303.755313] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[303.798359] [045/133] (715s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[303.876642] Starting subtest: 2x-absolute-wf_vblank-interruptible
[303.886077] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.008s)
[303.961484] [046/133] (715s left) gem_exec_balancer (semaphore)
[304.015764] Starting subtest: semaphore
[305.267450] Subtest semaphore: SUCCESS (1.250s)
[305.604486] [047/133] (714s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[305.682073] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[305.686181] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[305.780632] [048/133] (713s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[305.887809] Starting subtest: short-flip-after-cursor-toggle
[306.805495] Subtest short-flip-after-cursor-toggle: SUCCESS (0.915s)
[307.610329] [049/133] (712s left) gem_pwrite_snooped
[307.736087] [050/133] (712s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[307.816124] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[311.788293] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.975s)
[312.923843] [051/133] (706s left) kms_vblank (crtc-id)
[312.994513] Starting subtest: crtc-id
[312.996733] Starting dynamic subtest: pipe-A-eDP-1
[313.444251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s)
[313.461596] Starting dynamic subtest: pipe-D-eDP-1
[314.542743] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.097s)
[314.544949] Subtest crtc-id: SUCCESS (1.548s)
[315.385615] [052/133] (704s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[315.463115] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[315.465098] Starting dynamic subtest: pipe-A-eDP-1
[315.524505] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[315.533597] Starting dynamic subtest: pipe-B-eDP-1
[315.625786] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.101s)
[315.634956] Starting dynamic subtest: pipe-C-eDP-1
[315.687904] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.061s)
[315.696889] Starting dynamic subtest: pipe-D-eDP-1
[315.747969] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.057s)
[315.750129] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.286s)
[317.966532] [053/133] (701s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[318.058220] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[319.016235] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.958s)
[319.124807] [054/133] (700s left) kms_big_fb (yf-tiled-addfb)
[319.210130] Starting subtest: yf-tiled-addfb
[319.214591] Subtest yf-tiled-addfb: SKIP (0.000s)
[319.310023] [055/133] (700s left) gem_mmap_gtt (basic-wc)
[319.360502] Subtest basic-wc: SKIP (0.000s)
[319.412977] [056/133] (700s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[319.487046] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[323.700605] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.219s)
[324.857586] [057/133] (695s left) kms_cursor_crc (cursor-offscreen-64x21)
[325.028482] Starting subtest: cursor-offscreen-64x21
[325.073502] Subtest cursor-offscreen-64x21: SKIP (0.040s)
[325.298070] [058/133] (694s left) perf_pmu (init-wait)
[325.341307] Starting subtest: init-wait
[325.343562] Starting dynamic subtest: rcs0
[325.345850] Dynamic subtest rcs0: SUCCESS (0.002s)
[325.354898] Starting dynamic subtest: bcs0
[325.356769] Dynamic subtest bcs0: SUCCESS (0.000s)
[325.365047] Starting dynamic subtest: vcs0
[325.366962] Dynamic subtest vcs0: SUCCESS (0.000s)
[325.375253] Starting dynamic subtest: vcs1
[325.377199] Dynamic subtest vcs1: SUCCESS (0.000s)
[325.385935] Starting dynamic subtest: vecs0
[325.388096] Dynamic subtest vecs0: SUCCESS (0.000s)
[325.396727] Starting dynamic subtest: ccs0
[325.398603] Dynamic subtest ccs0: SUCCESS (0.000s)
[325.400437] Subtest init-wait: SUCCESS (0.007s)
[325.440955] [059/133] (694s left) kms_joiner (invalid-modeset-ultra-joiner)
[325.516465] Starting subtest: invalid-modeset-ultra-joiner
[325.520585] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[325.586011] [060/133] (694s left) kms_rotation_crc (bad-pixel-format)
[325.653268] Starting subtest: bad-pixel-format
[325.657489] Subtest bad-pixel-format: SKIP (0.001s)
[325.727215] [061/133] (694s left) kms_dp_link_training (non-uhbr-mst)
[325.799327] Starting subtest: non-uhbr-mst
[325.806879] Subtest non-uhbr-mst: SKIP (0.000s)
[325.903335] [062/133] (694s left) syncobj_basic (bad-create-flags)
[325.958045] Starting subtest: bad-create-flags
[325.959938] Subtest bad-create-flags: SUCCESS (0.000s)
[326.066711] [063/133] (694s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[326.110410] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[326.172760] [064/133] (694s left) syncobj_wait (reset-unsignaled)
[326.215431] Starting subtest: reset-unsignaled
[326.217361] Subtest reset-unsignaled: SUCCESS (0.000s)
[326.305114] [065/133] (694s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[326.384573] Starting subtest: plane-downscale-factor-0-75-with-rotation
[326.386609] Starting dynamic subtest: pipe-A
[326.613435] Dynamic subtest pipe-A: SUCCESS (0.230s)
[326.622886] Starting dynamic subtest: pipe-B
[327.920123] Dynamic subtest pipe-B: SUCCESS (1.306s)
[327.930326] Starting dynamic subtest: pipe-C
[329.256660] Dynamic subtest pipe-C: SUCCESS (1.336s)
[329.265732] Starting dynamic subtest: pipe-D
[330.587898] Dynamic subtest pipe-D: SUCCESS (1.330s)
[330.590215] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.206s)
[331.783985] [066/133] (688s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[331.846490] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[331.850986] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[332.026026] [067/133] (688s left) gem_spin_batch (engines)
[332.103696] Starting subtest: engines
[332.105758] Starting dynamic subtest: rcs0
[335.341483] Dynamic subtest rcs0: SUCCESS (3.236s)
[335.353544] Starting dynamic subtest: bcs0
[338.578849] Dynamic subtest bcs0: SUCCESS (3.235s)
[338.590151] Starting dynamic subtest: vcs0
[341.814157] Dynamic subtest vcs0: SUCCESS (3.233s)
[341.824554] Starting dynamic subtest: vcs1
[345.053815] Dynamic subtest vcs1: SUCCESS (3.237s)
[345.068804] Starting dynamic subtest: vecs0
[348.289678] Dynamic subtest vecs0: SUCCESS (3.233s)
[348.301187] Starting dynamic subtest: ccs0
[351.528257] Dynamic subtest ccs0: SUCCESS (3.236s)
[351.530500] Subtest engines: SUCCESS (19.428s)
[351.779731] [068/133] (668s left) gem_userptr_blits (unsync-unmap)
[351.850937] Subtest unsync-unmap: SKIP (0.000s)
[351.969353] [069/133] (668s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[352.057814] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[358.576682] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.522s)
[358.706328] [070/133] (661s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[358.788636] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[358.792702] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[358.870078] [071/133] (661s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[358.951429] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[358.953631] Starting dynamic subtest: pipe-A-eDP-1
[358.975971] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[358.986904] Starting dynamic subtest: pipe-B-eDP-1
[359.007883] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[359.017193] Starting dynamic subtest: pipe-C-eDP-1
[359.037814] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[359.047036] Starting dynamic subtest: pipe-D-eDP-1
[359.068893] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[359.072937] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[361.251324] [072/133] (659s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[361.305649] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[361.307973] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[361.415533] [073/133] (659s left) gem_exec_flush (basic-uc-ro-default)
[361.472078] Starting subtest: basic-uc-ro-default
[366.935983] Subtest basic-uc-ro-default: SUCCESS (5.466s)
[367.140724] [074/133] (653s left) syncobj_wait (single-wait-submitted)
[367.208962] Starting subtest: single-wait-submitted
[367.312884] Subtest single-wait-submitted: SUCCESS (0.104s)
[367.416760] [075/133] (653s left) vgem_slow (nohang)
[367.459963] Starting subtest: nohang
[377.642946] Subtest nohang: SUCCESS (10.188s)
[377.711683] [076/133] (643s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[377.787279] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[378.177701] Starting dynamic subtest: pipe-A-eDP-1
[380.930126] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.752s)
[381.304782] Starting dynamic subtest: pipe-B-eDP-1
[384.057309] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.759s)
[384.419944] Starting dynamic subtest: pipe-C-eDP-1
[387.183288] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.770s)
[387.553142] Starting dynamic subtest: pipe-D-eDP-1
[390.318608] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[390.320967] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.534s)
[391.516092] [077/133] (629s left) gem_busy (extended)
[391.700421] Starting subtest: extended
[391.702849] Starting dynamic subtest: rcs0
[391.785884] Dynamic subtest rcs0: SUCCESS (0.085s)
[391.797747] Starting dynamic subtest: bcs0
[391.826831] Dynamic subtest bcs0: SUCCESS (0.039s)
[391.837100] Starting dynamic subtest: vcs0
[393.293405] Dynamic subtest vcs0: SUCCESS (1.463s)
[393.306144] Starting dynamic subtest: vcs1
[395.277831] Dynamic subtest vcs1: SUCCESS (1.982s)
[395.290431] Starting dynamic subtest: vecs0
[397.261242] Dynamic subtest vecs0: SUCCESS (1.981s)
[397.274131] Starting dynamic subtest: ccs0
[397.306204] Dynamic subtest ccs0: SUCCESS (0.044s)
[397.308623] Subtest extended: SUCCESS (5.609s)
[397.529735] [078/133] (623s left) gem_exec_schedule (in-order)
[397.596548] Starting subtest: in-order
[397.598829] Starting dynamic subtest: rcs0
[397.754613] Dynamic subtest rcs0: SUCCESS (0.163s)
[397.765062] Starting dynamic subtest: vcs0
[397.875464] Dynamic subtest vcs0: SUCCESS (0.119s)
[397.891460] Starting dynamic subtest: vcs1
[397.982763] Dynamic subtest vcs1: SUCCESS (0.104s)
[397.995244] Starting dynamic subtest: vecs0
[398.085423] Dynamic subtest vecs0: SUCCESS (0.101s)
[398.108123] Starting dynamic subtest: ccs0
[398.206086] Dynamic subtest ccs0: SUCCESS (0.120s)
[398.208663] Subtest in-order: SUCCESS (0.615s)
[399.333784] [079/133] (621s left) gem_ctx_shared (disjoint-timelines)
[399.405080] Starting subtest: disjoint-timelines
[399.440171] Subtest disjoint-timelines: SUCCESS (0.035s)
[399.677319] [080/133] (621s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[399.766283] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[400.745846] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.980s)
[400.880191] [081/133] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[400.966452] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[400.969808] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[401.072493] [082/133] (620s left) kms_chamelium_edid (vga-edid-read)
[401.431397] Subtest vga-edid-read: SKIP (0.000s)
[402.200835] [083/133] (618s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[402.284120] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[406.736024] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.456s)
[407.929223] [084/133] (613s left) kms_cursor_crc (cursor-random-128x42)
[408.118035] Starting subtest: cursor-random-128x42
[408.165186] Subtest cursor-random-128x42: SKIP (0.042s)
[408.353543] [085/133] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[408.426540] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[408.430558] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[408.510577] [086/133] (612s left) kms_vblank (wait-idle-hang)
[408.582938] Starting subtest: wait-idle-hang
[408.585059] Starting dynamic subtest: pipe-A-eDP-1
[435.108279] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.513s)
[435.122979] Starting dynamic subtest: pipe-D-eDP-1
[450.183726] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.070s)
[450.186191] Subtest wait-idle-hang: SUCCESS (41.587s)
[450.986855] [087/133] (570s left) gem_exec_reloc (basic-write-read-noreloc)
[451.057180] Subtest basic-write-read-noreloc: SKIP (0.000s)
[451.131265] [088/133] (570s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[451.190090] Starting subtest: invalid-bsd2-flag-on-blt
[451.192456] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[451.314022] [089/133] (570s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[451.402721] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[452.505086] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.103s)
[452.626069] [090/133] (568s left) i915_pm_freq_mult (media-freq)
[452.677851] Starting subtest: media-freq
[452.679653] Starting dynamic subtest: gt0
[452.683338] Dynamic subtest gt0: SKIP (0.000s)
[452.697119] Starting dynamic subtest: gt1
[452.701299] Dynamic subtest gt1: SKIP (0.000s)
[452.704909] Subtest media-freq: SKIP (0.001s)
[452.777461] [091/133] (568s left) gem_exec_gttfill (basic)
[452.841443] Starting subtest: basic
[455.513722] Subtest basic: SUCCESS (2.671s)
[455.704111] [092/133] (565s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[455.843273] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[455.852915] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.008s)
[455.974628] [093/133] (565s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[456.095452] Starting subtest: dp-mst-lic-type-0-hdcp14
[456.099965] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[456.213614] [094/133] (565s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[456.577035] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[457.383864] [095/133] (564s left) kms_psr (pr-dpms)
[457.456184] Starting subtest: pr-dpms
[457.460378] Subtest pr-dpms: SKIP (0.000s)
[457.525680] [096/133] (564s left) kms_force_connector_basic (force-connector-state)
[457.590420] Subtest force-connector-state: SKIP (0.000s)
[457.684723] [097/133] (564s left) kms_vrr (seamless-rr-switch-drrs)
[457.757683] Starting subtest: seamless-rr-switch-drrs
[457.764405] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[457.836355] [098/133] (564s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[457.910182] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[457.914348] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[458.011604] [099/133] (563s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[458.089086] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[458.093120] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[458.191190] [100/133] (563s left) kms_plane_alpha_blend (coverage-7efc)
[458.267833] Starting subtest: coverage-7efc
[458.560103] Starting dynamic subtest: pipe-A-eDP-1
[459.200521] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.637s)
[459.227940] Starting dynamic subtest: pipe-D-eDP-1
[460.531920] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s)
[460.534267] Subtest coverage-7efc: SUCCESS (2.267s)
[461.369711] [101/133] (560s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[461.472121] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[470.813694] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.339s)
[471.607645] [102/133] (550s left) gem_userptr_blits (readonly-unsync)
[471.690949] Subtest readonly-unsync: SKIP (0.000s)
[471.810827] [103/133] (550s left) gem_exec_fence (submit-chain)
[472.009466] Starting subtest: submit-chain
[472.032725] Subtest submit-chain: SUCCESS (0.023s)
[473.365231] [104/133] (548s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[473.439729] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[480.171671] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.734s)
[480.295034] [105/133] (541s left) kms_cursor_crc (cursor-sliding-max-size)
[480.602043] Starting subtest: cursor-sliding-max-size
[480.608580] Subtest cursor-sliding-max-size: SKIP (0.000s)
[480.732610] [106/133] (541s left) gem_exec_flush (basic-wb-rw-default)
[480.790522] Starting subtest: basic-wb-rw-default
[486.245077] Subtest basic-wb-rw-default: SUCCESS (5.455s)
[486.447365] [107/133] (535s left) kms_pm_dc (dc3co-vpb-simulation)
[487.531126] Starting subtest: dc3co-vpb-simulation
[496.888253] Subtest dc3co-vpb-simulation: SKIP (9.353s)
[497.019898] [108/133] (525s left) gem_mmap_offset (partial-remap)
[497.085846] Starting subtest: partial-remap
[497.088673] Starting dynamic subtest: smem0
[497.097821] Dynamic subtest smem0: SUCCESS (0.005s)
[497.099864] Subtest partial-remap: SUCCESS (0.006s)
[497.196574] [109/133] (525s left) gem_exec_balancer (noheartbeat)
[497.443678] Starting subtest: noheartbeat
[497.448299] Subtest noheartbeat: SKIP (0.000s)
[497.544057] [110/133] (524s left) kms_psr (psr-primary-blt)
[497.625795] Starting subtest: psr-primary-blt
[497.628210] Starting dynamic subtest: eDP-1
[499.319162] Dynamic subtest eDP-1: SUCCESS (1.692s)
[499.321501] Subtest psr-primary-blt: SUCCESS (1.693s)
[500.192278] [111/133] (522s left) api_intel_bb (reset-flags)
[500.244436] Starting subtest: reset-flags
[500.250837] Subtest reset-flags: SUCCESS (0.009s)
[500.368312] [112/133] (522s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[500.436285] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[500.438579] Starting dynamic subtest: pipe-A-default-mode
[503.118752] Dynamic subtest pipe-A-default-mode: SUCCESS (2.681s)
[503.120622] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.682s)
[503.986090] [113/133] (518s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[504.040970] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[504.043430] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[504.149753] [114/133] (518s left) gem_exec_whisper (basic-forked)
[504.204217] Starting subtest: basic-forked
[511.900941] Subtest basic-forked: SUCCESS (7.697s)
[512.123063] [115/133] (510s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[512.204442] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[512.206799] Starting dynamic subtest: pipe-A
[512.224143] Dynamic subtest pipe-A: SKIP (0.016s)
[512.234682] Starting dynamic subtest: pipe-B
[512.254621] Dynamic subtest pipe-B: SKIP (0.030s)
[512.264110] Starting dynamic subtest: pipe-C
[512.283964] Dynamic subtest pipe-C: SKIP (0.029s)
[512.294159] Starting dynamic subtest: pipe-D
[512.314275] Dynamic subtest pipe-D: SKIP (0.029s)
[512.318631] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.106s)
[512.463300] [116/133] (510s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[512.544722] Starting subtest: x-tiled-16bpp-rotate-180
[513.736176] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.191s)
[513.847289] [117/133] (508s left) gem_exec_reloc (basic-write-wc-active)
[513.899654] Subtest basic-write-wc-active: SKIP (0.000s)
[513.965216] [118/133] (508s left) prime_self_import (basic-with_one_bo_two_files)
[513.999087] Starting subtest: basic-with_one_bo_two_files
[514.011914] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[514.111302] [119/133] (508s left) gem_exec_gttfill (all-engines)
[514.159268] Starting subtest: all-engines
[536.883470] Subtest all-engines: SUCCESS (22.723s)
[537.070407] [120/133] (485s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[537.163858] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[537.272769] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[537.350579] [121/133] (485s left) gem_exec_schedule (preempt-self)
[537.435281] Starting subtest: preempt-self
[537.437474] Starting dynamic subtest: rcs0
[537.461912] Dynamic subtest rcs0: SUCCESS (0.034s)
[537.478135] Starting dynamic subtest: bcs0
[537.493413] Dynamic subtest bcs0: SUCCESS (0.031s)
[537.503483] Starting dynamic subtest: vcs0
[537.523432] Dynamic subtest vcs0: SUCCESS (0.029s)
[537.533704] Starting dynamic subtest: vcs1
[537.547660] Dynamic subtest vcs1: SUCCESS (0.024s)
[537.557467] Starting dynamic subtest: vecs0
[537.575225] Dynamic subtest vecs0: SUCCESS (0.027s)
[537.585250] Starting dynamic subtest: ccs0
[537.605611] Dynamic subtest ccs0: SUCCESS (0.029s)
[537.607910] Subtest preempt-self: SUCCESS (0.179s)
[539.369669] [122/133] (483s left) gem_gtt_cpu_tlb
[539.491909] [123/133] (483s left) sysfs_timeslice_duration (invalid)
[539.546434] Starting subtest: invalid
[539.548830] Starting dynamic subtest: vecs0
[539.551261] Dynamic subtest vecs0: SUCCESS (0.000s)
[539.563125] Starting dynamic subtest: ccs0
[539.565043] Dynamic subtest ccs0: SUCCESS (0.000s)
[539.574749] Starting dynamic subtest: vcs0
[539.576961] Dynamic subtest vcs0: SUCCESS (0.000s)
[539.586505] Starting dynamic subtest: bcs0
[539.588404] Dynamic subtest bcs0: SUCCESS (0.000s)
[539.597501] Starting dynamic subtest: rcs0
[539.599399] Dynamic subtest rcs0: SUCCESS (0.000s)
[539.608534] Starting dynamic subtest: vcs1
[539.610415] Dynamic subtest vcs1: SUCCESS (0.000s)
[539.612286] Subtest invalid: SUCCESS (0.006s)
[539.651718] [124/133] (483s left) drm_read (empty-block)
[539.819519] Starting subtest: empty-block
[540.819097] Subtest empty-block: SUCCESS (1.002s)
[540.963824] [125/133] (482s left) gem_exec_params (invalid-bsd-ring)
[541.018091] Starting subtest: invalid-bsd-ring
[541.020606] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[541.110966] [126/133] (481s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[541.187438] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[541.189613] Starting dynamic subtest: pipe-A-eDP-1
[541.246691] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[541.256623] Starting dynamic subtest: pipe-B-eDP-1
[541.315355] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[541.326772] Starting dynamic subtest: pipe-C-eDP-1
[541.384701] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[541.395778] Starting dynamic subtest: pipe-D-eDP-1
[541.452674] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[541.457086] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[543.436561] [127/133] (479s left) dmabuf_sync_file (import-basic)
[543.478429] Starting subtest: import-basic
[543.480779] Subtest import-basic: SUCCESS (0.002s)
[543.540780] [128/133] (479s left) gem_eio (wait-10ms)
[543.767865] Starting subtest: wait-10ms
[544.111091] Subtest wait-10ms: SUCCESS (0.344s)
[544.285636] [129/133] (478s left) gem_eio (hibernate)
[544.523319] Starting subtest: hibernate
[558.788613] Subtest hibernate: SUCCESS (14.268s)
[567.958794] [130/133] (464s left) gem_ctx_exec (basic)
[568.059625] Starting subtest: basic
[568.065297] Subtest basic: SUCCESS (0.006s)
[568.172416] [131/133] (464s left) kms_properties (colorop-properties-atomic)
[568.266644] Starting subtest: colorop-properties-atomic
[568.268960] Starting dynamic subtest: pipe-A-eDP-1
[568.665149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[568.677283] Starting dynamic subtest: pipe-B-eDP-1
[569.711687] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.047s)
[569.723472] Starting dynamic subtest: pipe-C-eDP-1
[570.756957] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.041s)
[570.768412] Starting dynamic subtest: pipe-D-eDP-1
[571.796891] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.037s)
[571.798933] Subtest colorop-properties-atomic: SUCCESS (3.527s)
[572.590828] [132/133] (459s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[572.682917] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[572.687148] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[572.783627] [133/133] (459s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[572.858639] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[572.862598] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[572.974820] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: gem_ctx_freq
results: parsing output: 2/ for test: kms_invalid_mode
results: parsing output: 3/ for test: gem_wait
results: parsing output: 4/ for test: api_intel_allocator
results: parsing output: 5/ for test: kms_hdmi_inject
results: parsing output: 6/ for test: gen9_exec_parse
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: gem_basic
results: parsing output: 21/ for test: kms_fbcon_fbt
results: parsing output: 22/ for test: i915_selftest
results: parsing output: 23/ for test: gem_pxp
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_color
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_cdclk
results: parsing output: 28/ for test: kms_panel_fitting
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_universal_plane
results: parsing output: 35/ for test: gem_lmem_swapping
results: parsing output: 36/ for test: kms_getfb
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_fence_thrash
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_prop_blob
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_create
results: parsing output: 43/ for test: kms_dsc
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: gem_pwrite_snooped
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_joiner
results: parsing output: 59/ for test: kms_rotation_crc
results: parsing output: 60/ for test: kms_dp_link_training
results: parsing output: 61/ for test: syncobj_basic
results: parsing output: 62/ for test: gem_mmap_gtt
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_plane_scaling
results: parsing output: 65/ for test: gem_render_copy
results: parsing output: 66/ for test: gem_spin_batch
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_plane
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: gem_exec_flush
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: vgem_slow
results: parsing output: 75/ for test: kms_async_flips
results: parsing output: 76/ for test: gem_busy
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: gem_ctx_shared
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_chamelium_edid
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: i915_pm_freq_mult
results: parsing output: 90/ for test: gem_exec_gttfill
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_content_protection
results: parsing output: 93/ for test: kms_chamelium_hpd
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_force_connector_basic
results: parsing output: 96/ for test: kms_vrr
results: parsing output: 97/ for test: kms_plane
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_plane_alpha_blend
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: gem_userptr_blits
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: gem_exec_flush
results: parsing output: 106/ for test: kms_pm_dc
results: parsing output: 107/ for test: gem_mmap_offset
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_exec_whisper
results: parsing output: 114/ for test: kms_plane_scaling
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: prime_self_import
results: parsing output: 118/ for test: gem_exec_gttfill
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: gem_gtt_cpu_tlb
results: parsing output: 122/ for test: sysfs_timeslice_duration
results: parsing output: 123/ for test: drm_read
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: dmabuf_sync_file
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: gem_eio
results: parsing output: 129/ for test: gem_ctx_exec
results: parsing output: 130/ for test: kms_properties
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.