[50.303374] Initializing watchdogs [50.303440] /dev/watchdog0 [50.320753] [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] [50.326898] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [50.329606] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [50.331539] [001/156] (960s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-blt) [50.431289] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-blt [50.432698] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [50.537509] [002/156] (960s left) kms_pm_rpm (modeset-non-lpsp) [51.956276] Starting subtest: modeset-non-lpsp [53.160753] Subtest modeset-non-lpsp: SKIP (1.204s) [53.361773] [003/156] (957s left) api_intel_bb (blit-noreloc-keep-cache) [53.398391] Starting subtest: blit-noreloc-keep-cache [53.408269] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s) [53.520152] [004/156] (957s left) gem_exec_schedule (u-fairslice-all) [53.567474] Starting subtest: u-fairslice-all [55.608042] Subtest u-fairslice-all: SUCCESS (2.041s) [55.908776] [005/156] (955s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [55.996696] Starting subtest: planes-downscale-factor-0-75-unity-scaling [55.997463] Starting dynamic subtest: pipe-A [56.141927] Dynamic subtest pipe-A: SUCCESS (0.145s) [56.148420] Starting dynamic subtest: pipe-B [56.276773] Dynamic subtest pipe-B: SUCCESS (0.134s) [56.282955] Starting dynamic subtest: pipe-C [56.420655] Dynamic subtest pipe-C: SUCCESS (0.144s) [56.427078] Starting dynamic subtest: pipe-D [56.572205] Dynamic subtest pipe-D: SUCCESS (0.151s) [56.572929] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.576s) [56.747135] [006/156] (954s left) kms_properties (get_properties-sanity-atomic) [56.835705] Starting subtest: get_properties-sanity-atomic [56.839212] Subtest get_properties-sanity-atomic: SUCCESS (0.004s) [56.909673] [007/156] (954s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [56.997452] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [56.998843] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [57.055913] [008/156] (954s left) gen7_exec_parse (bitmasks) [57.093876] Subtest bitmasks: SKIP (0.000s) [57.133392] [009/156] (953s left) gem_userptr_blits (dmabuf-sync) [57.178322] Starting subtest: dmabuf-sync [57.180960] Subtest dmabuf-sync: SKIP (0.002s) [57.303668] [010/156] (953s left) gem_mmap_wc (write-wc-read-gtt) [57.337932] Starting subtest: write-wc-read-gtt [57.642489] Subtest write-wc-read-gtt: SUCCESS (0.296s) [57.709517] [011/156] (953s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [57.796708] Starting subtest: crc-primary-suspend-y-tiled-ccs [57.797440] Starting dynamic subtest: pipe-A-HDMI-A-1 [57.800309] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [57.806432] Starting dynamic subtest: pipe-B-HDMI-A-1 [57.809353] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [57.815330] Starting dynamic subtest: pipe-C-HDMI-A-1 [57.818332] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [57.824313] Starting dynamic subtest: pipe-D-HDMI-A-1 [57.827249] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [57.828816] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s) [58.042871] [012/156] (953s left) perf_pmu (rc6-suspend) [58.080640] Starting subtest: rc6-suspend [81.243666] Subtest rc6-suspend: SUCCESS (7.720s) [85.563020] [013/156] (929s left) kms_addfb_basic (addfb25-y-tiled-legacy) [85.664126] Starting subtest: addfb25-y-tiled-legacy [85.664889] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [85.744480] [014/156] (929s left) kms_addfb_basic (addfb25-modifier-no-flag) [85.832923] Starting subtest: addfb25-modifier-no-flag [85.833660] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [85.934079] [015/156] (929s left) kms_mmap_write_crc (main) [86.026592] Starting subtest: main [86.028192] Starting dynamic subtest: pipe-A-HDMI-A-1 [87.415198] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.386s) [87.415903] Subtest main: SUCCESS (1.387s) [87.577571] [016/156] (927s left) kms_force_connector_basic (prune-stale-modes) [87.702487] Starting subtest: prune-stale-modes [87.850916] Subtest prune-stale-modes: SUCCESS (0.148s) [88.002714] [017/156] (927s left) kms_sequence (queue-idle) [88.091184] Starting subtest: queue-idle [88.091984] Starting dynamic subtest: pipe-A-HDMI-A-1 [89.319496] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.227s) [89.335061] Starting dynamic subtest: pipe-B-HDMI-A-1 [90.509718] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.187s) [90.519540] Starting dynamic subtest: pipe-C-HDMI-A-1 [91.711337] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.200s) [91.719922] Starting dynamic subtest: pipe-D-HDMI-A-1 [92.902521] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.189s) [92.903337] Subtest queue-idle: SUCCESS (4.809s) [93.026440] [018/156] (922s left) gem_exec_reloc (basic-cpu-gtt-active) [93.068743] Starting subtest: basic-cpu-gtt-active [93.204799] Subtest basic-cpu-gtt-active: SUCCESS (0.127s) [93.340300] [019/156] (922s left) prime_vgem (basic-blt) [93.433359] Starting subtest: basic-blt [93.450901] Subtest basic-blt: SUCCESS (0.017s) [93.555822] [FACT prime_vgem (basic-blt)] new: kernel.kmod_is_loaded.vgem: true [93.557988] [020/156] (922s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [93.647322] Starting subtest: cursor-vs-flip-varying-size [125.586330] Subtest cursor-vs-flip-varying-size: SUCCESS (31.937s) [125.733298] [021/156] (889s left) gem_eio (create) [125.783199] Starting subtest: create [125.810403] Subtest create: SUCCESS (0.028s) [125.944271] [022/156] (889s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [125.984102] Starting subtest: x-tiled-to-vebox-yf-tiled [125.984811] Starting dynamic subtest: smem [126.052276] Dynamic subtest smem: SUCCESS (0.068s) [126.052974] Subtest x-tiled-to-vebox-yf-tiled: SUCCESS (0.069s) [126.232068] [023/156] (889s left) kms_big_fb (y-tiled-32bpp-rotate-180) [126.331284] Starting subtest: y-tiled-32bpp-rotate-180 [127.629161] Subtest y-tiled-32bpp-rotate-180: SUCCESS (1.298s) [127.769806] [024/156] (887s left) gem_exec_balancer (parallel-bb-first) [127.933236] Subtest parallel-bb-first: SKIP (0.000s) [128.008966] [025/156] (887s left) syncobj_wait (invalid-reset-bad-pad) [128.043046] Starting subtest: invalid-reset-bad-pad [128.043870] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [128.109450] [026/156] (887s left) kms_frontbuffer_tracking (hdr-suspend) [128.204884] Starting subtest: hdr-suspend [128.206290] Subtest hdr-suspend: SKIP (0.000s) [128.313292] [027/156] (887s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [128.400251] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [128.401626] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SKIP (0.000s) [128.455912] [028/156] (887s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [128.547549] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [128.548935] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [128.661040] [029/156] (887s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [128.706680] Starting subtest: map-fixed-invalidate-overlap-busy [128.707408] Starting dynamic subtest: gtt [130.330722] Dynamic subtest gtt: SUCCESS (1.615s) [130.338654] Starting dynamic subtest: wb [131.880222] Dynamic subtest wb: SUCCESS (1.549s) [131.889501] Starting dynamic subtest: wc [133.429273] Dynamic subtest wc: SUCCESS (1.549s) [133.437301] Starting dynamic subtest: uc [134.967816] Dynamic subtest uc: SUCCESS (1.538s) [134.968566] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (6.253s) [135.093046] [030/156] (880s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [135.187763] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [135.189176] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [135.295155] [031/156] (880s left) syncobj_basic (bad-flags-handle-to-fd) [135.329382] Starting subtest: bad-flags-handle-to-fd [135.330172] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [135.407353] [032/156] (880s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [135.499739] Starting subtest: fbc-indfb-scaledprimary [136.155033] Subtest fbc-indfb-scaledprimary: SUCCESS (0.655s) [136.277267] [033/156] (879s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [136.421875] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [136.533415] [034/156] (879s left) kms_plane_scaling (invalid-parameters) [136.637373] Starting subtest: invalid-parameters [136.638067] Starting dynamic subtest: less-than-1-height-src [136.652125] Dynamic subtest less-than-1-height-src: SUCCESS (0.015s) [136.660164] Starting dynamic subtest: less-than-1-width-src [136.667540] Dynamic subtest less-than-1-width-src: SUCCESS (0.015s) [136.668271] Subtest invalid-parameters: SUCCESS (0.031s) [136.771229] [035/156] (879s left) gem_lmem_swapping (verify) [136.809338] Subtest verify: SKIP (0.000s) [136.851085] [036/156] (879s left) gem_gtt_cpu_tlb [136.982347] [037/156] (879s left) kms_vrr (flip-suspend) [137.069186] Starting subtest: flip-suspend [137.071249] Subtest flip-suspend: SKIP (0.000s) [137.131366] [038/156] (879s left) kms_plane_lowres (tiling-x) [137.218214] Starting subtest: tiling-x [137.219894] Starting dynamic subtest: pipe-A-HDMI-A-1 [144.523685] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.305s) [144.614224] Starting dynamic subtest: pipe-B-HDMI-A-1 [151.742639] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (7.137s) [151.802323] Starting dynamic subtest: pipe-C-HDMI-A-1 [158.956761] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.164s) [159.039023] Starting dynamic subtest: pipe-D-HDMI-A-1 [166.189270] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (7.158s) [166.248645] Subtest tiling-x: SUCCESS (29.030s) [166.456636] [039/156] (849s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [166.563622] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [166.572817] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s) [166.647582] [040/156] (849s left) prime_mmap_kms (buffer-sharing) [166.737186] Starting subtest: buffer-sharing [166.916224] Subtest buffer-sharing: SUCCESS (0.179s) [167.099882] [041/156] (849s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [167.189450] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [167.191287] Starting dynamic subtest: pipe-A-HDMI-A-1 [167.198064] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [167.205926] Starting dynamic subtest: pipe-B-HDMI-A-1 [167.212854] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [167.220674] Starting dynamic subtest: pipe-C-HDMI-A-1 [167.227904] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [167.235575] Starting dynamic subtest: pipe-D-HDMI-A-1 [167.260519] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [167.261921] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.007s) [167.470600] [042/156] (849s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [167.566557] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [167.568035] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [167.661541] [043/156] (848s left) kms_psr (fbc-pr-cursor-plane-onoff) [167.750535] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [167.798773] [044/156] (848s left) kms_big_fb (4-tiled-addfb) [167.897908] Starting subtest: 4-tiled-addfb [167.899323] Subtest 4-tiled-addfb: SKIP (0.000s) [167.995634] [045/156] (848s left) gem_ctx_persistence (legacy-engines-hostile) [168.034780] Starting subtest: legacy-engines-hostile [168.035572] Starting dynamic subtest: render [168.079213] Dynamic subtest render: SUCCESS (0.043s) [168.097642] Starting dynamic subtest: bsd1 [168.176163] Dynamic subtest bsd1: SUCCESS (0.094s) [168.196514] Starting dynamic subtest: bsd2 [168.272233] Dynamic subtest bsd2: SUCCESS (0.093s) [168.291981] Starting dynamic subtest: blt [168.365246] Dynamic subtest blt: SUCCESS (0.090s) [168.386314] Starting dynamic subtest: vebox [168.469213] Dynamic subtest vebox: SUCCESS (0.101s) [168.470591] Subtest legacy-engines-hostile: SUCCESS (0.435s) [168.546945] [046/156] (848s left) gem_pipe_control_store_loop (reused-buffer) [168.584803] Starting subtest: reused-buffer [170.745350] Subtest reused-buffer: SUCCESS (2.152s) [170.853563] [047/156] (845s left) syncobj_timeline (wait-all-complex) [170.890397] Starting subtest: wait-all-complex [171.114385] Subtest wait-all-complex: SUCCESS (0.216s) [171.181795] [048/156] (845s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [171.276991] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt [171.278410] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [171.381280] [049/156] (845s left) kms_flip (2x-plain-flip-fb-recreate) [171.470147] Starting subtest: 2x-plain-flip-fb-recreate [171.479107] Subtest 2x-plain-flip-fb-recreate: SKIP (0.009s) [171.546547] [050/156] (845s left) kms_cursor_edge_walk (128x128-right-edge) [171.634592] Starting subtest: 128x128-right-edge [171.636444] Starting dynamic subtest: pipe-A-HDMI-A-1 [173.403780] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.768s) [173.414627] Starting dynamic subtest: pipe-D-HDMI-A-1 [175.105232] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.699s) [175.106104] Subtest 128x128-right-edge: SUCCESS (3.472s) [175.222605] [051/156] (841s left) gem_softpin (evict-prime) [175.262352] Starting subtest: evict-prime [175.263105] Starting dynamic subtest: rcs0 [176.385269] Dynamic subtest rcs0: SUCCESS (1.122s) [176.413346] Starting dynamic subtest: bcs0 [177.511324] Dynamic subtest bcs0: SUCCESS (1.123s) [177.540727] Starting dynamic subtest: vcs0 [178.631308] Dynamic subtest vcs0: SUCCESS (1.117s) [178.656072] Starting dynamic subtest: vcs1 [179.749088] Dynamic subtest vcs1: SUCCESS (1.114s) [179.772586] Starting dynamic subtest: vecs0 [180.872136] Dynamic subtest vecs0: SUCCESS (1.121s) [180.900249] Starting dynamic subtest: all [181.992256] Dynamic subtest all: SUCCESS (1.118s) [181.993563] Subtest evict-prime: SUCCESS (6.731s) [182.085748] [052/156] (834s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [182.185765] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [182.187227] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [182.289934] [053/156] (834s left) gem_exec_reloc (basic-wc-gtt-noreloc) [182.332450] Starting subtest: basic-wc-gtt-noreloc [182.335641] Subtest basic-wc-gtt-noreloc: SUCCESS (0.003s) [182.448467] [054/156] (834s left) gem_wait (busy) [182.494018] Starting subtest: busy [182.494772] Starting dynamic subtest: all-engines [183.011251] Dynamic subtest all-engines: SUCCESS (0.517s) [183.020728] Starting dynamic subtest: rcs0 [183.531512] Dynamic subtest rcs0: SUCCESS (0.519s) [183.541062] Starting dynamic subtest: bcs0 [184.044399] Dynamic subtest bcs0: SUCCESS (0.512s) [184.053611] Starting dynamic subtest: vcs0 [184.563617] Dynamic subtest vcs0: SUCCESS (0.518s) [184.573447] Starting dynamic subtest: vcs1 [185.077468] Dynamic subtest vcs1: SUCCESS (0.513s) [185.087088] Starting dynamic subtest: vecs0 [185.590748] Dynamic subtest vecs0: SUCCESS (0.511s) [185.591462] Subtest busy: SUCCESS (3.096s) [185.784908] [055/156] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [185.878612] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [185.880132] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [185.982310] [056/156] (831s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [186.074809] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [186.076229] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [186.174638] [057/156] (831s left) kms_explicit_fence (multiplane-atomic-fence-wait) [186.266274] Starting subtest: multiplane-atomic-fence-wait [186.488865] Subtest multiplane-atomic-fence-wait: SUCCESS (0.214s) [186.692324] [058/156] (830s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [186.784407] Starting subtest: cursorA-vs-flipB-toggle [186.786927] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [186.859073] [059/156] (830s left) gem_exec_schedule (pi-common) [187.027419] Starting subtest: pi-common [187.028298] Starting dynamic subtest: rcs0 [187.067342] Dynamic subtest rcs0: SUCCESS (0.041s) [187.078166] Starting dynamic subtest: bcs0 [187.100465] Dynamic subtest bcs0: SUCCESS (0.032s) [187.111595] Starting dynamic subtest: vcs0 [187.128177] Dynamic subtest vcs0: SUCCESS (0.027s) [187.139443] Starting dynamic subtest: vcs1 [187.153980] Dynamic subtest vcs1: SUCCESS (0.025s) [187.164101] Starting dynamic subtest: vecs0 [187.178634] Dynamic subtest vecs0: SUCCESS (0.024s) [187.179394] Subtest pi-common: SUCCESS (0.154s) [187.354801] [060/156] (829s left) prime_vgem (coherency-gtt) [187.414126] Starting subtest: coherency-gtt [187.415572] Subtest coherency-gtt: SKIP (0.000s) [187.516442] [061/156] (829s left) i915_pm_rpm (system-suspend-devices) [188.917166] Starting subtest: system-suspend-devices [196.614643] Subtest system-suspend-devices: SUCCESS (7.699s) [203.827863] [062/156] (820s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [203.921443] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [203.936064] Starting dynamic subtest: pipe-A-plane-0 [204.211117] Dynamic subtest pipe-A-plane-0: SUCCESS (0.275s) [204.229931] Starting dynamic subtest: pipe-A-plane-3 [204.437116] Dynamic subtest pipe-A-plane-3: SUCCESS (0.223s) [204.449979] Starting dynamic subtest: pipe-A-plane-5 [204.644518] Dynamic subtest pipe-A-plane-5: SUCCESS (0.206s) [204.804549] Starting dynamic subtest: pipe-B-plane-0 [205.021099] Dynamic subtest pipe-B-plane-0: SUCCESS (0.224s) [205.031531] Starting dynamic subtest: pipe-B-plane-3 [205.237766] Dynamic subtest pipe-B-plane-3: SUCCESS (0.215s) [205.249104] Starting dynamic subtest: pipe-B-plane-5 [205.454847] Dynamic subtest pipe-B-plane-5: SUCCESS (0.215s) [205.513990] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (1.592s) [205.679653] [063/156] (818s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc) [205.777907] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc [205.779289] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [205.882913] [064/156] (818s left) gem_ctx_exec (basic-close-race) [205.918854] Starting subtest: basic-close-race [211.497305] Subtest basic-close-race: SUCCESS (5.544s) [211.589019] [065/156] (812s left) kms_hdr (static-swap) [211.678415] Starting subtest: static-swap [211.680247] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB2101010 [211.681629] Dynamic subtest pipe-A-HDMI-A-1-XRGB2101010: SKIP (0.000s) [211.690062] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB16161616F [211.691423] Dynamic subtest pipe-A-HDMI-A-1-XRGB16161616F: SKIP (0.000s) [211.692815] Subtest static-swap: SKIP (0.004s) [211.760681] [066/156] (812s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [211.854550] Starting subtest: psr-2p-primscrn-cur-indfb-move [211.855997] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [211.958724] [067/156] (812s left) kms_color_pipeline (plane-lut1d-lut1d) [212.046871] Starting subtest: plane-lut1d-lut1d [212.143538] Starting dynamic subtest: pipe-A-plane-0 [212.243089] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s) [212.259589] Starting dynamic subtest: pipe-A-plane-1 [212.335781] Dynamic subtest pipe-A-plane-1: SUCCESS (0.089s) [212.351230] Starting dynamic subtest: pipe-A-plane-2 [212.426484] Dynamic subtest pipe-A-plane-2: SUCCESS (0.089s) [212.638822] Starting dynamic subtest: pipe-B-plane-0 [212.716404] Dynamic subtest pipe-B-plane-0: SUCCESS (0.083s) [212.730210] Starting dynamic subtest: pipe-B-plane-1 [212.808632] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s) [212.821864] Starting dynamic subtest: pipe-B-plane-2 [212.898536] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s) [213.114018] Starting dynamic subtest: pipe-C-plane-0 [213.190195] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s) [213.203385] Starting dynamic subtest: pipe-C-plane-1 [213.288185] Dynamic subtest pipe-C-plane-1: SUCCESS (0.097s) [213.301564] Starting dynamic subtest: pipe-C-plane-2 [213.388340] Dynamic subtest pipe-C-plane-2: SUCCESS (0.098s) [213.621288] Starting dynamic subtest: pipe-D-plane-0 [213.704242] Dynamic subtest pipe-D-plane-0: SUCCESS (0.091s) [213.717206] Starting dynamic subtest: pipe-D-plane-1 [213.804823] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s) [213.820223] Starting dynamic subtest: pipe-D-plane-2 [213.904571] Dynamic subtest pipe-D-plane-2: SUCCESS (0.097s) [213.953193] Subtest plane-lut1d-lut1d: SUCCESS (1.906s) [214.077583] [068/156] (810s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [214.177032] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu [214.178458] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [214.290114] [069/156] (810s left) kms_psr (fbc-pr-suspend) [214.379398] Subtest fbc-pr-suspend: SKIP (0.000s) [214.423263] [070/156] (810s left) gem_eio (hibernate) [214.466524] Starting subtest: hibernate [227.632885] Subtest hibernate: SUCCESS (13.166s) [235.795693] [071/156] (797s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move) [235.900053] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move [235.901437] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [236.004302] [072/156] (796s left) kms_psr (pr-cursor-blt) [236.093314] Subtest pr-cursor-blt: SKIP (0.000s) [236.138802] [073/156] (796s left) gem_exec_create (legacy) [236.180898] Starting subtest: legacy [236.182793] Starting dynamic subtest: smem [238.221690] Dynamic subtest smem: SUCCESS (2.040s) [238.222470] Subtest legacy: SUCCESS (2.041s) [238.411123] [074/156] (794s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite) [238.504986] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite [238.506446] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [238.592734] [075/156] (794s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [238.684954] Starting subtest: fbc-rgb565-draw-pwrite [240.022607] Subtest fbc-rgb565-draw-pwrite: SUCCESS (1.338s) [240.147610] [076/156] (792s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff) [240.244430] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff [240.245883] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [240.345889] [077/156] (792s left) kms_big_fb (x-tiled-32bpp-rotate-180) [240.443807] Starting subtest: x-tiled-32bpp-rotate-180 [241.856133] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.412s) [241.989300] [078/156] (791s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [242.080494] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [242.081550] Starting dynamic subtest: pipe-A-HDMI-A-1 [242.099611] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s) [242.108482] Starting dynamic subtest: pipe-B-HDMI-A-1 [242.126931] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s) [242.135752] Starting dynamic subtest: pipe-C-HDMI-A-1 [242.152977] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [242.162840] Starting dynamic subtest: pipe-D-HDMI-A-1 [242.181128] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s) [242.182523] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.016s) [242.361376] [079/156] (790s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [242.458643] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [243.762304] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (1.305s) [243.891358] [080/156] (789s left) kms_psr (pr-primary-mmap-gtt) [243.984052] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [244.028889] [081/156] (789s left) gem_exec_fence (syncobj-timeline-export) [244.491965] Starting subtest: syncobj-timeline-export [244.492815] Subtest syncobj-timeline-export: SUCCESS (0.005s) [244.674364] [082/156] (788s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [244.768881] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [244.770290] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [244.868865] [083/156] (788s left) perf (gen12-group-exclusive-stream-sample-oa) [244.949828] Starting subtest: gen12-group-exclusive-stream-sample-oa [244.961318] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.011s) [245.006219] [084/156] (788s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [245.104140] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [245.411705] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.308s) [245.545231] [085/156] (787s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4) [245.638471] Starting subtest: fbcpsrhdr-tiling-4 [245.639881] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s) [245.737541] [086/156] (787s left) gem_exec_store (pages) [245.779431] Starting subtest: pages [245.780197] Starting dynamic subtest: rcs0 [245.857189] Dynamic subtest rcs0: SUCCESS (0.077s) [245.875030] Starting dynamic subtest: bcs0 [245.918990] Dynamic subtest bcs0: SUCCESS (0.060s) [245.933219] Starting dynamic subtest: vcs0 [245.975648] Dynamic subtest vcs0: SUCCESS (0.055s) [245.988224] Starting dynamic subtest: vcs1 [246.036931] Dynamic subtest vcs1: SUCCESS (0.060s) [246.054704] Starting dynamic subtest: vecs0 [246.103852] Dynamic subtest vecs0: SUCCESS (0.065s) [246.104952] Subtest pages: SUCCESS (0.325s) [246.296513] [087/156] (787s left) kms_cursor_crc (cursor-rapid-movement-64x21) [246.389166] Starting subtest: cursor-rapid-movement-64x21 [246.393136] Starting dynamic subtest: pipe-A-HDMI-A-1 [246.628829] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.235s) [246.667222] Starting dynamic subtest: pipe-D-HDMI-A-1 [246.881179] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.225s) [246.881990] Subtest cursor-rapid-movement-64x21: SUCCESS (0.494s) [247.042554] [088/156] (786s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite) [247.138676] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite [247.140073] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [247.254099] [089/156] (786s left) kms_atomic_interruptible (universal-setplane-primary) [247.346582] Starting subtest: universal-setplane-primary [247.347276] Starting dynamic subtest: pipe-A-HDMI-A-1 [253.626159] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.279s) [253.626918] Subtest universal-setplane-primary: SUCCESS (6.281s) [253.770252] [090/156] (779s left) kms_addfb_basic (unused-handle) [253.808698] Starting subtest: unused-handle [253.809554] Subtest unused-handle: SUCCESS (0.000s) [253.959584] [091/156] (779s left) gem_exec_schedule (deep) [254.129666] Starting subtest: deep [254.132239] Starting dynamic subtest: rcs0 [262.199104] Dynamic subtest rcs0: SUCCESS (8.058s) [262.212722] Starting dynamic subtest: bcs0 [270.361604] Dynamic subtest bcs0: SUCCESS (8.163s) [270.391512] Starting dynamic subtest: vcs0 [278.539046] Dynamic subtest vcs0: SUCCESS (8.176s) [278.549256] Starting dynamic subtest: vcs1 [286.729491] Dynamic subtest vcs1: SUCCESS (8.190s) [286.741683] Starting dynamic subtest: vecs0 [294.823782] Dynamic subtest vecs0: SUCCESS (8.093s) [294.824703] Subtest deep: SUCCESS (40.686s) [295.373128] [092/156] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [295.469939] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [295.471350] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [295.557903] [093/156] (738s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [295.647481] Starting subtest: plane-primary-toggle-with-vblank-wait [295.648174] Starting dynamic subtest: pipe-A-HDMI-A-1 [295.770476] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.122s) [295.859032] Starting dynamic subtest: pipe-B-HDMI-A-1 [296.020346] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.171s) [296.069438] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.422s) [296.220648] [094/156] (737s left) kms_flip (plain-flip-fb-recreate) [296.312137] Starting subtest: plain-flip-fb-recreate [296.314970] Starting dynamic subtest: A-HDMI-A1 [304.140094] Dynamic subtest A-HDMI-A1: SUCCESS (7.825s) [304.158278] Starting dynamic subtest: B-HDMI-A1 [311.955811] Dynamic subtest B-HDMI-A1: SUCCESS (7.812s) [311.970226] Starting dynamic subtest: C-HDMI-A1 [319.773957] Dynamic subtest C-HDMI-A1: SUCCESS (7.815s) [319.791208] Starting dynamic subtest: D-HDMI-A1 [327.590521] Dynamic subtest D-HDMI-A1: SUCCESS (7.813s) [327.595750] Subtest plain-flip-fb-recreate: SUCCESS (31.284s) [327.773370] [095/156] (706s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [327.867931] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [327.869330] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [327.964779] [096/156] (705s left) i915_hangman (engine-error-state-capture) [328.006727] Starting subtest: engine-error-state-capture [328.007431] Starting dynamic subtest: rcs0 [331.856168] Dynamic subtest rcs0: SUCCESS (3.849s) [331.871491] Starting dynamic subtest: bcs0 [335.822025] Dynamic subtest bcs0: SUCCESS (3.964s) [335.836316] Starting dynamic subtest: vcs0 [339.855515] Dynamic subtest vcs0: SUCCESS (4.031s) [339.870328] Starting dynamic subtest: vcs1 [343.818472] Dynamic subtest vcs1: SUCCESS (3.961s) [343.831862] Starting dynamic subtest: vecs0 [347.858298] Dynamic subtest vecs0: SUCCESS (4.037s) [347.861431] Subtest engine-error-state-capture: SUCCESS (19.852s) [347.968793] [097/156] (686s left) kms_psr (psr2-suspend) [348.060113] Subtest psr2-suspend: SKIP (0.000s) [348.112109] [098/156] (685s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy) [348.204256] Starting subtest: fbchdr-modesetfrombusy [348.205644] Subtest fbchdr-modesetfrombusy: SKIP (0.000s) [348.299683] [099/156] (685s left) core_debugfs (read-all-entries) [348.336407] Starting subtest: read-all-entries [348.378343] Subtest read-all-entries: SUCCESS (0.042s) [348.496109] [100/156] (685s left) i915_drm_fdinfo (most-busy-idle-check-all) [348.533674] Starting subtest: most-busy-idle-check-all [348.534430] Starting dynamic subtest: rcs0 [349.175630] Dynamic subtest rcs0: SUCCESS (0.642s) [349.189030] Starting dynamic subtest: bcs0 [349.809964] Dynamic subtest bcs0: SUCCESS (0.629s) [349.820629] Starting dynamic subtest: vcs0 [350.441822] Dynamic subtest vcs0: SUCCESS (0.629s) [350.453485] Starting dynamic subtest: vcs1 [351.069592] Dynamic subtest vcs1: SUCCESS (0.626s) [351.080514] Starting dynamic subtest: vecs0 [351.694010] Dynamic subtest vecs0: SUCCESS (0.621s) [351.695091] Subtest most-busy-idle-check-all: SUCCESS (3.159s) [351.773290] [101/156] (682s left) gem_ringfill (basic-all) [351.998616] Starting subtest: basic-all [353.132585] Subtest basic-all: SUCCESS (1.126s) [353.262815] [102/156] (680s left) kms_invalid_mode (int-max-clock) [353.353023] Starting subtest: int-max-clock [353.353718] Starting dynamic subtest: pipe-A-HDMI-A-1 [353.404356] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.050s) [353.414996] Starting dynamic subtest: pipe-B-HDMI-A-1 [353.415739] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [353.424784] Starting dynamic subtest: pipe-C-HDMI-A-1 [353.425512] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [353.434463] Starting dynamic subtest: pipe-D-HDMI-A-1 [353.435174] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [353.435843] Subtest int-max-clock: SUCCESS (0.061s) [353.563725] [103/156] (680s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [353.656590] Starting subtest: 2x-cursor-vs-flip-atomic [353.659015] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s) [353.717924] [104/156] (680s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff) [353.809141] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff [353.810535] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [353.908293] [105/156] (680s left) syncobj_timeline (invalid-signal-illegal-point) [353.943356] Starting subtest: invalid-signal-illegal-point [353.944119] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [354.003598] [106/156] (680s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [354.090819] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s) [354.139569] [107/156] (680s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt) [354.231898] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt [354.233314] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [354.322442] [108/156] (680s left) gem_userptr_blits (stress-mm) [354.367669] Starting subtest: stress-mm [359.771270] Subtest stress-mm: SUCCESS (5.369s) [359.849124] [109/156] (674s left) gem_exercise_blt (fast-copy) [359.885670] Starting subtest: fast-copy [359.886400] Starting dynamic subtest: linear-smem-smem [359.906214] Dynamic subtest linear-smem-smem: SUCCESS (0.020s) [359.916266] Starting dynamic subtest: ymajor-smem-smem [359.923938] Dynamic subtest ymajor-smem-smem: SUCCESS (0.017s) [359.934056] Starting dynamic subtest: tile4-smem-smem [359.941239] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s) [359.951362] Starting dynamic subtest: tile64-smem-smem [359.958722] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s) [359.959498] Subtest fast-copy: SUCCESS (0.074s) [360.061609] [110/156] (674s left) kms_cursor_crc (cursor-onscreen-128x128) [360.154743] Starting subtest: cursor-onscreen-128x128 [360.159428] Starting dynamic subtest: pipe-A-HDMI-A-1 [361.334366] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.176s) [361.380807] Starting dynamic subtest: pipe-D-HDMI-A-1 [362.536657] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.163s) [362.537392] Subtest cursor-onscreen-128x128: SUCCESS (2.383s) [362.691218] [111/156] (671s left) prime_vgem (basic-gtt) [362.749242] Starting subtest: basic-gtt [362.761636] Subtest basic-gtt: SUCCESS (0.012s) [362.863632] [112/156] (671s left) i915_suspend (basic-s3-without-i915) [362.896658] Starting subtest: basic-s3-without-i915