[61.995939] Initializing watchdogs [61.996030] /dev/watchdog0 [62.012479] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics] [62.018360] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.020769] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.022868] [001/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-180) [62.125878] Starting subtest: x-tiled-8bpp-rotate-180 [63.156072] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.030s) [63.286961] [002/133] (959s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier) [63.377547] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier [63.378977] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s) [63.428856] [003/133] (959s left) kms_psr2_sf (pr-cursor-plane-update-sf) [63.515710] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [63.556765] [004/133] (959s left) kms_frontbuffer_tracking (psr-slowdraw) [63.645485] Starting subtest: psr-slowdraw [63.646890] Subtest psr-slowdraw: SKIP (0.000s) [63.740496] [005/133] (958s left) kms_flip (plain-flip-fb-recreate) [63.826160] Starting subtest: plain-flip-fb-recreate [63.827946] Starting dynamic subtest: A-HDMI-A1 [71.648767] Dynamic subtest A-HDMI-A1: SUCCESS (7.820s) [71.661139] Starting dynamic subtest: B-HDMI-A1 [79.456794] Dynamic subtest B-HDMI-A1: SUCCESS (7.807s) [79.465083] Starting dynamic subtest: C-HDMI-A1 [87.258030] Dynamic subtest C-HDMI-A1: SUCCESS (7.800s) [87.270799] Starting dynamic subtest: D-HDMI-A1 [95.072177] Dynamic subtest D-HDMI-A1: SUCCESS (7.813s) [95.076488] Subtest plain-flip-fb-recreate: SUCCESS (31.251s) [95.219415] [006/133] (927s left) syncobj_timeline (invalid-signal-one-illegal-handle) [95.254538] Starting subtest: invalid-signal-one-illegal-handle [95.255281] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [95.313317] [007/133] (927s left) api_intel_allocator (open-vm) [95.345246] Starting subtest: open-vm [95.346812] Subtest open-vm: SUCCESS (0.001s) [95.436755] [008/133] (927s left) gem_exec_params (cliprects_ptr-dirt) [95.473997] Starting subtest: cliprects_ptr-dirt [95.474716] Subtest cliprects_ptr-dirt: SUCCESS (0.000s) [95.561747] [009/133] (927s left) gem_ctx_persistence (engines-hang) [95.598146] Starting subtest: engines-hang [95.598869] Starting dynamic subtest: rcs0 [95.627600] Dynamic subtest rcs0: SUCCESS (0.029s) [95.636721] Starting dynamic subtest: bcs0 [95.676639] Dynamic subtest bcs0: SUCCESS (0.048s) [95.692746] Starting dynamic subtest: vcs0 [95.724584] Dynamic subtest vcs0: SUCCESS (0.047s) [95.738752] Starting dynamic subtest: vcs1 [95.779554] Dynamic subtest vcs1: SUCCESS (0.054s) [95.794183] Starting dynamic subtest: vecs0 [95.814628] Dynamic subtest vecs0: SUCCESS (0.034s) [95.815909] Subtest engines-hang: SUCCESS (0.216s) [95.888895] [010/133] (926s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [95.978733] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [97.247484] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (1.269s) [97.363694] [011/133] (925s left) kms_psr (fbc-psr2-primary-page-flip) [97.451094] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s) [97.489293] [012/133] (925s left) i915_drm_fdinfo (busy) [97.523863] Starting subtest: busy [97.524553] Starting dynamic subtest: rcs0 [98.046360] Dynamic subtest rcs0: SUCCESS (0.522s) [98.055443] Starting dynamic subtest: bcs0 [98.568219] Dynamic subtest bcs0: SUCCESS (0.521s) [98.576042] Starting dynamic subtest: vcs0 [99.088485] Dynamic subtest vcs0: SUCCESS (0.520s) [99.096838] Starting dynamic subtest: vcs1 [99.610453] Dynamic subtest vcs1: SUCCESS (0.521s) [99.620189] Starting dynamic subtest: vecs0 [100.135214] Dynamic subtest vecs0: SUCCESS (0.524s) [100.136165] Subtest busy: SUCCESS (2.611s) [100.202726] [013/133] (922s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [100.294099] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [100.355189] [014/133] (922s left) kms_cursor_crc (cursor-offscreen-64x64) [100.441213] Starting subtest: cursor-offscreen-64x64 [100.445651] Starting dynamic subtest: pipe-A-HDMI-A-1 [101.680351] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.235s) [101.713893] Starting dynamic subtest: pipe-D-HDMI-A-1 [102.921793] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.215s) [102.922574] Subtest cursor-offscreen-64x64: SUCCESS (2.481s) [103.070689] [015/133] (919s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [103.158796] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [103.159536] Starting dynamic subtest: pipe-A-HDMI-A-1 [103.166393] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [103.174333] Starting dynamic subtest: pipe-B-HDMI-A-1 [103.181160] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [103.188806] Starting dynamic subtest: pipe-C-HDMI-A-1 [103.195570] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [103.203054] Starting dynamic subtest: pipe-D-HDMI-A-1 [103.209724] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [103.211053] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s) [103.396662] [016/133] (919s left) syncobj_timeline (single-wait-available-signaled) [103.432556] Starting subtest: single-wait-available-signaled [103.433294] Subtest single-wait-available-signaled: SUCCESS (0.000s) [103.486591] [017/133] (919s left) gem_tiled_fence_blits (normal) [103.774495] Starting subtest: normal [107.036301] Subtest normal: SUCCESS (3.262s) [107.159313] [018/133] (915s left) kms_flip (2x-flip-vs-modeset-vs-hang) [107.303370] Starting subtest: 2x-flip-vs-modeset-vs-hang [107.311753] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.009s) [107.369140] [019/133] (915s left) syncobj_timeline (multi-wait-available-signaled) [107.411335] Starting subtest: multi-wait-available-signaled [107.412099] Subtest multi-wait-available-signaled: SUCCESS (0.001s) [107.476909] [020/133] (915s left) kms_content_protection (uevent-hdcp14) [107.570197] Starting subtest: uevent-hdcp14 [107.574931] Subtest uevent-hdcp14: SKIP (0.003s) [107.663842] [021/133] (915s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [107.753808] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [107.755249] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [107.860698] [022/133] (915s left) perf_pmu (semaphore-wait-idle) [107.898746] Starting subtest: semaphore-wait-idle [107.899476] Starting dynamic subtest: rcs0 [108.416759] Dynamic subtest rcs0: SUCCESS (0.509s) [108.426167] Starting dynamic subtest: bcs0 [108.927954] Dynamic subtest bcs0: SUCCESS (0.511s) [108.937010] Starting dynamic subtest: vcs0 [109.438971] Dynamic subtest vcs0: SUCCESS (0.510s) [109.448094] Starting dynamic subtest: vcs1 [109.949808] Dynamic subtest vcs1: SUCCESS (0.510s) [109.959405] Starting dynamic subtest: vecs0 [110.460576] Dynamic subtest vecs0: SUCCESS (0.510s) [110.461535] Subtest semaphore-wait-idle: SUCCESS (2.553s) [110.548924] [023/133] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [110.639478] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [110.640861] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [110.720464] [024/133] (912s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [110.805481] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [110.806867] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [110.874559] [025/133] (912s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [110.962479] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [110.963887] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [111.045826] [026/133] (912s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [111.082454] Starting subtest: no-spare-fences-interruptible [113.237234] Subtest no-spare-fences-interruptible: SUCCESS (2.154s) [113.350411] [027/133] (910s left) kms_psr (pr-sprite-blt) [113.438394] Subtest pr-sprite-blt: SKIP (0.000s) [113.475166] [028/133] (910s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [113.562066] Starting subtest: flip-vs-cursor-busy-crc-atomic [113.963163] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.402s) [114.100444] [029/133] (909s left) kms_psr (psr2-dpms) [114.187376] Subtest psr2-dpms: SKIP (0.000s) [114.226253] [030/133] (909s left) syncobj_wait (single-wait-all-signaled) [114.260232] Starting subtest: single-wait-all-signaled [114.260952] Subtest single-wait-all-signaled: SUCCESS (0.000s) [114.337462] [031/133] (909s left) gem_render_copy_redux (interruptible) [114.374127] Starting subtest: interruptible [114.699379] Subtest interruptible: SUCCESS (0.318s) [114.800509] [032/133] (908s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [114.889661] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [114.891062] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [114.974217] [033/133] (908s left) i915_pm_freq_api (freq-basic-api) [115.011625] Subtest freq-basic-api: SKIP (0.000s) [115.051539] [034/133] (908s left) gem_exercise_blt (fast-copy) [115.087892] Starting subtest: fast-copy [115.088619] Starting dynamic subtest: linear-smem-smem [115.108146] Dynamic subtest linear-smem-smem: SUCCESS (0.020s) [115.114434] Starting dynamic subtest: ymajor-smem-smem [115.125412] Dynamic subtest ymajor-smem-smem: SUCCESS (0.017s) [115.131667] Starting dynamic subtest: tile4-smem-smem [115.142012] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s) [115.148282] Starting dynamic subtest: tile64-smem-smem [115.158523] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s) [115.159276] Subtest fast-copy: SUCCESS (0.071s) [115.258102] [035/133] (908s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [115.346731] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [115.348139] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [115.431813] [036/133] (908s left) gem_partial_pwrite_pread (reads-display) [115.468651] Starting subtest: reads-display [117.268627] Subtest reads-display: SUCCESS (1.801s) [117.367320] [037/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [117.457835] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [117.459336] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [117.550942] [038/133] (906s left) gem_ctx_param (basic-default) [117.584629] Starting subtest: basic-default [117.585398] Subtest basic-default: SUCCESS (0.000s) [117.642416] [039/133] (906s left) gem_exec_balancer (parallel) [117.805414] Subtest parallel: SKIP (0.000s) [117.867964] [040/133] (906s left) gem_create (create-ext-set-pat) [118.022373] Starting subtest: create-ext-set-pat [118.024767] Subtest create-ext-set-pat: SKIP (0.000s) [118.069580] [041/133] (905s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [118.153855] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [118.155665] Starting dynamic subtest: pipe-A-valid-mode [119.976881] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.822s) [119.977777] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (1.823s) [120.144651] [042/133] (903s left) gem_exec_reloc (basic-gtt-cpu-active) [120.184929] Starting subtest: basic-gtt-cpu-active [120.316277] Subtest basic-gtt-cpu-active: SUCCESS (0.122s) [120.426397] [043/133] (903s left) perf (rc6-disable) [120.515892] Starting subtest: rc6-disable [120.712514] Subtest rc6-disable: SUCCESS (0.196s) [120.767610] [044/133] (903s left) gem_mmap_offset (clear-via-pagefault) [120.800950] Starting subtest: clear-via-pagefault [120.801755] Starting dynamic subtest: smem0 [143.556559] Dynamic subtest smem0: SUCCESS (22.754s) [143.557353] Subtest clear-via-pagefault: SUCCESS (22.755s) [143.653336] [045/133] (880s left) kms_dirtyfb (psr-dirtyfb-ioctl) [143.742060] Starting subtest: psr-dirtyfb-ioctl [143.746119] Subtest psr-dirtyfb-ioctl: SKIP (0.000s) [143.814146] [046/133] (880s left) kms_lease (lease-unleased-crtc) [143.899773] Starting subtest: lease-unleased-crtc [143.900478] Starting dynamic subtest: pipe-A-HDMI-A-1 [143.981205] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.080s) [143.990264] Starting dynamic subtest: pipe-B-HDMI-A-1 [144.017422] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.032s) [144.024666] Starting dynamic subtest: pipe-C-HDMI-A-1 [144.048182] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.031s) [144.058504] Starting dynamic subtest: pipe-D-HDMI-A-1 [144.082735] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.031s) [144.083457] Subtest lease-unleased-crtc: SUCCESS (0.182s) [144.189541] [047/133] (879s left) gem_render_copy (yf-tiled) [144.232350] Starting subtest: yf-tiled [144.233189] Starting dynamic subtest: smem [144.302262] Dynamic subtest smem: SUCCESS (0.069s) [144.303058] Subtest yf-tiled: SUCCESS (0.070s) [144.479568] [048/133] (879s left) i915_suspend (sysfs-reader) [144.512762] Starting subtest: sysfs-reader [163.003678] Subtest sysfs-reader: SUCCESS (3.412s) [172.136006] [049/133] (861s left) gem_render_linear_blits (basic) [172.187226] Starting subtest: basic [172.209273] Subtest basic: SUCCESS (0.023s) [172.282581] [050/133] (861s left) gem_ctx_bad_destroy (invalid-pad) [172.316729] Starting subtest: invalid-pad [172.317498] Subtest invalid-pad: SUCCESS (0.000s) [172.379804] [051/133] (861s left) gem_render_copy (y-tiled-ccs-to-linear) [172.418046] Starting subtest: y-tiled-ccs-to-linear [172.418775] Starting dynamic subtest: smem [172.489598] Dynamic subtest smem: SUCCESS (0.071s) [172.490368] Subtest y-tiled-ccs-to-linear: SUCCESS (0.072s) [172.674178] [052/133] (860s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [172.764031] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [172.765462] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [172.860475] [053/133] (860s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [172.949356] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [172.950762] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [173.045490] [054/133] (860s left) kms_cursor_edge_walk (128x128-right-edge) [173.130491] Starting subtest: 128x128-right-edge [173.132125] Starting dynamic subtest: pipe-A-HDMI-A-1 [174.873795] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.732s) [174.881215] Starting dynamic subtest: pipe-D-HDMI-A-1 [176.522373] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.653s) [176.523083] Subtest 128x128-right-edge: SUCCESS (3.389s) [176.633326] [055/133] (856s left) kms_plane (plane-position-hole-dpms) [176.721308] Starting subtest: plane-position-hole-dpms [176.933728] Starting dynamic subtest: pipe-A-plane-1 [177.248168] Dynamic subtest pipe-A-plane-1: SUCCESS (0.315s) [177.258133] Starting dynamic subtest: pipe-A-plane-2 [177.589575] Dynamic subtest pipe-A-plane-2: SUCCESS (0.340s) [177.597252] Starting dynamic subtest: pipe-A-plane-3 [177.910797] Dynamic subtest pipe-A-plane-3: SUCCESS (0.319s) [177.919713] Starting dynamic subtest: pipe-A-plane-4 [178.225670] Dynamic subtest pipe-A-plane-4: SUCCESS (0.314s) [178.233360] Starting dynamic subtest: pipe-A-plane-5 [178.551073] Dynamic subtest pipe-A-plane-5: SUCCESS (0.324s) [178.558552] Starting dynamic subtest: pipe-A-plane-6 [178.886399] Dynamic subtest pipe-A-plane-6: SUCCESS (0.334s) [178.896697] Starting dynamic subtest: pipe-A-plane-7 [178.898194] Dynamic subtest pipe-A-plane-7: SUCCESS (0.002s) [179.094926] Starting dynamic subtest: pipe-B-plane-1 [179.415282] Dynamic subtest pipe-B-plane-1: SUCCESS (0.328s) [179.424141] Starting dynamic subtest: pipe-B-plane-2 [179.725027] Dynamic subtest pipe-B-plane-2: SUCCESS (0.308s) [179.732682] Starting dynamic subtest: pipe-B-plane-3 [180.060491] Dynamic subtest pipe-B-plane-3: SUCCESS (0.334s) [180.069124] Starting dynamic subtest: pipe-B-plane-4 [180.377063] Dynamic subtest pipe-B-plane-4: SUCCESS (0.315s) [180.386455] Starting dynamic subtest: pipe-B-plane-5 [180.685084] Dynamic subtest pipe-B-plane-5: SUCCESS (0.308s) [180.694634] Starting dynamic subtest: pipe-B-plane-6 [181.008182] Dynamic subtest pipe-B-plane-6: SUCCESS (0.322s) [181.017325] Starting dynamic subtest: pipe-B-plane-7 [181.018722] Dynamic subtest pipe-B-plane-7: SUCCESS (0.003s) [181.019444] Subtest plane-position-hole-dpms: SUCCESS (4.290s) [181.162129] [056/133] (852s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [181.258337] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [181.259811] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [181.344742] [057/133] (852s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [181.434135] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [181.435658] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [181.516458] [058/133] (852s left) gem_softpin (full) [181.556475] Starting subtest: full [181.561401] Subtest full: SUCCESS (0.006s) [181.663415] [059/133] (852s left) kms_chamelium_edid (dp-edid-change-during-suspend) [181.802051] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [181.890457] [060/133] (851s left) kms_dsc (dsc-fractional-bpp) [181.978694] Starting subtest: dsc-fractional-bpp [181.982749] Subtest dsc-fractional-bpp: SKIP (0.000s) [182.039239] [061/133] (851s left) gem_exec_parallel (userptr) [182.081846] Starting subtest: userptr [182.082675] Starting dynamic subtest: rcs0 [183.924836] Dynamic subtest rcs0: SUCCESS (1.842s) [183.933516] Starting dynamic subtest: bcs0 [185.751673] Dynamic subtest bcs0: SUCCESS (1.825s) [185.760455] Starting dynamic subtest: vcs0 [187.636814] Dynamic subtest vcs0: SUCCESS (1.883s) [187.646491] Starting dynamic subtest: vcs1 [189.716699] Dynamic subtest vcs1: SUCCESS (2.078s) [189.726284] Starting dynamic subtest: vecs0 [192.043429] Dynamic subtest vecs0: SUCCESS (2.299s) [192.044469] Subtest userptr: SUCCESS (9.933s) [192.219759] [062/133] (841s left) gem_ctx_exec (basic) [192.254999] Starting subtest: basic [192.257389] Subtest basic: SUCCESS (0.003s) [192.385385] [063/133] (841s left) gem_exec_schedule (submit-late-slice) [192.433438] Starting subtest: submit-late-slice [192.434200] Starting dynamic subtest: rcs0 [192.462264] Dynamic subtest rcs0: SUCCESS (0.029s) [192.471020] Starting dynamic subtest: bcs0 [192.491685] Dynamic subtest bcs0: SUCCESS (0.029s) [192.502553] Starting dynamic subtest: vcs0 [192.518643] Dynamic subtest vcs0: SUCCESS (0.026s) [192.528950] Starting dynamic subtest: vcs1 [192.545786] Dynamic subtest vcs1: SUCCESS (0.026s) [192.555255] Starting dynamic subtest: vecs0 [192.569736] Dynamic subtest vecs0: SUCCESS (0.023s) [192.570519] Subtest submit-late-slice: SUCCESS (0.138s) [192.873667] [064/133] (841s left) gem_exec_schedule (preempt-contexts) [192.919260] Starting subtest: preempt-contexts [192.920002] Starting dynamic subtest: rcs0 [192.961592] Dynamic subtest rcs0: SUCCESS (0.042s) [192.971227] Starting dynamic subtest: bcs0 [193.006355] Dynamic subtest bcs0: SUCCESS (0.043s) [193.015333] Starting dynamic subtest: vcs0 [193.047396] Dynamic subtest vcs0: SUCCESS (0.040s) [193.056090] Starting dynamic subtest: vcs1 [193.088880] Dynamic subtest vcs1: SUCCESS (0.040s) [193.099824] Starting dynamic subtest: vecs0 [193.130026] Dynamic subtest vecs0: SUCCESS (0.040s) [193.130871] Subtest preempt-contexts: SUCCESS (0.211s) [193.432231] [065/133] (840s left) gem_mmap_gtt (cpuset-medium-copy-xy) [193.466685] Starting subtest: cpuset-medium-copy-XY [203.710741] Subtest cpuset-medium-copy-XY: SUCCESS (10.243s) [203.789015] [066/133] (830s left) gem_exec_reloc (basic-write-read-noreloc) [203.878244] Starting subtest: basic-write-read-noreloc [203.880529] Subtest basic-write-read-noreloc: SUCCESS (0.002s) [203.996765] [067/133] (830s left) kms_addfb_basic (master-rmfb) [204.032031] Starting subtest: master-rmfb [204.032734] Subtest master-rmfb: SUCCESS (0.001s) [204.185560] [068/133] (829s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [204.282447] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [204.605524] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.323s) [204.727883] [069/133] (829s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [204.812673] Starting subtest: nonblocking-crc-frame-sequence [204.814429] Starting dynamic subtest: pipe-A-HDMI-A-1 [205.170630] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.357s) [205.181053] Starting dynamic subtest: pipe-B-HDMI-A-1 [205.504188] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.331s) [205.516732] Starting dynamic subtest: pipe-C-HDMI-A-1 [205.845852] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.339s) [205.856453] Starting dynamic subtest: pipe-D-HDMI-A-1 [206.184108] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.337s) [206.184849] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.372s) [206.294678] [070/133] (827s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [206.391337] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [206.392716] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [206.489460] [071/133] (827s left) kms_color (ctm-signed) [206.576080] Starting subtest: ctm-signed [206.576857] Starting dynamic subtest: pipe-A-HDMI-A-1 [207.149521] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.573s) [207.158227] Starting dynamic subtest: pipe-B-HDMI-A-1 [207.722428] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.571s) [207.731285] Starting dynamic subtest: pipe-C-HDMI-A-1 [208.279830] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.555s) [208.288992] Starting dynamic subtest: pipe-D-HDMI-A-1 [208.816536] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.535s) [208.817570] Subtest ctm-signed: SUCCESS (2.241s) [208.970713] [072/133] (825s left) gem_exec_alignment (forked) [209.010958] Starting subtest: forked [247.929963] Subtest forked: SUCCESS (38.904s) [247.988832] [073/133] (786s left) kms_big_fb (4-tiled-32bpp-rotate-90) [248.160944] Starting subtest: 4-tiled-32bpp-rotate-90 [248.162405] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s) [248.256249] [074/133] (786s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip) [248.355078] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip [248.944195] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.590s) [249.052802] [075/133] (785s left) syncobj_wait (invalid-wait-bad-flags) [249.094851] Starting subtest: invalid-wait-bad-flags [249.095559] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [249.156338] [076/133] (785s left) sw_sync (sync_multi_timeline_wait) [249.189148] Starting subtest: sync_multi_timeline_wait [249.189854] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [249.246661] [077/133] (785s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [249.337180] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [249.338547] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [249.417076] [078/133] (785s left) gem_exec_fence (basic-busy) [249.589384] Starting subtest: basic-busy [249.590212] Starting dynamic subtest: rcs0 [249.628851] Dynamic subtest rcs0: SUCCESS (0.040s) [249.647954] Starting dynamic subtest: bcs0 [249.661049] Dynamic subtest bcs0: SUCCESS (0.030s) [249.676153] Starting dynamic subtest: vcs0 [249.695035] Dynamic subtest vcs0: SUCCESS (0.032s) [249.709181] Starting dynamic subtest: vcs1 [249.723933] Dynamic subtest vcs1: SUCCESS (0.027s) [249.736315] Starting dynamic subtest: vecs0 [249.753713] Dynamic subtest vecs0: SUCCESS (0.028s) [249.756615] Subtest basic-busy: SUCCESS (0.167s) [250.239273] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [250.242047] [079/133] (784s left) kms_async_flips (invalid-async-flip) [250.329114] Starting subtest: invalid-async-flip [250.460183] Starting dynamic subtest: pipe-A-HDMI-A-1 [250.594904] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.134s) [250.712895] Starting dynamic subtest: pipe-B-HDMI-A-1 [250.796059] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.091s) [250.903637] Starting dynamic subtest: pipe-C-HDMI-A-1 [250.996903] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.102s) [251.120690] Starting dynamic subtest: pipe-D-HDMI-A-1 [251.222099] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.115s) [251.223036] Subtest invalid-async-flip: SUCCESS (0.894s) [251.467414] [080/133] (783s left) kms_psr2_su (frontbuffer-xrgb8888) [251.505361] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [251.548066] [081/133] (783s left) syncobj_timeline (etime-single-wait-submitted) [251.585313] Starting subtest: etime-single-wait-submitted [251.687248] Subtest etime-single-wait-submitted: SUCCESS (0.102s) [251.760266] [082/133] (782s left) gem_exec_reloc (basic-cpu-wc-active) [251.798579] Starting subtest: basic-cpu-wc-active [251.930158] Subtest basic-cpu-wc-active: SUCCESS (0.123s) [252.043457] [083/133] (782s left) kms_flip (2x-flip-vs-panning-interruptible) [252.134170] Starting subtest: 2x-flip-vs-panning-interruptible [252.143757] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.009s) [252.212870] [084/133] (782s left) i915_pm_freq_mult (media-freq) [252.246600] Starting subtest: media-freq [252.247314] Starting dynamic subtest: gt0 [252.248685] Dynamic subtest gt0: SKIP (0.000s) [252.250051] Subtest media-freq: SKIP (0.001s) [252.313293] [085/133] (782s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [252.400674] Starting subtest: cursorA-vs-flipB-varying-size [252.403042] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [252.459743] [086/133] (782s left) kms_pm_rpm (modeset-lpsp) [253.860547] Starting subtest: modeset-lpsp [255.179919] Subtest modeset-lpsp: SUCCESS (1.318s) [255.288199] [087/133] (779s left) gem_exec_whisper (basic-fds-all) [255.331845] Starting subtest: basic-fds-all [257.908093] Subtest basic-fds-all: SUCCESS (2.575s) [258.091656] [088/133] (776s left) fbdev (nullptr) [258.128265] Starting subtest: nullptr [258.128964] Subtest nullptr: SUCCESS (0.000s) [258.180848] [089/133] (776s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite) [258.272256] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite [258.273694] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [258.355954] [090/133] (776s left) gem_userptr_blits (nohangcheck) [258.410238] Starting subtest: nohangcheck [258.572044] Subtest nohangcheck: SUCCESS (0.159s) [258.674378] [091/133] (776s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [258.761711] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [258.762427] Starting dynamic subtest: pipe-A-HDMI-A-1 [258.768679] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [258.776872] Starting dynamic subtest: pipe-B-HDMI-A-1 [258.783329] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [258.793654] Starting dynamic subtest: pipe-C-HDMI-A-1 [258.799785] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [258.810323] Starting dynamic subtest: pipe-D-HDMI-A-1 [258.816102] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [258.816764] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SUCCESS (0.012s) [259.000175] [092/133] (776s left) kms_chamelium_hpd (dp-hpd-after-suspend) [259.137456] Subtest dp-hpd-after-suspend: SKIP (0.000s) [259.229475] [093/133] (775s left) perf (blocking) [259.319774] Starting subtest: blocking [259.320469] Starting dynamic subtest: 0-rcs0 [269.374332] Dynamic subtest 0-rcs0: SUCCESS (10.024s) [269.375329] Subtest blocking: SUCCESS (10.025s) [269.438138] [094/133] (765s left) kms_psr (psr-primary-mmap-gtt) [269.532372] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [269.575352] [095/133] (765s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [269.665720] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [269.666444] Starting dynamic subtest: pipe-A-HDMI-A-1 [269.673237] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [269.681517] Starting dynamic subtest: pipe-B-HDMI-A-1 [269.688241] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [269.696303] Starting dynamic subtest: pipe-C-HDMI-A-1 [269.703012] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [269.711246] Starting dynamic subtest: pipe-D-HDMI-A-1 [269.717868] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [269.719162] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.010s) [269.917818] [096/133] (765s left) gem_exec_params (no-vebox) [269.958529] Starting subtest: no-vebox [269.960817] Subtest no-vebox: SUCCESS (0.001s) [270.078800] [097/133] (765s left) kms_pm_dc (dc5-psr) [271.171305] Starting subtest: dc5-psr [271.172653] Subtest dc5-psr: SKIP (0.000s) [271.231377] [098/133] (764s left) gem_pread (self) [271.264603] Starting subtest: self [271.270523] Subtest self: SUCCESS (0.006s) [271.354990] [099/133] (763s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [271.451060] Starting subtest: yf-tiled-32bpp-rotate-90 [271.452433] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [271.551874] [100/133] (763s left) syncobj_eventfd (binary-wait) [271.586509] Starting subtest: binary-wait [271.597139] Subtest binary-wait: SUCCESS (0.011s) [271.661425] [101/133] (763s left) kms_cursor_crc (cursor-size-hints) [271.750008] Starting subtest: cursor-size-hints [271.750713] Starting dynamic subtest: pipe-A-HDMI-A-1 [272.065801] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.315s) [272.075537] Starting dynamic subtest: pipe-D-HDMI-A-1 [272.340350] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.273s) [272.341056] Subtest cursor-size-hints: SUCCESS (0.592s) [272.489245] [102/133] (762s left) kms_atomic_interruptible (legacy-cursor) [272.581317] Starting subtest: legacy-cursor [272.583058] Starting dynamic subtest: pipe-A-HDMI-A-1 [278.815301] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.235s) [278.817046] Subtest legacy-cursor: SUCCESS (6.237s) [278.959311] [103/133] (756s left) gem_render_copy (x-tiled) [279.001540] Starting subtest: x-tiled [279.002322] Starting dynamic subtest: smem [279.097902] Dynamic subtest smem: SUCCESS (0.096s) [279.098672] Subtest x-tiled: SUCCESS (0.097s) [279.295187] [104/133] (756s left) gen9_exec_parse (basic-rejected) [279.332967] Subtest basic-rejected: SKIP (0.000s) [279.376233] [105/133] (756s left) core_sysfs (read-all-entries) [279.409125] Starting subtest: read-all-entries [279.412576] Subtest read-all-entries: SUCCESS (0.004s) [279.488424] [106/133] (756s left) perf (gen12-unprivileged-single-ctx-counters) [279.559101] Starting subtest: gen12-unprivileged-single-ctx-counters [279.559810] Starting dynamic subtest: rcs0 [279.662455] Dynamic subtest rcs0: SUCCESS (0.103s) [279.663261] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.104s) [279.705901] [107/133] (755s left) kms_big_fb (linear-32bpp-rotate-90) [279.804376] Starting subtest: linear-32bpp-rotate-90 [279.888164] Subtest linear-32bpp-rotate-90: SKIP (0.082s) [280.001017] [108/133] (755s left) gem_ctx_persistence (legacy-engines-hostile) [280.039638] Starting subtest: legacy-engines-hostile [280.040352] Starting dynamic subtest: render [280.070195] Dynamic subtest render: SUCCESS (0.029s) [280.089741] Starting dynamic subtest: bsd1 [280.177285] Dynamic subtest bsd1: SUCCESS (0.104s) [280.198076] Starting dynamic subtest: bsd2 [280.280135] Dynamic subtest bsd2: SUCCESS (0.100s) [280.300969] Starting dynamic subtest: blt [280.374100] Dynamic subtest blt: SUCCESS (0.091s) [280.394198] Starting dynamic subtest: vebox [280.470191] Dynamic subtest vebox: SUCCESS (0.093s) [280.471507] Subtest legacy-engines-hostile: SUCCESS (0.432s) [280.552327] [109/133] (755s left) perf_pmu (enable-race) [280.589203] Starting subtest: enable-race [280.589914] Starting dynamic subtest: rcs0 [293.184008] Dynamic subtest rcs0: SUCCESS (12.577s) [293.195352] Starting dynamic subtest: bcs0 [305.757794] Dynamic subtest bcs0: SUCCESS (12.572s) [305.769249] Starting dynamic subtest: vcs0 [318.327649] Dynamic subtest vcs0: SUCCESS (12.570s) [318.342938] Starting dynamic subtest: vcs1 [330.875656] Dynamic subtest vcs1: SUCCESS (12.570s) [330.885388] Starting dynamic subtest: vecs0 [343.445301] Dynamic subtest vecs0: SUCCESS (12.568s) [343.446044] Subtest enable-race: SUCCESS (62.863s) [343.512484] [110/133] (692s left) gem_softpin (32b-excludes-last-page) [343.550608] Starting subtest: 32b-excludes-last-page [343.552421] Subtest 32b-excludes-last-page: SUCCESS (0.002s) [343.670943] [111/133] (692s left) api_intel_bb (purge-bb) [343.706473] Starting subtest: purge-bb [343.708414] Subtest purge-bb: SUCCESS (0.003s) [343.817617] [112/133] (692s left) kms_sequence (queue-idle) [343.907498] Starting subtest: queue-idle [343.908225] Starting dynamic subtest: pipe-A-HDMI-A-1 [345.103823] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.196s) [345.115988] Starting dynamic subtest: pipe-B-HDMI-A-1 [346.288036] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.182s) [346.298063] Starting dynamic subtest: pipe-C-HDMI-A-1 [347.492844] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.201s) [347.504720] Starting dynamic subtest: pipe-D-HDMI-A-1 [348.679122] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.184s) [348.679828] Subtest queue-idle: SUCCESS (4.773s) [348.791187] [113/133] (687s left) gem_exec_flush (basic-wb-rw-before-default) [348.839842] Starting subtest: basic-wb-rw-before-default [354.266501] Subtest basic-wb-rw-before-default: SUCCESS (5.427s) [354.472450] [114/133] (681s left) syncobj_timeline (wait-for-submit-delayed-submit) [354.506508] Starting subtest: wait-for-submit-delayed-submit [354.608634] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s) [354.701969] [115/133] (681s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [354.793890] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [354.795341] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [354.906054] [116/133] (681s left) kms_flip (flip-vs-panning-interruptible) [354.997218] Starting subtest: flip-vs-panning-interruptible [355.000011] Starting dynamic subtest: A-HDMI-A1 [362.666832] Dynamic subtest A-HDMI-A1: SUCCESS (7.666s) [362.683088] Starting dynamic subtest: B-HDMI-A1 [370.318148] Dynamic subtest B-HDMI-A1: SUCCESS (7.643s) [370.332713] Starting dynamic subtest: C-HDMI-A1 [377.968480] Dynamic subtest C-HDMI-A1: SUCCESS (7.652s) [377.984901] Starting dynamic subtest: D-HDMI-A1 [385.617896] Dynamic subtest D-HDMI-A1: SUCCESS (7.646s) [385.622778] Subtest flip-vs-panning-interruptible: SUCCESS (30.624s) [385.774666] [117/133] (650s left) kms_big_fb (y-tiled-16bpp-rotate-90) [385.880562] Starting subtest: y-tiled-16bpp-rotate-90 [386.987145] Subtest y-tiled-16bpp-rotate-90: SUCCESS (1.106s) [387.101804] [118/133] (649s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [387.199342] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [387.200713] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [387.294147] [119/133] (648s left) kms_plane_multiple (2x-tiling-4) [387.381599] Starting subtest: 2x-tiling-4 [387.382974] Subtest 2x-tiling-4: SKIP (0.000s) [387.439231] [120/133] (648s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [387.525618] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [387.527316] Starting dynamic subtest: pipe-A-HDMI-A-1 [388.199650] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.669s) [388.215722] Starting dynamic subtest: pipe-B-HDMI-A-1 [388.726053] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.522s) [388.743131] Starting dynamic subtest: pipe-C-HDMI-A-1 [389.242791] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.513s) [389.258975] Starting dynamic subtest: pipe-D-HDMI-A-1 [389.775875] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.521s) [389.776807] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.240s) [389.955388] [121/133] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [390.049366] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [390.050758] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [390.151432] [122/133] (646s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [390.241400] Starting subtest: fbcpsr-slowdraw [390.242781] Subtest fbcpsr-slowdraw: SKIP (0.000s) [390.336309] [123/133] (646s left) kms_invalid_mode (clock-too-high) [390.423341] Starting subtest: clock-too-high [390.425097] Starting dynamic subtest: pipe-A-HDMI-A-1 [390.488137] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.064s) [390.500725] Starting dynamic subtest: pipe-B-HDMI-A-1 [390.501474] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.010s) [390.514819] Starting dynamic subtest: pipe-C-HDMI-A-1 [390.515665] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.010s) [390.525272] Starting dynamic subtest: pipe-D-HDMI-A-1 [390.525989] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.009s) [390.526706] Subtest clock-too-high: SUCCESS (0.100s) [390.670139] [124/133] (645s left) gem_exec_fence (submit) [390.852912] Starting subtest: submit [390.855527] Starting dynamic subtest: rcs0 [390.856290] Dynamic subtest rcs0: SUCCESS (0.012s) [390.865521] Starting dynamic subtest: bcs0 [390.866379] Dynamic subtest bcs0: SUCCESS (0.009s) [390.877293] Starting dynamic subtest: vcs0 [390.878055] Dynamic subtest vcs0: SUCCESS (0.011s) [390.887623] Starting dynamic subtest: vcs1 [390.888360] Dynamic subtest vcs1: SUCCESS (0.010s) [390.897509] Starting dynamic subtest: vecs0 [390.898236] Dynamic subtest vecs0: SUCCESS (0.009s) [390.898919] Subtest submit: SUCCESS (0.057s) [391.391465] [125/133] (645s left) kms_vblank (query-forked-busy-hang) [391.488660] Starting subtest: query-forked-busy-hang [391.489488] Starting dynamic subtest: pipe-A-HDMI-A-1 [405.873760] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.383s) [405.889039] Starting dynamic subtest: pipe-D-HDMI-A-1 [419.689637] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.811s) [419.690416] Subtest query-forked-busy-hang: SUCCESS (28.200s) [419.830605] [126/133] (616s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [419.926291] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [419.927671] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [420.018063] [127/133] (616s left) gem_userptr_blits (dmabuf-unsync) [420.056970] Subtest dmabuf-unsync: SKIP (0.000s) [420.164445] [128/133] (616s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [420.250508] Starting subtest: plane-upscale-20x20-with-pixel-format [420.251328] Starting dynamic subtest: pipe-A [421.380393] Dynamic subtest pipe-A: SUCCESS (1.130s) [421.390752] Starting dynamic subtest: pipe-B [422.556835] Dynamic subtest pipe-B: SUCCESS (1.175s) [422.566500] Starting dynamic subtest: pipe-C [422.757244] Dynamic subtest pipe-C: SUCCESS (0.199s) [422.770941] Starting dynamic subtest: pipe-D [422.959233] Dynamic subtest pipe-D: SUCCESS (0.201s) [422.959948] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (2.710s) [423.138739] [129/133] (613s left) kms_chamelium_color (ctm-max) [423.230180] Subtest ctm-max: SKIP (0.000s) [423.277817] [130/133] (613s left) gem_render_copy (y-tiled) [423.318797] Starting subtest: y-tiled [423.319519] Starting dynamic subtest: smem [423.415876] Dynamic subtest smem: SUCCESS (0.096s) [423.416642] Subtest y-tiled: SUCCESS (0.098s) [423.599392] [131/133] (613s left) kms_psr (fbc-psr-primary-mmap-gtt) [423.686820] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s) [423.736652] [132/133] (612s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [423.826044] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [423.827422] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [423.933991] [133/133] (612s left) gem_exec_params (secure-non-master) [423.971614] Starting subtest: secure-non-master [423.972996] Subtest secure-non-master: SKIP (0.000s) [424.062070] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: kms_plane results: parsing output: 2/ for test: kms_psr2_sf results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_flip results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: api_intel_allocator results: parsing output: 7/ for test: gem_exec_params results: parsing output: 8/ for test: gem_ctx_persistence results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: i915_drm_fdinfo results: parsing output: 12/ for test: kms_psr2_sf results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: gem_tiled_fence_blits results: parsing output: 17/ for test: kms_flip results: parsing output: 18/ for test: syncobj_timeline results: parsing output: 19/ for test: kms_content_protection results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: perf_pmu results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_flip_scaled_crc results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: gem_fenced_exec_thrash results: parsing output: 26/ for test: kms_psr results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: syncobj_wait results: parsing output: 30/ for test: gem_render_copy_redux results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: i915_pm_freq_api results: parsing output: 33/ for test: gem_exercise_blt results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: gem_partial_pwrite_pread results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_ctx_param results: parsing output: 38/ for test: gem_exec_balancer results: parsing output: 39/ for test: gem_create results: parsing output: 40/ for test: kms_flip_scaled_crc results: parsing output: 41/ for test: gem_exec_reloc results: parsing output: 42/ for test: perf results: parsing output: 43/ for test: gem_mmap_offset results: parsing output: 44/ for test: kms_dirtyfb results: parsing output: 45/ for test: kms_lease results: parsing output: 46/ for test: gem_render_copy results: parsing output: 47/ for test: i915_suspend results: parsing output: 48/ for test: gem_render_linear_blits results: parsing output: 49/ for test: gem_ctx_bad_destroy results: parsing output: 50/ for test: gem_render_copy results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_cursor_edge_walk results: parsing output: 54/ for test: kms_plane results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gem_softpin results: parsing output: 58/ for test: kms_chamelium_edid results: parsing output: 59/ for test: kms_dsc results: parsing output: 60/ for test: gem_exec_parallel results: parsing output: 61/ for test: gem_ctx_exec results: parsing output: 62/ for test: gem_exec_schedule results: parsing output: 63/ for test: gem_exec_schedule results: parsing output: 64/ for test: gem_mmap_gtt results: parsing output: 65/ for test: gem_exec_reloc results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: kms_pipe_crc_basic results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_color results: parsing output: 71/ for test: gem_exec_alignment results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: kms_big_fb results: parsing output: 74/ for test: syncobj_wait results: parsing output: 75/ for test: sw_sync results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_exec_fence results: parsing output: 78/ for test: kms_async_flips results: parsing output: 79/ for test: kms_psr2_su results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: gem_exec_reloc results: parsing output: 82/ for test: kms_flip results: parsing output: 83/ for test: i915_pm_freq_mult results: parsing output: 84/ for test: kms_cursor_legacy results: parsing output: 85/ for test: kms_pm_rpm results: parsing output: 86/ for test: gem_exec_whisper results: parsing output: 87/ for test: fbdev results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: gem_userptr_blits results: parsing output: 90/ for test: kms_ccs results: parsing output: 91/ for test: kms_chamelium_hpd results: parsing output: 92/ for test: perf results: parsing output: 93/ for test: kms_psr results: parsing output: 94/ for test: kms_ccs results: parsing output: 95/ for test: gem_exec_params results: parsing output: 96/ for test: kms_pm_dc results: parsing output: 97/ for test: gem_pread results: parsing output: 98/ for test: kms_big_fb results: parsing output: 99/ for test: syncobj_eventfd results: parsing output: 100/ for test: kms_cursor_crc results: parsing output: 101/ for test: kms_atomic_interruptible results: parsing output: 102/ for test: gem_render_copy results: parsing output: 103/ for test: gen9_exec_parse results: parsing output: 104/ for test: core_sysfs results: parsing output: 105/ for test: perf results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_ctx_persistence results: parsing output: 108/ for test: perf_pmu results: parsing output: 109/ for test: gem_softpin results: parsing output: 110/ for test: api_intel_bb results: parsing output: 111/ for test: kms_sequence results: parsing output: 112/ for test: gem_exec_flush results: parsing output: 113/ for test: syncobj_timeline results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_flip results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_plane_multiple results: parsing output: 119/ for test: kms_ccs results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_invalid_mode results: parsing output: 123/ for test: gem_exec_fence results: parsing output: 124/ for test: kms_vblank results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_userptr_blits results: parsing output: 127/ for test: kms_plane_scaling results: parsing output: 128/ for test: kms_chamelium_color results: parsing output: 129/ for test: gem_render_copy results: parsing output: 130/ for test: kms_psr results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: gem_exec_params Done.