[56.643979] Initializing watchdogs [56.644076] /dev/watchdog0 [56.658741] [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] [56.664085] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.666566] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.668606] [001/134] (960s left) api_intel_allocator (reopen-fork) [56.701280] Starting subtest: reopen-fork [60.061403] Subtest reopen-fork: SUCCESS (3.365s) [60.147954] [002/134] (957s left) gen9_exec_parse (unaligned-jump) [60.185178] Subtest unaligned-jump: SKIP (0.000s) [60.223144] [003/134] (957s left) i915_pm_rc6_residency (rc6-accuracy) [60.254428] Starting subtest: rc6-accuracy [60.255112] Starting dynamic subtest: gt0 [63.457385] Dynamic subtest gt0: SUCCESS (3.191s) [63.458268] Subtest rc6-accuracy: SUCCESS (3.192s) [63.533791] [004/134] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [63.622524] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [63.623876] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [63.743802] [005/134] (953s left) gem_exec_reloc (basic-cpu-gtt-active) [63.780109] Starting subtest: basic-cpu-gtt-active [63.912415] Subtest basic-cpu-gtt-active: SUCCESS (0.124s) [64.083513] [006/134] (953s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [64.168704] Starting subtest: plane-scaler-unity-scaling-with-modifiers [64.169385] Starting dynamic subtest: pipe-A [65.041450] Dynamic subtest pipe-A: SUCCESS (0.877s) [65.051885] Starting dynamic subtest: pipe-B [65.899705] Dynamic subtest pipe-B: SUCCESS (0.861s) [65.916236] Starting dynamic subtest: pipe-C [66.756272] Dynamic subtest pipe-C: SUCCESS (0.860s) [66.768399] Starting dynamic subtest: pipe-D [67.614647] Dynamic subtest pipe-D: SUCCESS (0.861s) [67.615375] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (3.462s) [68.035197] [007/134] (949s left) kms_plane_cursor (overlay) [68.123510] Starting subtest: overlay [68.125972] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64 [70.877381] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.760s) [70.964474] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128 [73.699456] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.751s) [73.782544] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256 [76.522739] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.751s) [76.651361] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64 [79.425731] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.781s) [79.489891] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128 [82.234849] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.751s) [82.301508] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256 [85.043513] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.751s) [85.156317] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64 [87.936714] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.784s) [88.000366] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128 [90.745596] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.751s) [90.809818] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256 [93.554346] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.751s) [93.663741] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64 [96.444455] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (2.784s) [96.508278] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128 [99.253239] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (2.751s) [99.320054] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256 [102.061750] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (2.751s) [102.166759] Subtest overlay: SUCCESS (34.055s) [102.311081] [008/134] (915s left) sw_sync (alloc_fence) [102.342655] Starting subtest: alloc_fence [102.343313] Subtest alloc_fence: SUCCESS (0.000s) [102.445317] [009/134] (915s left) gen9_exec_parse (batch-invalid-length) [102.479806] Subtest batch-invalid-length: SKIP (0.000s) [102.529068] [010/134] (914s left) gem_mmap_offset (blt-coherency) [102.559617] Starting subtest: blt-coherency [102.565056] Subtest blt-coherency: SUCCESS (0.006s) [102.731656] [011/134] (914s left) kms_psr (pr-primary-page-flip) [102.817138] Subtest pr-primary-page-flip: SKIP (0.000s) [102.869463] [012/134] (914s left) kms_vblank (query-busy-hang) [102.952886] Starting subtest: query-busy-hang [102.954463] Starting dynamic subtest: pipe-A-HDMI-A-1 [116.874167] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.918s) [116.882321] Starting dynamic subtest: pipe-D-HDMI-A-1 [130.682985] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.803s) [130.683680] Subtest query-busy-hang: SUCCESS (27.727s) [130.879862] [013/134] (886s left) gem_softpin (allocator-evict) [130.917234] Starting subtest: allocator-evict [130.917946] Starting dynamic subtest: rcs0 [154.263799] Dynamic subtest rcs0: SUCCESS (23.346s) [154.270178] Starting dynamic subtest: bcs0 [177.547535] Dynamic subtest bcs0: SUCCESS (23.285s) [177.553738] Starting dynamic subtest: vcs0 [200.778373] Dynamic subtest vcs0: SUCCESS (23.230s) [200.784366] Starting dynamic subtest: vcs1 [224.105301] Dynamic subtest vcs1: SUCCESS (23.326s) [224.111292] Starting dynamic subtest: vecs0 [247.179687] Dynamic subtest vecs0: SUCCESS (23.073s) [247.180462] Subtest allocator-evict: SUCCESS (116.264s) [247.308061] [014/134] (770s left) kms_chamelium_color (ctm-max) [247.452230] Subtest ctm-max: SKIP (0.000s) [247.495787] [015/134] (770s left) syncobj_timeline (single-wait-signaled) [247.534960] Starting subtest: single-wait-signaled [247.535686] Subtest single-wait-signaled: SUCCESS (0.000s) [247.645649] [016/134] (770s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [247.733585] Starting subtest: fbc-shrfb-scaledprimary [251.188265] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.455s) [251.410803] [017/134] (766s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [251.514852] Starting subtest: psr-2p-scndscrn-spr-indfb-move [251.516214] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [251.669695] [018/134] (766s left) prime_mmap (test_correct_cpu_write) [251.703418] Starting subtest: test_correct_cpu_write [251.704104] Starting dynamic subtest: test_correct_cpu_write-smem [251.704782] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [251.705434] Subtest test_correct_cpu_write: SUCCESS (0.001s) [251.829235] [019/134] (765s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [251.927119] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [253.847174] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (1.921s) [254.022293] [020/134] (763s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [254.061157] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [254.061888] Starting dynamic subtest: smem [254.140496] Dynamic subtest smem: SUCCESS (0.079s) [254.141240] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.080s) [254.384853] [021/134] (763s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [254.470625] Starting subtest: basic-flip-after-cursor-atomic [255.559719] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.089s) [255.751608] [022/134] (762s left) gem_ctx_create (basic-files) [255.793102] Starting subtest: basic-files [257.802459] Subtest basic-files: SUCCESS (2.009s) [258.028813] [023/134] (759s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [258.112784] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [258.114139] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [258.216647] [024/134] (759s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [258.303325] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [258.304703] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [258.446552] [025/134] (759s left) syncobj_basic (bad-flags-fd-to-handle) [258.478784] Starting subtest: bad-flags-fd-to-handle [258.479468] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s) [258.596983] [026/134] (759s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [258.629564] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [258.734915] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s) [258.858061] [027/134] (759s left) kms_pm_dc (dc6-dpms) [259.949833] Starting subtest: dc6-dpms [263.305371] Subtest dc6-dpms: FAIL (3.342s) [263.449141] [028/134] (754s left) gem_exec_reloc (basic-write-gtt-noreloc) [263.486399] Starting subtest: basic-write-gtt-noreloc [263.488885] Subtest basic-write-gtt-noreloc: SUCCESS (0.002s) [263.661825] [029/134] (754s left) kms_big_fb (y-tiled-64bpp-rotate-270) [263.754592] Starting subtest: y-tiled-64bpp-rotate-270 [263.814175] Subtest y-tiled-64bpp-rotate-270: SKIP (0.058s) [263.984425] [030/134] (754s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [264.074479] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [264.075813] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [264.250879] [031/134] (754s left) kms_content_protection (content-type-change) [264.338527] Starting subtest: content-type-change [264.352185] Subtest content-type-change: SKIP (0.012s) [264.516761] [032/134] (753s left) kms_cursor_crc (cursor-sliding-32x32) [264.602824] Starting subtest: cursor-sliding-32x32 [264.652500] Subtest cursor-sliding-32x32: SKIP (0.048s) [264.801478] [033/134] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [264.888565] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [264.889910] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [265.053505] [034/134] (753s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [265.138664] Starting subtest: short-flip-after-cursor-atomic-transitions [266.204384] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.066s) [266.386340] [035/134] (752s left) gem_ctx_shared (disjoint-timelines) [266.427452] Starting subtest: disjoint-timelines [266.470110] Subtest disjoint-timelines: SUCCESS (0.043s) [266.747771] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true [266.749472] [036/134] (751s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [266.836348] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [266.837780] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [266.976803] [037/134] (751s left) prime_busy (hang) [267.013110] Starting subtest: hang [267.013844] Starting dynamic subtest: rcs0 [280.697680] Dynamic subtest rcs0: SUCCESS (13.649s) [280.703991] Starting dynamic subtest: bcs0 [287.545688] Dynamic subtest bcs0: SUCCESS (6.847s) [287.551913] Starting dynamic subtest: vcs0 [294.585663] Dynamic subtest vcs0: SUCCESS (7.039s) [294.591891] Starting dynamic subtest: vcs1 [301.561356] Dynamic subtest vcs1: SUCCESS (6.976s) [301.567586] Starting dynamic subtest: vecs0 [308.602375] Dynamic subtest vecs0: SUCCESS (7.039s) [308.603276] Subtest hang: SUCCESS (41.555s) [308.729411] [038/134] (709s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [308.818422] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [308.819838] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [308.959637] [039/134] (709s left) sysfs_preempt_timeout (timeout) [308.995479] Starting subtest: timeout [308.997117] Starting dynamic subtest: vecs0 [309.932469] Dynamic subtest vecs0: SUCCESS (0.936s) [309.941867] Starting dynamic subtest: vcs0 [310.883467] Dynamic subtest vcs0: SUCCESS (0.950s) [310.894766] Starting dynamic subtest: bcs0 [311.826374] Dynamic subtest bcs0: SUCCESS (0.941s) [311.837770] Starting dynamic subtest: rcs0 [312.780315] Dynamic subtest rcs0: SUCCESS (0.953s) [312.794406] Starting dynamic subtest: vcs1 [313.750222] Dynamic subtest vcs1: SUCCESS (0.969s) [313.751135] Subtest timeout: SUCCESS (4.755s) [313.855715] [040/134] (704s left) gem_pwrite (basic-random) [313.889204] Starting subtest: basic-random [319.404423] Subtest basic-random: SUCCESS (5.479s) [319.543197] [041/134] (699s left) kms_vblank (ts-continuation-dpms-rpm) [319.682755] Starting subtest: ts-continuation-dpms-rpm [319.684394] Starting dynamic subtest: pipe-A-HDMI-A-1 [321.323198] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.639s) [321.332012] Starting dynamic subtest: pipe-D-HDMI-A-1 [322.544957] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.218s) [322.545627] Subtest ts-continuation-dpms-rpm: SUCCESS (2.863s) [322.748023] [042/134] (695s left) kms_chamelium_hpd (vga-hpd-without-ddc) [322.877821] Subtest vga-hpd-without-ddc: SKIP (0.000s) [322.958420] [043/134] (695s left) prime_self_import (basic-with_one_bo_two_files) [322.988969] Starting subtest: basic-with_one_bo_two_files [322.992267] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [323.163024] [044/134] (695s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [323.246685] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [323.247366] Starting dynamic subtest: pipe-A-valid-mode [323.966797] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.719s) [323.967535] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.720s) [324.195617] [045/134] (694s left) gem_exec_reloc (basic-gtt) [324.233161] Starting subtest: basic-gtt [324.240073] Subtest basic-gtt: SUCCESS (0.007s) [324.420465] [046/134] (694s left) kms_big_fb (linear-32bpp-rotate-0) [324.514411] Starting subtest: linear-32bpp-rotate-0 [326.446225] Subtest linear-32bpp-rotate-0: SUCCESS (1.932s) [326.645808] [047/134] (692s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [326.730909] Starting subtest: basic-max-pipe-crc-check [326.732330] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [326.779232] [048/134] (692s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [326.866777] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [326.914681] [049/134] (692s left) drm_read (short-buffer-block) [327.015865] Starting subtest: short-buffer-block [327.016538] Subtest short-buffer-block: SUCCESS (0.000s) [327.194841] [050/134] (691s left) gem_ctx_persistence (many-contexts) [327.232237] Starting subtest: many-contexts [366.285748] Subtest many-contexts: SUCCESS (39.052s) [366.389580] [051/134] (652s left) prime_mmap (test_correct) [366.421759] Starting subtest: test_correct [366.422462] Starting dynamic subtest: test_correct-smem [366.424320] Dynamic subtest test_correct-smem: SUCCESS (0.002s) [366.425045] Subtest test_correct: SUCCESS (0.002s) [366.565283] [052/134] (652s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [366.604256] Starting subtest: invalid-multi-wait-all-unsubmitted [366.605020] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [366.738515] [053/134] (652s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [366.833332] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [368.188736] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.355s) [368.409009] [054/134] (650s left) gem_mmap_gtt (basic-copy) [368.442365] Starting subtest: basic-copy [368.919731] Subtest basic-copy: SUCCESS (0.469s) [369.047545] [055/134] (650s left) gem_exec_suspend (basic) [369.087248] Starting subtest: basic [369.087976] Starting dynamic subtest: smem [369.601150] Dynamic subtest smem: SUCCESS (0.514s) [369.601937] Subtest basic: SUCCESS (0.514s) [369.844599] [056/134] (649s left) perf_pmu (busy-accuracy-2) [369.880296] Starting subtest: busy-accuracy-2 [369.881016] Starting dynamic subtest: rcs0 [372.911830] Dynamic subtest rcs0: SUCCESS (3.028s) [372.919632] Starting dynamic subtest: bcs0 [375.942953] Dynamic subtest bcs0: SUCCESS (3.031s) [375.951992] Starting dynamic subtest: vcs0 [378.973109] Dynamic subtest vcs0: SUCCESS (3.029s) [378.983594] Starting dynamic subtest: vcs1 [382.003051] Dynamic subtest vcs1: SUCCESS (3.030s) [382.012242] Starting dynamic subtest: vecs0 [385.034324] Dynamic subtest vecs0: SUCCESS (3.030s) [385.035057] Subtest busy-accuracy-2: SUCCESS (15.151s) [385.136374] [057/134] (634s left) gem_wait (await) [385.180674] Starting subtest: await [385.181436] Starting dynamic subtest: all-engines [386.238391] Dynamic subtest all-engines: SUCCESS (1.057s) [386.248674] Starting dynamic subtest: rcs0 [387.275676] Dynamic subtest rcs0: SUCCESS (1.035s) [387.287840] Starting dynamic subtest: bcs0 [388.308908] Dynamic subtest bcs0: SUCCESS (1.032s) [388.319432] Starting dynamic subtest: vcs0 [389.356308] Dynamic subtest vcs0: SUCCESS (1.046s) [389.366470] Starting dynamic subtest: vcs1 [390.385050] Dynamic subtest vcs1: SUCCESS (1.026s) [390.394960] Starting dynamic subtest: vecs0 [391.415108] Dynamic subtest vecs0: SUCCESS (1.030s) [391.416099] Subtest await: SUCCESS (6.235s) [391.666245] [058/134] (627s left) prime_mmap (test_refcounting) [391.697478] Starting subtest: test_refcounting [391.698212] Starting dynamic subtest: test_refcounting-smem [391.699883] Dynamic subtest test_refcounting-smem: SUCCESS (0.002s) [391.700589] Subtest test_refcounting: SUCCESS (0.002s) [391.836847] [059/134] (627s left) gem_exec_balancer (individual) [391.878236] Starting subtest: individual [393.391117] Subtest individual: SUCCESS (1.504s) [393.638944] [060/134] (625s left) kms_dp_link_training (uhbr-sst) [393.727006] Starting subtest: uhbr-sst [393.728426] Subtest uhbr-sst: SKIP (0.000s) [393.850767] [061/134] (625s left) gem_busy (busy) [393.892430] Starting subtest: busy [393.893139] Starting dynamic subtest: all-engines [393.920302] Dynamic subtest all-engines: SUCCESS (0.028s) [393.928450] Starting dynamic subtest: rcs0 [393.935646] Dynamic subtest rcs0: SUCCESS (0.015s) [393.943839] Starting dynamic subtest: bcs0 [393.968189] Dynamic subtest bcs0: SUCCESS (0.031s) [393.981819] Starting dynamic subtest: vcs0 [394.002169] Dynamic subtest vcs0: SUCCESS (0.032s) [394.015583] Starting dynamic subtest: vcs1 [394.021734] Dynamic subtest vcs1: SUCCESS (0.019s) [394.032458] Starting dynamic subtest: vecs0 [394.034094] Dynamic subtest vecs0: SUCCESS (0.011s) [394.034803] Subtest busy: SUCCESS (0.142s) [394.442071] [062/134] (625s left) kms_big_fb (4-tiled-8bpp-rotate-180) [394.533918] Starting subtest: 4-tiled-8bpp-rotate-180 [394.535297] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s) [394.704874] [063/134] (624s left) kms_cursor_crc (cursor-rapid-movement-128x42) [394.797277] Starting subtest: cursor-rapid-movement-128x42 [394.805209] Starting dynamic subtest: pipe-A-HDMI-A-1 [395.197142] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.391s) [395.225605] Starting dynamic subtest: pipe-D-HDMI-A-1 [395.512404] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.293s) [395.513080] Subtest cursor-rapid-movement-128x42: SUCCESS (0.715s) [395.706869] [064/134] (623s left) kms_joiner (invalid-modeset-force-big-joiner) [395.791889] Starting subtest: invalid-modeset-force-big-joiner [395.793245] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [395.912447] [065/134] (623s left) kms_flip (dpms-off-confusion-interruptible) [395.999340] Starting subtest: dpms-off-confusion-interruptible [396.001961] Starting dynamic subtest: A-HDMI-A1 [403.697796] Dynamic subtest A-HDMI-A1: SUCCESS (7.695s) [403.713289] Starting dynamic subtest: B-HDMI-A1 [411.384714] Dynamic subtest B-HDMI-A1: SUCCESS (7.667s) [411.391635] Starting dynamic subtest: C-HDMI-A1 [419.053834] Dynamic subtest C-HDMI-A1: SUCCESS (7.668s) [419.060970] Starting dynamic subtest: D-HDMI-A1 [426.708177] Dynamic subtest D-HDMI-A1: SUCCESS (7.669s) [426.710413] Subtest dpms-off-confusion-interruptible: SUCCESS (30.711s) [426.953167] [066/134] (592s left) perf_pmu (pmu-read) [426.987647] Starting subtest: pmu-read [426.989733] Subtest pmu-read: SUCCESS (0.003s) [427.121950] [067/134] (592s left) gem_lmem_swapping (random) [427.158011] Subtest random: SKIP (0.000s) [427.200631] [068/134] (592s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [427.286976] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [427.288405] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [427.479248] [069/134] (592s left) gem_exec_schedule (u-semaphore-user) [427.522435] Starting subtest: u-semaphore-user [427.530020] Subtest u-semaphore-user: SUCCESS (0.008s) [427.876545] [070/134] (592s left) gem_workarounds (basic-read) [427.921422] Starting subtest: basic-read [427.929720] Subtest basic-read: SUCCESS (0.008s) [428.085757] [071/134] (591s left) kms_hdr (bpc-switch-suspend) [428.168901] Starting subtest: bpc-switch-suspend [428.171028] Subtest bpc-switch-suspend: SKIP (0.001s) [428.290797] [072/134] (591s left) kms_prime (d3hot) [428.386405] Subtest D3hot: SKIP (0.000s) [428.539997] [073/134] (591s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [428.623910] Starting subtest: bad-rotation-90-yf-tiled-ccs [428.624655] Starting dynamic subtest: pipe-A-HDMI-A-1 [428.631396] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [428.638636] Starting dynamic subtest: pipe-B-HDMI-A-1 [428.645372] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [428.652541] Starting dynamic subtest: pipe-C-HDMI-A-1 [428.659171] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [428.666153] Starting dynamic subtest: pipe-D-HDMI-A-1 [428.672782] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [428.674092] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.006s) [428.897579] [074/134] (591s left) gem_exec_endless (dispatch) [428.943098] Starting subtest: dispatch [428.943911] Starting dynamic subtest: rcs0 [428.946699] Dynamic subtest rcs0: SUCCESS (0.003s) [428.954363] Starting dynamic subtest: bcs0 [428.955710] Dynamic subtest bcs0: SUCCESS (0.003s) [428.963891] Starting dynamic subtest: vcs0 [428.965434] Dynamic subtest vcs0: SUCCESS (0.003s) [428.972519] Starting dynamic subtest: vcs1 [428.973844] Dynamic subtest vcs1: SUCCESS (0.003s) [428.980723] Starting dynamic subtest: vecs0 [428.982041] Dynamic subtest vecs0: SUCCESS (0.003s) [428.982715] Subtest dispatch: SUCCESS (0.019s) [429.125805] [075/134] (590s left) kms_async_flips (test-time-stamp-atomic) [429.208518] Starting subtest: test-time-stamp-atomic [429.413032] Starting dynamic subtest: pipe-A-HDMI-A-1 [429.543856] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.130s) [429.753164] Starting dynamic subtest: pipe-B-HDMI-A-1 [429.854426] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.107s) [430.033255] Starting dynamic subtest: pipe-C-HDMI-A-1 [430.141186] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.113s) [430.336554] Starting dynamic subtest: pipe-D-HDMI-A-1 [430.445451] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.116s) [430.446532] Subtest test-time-stamp-atomic: SUCCESS (1.237s) [430.798629] [076/134] (589s left) dmabuf_sync_file (export-wait-after-attach) [430.845016] Starting subtest: export-wait-after-attach [430.846717] Subtest export-wait-after-attach: SUCCESS (0.001s) [430.950840] [077/134] (589s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping) [431.035912] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping [431.072848] Starting dynamic subtest: pipe-A-plane-0 [431.074637] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [431.087351] Starting dynamic subtest: pipe-A-plane-3 [431.088934] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [431.098466] Starting dynamic subtest: pipe-A-plane-5 [431.099860] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [431.106815] Starting dynamic subtest: pipe-A-plane-7 [431.108177] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [431.218606] Starting dynamic subtest: pipe-B-plane-0 [431.220191] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [431.229343] Starting dynamic subtest: pipe-B-plane-3 [431.230709] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [431.237690] Starting dynamic subtest: pipe-B-plane-5 [431.239092] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [431.246068] Starting dynamic subtest: pipe-B-plane-7 [431.247417] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [431.268107] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SKIP (0.232s) [431.454012] [078/134] (588s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [431.535951] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [431.537340] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [431.748648] [079/134] (588s left) kms_flip (2x-flip-vs-panning-vs-hang) [431.831736] Starting subtest: 2x-flip-vs-panning-vs-hang [431.840649] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.009s) [431.976772] [080/134] (588s left) gem_mmap_gtt (basic-small-copy-xy) [432.009254] Starting subtest: basic-small-copy-XY [434.575869] Subtest basic-small-copy-XY: SUCCESS (2.567s) [434.686098] [081/134] (585s left) kms_cursor_crc (cursor-dpms) [434.832853] Starting subtest: cursor-dpms [434.833566] Starting dynamic subtest: pipe-A-HDMI-A-1 [435.872095] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.038s) [435.881582] Starting dynamic subtest: pipe-D-HDMI-A-1 [436.736995] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.862s) [436.737747] Subtest cursor-dpms: SUCCESS (1.905s) [436.935579] [082/134] (583s left) kms_chamelium_frames (hdmi-frame-dump) [437.064391] Subtest hdmi-frame-dump: SKIP (0.000s) [437.146329] [083/134] (583s left) gen3_render_linear_blits [437.221787] [084/134] (583s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [437.315949] Starting subtest: yf-tiled-64bpp-rotate-180 [437.317338] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [437.467069] [085/134] (583s left) kms_properties (invalid-properties-legacy) [437.550017] Starting subtest: invalid-properties-legacy [437.764395] Subtest invalid-properties-legacy: SUCCESS (0.208s) [437.884830] [086/134] (582s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [437.923748] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [438.035786] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s) [438.130443] [087/134] (582s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [438.217008] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu [438.218559] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [438.377291] [088/134] (582s left) kms_psr (psr-no-drrs) [438.461305] Subtest psr-no-drrs: SKIP (0.000s) [438.513250] [089/134] (582s left) gem_exec_params (readonly) [438.550957] Starting subtest: readonly [438.551677] Subtest readonly: SUCCESS (0.001s) [438.738456] [090/134] (581s left) i915_hangman (gt-error-state-capture) [438.780716] Starting subtest: gt-error-state-capture [438.781384] Starting dynamic subtest: rcs0 [447.930738] Dynamic subtest rcs0: SUCCESS (9.150s) [447.947670] Starting dynamic subtest: bcs0 [457.877659] Dynamic subtest bcs0: SUCCESS (9.944s) [457.894484] Starting dynamic subtest: vcs0 [467.940863] Dynamic subtest vcs0: SUCCESS (10.060s) [467.958502] Starting dynamic subtest: vcs1 [477.921746] Dynamic subtest vcs1: SUCCESS (9.978s) [477.936754] Starting dynamic subtest: vecs0 [487.904849] Dynamic subtest vecs0: SUCCESS (9.981s) [487.906202] Subtest gt-error-state-capture: SUCCESS (49.125s) [488.014158] [091/134] (532s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling) [488.101240] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling [488.101949] Starting dynamic subtest: pipe-A-valid-mode [489.870520] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.768s) [489.871265] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SUCCESS (1.770s) [490.067747] [092/134] (530s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [490.162064] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [490.163473] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [490.322231] [093/134] (530s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [490.410053] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s) [490.462234] [094/134] (530s left) gem_ctx_param (invalid-get-no-zeromap) [490.494844] Starting subtest: invalid-get-no-zeromap [490.495527] Subtest invalid-get-no-zeromap: SUCCESS (0.000s) [490.630199] [095/134] (530s left) kms_flip (bo-too-big) [490.714081] Starting subtest: bo-too-big [490.716165] Starting dynamic subtest: A-HDMI-A1 [491.073642] Dynamic subtest A-HDMI-A1: SUCCESS (0.357s) [491.089973] Starting dynamic subtest: B-HDMI-A1 [491.390263] Dynamic subtest B-HDMI-A1: SUCCESS (0.314s) [491.404287] Starting dynamic subtest: C-HDMI-A1 [491.684990] Dynamic subtest C-HDMI-A1: SUCCESS (0.292s) [491.699570] Starting dynamic subtest: D-HDMI-A1 [491.979590] Dynamic subtest D-HDMI-A1: SUCCESS (0.292s) [491.983595] Subtest bo-too-big: SUCCESS (1.270s) [492.205451] [096/134] (528s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render) [492.297068] Starting subtest: fbcpsr-abgr161616f-draw-render [492.298474] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s) [492.450762] [097/134] (528s left) kms_flip (2x-flip-vs-dpms) [492.535112] Starting subtest: 2x-flip-vs-dpms [492.543932] Subtest 2x-flip-vs-dpms: SKIP (0.009s) [492.657695] [098/134] (528s left) core_auth (getclient-master-drop) [492.688973] Starting subtest: getclient-master-drop [492.690360] Subtest getclient-master-drop: SUCCESS (0.002s) [492.829647] [099/134] (528s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [492.917875] Starting subtest: fbc-1p-primscrn-cur-indfb-move [495.988604] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.071s) [496.187074] [100/134] (524s left) gem_render_copy (yf-tiled) [496.225488] Starting subtest: yf-tiled [496.226205] Starting dynamic subtest: smem [496.294601] Dynamic subtest smem: SUCCESS (0.068s) [496.295324] Subtest yf-tiled: SUCCESS (0.070s) [496.529065] [101/134] (524s left) i915_selftest (mock) [497.499215] Starting subtest: mock [497.500154] Starting dynamic subtest: sanitycheck [498.235621] Dynamic subtest sanitycheck: SUCCESS (0.728s) [498.244935] Starting dynamic subtest: shmem [498.934471] Dynamic subtest shmem: SUCCESS (0.697s) [498.943749] Starting dynamic subtest: fence [507.031508] Dynamic subtest fence: SUCCESS (8.095s) [507.045054] Starting dynamic subtest: scatterlist [508.736319] Dynamic subtest scatterlist: SUCCESS (1.703s) [508.744972] Starting dynamic subtest: syncmap [511.690380] Dynamic subtest syncmap: SUCCESS (2.952s) [511.699140] Starting dynamic subtest: uncore [512.402397] Dynamic subtest uncore: SUCCESS (0.710s) [512.411769] Starting dynamic subtest: ring [513.108493] Dynamic subtest ring: SUCCESS (0.704s) [513.117899] Starting dynamic subtest: engine [513.809375] Dynamic subtest engine: SUCCESS (0.699s) [513.818788] Starting dynamic subtest: timelines [518.242551] Dynamic subtest timelines: SUCCESS (4.431s) [518.249035] Starting dynamic subtest: requests [521.037475] Dynamic subtest requests: SUCCESS (2.793s) [521.047114] Starting dynamic subtest: objects [521.852600] Dynamic subtest objects: SUCCESS (0.813s) [521.861194] Starting dynamic subtest: phys [522.679484] Dynamic subtest phys: SUCCESS (0.825s) [522.688622] Starting dynamic subtest: dmabuf [523.466383] Dynamic subtest dmabuf: SUCCESS (0.785s) [523.476110] Starting dynamic subtest: vma [530.876393] Dynamic subtest vma: SUCCESS (7.408s) [530.885902] Starting dynamic subtest: evict [532.541309] Dynamic subtest evict: SUCCESS (1.663s) [532.549804] Starting dynamic subtest: gtt [536.275507] Dynamic subtest gtt: SUCCESS (3.732s) [536.283656] Starting dynamic subtest: hugepages [537.256409] Dynamic subtest hugepages: SUCCESS (0.979s) [537.265245] Starting dynamic subtest: memory_region [540.486362] Dynamic subtest memory_region: SUCCESS (3.228s) [540.487220] Subtest mock: SUCCESS (42.981s) [540.514209] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [540.515004] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [540.517289] [102/134] (480s left) kms_big_fb (x-tiled-8bpp-rotate-180) [541.721879] Starting subtest: x-tiled-8bpp-rotate-180 [543.284800] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.555s) [543.446949] [FACT kms_big_fb (x-tiled-8bpp-rotate-180)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [543.448322] [FACT kms_big_fb (x-tiled-8bpp-rotate-180)] new: kernel.kmod_is_loaded.i915: true [543.450518] [103/134] (477s left) gem_userptr_blits (relocations) [543.490831] Starting subtest: relocations [543.492704] Subtest relocations: SUCCESS (0.002s) [543.661351] [104/134] (477s left) gem_exec_fence (submit3) [543.814527] Starting subtest: submit3 [543.816031] Starting dynamic subtest: rcs0 [543.819403] Dynamic subtest rcs0: SUCCESS (0.005s) [543.828652] Starting dynamic subtest: bcs0 [543.830102] Dynamic subtest bcs0: SUCCESS (0.004s) [543.838040] Starting dynamic subtest: vcs0 [543.839645] Dynamic subtest vcs0: SUCCESS (0.004s) [543.848116] Starting dynamic subtest: vcs1 [543.849540] Dynamic subtest vcs1: SUCCESS (0.004s) [543.857336] Starting dynamic subtest: vecs0 [543.858571] Dynamic subtest vecs0: SUCCESS (0.004s) [543.859988] Subtest submit3: SUCCESS (0.027s) [544.325341] [105/134] (477s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [544.359862] Subtest flip-primary-invalidate-overlay: SKIP (0.000s) [544.432337] [106/134] (476s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [544.465534] Starting subtest: multi-wait-all-for-submit-available-submitted [544.466218] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s) [544.595472] [107/134] (476s left) gem_ctx_engines (invalid-engines) [544.635410] Starting subtest: invalid-engines [544.640818] Subtest invalid-engines: SUCCESS (0.005s) [544.855765] [108/134] (476s left) gem_exec_schedule (pi-ringfull) [545.018345] Starting subtest: pi-ringfull [545.019315] Starting dynamic subtest: rcs0 [545.049941] Dynamic subtest rcs0: SUCCESS (0.032s) [545.058497] Starting dynamic subtest: bcs0 [545.074875] Dynamic subtest bcs0: SUCCESS (0.024s) [545.083375] Starting dynamic subtest: vcs0 [545.099535] Dynamic subtest vcs0: SUCCESS (0.024s) [545.108908] Starting dynamic subtest: vcs1 [545.123890] Dynamic subtest vcs1: SUCCESS (0.023s) [545.133018] Starting dynamic subtest: vecs0 [545.148164] Dynamic subtest vecs0: SUCCESS (0.023s) [545.149402] Subtest pi-ringfull: SUCCESS (0.132s) [545.354304] [109/134] (476s left) gem_exec_whisper (basic-fds-all) [545.396378] Starting subtest: basic-fds-all [548.032799] Subtest basic-fds-all: SUCCESS (2.635s) [548.238673] [110/134] (473s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [548.323951] Starting subtest: plane-upscale-factor-0-25-with-modifiers [548.324725] Starting dynamic subtest: pipe-A [549.139052] Dynamic subtest pipe-A: SUCCESS (0.814s) [549.155080] Starting dynamic subtest: pipe-B [550.000139] Dynamic subtest pipe-B: SUCCESS (0.859s) [550.014883] Starting dynamic subtest: pipe-C [550.861736] Dynamic subtest pipe-C: SUCCESS (0.860s) [550.884037] Starting dynamic subtest: pipe-D [551.743497] Dynamic subtest pipe-D: SUCCESS (0.879s) [551.744426] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (3.420s) [551.988907] [111/134] (469s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [552.078546] Starting subtest: 2x-flip-vs-blocking-wf-vblank [552.087409] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.009s) [552.213801] [112/134] (469s left) kms_plane_multiple (tiling-x) [552.299199] Starting subtest: tiling-x [552.299881] Starting dynamic subtest: pipe-A-HDMI-A-1 [552.987820] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.688s) [552.997106] Starting dynamic subtest: pipe-B-HDMI-A-1 [553.628853] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.639s) [553.638430] Starting dynamic subtest: pipe-C-HDMI-A-1 [554.267752] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.637s) [554.276314] Starting dynamic subtest: pipe-D-HDMI-A-1 [554.893566] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.624s) [554.894271] Subtest tiling-x: SUCCESS (2.595s) [555.098067] [113/134] (466s left) gem_flink_basic (basic) [555.132515] Starting subtest: basic [555.133198] Subtest basic: SUCCESS (0.000s) [555.265073] [114/134] (466s left) gem_exec_parallel (basic) [555.305548] Starting subtest: basic [555.306272] Starting dynamic subtest: rcs0 [556.923834] Dynamic subtest rcs0: SUCCESS (1.618s) [556.935694] Starting dynamic subtest: bcs0 [558.503270] Dynamic subtest bcs0: SUCCESS (1.578s) [558.512532] Starting dynamic subtest: vcs0 [560.083910] Dynamic subtest vcs0: SUCCESS (1.580s) [560.092801] Starting dynamic subtest: vcs1 [561.653069] Dynamic subtest vcs1: SUCCESS (1.568s) [561.662339] Starting dynamic subtest: vecs0 [563.235483] Dynamic subtest vecs0: SUCCESS (1.581s) [563.236186] Subtest basic: SUCCESS (7.931s) [563.484909] [115/134] (458s left) gem_exec_whisper (basic-queues-priority-all) [563.525284] Starting subtest: basic-queues-priority-all [566.507972] Subtest basic-queues-priority-all: SUCCESS (2.973s) [566.727992] [116/134] (455s left) kms_psr (fbc-psr-sprite-plane-move) [566.815781] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s) [566.861083] [117/134] (454s left) gem_sync (basic-many-each) [566.903552] Starting subtest: basic-many-each [569.135729] Subtest basic-many-each: SUCCESS (2.231s) [569.395146] [118/134] (452s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [569.484547] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [569.485895] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [569.628427] [119/134] (452s left) gem_fence_thrash (bo-write-verify-threaded-x) [569.660202] Starting subtest: bo-write-verify-threaded-x [574.350980] Subtest bo-write-verify-threaded-x: SUCCESS (4.657s) [574.487472] [120/134] (447s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [574.521105] Starting subtest: multi-wait-available-unsubmitted-signaled [574.521793] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [574.657995] [121/134] (447s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [574.745988] Starting subtest: primary-yf-tiled-reflect-x-270 [574.856672] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.110s) [575.008371] [122/134] (447s left) kms_psr (fbc-pr-sprite-mmap-gtt) [575.096632] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [575.152506] [123/134] (446s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [575.242174] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [575.243590] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [575.377064] [124/134] (446s left) syncobj_wait (multi-wait-for-submit-submitted) [575.409509] Starting subtest: multi-wait-for-submit-submitted [575.520370] Subtest multi-wait-for-submit-submitted: SUCCESS (0.109s) [575.661933] [125/134] (446s left) sw_sync (sync_busy_fork_unixsocket) [575.694742] Starting subtest: sync_busy_fork_unixsocket [575.702663] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s) [575.794751] [126/134] (446s left) kms_async_flips (crc) [575.880098] Starting subtest: crc [576.084855] Starting dynamic subtest: pipe-A-HDMI-A-1 [578.273578] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.180s) [578.475761] Starting dynamic subtest: pipe-B-HDMI-A-1 [580.644784] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.167s) [580.797342] Starting dynamic subtest: pipe-C-HDMI-A-1 [582.960416] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.161s) [583.108017] Starting dynamic subtest: pipe-D-HDMI-A-1 [585.274791] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.165s) [585.275620] Subtest crc: SUCCESS (9.387s) [585.585911] [127/134] (436s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [585.672925] Starting subtest: cursorB-vs-flipA-atomic [585.675660] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s) [585.810445] [128/134] (436s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [585.900743] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [585.902080] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [586.058625] [129/134] (436s left) gem_exec_flush (basic-wb-rw-before-default) [586.099018] Starting subtest: basic-wb-rw-before-default [591.520686] Subtest basic-wb-rw-before-default: SUCCESS (5.422s) [591.782107] [130/134] (430s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [591.868950] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [591.869653] Starting dynamic subtest: pipe-A-HDMI-A-1 [591.876217] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [591.883934] Starting dynamic subtest: pipe-B-HDMI-A-1 [591.890447] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [591.898176] Starting dynamic subtest: pipe-C-HDMI-A-1 [591.904656] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [591.912177] Starting dynamic subtest: pipe-D-HDMI-A-1 [591.918711] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [591.920050] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s) [592.122816] [131/134] (430s left) kms_properties (colorop-properties-legacy) [592.209082] Starting subtest: colorop-properties-legacy [592.209822] Starting dynamic subtest: pipe-A-HDMI-A-1 [592.307985] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.098s) [592.316708] Starting dynamic subtest: pipe-B-HDMI-A-1 [592.406217] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.096s) [592.415351] Starting dynamic subtest: pipe-C-HDMI-A-1 [592.507874] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.099s) [592.516711] Starting dynamic subtest: pipe-D-HDMI-A-1 [592.605739] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.096s) [592.606401] Subtest colorop-properties-legacy: SUCCESS (0.398s) [592.815334] [132/134] (429s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [592.904802] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [592.906158] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [593.039906] [133/134] (429s left) kms_busy (extended-modeset-hang-newfb) [593.129020] Starting subtest: extended-modeset-hang-newfb [593.130736] Starting dynamic subtest: pipe-A [617.157347] Dynamic subtest pipe-A: SUCCESS (24.027s) [617.167906] Starting dynamic subtest: pipe-D [640.691747] Dynamic subtest pipe-D: SUCCESS (23.531s) [640.693574] Subtest extended-modeset-hang-newfb: SUCCESS (47.564s) [640.895269] [134/134] (381s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [640.986665] Starting subtest: plane-lut1d-ctm3x4-lut1d [641.023560] Starting dynamic subtest: pipe-A-HDMI-A-1 [641.361530] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.340s) [641.506860] Starting dynamic subtest: pipe-B-HDMI-A-1 [641.819771] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.321s) [641.937121] Starting dynamic subtest: pipe-C-HDMI-A-1 [642.250684] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.321s) [642.386825] Starting dynamic subtest: pipe-D-HDMI-A-1 [642.700515] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.321s) [642.744165] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (1.758s) [642.914661] Closing watchdogs results: parsing output: 0/ for test: api_intel_allocator results: parsing output: 1/ for test: gen9_exec_parse results: parsing output: 2/ for test: i915_pm_rc6_residency results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_reloc results: parsing output: 5/ for test: kms_plane_scaling results: parsing output: 6/ for test: kms_plane_cursor results: parsing output: 7/ for test: sw_sync results: parsing output: 8/ for test: gen9_exec_parse results: parsing output: 9/ for test: gem_mmap_offset results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: kms_vblank results: parsing output: 12/ for test: gem_softpin results: parsing output: 13/ for test: kms_chamelium_color results: parsing output: 14/ for test: syncobj_timeline results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: prime_mmap results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_render_copy results: parsing output: 20/ for test: kms_cursor_legacy results: parsing output: 21/ for test: gem_ctx_create results: parsing output: 22/ for test: kms_cursor_legacy results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: syncobj_basic results: parsing output: 25/ for test: syncobj_timeline results: parsing output: 26/ for test: kms_pm_dc results: parsing output: 27/ for test: gem_exec_reloc results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_content_protection results: parsing output: 31/ for test: kms_cursor_crc results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_cursor_legacy results: parsing output: 34/ for test: gem_ctx_shared results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: prime_busy results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: sysfs_preempt_timeout results: parsing output: 39/ for test: gem_pwrite results: parsing output: 40/ for test: kms_vblank results: parsing output: 41/ for test: kms_chamelium_hpd results: parsing output: 42/ for test: prime_self_import results: parsing output: 43/ for test: kms_flip_scaled_crc results: parsing output: 44/ for test: gem_exec_reloc results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: kms_multipipe_modeset results: parsing output: 47/ for test: kms_psr2_sf results: parsing output: 48/ for test: drm_read results: parsing output: 49/ for test: gem_ctx_persistence results: parsing output: 50/ for test: prime_mmap results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: gem_mmap_gtt results: parsing output: 54/ for test: gem_exec_suspend results: parsing output: 55/ for test: perf_pmu results: parsing output: 56/ for test: gem_wait results: parsing output: 57/ for test: prime_mmap results: parsing output: 58/ for test: gem_exec_balancer results: parsing output: 59/ for test: kms_dp_link_training results: parsing output: 60/ for test: gem_busy results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: kms_cursor_crc results: parsing output: 63/ for test: kms_joiner results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: perf_pmu results: parsing output: 66/ for test: gem_lmem_swapping results: parsing output: 67/ for test: kms_ccs results: parsing output: 68/ for test: gem_exec_schedule results: parsing output: 69/ for test: gem_workarounds results: parsing output: 70/ for test: kms_hdr results: parsing output: 71/ for test: kms_prime results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: gem_exec_endless results: parsing output: 74/ for test: kms_async_flips results: parsing output: 75/ for test: dmabuf_sync_file results: parsing output: 76/ for test: kms_plane results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: kms_flip results: parsing output: 79/ for test: gem_mmap_gtt results: parsing output: 80/ for test: kms_cursor_crc results: parsing output: 81/ for test: kms_chamelium_frames results: parsing output: 82/ for test: gen3_render_linear_blits results: parsing output: 83/ for test: kms_big_fb results: parsing output: 84/ for test: kms_properties results: parsing output: 85/ for test: syncobj_wait results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: gem_exec_params results: parsing output: 89/ for test: i915_hangman results: parsing output: 90/ for test: kms_flip_scaled_crc results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_psr2_sf results: parsing output: 93/ for test: gem_ctx_param results: parsing output: 94/ for test: kms_flip results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_flip results: parsing output: 97/ for test: core_auth results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_render_copy results: parsing output: 100/ for test: i915_selftest results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: gem_userptr_blits results: parsing output: 103/ for test: gem_exec_fence results: parsing output: 104/ for test: kms_psr_stress_test results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: gem_ctx_engines results: parsing output: 107/ for test: gem_exec_schedule results: parsing output: 108/ for test: gem_exec_whisper results: parsing output: 109/ for test: kms_plane_scaling results: parsing output: 110/ for test: kms_flip results: parsing output: 111/ for test: kms_plane_multiple results: parsing output: 112/ for test: gem_flink_basic results: parsing output: 113/ for test: gem_exec_parallel results: parsing output: 114/ for test: gem_exec_whisper results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: gem_sync results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_fence_thrash results: parsing output: 119/ for test: syncobj_timeline results: parsing output: 120/ for test: kms_rotation_crc results: parsing output: 121/ for test: kms_psr results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: sw_sync results: parsing output: 125/ for test: kms_async_flips results: parsing output: 126/ for test: kms_cursor_legacy results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_exec_flush results: parsing output: 129/ for test: kms_ccs results: parsing output: 130/ for test: kms_properties results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_busy results: parsing output: 133/ for test: kms_color_pipeline Done.