[41.726967] Initializing watchdogs [41.727168] /dev/watchdog0 [41.740185] [001/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [41.855841] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [46.800301] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.949s) [46.889618] [002/133] (955s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [46.978346] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [46.982113] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [47.046611] [003/133] (955s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [47.120308] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [47.124905] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [47.193576] [004/133] (955s left) i915_pm_rc6_residency (media-rc6-accuracy) [47.259636] Starting subtest: media-rc6-accuracy [47.264540] Subtest media-rc6-accuracy: SKIP (0.000s) [47.334264] [005/133] (955s left) perf_pmu (init-wait) [47.393256] Starting subtest: init-wait [47.395838] Starting dynamic subtest: rcs0 [47.398442] Dynamic subtest rcs0: SUCCESS (0.002s) [47.411330] Starting dynamic subtest: bcs0 [47.413974] Dynamic subtest bcs0: SUCCESS (0.001s) [47.425119] Starting dynamic subtest: vcs0 [47.427688] Dynamic subtest vcs0: SUCCESS (0.001s) [47.438320] Starting dynamic subtest: vcs1 [47.441082] Dynamic subtest vcs1: SUCCESS (0.000s) [47.450431] Starting dynamic subtest: vecs0 [47.453043] Dynamic subtest vecs0: SUCCESS (0.000s) [47.461259] Starting dynamic subtest: ccs0 [47.463839] Dynamic subtest ccs0: SUCCESS (0.000s) [47.466425] Subtest init-wait: SUCCESS (0.005s) [47.487441] [006/133] (954s left) kms_pm_rpm (modeset-non-lpsp-stress) [49.622390] Starting subtest: modeset-non-lpsp-stress [52.999397] Subtest modeset-non-lpsp-stress: SKIP (3.374s) [53.814238] [007/133] (948s left) syncobj_timeline (host-signal-points) [53.890895] Starting subtest: host-signal-points [53.895851] Subtest host-signal-points: SUCCESS (0.006s) [53.964335] [008/133] (948s left) syncobj_eventfd (timeline-wait-before-signal) [54.035043] Starting subtest: timeline-wait-before-signal [54.065999] Subtest timeline-wait-before-signal: SUCCESS (0.031s) [54.129185] [009/133] (948s left) gem_exec_reloc (basic-wc-read) [54.212151] Subtest basic-wc-read: SKIP (0.000s) [54.261966] [010/133] (948s left) gem_softpin (full) [54.331801] Starting subtest: full [54.349399] Subtest full: SUCCESS (0.017s) [54.448231] [011/133] (948s left) sw_sync (sync_random_merge) [54.511486] Starting subtest: sync_random_merge [54.561741] Subtest sync_random_merge: SUCCESS (0.052s) [54.608813] [012/133] (947s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [54.700380] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [54.702718] Starting dynamic subtest: pipe-A-eDP-1 [54.709411] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [54.721368] Starting dynamic subtest: pipe-B-eDP-1 [54.728357] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [54.740064] Starting dynamic subtest: pipe-C-eDP-1 [54.746248] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [54.754926] Starting dynamic subtest: pipe-D-eDP-1 [54.761045] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [54.765092] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.002s) [54.783036] [013/133] (947s left) kms_psr (psr-sprite-mmap-cpu) [54.852738] Starting subtest: psr-sprite-mmap-cpu [54.854896] Starting dynamic subtest: eDP-1 [56.717066] Dynamic subtest eDP-1: SUCCESS (1.864s) [56.719662] Subtest psr-sprite-mmap-cpu: SUCCESS (1.865s) [57.610725] [014/133] (944s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [57.687747] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [57.690162] Starting dynamic subtest: pipe-A-eDP-1 [57.697873] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s) [57.703700] Starting dynamic subtest: pipe-B-eDP-1 [57.731497] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s) [57.739919] Starting dynamic subtest: pipe-C-eDP-1 [57.750835] Dynamic subtest pipe-C-eDP-1: SKIP (0.016s) [57.760174] Starting dynamic subtest: pipe-D-eDP-1 [57.767996] Dynamic subtest pipe-D-eDP-1: SKIP (0.016s) [57.772037] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.077s) [57.844467] [015/133] (944s left) kms_atomic_transition (modeset-transition-fencing) [57.933411] Starting subtest: modeset-transition-fencing [57.935736] Starting dynamic subtest: 1x-outputs [70.058999] Dynamic subtest 1x-outputs: SUCCESS (12.124s) [70.355927] Subtest modeset-transition-fencing: SUCCESS (12.422s) [71.252722] [016/133] (931s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [71.321761] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [71.324201] Starting dynamic subtest: pipe-A-default-mode [71.612830] Dynamic subtest pipe-A-default-mode: SKIP (0.288s) [71.617701] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.289s) [72.538893] [017/133] (930s left) gem_ctx_persistence (legacy-engines-hang) [72.618898] Starting subtest: legacy-engines-hang [72.621452] Starting dynamic subtest: render [72.719362] Dynamic subtest render: SUCCESS (0.100s) [72.732335] Starting dynamic subtest: bsd1 [72.803986] Dynamic subtest bsd1: SUCCESS (0.083s) [72.816508] Starting dynamic subtest: bsd2 [72.887759] Dynamic subtest bsd2: SUCCESS (0.083s) [72.903395] Starting dynamic subtest: blt [72.976071] Dynamic subtest blt: SUCCESS (0.087s) [72.991373] Starting dynamic subtest: vebox [73.061815] Dynamic subtest vebox: SUCCESS (0.085s) [73.064520] Subtest legacy-engines-hang: SUCCESS (0.443s) [73.132455] [018/133] (929s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [73.245379] Starting subtest: primary-yf-tiled-reflect-x-90 [73.249734] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.002s) [73.308466] [019/133] (929s left) gem_exec_flush (basic-wb-pro-default) [73.390438] Starting subtest: basic-wb-pro-default [78.867222] Subtest basic-wb-pro-default: SUCCESS (5.478s) [79.049279] [020/133] (923s left) gem_exec_balancer (noheartbeat) [79.328220] Starting subtest: noheartbeat [79.333573] Subtest noheartbeat: SKIP (0.000s) [79.395712] [021/133] (923s left) gem_readwrite (beyond-eob) [79.455751] Subtest beyond-EOB: SKIP (0.000s) [79.497398] [022/133] (923s left) gem_exec_flush (basic-batch-kernel-default-cmd) [79.587714] Starting subtest: basic-batch-kernel-default-cmd [79.592962] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s) [79.771959] [023/133] (923s left) perf (non-zero-reason) [79.942322] Starting subtest: non-zero-reason [79.944999] Starting dynamic subtest: 0-rcs0 [86.081327] Dynamic subtest 0-rcs0: SUCCESS (6.138s) [86.095883] Starting dynamic subtest: 1-vcs1 [90.402731] Dynamic subtest 1-vcs1: SUCCESS (4.321s) [90.406050] Subtest non-zero-reason: SUCCESS (10.460s) [90.436758] [024/133] (912s left) kms_psr2_sf (overlay-plane-move-continuous-exceed-sf) [95.702359] Starting subtest: overlay-plane-move-continuous-exceed-sf [95.704998] Starting dynamic subtest: psr2-pipe-A-eDP-1 [107.794141] Dynamic subtest psr2-pipe-A-eDP-1: SUCCESS (12.089s) [107.809454] Starting dynamic subtest: psr2-pipe-B-eDP-1 [119.908654] Dynamic subtest psr2-pipe-B-eDP-1: SUCCESS (12.113s) [119.911273] Subtest overlay-plane-move-continuous-exceed-sf: SUCCESS (24.207s) [120.844444] [025/133] (881s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [120.914779] Starting subtest: invalid-multi-wait-unsubmitted-submitted [120.917433] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [120.990125] [026/133] (881s left) kms_cursor_edge_walk (64x64-right-edge) [121.046845] Starting subtest: 64x64-right-edge [121.049231] Starting dynamic subtest: pipe-A-eDP-1 [124.607749] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.560s) [124.620595] Starting dynamic subtest: pipe-D-eDP-1 [127.856260] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.247s) [127.859059] Subtest 64x64-right-edge: SUCCESS (6.811s) [128.784991] [027/133] (874s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [128.856454] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [130.118682] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (1.113s) [130.141277] [028/133] (872s left) fbdev (nullptr) [130.205465] Starting subtest: nullptr [130.207623] Subtest nullptr: SUCCESS (0.000s) [130.266901] [029/133] (872s left) syncobj_timeline (wait-delayed-signal) [130.322557] Starting subtest: wait-delayed-signal [130.426053] Subtest wait-delayed-signal: SUCCESS (0.102s) [130.496348] [030/133] (872s left) kms_psr (fbc-psr2-dpms) [130.586167] Starting subtest: fbc-psr2-dpms [130.588443] Starting dynamic subtest: eDP-1 [130.592673] Dynamic subtest eDP-1: SKIP (0.000s) [130.596861] Subtest fbc-psr2-dpms: SKIP (0.001s) [130.645944] [031/133] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [130.731677] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [133.262478] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.536s) [133.369852] [032/133] (869s left) gem_exec_capture (capture) [133.460939] Starting subtest: capture [133.463310] Starting dynamic subtest: rcs0-smem [134.305784] Dynamic subtest rcs0-smem: SUCCESS (0.844s) [134.311902] Starting dynamic subtest: bcs0-smem [135.147059] Dynamic subtest bcs0-smem: SUCCESS (0.841s) [135.153278] Starting dynamic subtest: vcs0-smem [135.981973] Dynamic subtest vcs0-smem: SUCCESS (0.834s) [135.987408] Starting dynamic subtest: vcs1-smem [137.320511] Dynamic subtest vcs1-smem: SUCCESS (1.335s) [137.325840] Starting dynamic subtest: vecs0-smem [138.140085] Dynamic subtest vecs0-smem: SUCCESS (0.820s) [138.145716] Starting dynamic subtest: ccs0-smem [138.974212] Dynamic subtest ccs0-smem: SUCCESS (0.832s) [138.977100] Subtest capture: SUCCESS (5.509s) [139.084225] [033/133] (863s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [139.171708] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [144.121939] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.954s) [144.226464] [034/133] (858s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [144.319655] Starting subtest: 2x-wf_vblank-ts-check-interruptible [144.332305] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.013s) [144.401259] [035/133] (858s left) gem_exec_schedule (deep) [144.614337] Starting subtest: deep [144.616926] Starting dynamic subtest: rcs0 [149.141065] Dynamic subtest rcs0: SKIP (4.524s) [149.163061] Starting dynamic subtest: vcs0 [160.120807] Dynamic subtest vcs0: SUCCESS (10.981s) [160.137313] Starting dynamic subtest: vcs1 [171.863824] Dynamic subtest vcs1: SUCCESS (11.743s) [171.878695] Starting dynamic subtest: vecs0 [183.314278] Dynamic subtest vecs0: SUCCESS (11.450s) [183.328912] Starting dynamic subtest: ccs0 [194.134067] Dynamic subtest ccs0: SUCCESS (10.819s) [194.137049] Subtest deep: SUCCESS (49.519s) [195.235537] [036/133] (807s left) syncobj_wait (multi-wait-submitted-signaled) [195.318920] Starting subtest: multi-wait-submitted-signaled [195.321498] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [195.403232] [037/133] (807s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [198.051533] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s) [198.078144] [038/133] (805s left) syncobj_basic (bad-pad-fd-to-handle) [198.150228] Starting subtest: bad-pad-fd-to-handle [198.153447] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [198.238924] [039/133] (804s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [198.337988] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [199.412866] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.080s) [199.528865] [040/133] (803s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [199.662185] Starting subtest: 2x-long-cursor-vs-flip-legacy [199.666575] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.003s) [199.799936] [041/133] (803s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [200.176565] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [201.074215] [042/133] (802s left) sw_sync (sync_multi_consumer_producer) [201.115336] Starting subtest: sync_multi_consumer_producer [201.448845] Subtest sync_multi_consumer_producer: SUCCESS (0.335s) [201.502680] [043/133] (801s left) perf (gen8-unprivileged-single-ctx-counters) [201.585086] Starting subtest: gen8-unprivileged-single-ctx-counters [201.589867] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [201.616759] [044/133] (801s left) gem_mmap_gtt (flink-race) [201.694621] Subtest flink-race: SKIP (0.000s) [201.741030] [045/133] (801s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [201.863184] Starting subtest: cursor-vs-flip-atomic-transitions [231.258964] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.397s) [232.144129] [046/133] (771s left) kms_cursor_crc (cursor-onscreen-512x512) [232.400078] Starting subtest: cursor-onscreen-512x512 [232.405454] Subtest cursor-onscreen-512x512: SKIP (0.001s) [232.528914] [047/133] (770s left) api_intel_bb (lot-of-buffers) [232.596110] Starting subtest: lot-of-buffers [233.518477] Subtest lot-of-buffers: SUCCESS (0.924s) [233.956354] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1827 [max: 8192] direct dependencies: 18274 [max: 32768] indirect dependencies: 137729 all direct dependencies: 377729 dependency chains: 26876 [max: 131072] dependency chain hlocks used: 113090 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 300 in-softirq chains: 542 in-process chains: 26034 stack-trace entries: 173803 [max: 1048576] number of stack traces: 8735 number of stack hash chains: 6736 combined max dependencies: 4255238505 hardirq-safe locks: 110 hardirq-unsafe locks: 1073 softirq-safe locks: 197 softirq-unsafe locks: 985 irq-safe locks: 225 irq-unsafe locks: 1073 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 346 softirq-read-safe locks: 7 softirq-read-unsafe locks: 341 irq-read-safe locks: 7 irq-read-unsafe locks: 346 uncategorized locks: 293 unused locks: 1 max locking depth: 16 max bfs queue depth: 421 max lock class index: 1826 chain lookup misses: 27465 chain lookup hits: 243978011 cyclic checks: 27557 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4160 find-mask backwards checks: 2747 hardirq on events: 177838077 hardirq off events: 177838055 redundant hardirq ons: 32 redundant hardirq offs: 31 softirq on events: 442438 softirq off events: 442438 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 106 large chain blocks: 1 [233.959391] Closing watchdogs Done.