[31.562363] Initializing watchdogs [31.562421] /dev/watchdog0 [31.567012] [001/137] (960s left) kms_cursor_crc (cursor-rapid-movement-512x170) [31.682504] Starting subtest: cursor-rapid-movement-512x170 [31.685420] Subtest cursor-rapid-movement-512x170: SKIP (0.003s) [31.743445] [002/137] (960s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs_cc) [32.121011] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs_cc [32.122487] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [32.252825] [003/137] (959s left) kms_ccs (pipe-d-bad-aux-stride-y_tiled_gen12_mc_ccs) [32.693844] Starting subtest: pipe-D-bad-aux-stride-y_tiled_gen12_mc_ccs [32.695225] Subtest pipe-D-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s) [32.778390] [004/137] (959s left) gem_softpin (allocator-fork) [32.829977] Starting subtest: allocator-fork [35.052818] Subtest allocator-fork: SUCCESS (2.214s) [35.120720] [005/137] (956s left) i915_fb_tiling [35.231686] [006/137] (956s left) syncobj_wait (multi-wait-all-submitted) [35.291475] Starting subtest: multi-wait-all-submitted [35.396677] Subtest multi-wait-all-submitted: SUCCESS (0.105s) [35.436566] [007/137] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [35.552123] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [35.553626] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [35.612329] [008/137] (956s left) gem_mmap_gtt (ptrace) [35.658660] Starting subtest: ptrace [35.768498] Subtest ptrace: SUCCESS (0.109s) [35.815721] [009/137] (956s left) gem_exec_whisper (basic-contexts-priority) [35.879152] Starting subtest: basic-contexts-priority [40.395395] Subtest basic-contexts-priority: SUCCESS (4.507s) [40.540107] [010/137] (951s left) gem_ctx_persistence (heartbeat-many) [40.601656] Starting subtest: heartbeat-many [40.931032] Subtest heartbeat-many: SUCCESS (0.329s) [40.980546] [011/137] (951s left) kms_busy (extended-pageflip-hang-oldfb) [41.086753] Starting subtest: extended-pageflip-hang-oldfb [41.088175] Starting dynamic subtest: pipe-A [41.284602] Dynamic subtest pipe-A: SUCCESS (0.197s) [41.298344] Starting dynamic subtest: pipe-D [41.428620] Dynamic subtest pipe-D: SUCCESS (0.133s) [41.429424] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.342s) [41.547893] [012/137] (950s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [41.646652] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [41.648095] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [41.696661] [013/137] (950s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [41.798954] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [41.800451] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [41.854882] [014/137] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [41.955488] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [41.956877] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [42.004624] [015/137] (950s left) kms_lease (lease_unleased_connector) [42.101094] Starting subtest: lease_unleased_connector [42.101821] Starting dynamic subtest: pipe-A-HDMI-A-1 [42.163580] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.061s) [42.169526] Starting dynamic subtest: pipe-B-HDMI-A-1 [42.225092] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.061s) [42.231028] Starting dynamic subtest: pipe-C-HDMI-A-1 [42.287146] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.061s) [42.294682] Starting dynamic subtest: pipe-D-HDMI-A-1 [42.349139] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.061s) [42.349909] Subtest lease_unleased_connector: SUCCESS (0.248s) [42.381204] [016/137] (949s left) gem_exec_params (invalid-flag) [42.432692] Starting subtest: invalid-flag [42.433601] Subtest invalid-flag: SUCCESS (0.000s) [42.481237] [017/137] (949s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_mc_ccs) [42.778563] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs [42.780048] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s) [42.989041] [018/137] (949s left) kms_vblank (pipe-a-ts-continuation-modeset-hang) [43.084398] Starting subtest: pipe-A-ts-continuation-modeset-hang [56.802575] Subtest pipe-A-ts-continuation-modeset-hang: SUCCESS (13.718s) [56.911336] [019/137] (935s left) kms_chamelium_edid (hdmi-edid-read) [57.065345] Subtest hdmi-edid-read: SKIP (0.000s) [57.117866] [020/137] (935s left) kms_psr (psr2_suspend) [57.166555] Subtest psr2_suspend: SKIP (0.000s) [57.183088] [021/137] (935s left) gem_tiled_swapping (non-threaded) [59.492189] Starting subtest: non-threaded [65.867942] Subtest non-threaded: SUCCESS (6.372s) [66.831062] [022/137] (925s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [67.018492] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [67.020143] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [67.072516] [023/137] (925s left) gem_exec_flush (basic-wb-prw-default) [67.127771] Starting subtest: basic-wb-prw-default [72.542279] Subtest basic-wb-prw-default: SUCCESS (5.414s) [72.709309] [024/137] (919s left) kms_plane_multiple (tiling-4) [72.825170] Starting subtest: tiling-4 [72.826697] Subtest tiling-4: SKIP (0.000s) [72.859271] [025/137] (919s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [72.959846] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [72.961270] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [73.017086] [026/137] (919s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs) [73.366095] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs [74.191982] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.825s) [74.389567] [027/137] (918s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc) [74.640476] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc [74.641290] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.000s) [74.890645] [028/137] (917s left) gem_exec_balancer (hog) [74.943330] Starting subtest: hog [75.828702] Subtest hog: SUCCESS (0.885s) [76.058822] [029/137] (916s left) kms_flip (2x-plain-flip-ts-check) [76.148457] Starting subtest: 2x-plain-flip-ts-check [76.160560] Subtest 2x-plain-flip-ts-check: SKIP (0.013s) [76.199363] [030/137] (916s left) kms_vblank (pipe-a-query-forked-busy) [76.296793] Starting subtest: pipe-A-query-forked-busy [77.562120] Subtest pipe-A-query-forked-busy: SUCCESS (1.265s) [77.654045] [031/137] (914s left) i915_query (engine-info-invalid) [77.701446] Starting subtest: engine-info-invalid [77.702176] Subtest engine-info-invalid: SUCCESS (0.000s) [77.738447] [032/137] (914s left) kms_addfb_basic (addfb25-modifier-no-flag) [77.787409] Starting subtest: addfb25-modifier-no-flag [77.788107] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [77.895528] [033/137] (914s left) kms_flip (nonexisting-fb) [77.975138] Starting subtest: nonexisting-fb [77.977612] Starting dynamic subtest: A-HDMI-A1 [78.215140] Dynamic subtest A-HDMI-A1: SUCCESS (0.237s) [78.220413] Starting dynamic subtest: B-HDMI-A1 [78.342308] Dynamic subtest B-HDMI-A1: SUCCESS (0.127s) [78.346946] Starting dynamic subtest: C-HDMI-A1 [78.478794] Dynamic subtest C-HDMI-A1: SUCCESS (0.136s) [78.484576] Starting dynamic subtest: D-HDMI-A1 [78.606596] Dynamic subtest D-HDMI-A1: SUCCESS (0.127s) [78.608797] Subtest nonexisting-fb: SUCCESS (0.634s) [78.719467] [034/137] (913s left) gem_exec_reloc (basic-cpu-wc-noreloc) [78.769817] Starting subtest: basic-cpu-wc-noreloc [78.772197] Subtest basic-cpu-wc-noreloc: SUCCESS (0.002s) [78.860199] [035/137] (913s left) gem_exec_gttfill (multigpu-basic) [79.018073] Starting subtest: multigpu-basic [79.019624] Subtest multigpu-basic: SKIP (0.000s) [79.052263] [036/137] (913s left) kms_cursor_crc (cursor-rapid-movement-32x32) [79.151320] Starting subtest: cursor-rapid-movement-32x32 [79.194416] Subtest cursor-rapid-movement-32x32: SKIP (0.041s) [79.252524] [037/137] (913s left) kms_big_fb (x-tiled-addfb-size-offset-overflow) [79.356309] Starting subtest: x-tiled-addfb-size-offset-overflow [79.357129] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [79.409974] [038/137] (913s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [79.513015] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [79.514459] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [79.568858] [039/137] (913s left) gem_lmem_swapping (random) [79.625795] Subtest random: SKIP (0.000s) [79.644783] [040/137] (912s left) gem_exec_schedule (preempt-engines) [79.702587] Starting subtest: preempt-engines [79.703352] Starting dynamic subtest: rcs0 [79.763928] Dynamic subtest rcs0: SUCCESS (0.061s) [79.769020] Starting dynamic subtest: bcs0 [79.824820] Dynamic subtest bcs0: SUCCESS (0.061s) [79.831391] Starting dynamic subtest: vcs0 [79.888177] Dynamic subtest vcs0: SUCCESS (0.063s) [79.893473] Starting dynamic subtest: vcs1 [79.948914] Dynamic subtest vcs1: SUCCESS (0.061s) [79.954242] Starting dynamic subtest: vecs0 [80.016455] Dynamic subtest vecs0: SUCCESS (0.067s) [80.017312] Subtest preempt-engines: SUCCESS (0.314s) [80.280494] [041/137] (912s left) kms_big_fb (x-tiled-16bpp-rotate-180) [80.392048] Starting subtest: x-tiled-16bpp-rotate-180 [81.415092] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.023s) [81.530154] [042/137] (911s left) gem_userptr_blits (sync-overlap) [81.593639] Starting subtest: sync-overlap [81.594492] Subtest sync-overlap: SUCCESS (0.000s) [81.678139] [043/137] (910s left) perf (gen12-group-exclusive-stream-ctx-handle) [81.786493] Starting subtest: gen12-group-exclusive-stream-ctx-handle [81.795865] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.010s) [81.808165] [044/137] (910s left) vc4/vc4_tiling (get-bad-modifier) [81.873189] Subtest get-bad-modifier: SKIP (0.000s) [81.902367] [045/137] (910s left) gem_ctx_persistence (legacy-engines-queued) [81.958483] Starting subtest: legacy-engines-queued [81.959217] Starting dynamic subtest: render [81.998813] Dynamic subtest render: SUCCESS (0.039s) [82.009647] Starting dynamic subtest: bsd1 [82.040618] Dynamic subtest bsd1: SUCCESS (0.041s) [82.048888] Starting dynamic subtest: bsd2 [82.080683] Dynamic subtest bsd2: SUCCESS (0.039s) [82.095263] Starting dynamic subtest: blt [82.126604] Dynamic subtest blt: SUCCESS (0.045s) [82.138108] Starting dynamic subtest: vebox [82.164543] Dynamic subtest vebox: SUCCESS (0.037s) [82.165775] Subtest legacy-engines-queued: SUCCESS (0.206s) [82.207039] [046/137] (910s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [82.313429] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [82.315090] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [82.352779] [047/137] (910s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [82.449671] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [82.451419] Starting dynamic subtest: pipe-A-valid-mode [83.382062] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.931s) [83.382758] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SUCCESS (0.932s) [83.479475] [048/137] (909s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted) [83.527999] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted [83.528837] Subtest invalid-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.000s) [83.563146] [049/137] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [83.662707] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [84.700577] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.039s) [84.791973] [050/137] (907s left) gem_pxp (create-regular-context-2) [87.372270] Subtest create-regular-context-2: SKIP (0.000s) [87.401523] [051/137] (905s left) gem_exec_reloc (basic-gtt-active) [87.453304] Starting subtest: basic-gtt-active [87.572082] Subtest basic-gtt-active: SUCCESS (0.118s) [87.664252] [052/137] (905s left) api_intel_bb (lot-of-buffers) [87.713335] Starting subtest: lot-of-buffers [88.362130] Subtest lot-of-buffers: SUCCESS (0.649s) [88.435852] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1767 [max: 8192] direct dependencies: 16652 [max: 32768] indirect dependencies: 131512 all direct dependencies: 364004 dependency chains: 23431 [max: 131072] dependency chain hlocks used: 95309 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 267 in-softirq chains: 626 in-process chains: 22538 stack-trace entries: 152407 [max: 1048576] number of stack traces: 7992 number of stack hash chains: 6314 combined max dependencies: 3787363404 hardirq-safe locks: 105 hardirq-unsafe locks: 1059 softirq-safe locks: 208 softirq-unsafe locks: 971 irq-safe locks: 223 irq-unsafe locks: 1059 hardirq-read-safe locks: 4 hardirq-read-unsafe locks: 314 softirq-read-safe locks: 8 softirq-read-unsafe locks: 309 irq-read-safe locks: 8 irq-read-unsafe locks: 314 uncategorized locks: 284 unused locks: 1 max locking depth: 15 max bfs queue depth: 379 max lock class index: 1766 chain lookup misses: 23715 chain lookup hits: 173527037 cyclic checks: 23510 redundant checks: 0 redundant links: 0 find-mask forwards checks: 3782 find-mask backwards checks: 2655 hardirq on events: 105064547 hardirq off events: 105064539 redundant hardirq ons: 10992 redundant hardirq offs: 13 softirq on events: 1082659 softirq off events: 1082659 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 116 large chain blocks: 1 [88.440237] Closing watchdogs Done.