[46.209103] Initializing watchdogs [46.209175] /dev/watchdog0 [46.223639] [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] [46.228741] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [46.231065] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [46.232867] [001/130] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [46.405651] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [46.407144] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [46.526533] [002/130] (960s left) gem_exec_gttfill (engines) [46.576380] Starting subtest: engines [46.577146] Starting dynamic subtest: rcs0 [71.962892] Dynamic subtest rcs0: SUCCESS (25.212s) [71.967971] Starting dynamic subtest: bcs0 [97.537780] Dynamic subtest bcs0: SUCCESS (25.563s) [97.543085] Starting dynamic subtest: vcs0 [122.866690] Dynamic subtest vcs0: SUCCESS (25.325s) [122.872089] Starting dynamic subtest: vcs1 [148.348756] Dynamic subtest vcs1: SUCCESS (25.481s) [148.353781] Starting dynamic subtest: vecs0 [174.141854] Dynamic subtest vecs0: SUCCESS (25.796s) [174.142598] Subtest engines: SUCCESS (127.378s) [174.296588] [003/130] (832s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [174.430056] Starting subtest: switch-modeset-ultra-joiner-big-joiner [174.431491] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [174.492529] [004/130] (832s left) kms_psr (fbc-psr-cursor-plane-move) [174.583307] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s) [174.619288] [005/130] (832s left) gem_pxp (create-regular-context-1) [174.723427] Starting subtest: create-regular-context-1 [174.724260] Subtest create-regular-context-1: SUCCESS (0.000s) [174.824886] [006/130] (832s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [174.919712] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [174.921178] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [175.010018] [007/130] (832s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [175.099539] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [175.100974] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [175.267831] [008/130] (831s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [175.359576] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [175.360987] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [175.443699] [009/130] (831s left) kms_psr (psr-primary-mmap-cpu) [175.534360] Subtest psr-primary-mmap-cpu: SKIP (0.000s) [175.578972] [010/130] (831s left) gem_wait (busy) [175.630100] Starting subtest: busy [175.630936] Starting dynamic subtest: all-engines [176.164884] Dynamic subtest all-engines: SUCCESS (0.535s) [176.170336] Starting dynamic subtest: rcs0 [176.688300] Dynamic subtest rcs0: SUCCESS (0.523s) [176.693981] Starting dynamic subtest: bcs0 [177.207932] Dynamic subtest bcs0: SUCCESS (0.520s) [177.213228] Starting dynamic subtest: vcs0 [177.730128] Dynamic subtest vcs0: SUCCESS (0.522s) [177.735721] Starting dynamic subtest: vcs1 [178.252097] Dynamic subtest vcs1: SUCCESS (0.522s) [178.257379] Starting dynamic subtest: vecs0 [178.778221] Dynamic subtest vecs0: SUCCESS (0.526s) [178.779136] Subtest busy: SUCCESS (3.148s) [178.977991] [011/130] (828s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25) [179.069210] Starting subtest: planes-upscale-20x20-downscale-factor-0-25 [179.070063] Starting dynamic subtest: pipe-A [180.563261] Dynamic subtest pipe-A: SKIP (1.494s) [180.568617] Starting dynamic subtest: pipe-B [182.912168] Dynamic subtest pipe-B: SKIP (2.348s) [182.919083] Starting dynamic subtest: pipe-C [185.307495] Dynamic subtest pipe-C: SKIP (2.395s) [185.312866] Starting dynamic subtest: pipe-D [187.644400] Dynamic subtest pipe-D: SKIP (2.337s) [187.645792] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (8.576s) [187.737124] [012/130] (819s left) gem_exec_schedule (preempt-queue-contexts-chain) [187.811303] Starting subtest: preempt-queue-contexts-chain [187.812077] Starting dynamic subtest: rcs0 [188.146330] Dynamic subtest rcs0: SUCCESS (0.328s) [188.153031] Starting dynamic subtest: bcs0 [188.479304] Dynamic subtest bcs0: SUCCESS (0.332s) [188.485874] Starting dynamic subtest: vcs0 [188.788673] Dynamic subtest vcs0: SUCCESS (0.306s) [188.796412] Starting dynamic subtest: vcs1 [189.104103] Dynamic subtest vcs1: SUCCESS (0.313s) [189.120643] Starting dynamic subtest: vecs0 [189.422395] Dynamic subtest vecs0: SUCCESS (0.318s) [189.423162] Subtest preempt-queue-contexts-chain: SUCCESS (1.604s) [189.700165] [013/130] (817s left) gem_exec_suspend (basic) [189.747613] Starting subtest: basic [189.748391] Starting dynamic subtest: smem [190.153167] Dynamic subtest smem: SUCCESS (0.405s) [190.154046] Subtest basic: SUCCESS (0.406s) [190.330401] [014/130] (817s left) kms_pm_rpm (cursor-dpms) [191.752547] Starting subtest: cursor-dpms [203.583341] Subtest cursor-dpms: SUCCESS (11.822s) [203.749049] [015/130] (803s left) gem_lmem_swapping (verify-ccs) [203.794321] Subtest verify-ccs: SKIP (0.000s) [203.838673] [016/130] (803s left) perf_pmu (busy-idle-check-all) [203.877836] Starting subtest: busy-idle-check-all [203.878600] Starting dynamic subtest: rcs0 [204.498636] Dynamic subtest rcs0: SUCCESS (0.620s) [204.508506] Starting dynamic subtest: bcs0 [205.123447] Dynamic subtest bcs0: SUCCESS (0.623s) [205.133283] Starting dynamic subtest: vcs0 [205.756503] Dynamic subtest vcs0: SUCCESS (0.631s) [205.766029] Starting dynamic subtest: vcs1 [206.387315] Dynamic subtest vcs1: SUCCESS (0.629s) [206.396905] Starting dynamic subtest: vecs0 [207.018283] Dynamic subtest vecs0: SUCCESS (0.629s) [207.019293] Subtest busy-idle-check-all: SUCCESS (3.141s) [207.079675] [017/130] (800s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [207.175016] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [207.176466] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [207.277601] [018/130] (800s left) gem_exec_reloc (basic-active) [207.319921] Starting subtest: basic-active [207.320622] Starting dynamic subtest: all-engines [207.416250] Dynamic subtest all-engines: SUCCESS (0.096s) [207.424582] Starting dynamic subtest: rcs0 [207.472176] Dynamic subtest rcs0: SUCCESS (0.055s) [207.480440] Starting dynamic subtest: bcs0 [207.604197] Dynamic subtest bcs0: SUCCESS (0.122s) [207.611293] Starting dynamic subtest: vcs0 [207.647662] Dynamic subtest vcs0: SUCCESS (0.051s) [207.654647] Starting dynamic subtest: vcs1 [207.699168] Dynamic subtest vcs1: SUCCESS (0.051s) [207.705798] Starting dynamic subtest: vecs0 [207.749880] Dynamic subtest vecs0: SUCCESS (0.050s) [207.750661] Subtest basic-active: SUCCESS (0.431s) [207.858153] [019/130] (799s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [207.896416] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [207.897204] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s) [207.956515] [020/130] (799s left) gem_exec_reloc (basic-wc-noreloc) [207.997224] Starting subtest: basic-wc-noreloc [208.000250] Subtest basic-wc-noreloc: SUCCESS (0.003s) [208.107733] [021/130] (799s left) kms_addfb_basic (unused-modifier) [208.144525] Starting subtest: unused-modifier [208.145289] Subtest unused-modifier: SUCCESS (0.000s) [208.293348] [022/130] (799s left) kms_draw_crc (fill-fb) [208.385407] Starting subtest: fill-fb [208.644384] Subtest fill-fb: SUCCESS (0.258s) [208.767122] [023/130] (798s left) prime_self_import (basic-with_two_bos) [208.803127] Starting subtest: basic-with_two_bos [208.805805] Subtest basic-with_two_bos: SUCCESS (0.003s) [208.892298] [024/130] (798s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [208.989846] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [208.991290] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [209.075257] [025/130] (798s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [209.169084] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [210.419459] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (1.250s) [210.529033] [026/130] (797s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [210.623091] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [210.623797] Starting dynamic subtest: pipe-A-HDMI-A-1 [210.626491] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [210.632487] Starting dynamic subtest: pipe-B-HDMI-A-1 [210.635210] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [210.641040] Starting dynamic subtest: pipe-C-HDMI-A-1 [210.643774] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [210.649615] Starting dynamic subtest: pipe-D-HDMI-A-1 [210.652344] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [210.653705] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.007s) [210.866715] [027/130] (796s left) kms_addfb_basic (addfb25-x-tiled-legacy) [210.958060] Starting subtest: addfb25-x-tiled-legacy [210.958850] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [211.043816] [028/130] (796s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [211.138296] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [211.169163] [029/130] (796s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [211.258112] Starting subtest: primary-yf-tiled-reflect-x-180 [211.312613] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.054s) [211.394993] [030/130] (796s left) syncobj_timeline (invalid-signal-bad-pad) [211.432282] Starting subtest: invalid-signal-bad-pad [211.433024] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [211.495560] [031/130] (796s left) sysfs_heartbeat_interval (idempotent) [211.534142] Starting subtest: idempotent [211.536057] Starting dynamic subtest: vecs0 [211.536814] Dynamic subtest vecs0: SUCCESS (0.001s) [211.543367] Starting dynamic subtest: vcs0 [211.544092] Dynamic subtest vcs0: SUCCESS (0.001s) [211.550400] Starting dynamic subtest: bcs0 [211.551112] Dynamic subtest bcs0: SUCCESS (0.001s) [211.556612] Starting dynamic subtest: rcs0 [211.557321] Dynamic subtest rcs0: SUCCESS (0.001s) [211.562967] Starting dynamic subtest: vcs1 [211.563693] Dynamic subtest vcs1: SUCCESS (0.001s) [211.564378] Subtest idempotent: SUCCESS (0.010s) [211.644876] [032/130] (796s left) prime_busy (hang) [211.684107] Starting subtest: hang [211.684890] Starting dynamic subtest: rcs0 [225.947105] Dynamic subtest rcs0: SUCCESS (14.228s) [225.953041] Starting dynamic subtest: bcs0 [232.602549] Dynamic subtest bcs0: SUCCESS (6.654s) [232.608510] Starting dynamic subtest: vcs0 [239.642870] Dynamic subtest vcs0: SUCCESS (7.039s) [239.648718] Starting dynamic subtest: vcs1 [246.620152] Dynamic subtest vcs1: SUCCESS (6.975s) [246.626126] Starting dynamic subtest: vecs0 [253.595353] Dynamic subtest vecs0: SUCCESS (6.975s) [253.596378] Subtest hang: SUCCESS (41.875s) [253.666873] [033/130] (754s left) kms_feature_discovery (psr2) [253.759992] Starting subtest: psr2 [253.761472] Subtest psr2: SKIP (0.000s) [253.814679] [034/130] (754s left) kms_chamelium_hpd (vga-hpd-after-suspend) [253.967512] Subtest vga-hpd-after-suspend: SKIP (0.000s) [254.051350] [035/130] (754s left) kms_flip (bo-too-big) [254.146584] Starting subtest: bo-too-big [254.148537] Starting dynamic subtest: A-HDMI-A1 [254.991694] Dynamic subtest A-HDMI-A1: SUCCESS (0.843s) [255.002929] Starting dynamic subtest: B-HDMI-A1 [255.820643] Dynamic subtest B-HDMI-A1: SUCCESS (0.824s) [255.828682] Starting dynamic subtest: C-HDMI-A1 [256.660453] Dynamic subtest C-HDMI-A1: SUCCESS (0.834s) [256.666430] Starting dynamic subtest: D-HDMI-A1 [257.501964] Dynamic subtest D-HDMI-A1: SUCCESS (0.839s) [257.502712] Subtest bo-too-big: SUCCESS (3.353s) [257.762555] [036/130] (750s left) kms_psr (psr2-cursor-blt) [257.855874] Subtest psr2-cursor-blt: SKIP (0.000s) [257.897442] [037/130] (750s left) kms_prop_blob (blob-prop-lifetime) [257.935012] Starting subtest: blob-prop-lifetime [257.935788] Subtest blob-prop-lifetime: SUCCESS (0.000s) [257.992422] [038/130] (750s left) perf (unprivileged-single-ctx-counters) [258.077039] Starting subtest: unprivileged-single-ctx-counters [258.078439] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [258.110113] [039/130] (750s left) gem_exec_reloc (basic-cpu-gtt-active) [258.149892] Starting subtest: basic-cpu-gtt-active [258.280593] Subtest basic-cpu-gtt-active: SUCCESS (0.121s) [258.387329] [040/130] (749s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [258.479451] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [258.481671] Starting dynamic subtest: pipe-A-valid-mode [259.321564] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.841s) [259.322338] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.843s) [259.465793] [041/130] (748s left) syncobj_basic (bad-fd-to-handle) [259.503147] Starting subtest: bad-fd-to-handle [259.503861] Subtest bad-fd-to-handle: SUCCESS (0.000s) [259.559399] [042/130] (748s left) kms_hdr (static-swap) [259.649200] Starting subtest: static-swap [259.651488] Subtest static-swap: SKIP (0.000s) [259.708020] [043/130] (748s left) kms_dp_link_training (uhbr-mst) [259.796046] Starting subtest: uhbr-mst [259.797570] Subtest uhbr-mst: SKIP (0.000s) [259.849078] [044/130] (748s left) gem_exec_schedule (u-submit-early-slice) [259.900389] Starting subtest: u-submit-early-slice [259.901150] Starting dynamic subtest: rcs0 [259.929734] Dynamic subtest rcs0: SUCCESS (0.029s) [259.936170] Starting dynamic subtest: bcs0 [259.957602] Dynamic subtest bcs0: SUCCESS (0.027s) [259.963986] Starting dynamic subtest: vcs0 [259.988668] Dynamic subtest vcs0: SUCCESS (0.030s) [259.996738] Starting dynamic subtest: vcs1 [260.018901] Dynamic subtest vcs1: SUCCESS (0.029s) [260.025380] Starting dynamic subtest: vecs0 [260.046145] Dynamic subtest vecs0: SUCCESS (0.026s) [260.046900] Subtest u-submit-early-slice: SUCCESS (0.146s) [260.352244] [045/130] (748s left) kms_plane_multiple (tiling-x) [260.442985] Starting subtest: tiling-x [260.444884] Starting dynamic subtest: pipe-A-HDMI-A-1 [261.041083] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.596s) [261.048147] Starting dynamic subtest: pipe-B-HDMI-A-1 [261.608052] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.565s) [261.616208] Starting dynamic subtest: pipe-C-HDMI-A-1 [262.195727] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.587s) [262.203190] Starting dynamic subtest: pipe-D-HDMI-A-1 [262.795417] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.597s) [262.796204] Subtest tiling-x: SUCCESS (2.352s) [262.931205] [046/130] (745s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [263.033044] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [263.725155] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.691s) [263.874342] [047/130] (744s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [263.915802] Starting subtest: basic-gtt-cpu-noreloc [263.919128] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.003s) [264.032669] [048/130] (744s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [264.177365] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [264.266534] [049/130] (744s left) gem_exec_balancer (parallel-contexts) [264.439765] Subtest parallel-contexts: SKIP (0.000s) [264.504063] [050/130] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [264.597926] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [264.599342] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [264.688513] [051/130] (743s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [264.779120] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [264.780665] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [264.870286] [052/130] (743s left) gem_ctx_persistence (hostile) [264.912903] Starting subtest: hostile [275.330803] Subtest hostile: SUCCESS (10.408s) [275.440986] [053/130] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [275.535262] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [275.536698] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [275.632221] [054/130] (733s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [275.676271] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [275.677049] Starting dynamic subtest: smem [275.759528] Dynamic subtest smem: SUCCESS (0.083s) [275.760242] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (0.084s) [275.938129] [055/130] (732s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [276.031502] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [276.032930] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [276.113509] [056/130] (732s left) kms_cursor_edge_walk (128x128-top-bottom) [276.205570] Starting subtest: 128x128-top-bottom [276.206483] Starting dynamic subtest: pipe-A-HDMI-A-1 [277.965809] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.758s) [277.975423] Starting dynamic subtest: pipe-D-HDMI-A-1 [279.670524] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.703s) [279.671294] Subtest 128x128-top-bottom: SUCCESS (3.465s) [279.769559] [057/130] (729s left) kms_chamelium_color (ctm-limited-range) [279.868378] Subtest ctm-limited-range: SKIP (0.000s) [279.905610] [058/130] (728s left) gem_exec_big (single) [279.945468] Starting subtest: single [283.214031] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2187 [max: 8192] direct dependencies: 23432 [max: 524288] indirect dependencies: 176352 all direct dependencies: 500899 dependency chains: 33394 [max: 524288] dependency chain hlocks used: 136375 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 307 in-softirq chains: 948 in-process chains: 32139 stack-trace entries: 244657 [max: 524288] number of stack traces: 11455 number of stack hash chains: 8268 combined max dependencies: 804330288 hardirq-safe locks: 104 hardirq-unsafe locks: 1301 softirq-safe locks: 253 softirq-unsafe locks: 1191 irq-safe locks: 263 irq-unsafe locks: 1301 hardirq-read-safe locks: 5 hardirq-read-unsafe locks: 410 softirq-read-safe locks: 10 softirq-read-unsafe locks: 405 irq-read-safe locks: 10 irq-read-unsafe locks: 410 uncategorized locks: 350 unused locks: 1 max locking depth: 16 max bfs queue depth: 370 max lock class index: 2186 debug_locks: 0 zapped classes: 3 zapped lock chains: 159 large chain blocks: 1 [283.225256] [FACT gem_exec_big (single)] new: kernel.is_tainted.taint_die: true [283.226972] Closing watchdogs Done.