[35.019965] Initializing watchdogs [35.020072] /dev/watchdog0 [35.026262] [001/138] (960s left) syncobj_timeline (wait-for-submit-complex) [35.077977] Starting subtest: wait-for-submit-complex [35.140660] Subtest wait-for-submit-complex: SUCCESS (0.062s) [35.232615] [002/138] (960s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [37.203823] Starting subtest: yf-tiled-16bpp-rotate-0 [37.205906] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [37.288889] [003/138] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [39.323699] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [41.923673] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (2.607s) [42.076662] [004/138] (953s left) gem_exec_alignment (single) [42.142394] Starting subtest: single [42.147434] Subtest single: SUCCESS (0.005s) [42.239167] [005/138] (953s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [44.265378] Starting subtest: pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs-cc [44.267128] Subtest pipe-A-crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [44.420883] [006/138] (951s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [46.375050] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [46.376572] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [46.458190] [007/138] (949s left) kms_frontbuffer_tracking (fbc-2p-rte) [48.483875] Starting subtest: fbc-2p-rte [48.485354] Subtest fbc-2p-rte: SKIP (0.000s) [48.554907] [008/138] (947s left) gem_ctx_sseu (engines) [48.677806] Subtest engines: SKIP (0.000s) [48.698436] [009/138] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [50.653925] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [50.655531] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [50.740686] [010/138] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [52.775139] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [52.778489] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [52.864585] [011/138] (942s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt) [54.875465] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt [54.877135] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [54.938912] [012/138] (940s left) kms_ccs (pipe-a-bad-aux-stride-y-tiled-gen12-rc-ccs) [56.993198] Starting subtest: pipe-A-bad-aux-stride-y-tiled-gen12-rc-ccs [56.995049] Subtest pipe-A-bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.000s) [57.137149] [013/138] (938s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [59.131058] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [59.184886] [014/138] (936s left) kms_chamelium_color (degamma) [61.134452] Subtest degamma: SKIP (0.000s) [61.149298] [015/138] (934s left) sw_sync (sync_busy) [61.189401] Starting subtest: sync_busy [61.191216] Subtest sync_busy: SUCCESS (0.001s) [61.221642] [016/138] (934s left) kms_color (ctm-green-to-red) [63.185945] Starting subtest: ctm-green-to-red [63.186855] Starting dynamic subtest: pipe-A [63.798984] Dynamic subtest pipe-A: SUCCESS (0.612s) [63.803487] Starting dynamic subtest: pipe-B [64.229500] Dynamic subtest pipe-B: SUCCESS (0.431s) [64.234144] Starting dynamic subtest: pipe-C [64.665232] Dynamic subtest pipe-C: SUCCESS (0.435s) [64.669691] Starting dynamic subtest: pipe-D [65.119063] Dynamic subtest pipe-D: SUCCESS (0.454s) [65.119927] Subtest ctm-green-to-red: SUCCESS (1.933s) [65.256551] [017/138] (930s left) syncobj_wait (multi-wait-all-submitted) [65.325970] Starting subtest: multi-wait-all-submitted [65.434039] Subtest multi-wait-all-submitted: SUCCESS (0.108s) [65.488944] [018/138] (930s left) gem_exec_schedule (noreorder) [65.666176] Starting subtest: noreorder [65.667498] Starting dynamic subtest: rcs0 [65.720192] Dynamic subtest rcs0: SUCCESS (0.060s) [65.725155] Starting dynamic subtest: bcs0 [65.778576] Dynamic subtest bcs0: SUCCESS (0.058s) [65.785154] Starting dynamic subtest: vcs0 [65.836256] Dynamic subtest vcs0: SUCCESS (0.058s) [65.844020] Starting dynamic subtest: vcs1 [65.861505] Dynamic subtest vcs1: SUCCESS (0.025s) [65.869527] Starting dynamic subtest: vecs0 [65.913564] Dynamic subtest vecs0: SUCCESS (0.052s) [65.921155] Starting dynamic subtest: vecs1 [65.946360] Dynamic subtest vecs1: SUCCESS (0.033s) [65.954614] Starting dynamic subtest: ccs0 [66.001737] Dynamic subtest ccs0: SUCCESS (0.055s) [66.010477] Starting dynamic subtest: ccs1 [66.066796] Dynamic subtest ccs1: SUCCESS (0.063s) [66.085708] Starting dynamic subtest: ccs2 [66.137803] Dynamic subtest ccs2: SUCCESS (0.072s) [66.152044] Starting dynamic subtest: ccs3 [66.213248] Dynamic subtest ccs3: SUCCESS (0.075s) [66.215112] Subtest noreorder: SUCCESS (0.553s) [66.426835] [019/138] (929s left) gem_partial_pwrite_pread (reads-uncached) [66.474684] Subtest reads-uncached: SKIP (0.000s) [66.532292] [020/138] (929s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc) [68.594978] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc [68.596900] Subtest pipe-B-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [68.728335] [021/138] (927s left) v3d/v3d_submit_cl (multi-and-single-sync) [68.816505] Subtest multi-and-single-sync: SKIP (0.000s) [68.888411] [022/138] (927s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [70.874311] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [81.837436] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.964s) [81.971360] [023/138] (913s left) gem_exec_reloc (basic-write-read) [82.061347] Subtest basic-write-read: SKIP (0.000s) [82.112917] [024/138] (913s left) kms_vrr (flip-dpms) [84.054428] Starting subtest: flip-dpms [84.056236] Subtest flip-dpms: SKIP (0.000s) [84.147428] [025/138] (911s left) v3d/v3d_submit_csd (bad-perfmon) [84.288678] Subtest bad-perfmon: SKIP (0.000s) [84.345253] [026/138] (911s left) perf_pmu (busy-double-start) [84.418341] Starting subtest: busy-double-start [84.419154] Starting dynamic subtest: rcs0 [88.026270] Dynamic subtest rcs0: SUCCESS (3.607s) [88.035922] Starting dynamic subtest: bcs0 [91.595078] Dynamic subtest bcs0: SUCCESS (3.567s) [91.604189] Starting dynamic subtest: vcs0 [95.186652] Dynamic subtest vcs0: FAIL (3.573s) [95.196424] Starting dynamic subtest: vcs1 [98.756191] Dynamic subtest vcs1: FAIL (3.560s) [98.763531] Starting dynamic subtest: vecs0 [102.317280] Dynamic subtest vecs0: FAIL (3.560s) [102.324686] Starting dynamic subtest: vecs1 [105.877796] Dynamic subtest vecs1: FAIL (3.561s) [105.885210] Starting dynamic subtest: ccs0 [109.417193] Dynamic subtest ccs0: SUCCESS (3.565s) [109.426265] Starting dynamic subtest: ccs1 [113.002147] Dynamic subtest ccs1: SUCCESS (3.583s) [113.011234] Starting dynamic subtest: ccs2 [116.586065] Dynamic subtest ccs2: SUCCESS (3.582s) [116.595392] Starting dynamic subtest: ccs3 [120.172404] Dynamic subtest ccs3: SUCCESS (3.585s) [120.174380] Subtest busy-double-start: FAIL (35.754s) [120.238512] [027/138] (875s left) gem_mmap_gtt (close-race) [120.285390] Subtest close-race: SKIP (0.000s) [120.311904] [028/138] (875s left) gem_pxp (protected-encrypted-src-copy-not-readible) [122.918033] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s) [122.943291] [029/138] (873s left) kms_ccs (pipe-c-bad-aux-stride-y-tiled-ccs) [124.979020] Starting subtest: pipe-C-bad-aux-stride-y-tiled-ccs [124.980734] Subtest pipe-C-bad-aux-stride-y-tiled-ccs: SKIP (0.000s) [125.088432] [030/138] (870s left) gem_exec_suspend (basic-s3-devices) [125.162524] Starting subtest: basic-S3-devices [125.163583] Starting dynamic subtest: smem [134.714101] Dynamic subtest smem: SUCCESS (9.553s) [134.732795] Starting dynamic subtest: lmem0 [143.997041] Dynamic subtest lmem0: SUCCESS (9.282s) [143.998577] Subtest basic-S3-devices: SUCCESS (18.837s) [148.177803] [031/138] (851s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc) [150.167936] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc [150.169741] Subtest pipe-A-missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [150.319035] [032/138] (849s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [152.273167] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [152.274859] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [152.337207] [033/138] (847s left) drm_fdinfo (virtual-busy-hang) [152.460659] Starting subtest: virtual-busy-hang [152.463194] Subtest virtual-busy-hang: SKIP (0.000s) [152.532517] [034/138] (847s left) gen9_exec_parse (cmd-crossing-page) [152.608596] Subtest cmd-crossing-page: SKIP (0.000s) [152.637382] [035/138] (847s left) syncobj_wait (invalid-reset-zero-handles) [152.708950] Starting subtest: invalid-reset-zero-handles [152.709917] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [152.775032] [036/138] (847s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [154.746255] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [154.747923] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [154.822609] [037/138] (845s left) gem_softpin (allocator-nopin) [154.946585] Starting subtest: allocator-nopin [155.122253] Subtest allocator-nopin: SUCCESS (0.167s) [155.235015] [038/138] (845s left) gem_eio (wait-10ms) [155.481396] Starting subtest: wait-10ms [156.057961] Subtest wait-10ms: SUCCESS (0.577s) [158.023485] [039/138] (842s left) syncobj_timeline (invalid-query-bad-pad) [158.139930] Starting subtest: invalid-query-bad-pad [158.141408] Subtest invalid-query-bad-pad: SUCCESS (0.000s) [158.231666] [040/138] (842s left) perf (stress-open-close) [158.597213] Starting subtest: stress-open-close [158.598035] Starting dynamic subtest: 0-rcs0 [160.795332] Dynamic subtest 0-rcs0: SUCCESS (2.199s) [160.796202] Subtest stress-open-close: SUCCESS (2.199s) [160.816500] [041/138] (839s left) gem_exec_fair (basic-pace) [160.867401] Subtest basic-pace: SKIP (0.000s) [160.895357] [042/138] (839s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [162.844919] Starting subtest: yf-tiled-8bpp-rotate-180 [162.846992] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [162.923246] [043/138] (837s left) kms_ccs (pipe-d-missing-ccs-buffer-y-tiled-ccs) [165.043037] Starting subtest: pipe-D-missing-ccs-buffer-y-tiled-ccs [165.044775] Subtest pipe-D-missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s) [165.138466] [044/138] (835s left) gem_set_tiling_vs_blt (untiled-to-tiled) [165.205107] Subtest untiled-to-tiled: SKIP (0.000s) [165.235964] [045/138] (835s left) fbdev (write) [165.307693] Starting subtest: write [166.773502] Subtest write: SUCCESS (1.457s) [166.805316] [046/138] (833s left) kms_psr (psr2_cursor_blt) [166.848146] Subtest psr2_cursor_blt: SKIP (0.000s) [166.865782] [047/138] (833s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [168.810055] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [169.991722] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.181s) [170.092416] [048/138] (830s left) kms_plane (plane-panning-bottom-right) [172.036489] Starting subtest: plane-panning-bottom-right [172.037391] Starting dynamic subtest: pipe-A [172.635993] Dynamic subtest pipe-A: SUCCESS (0.599s) [172.643911] Starting dynamic subtest: pipe-B [173.083059] Dynamic subtest pipe-B: SUCCESS (0.445s) [173.084215] Subtest plane-panning-bottom-right: SUCCESS (1.047s) [173.220764] [049/138] (827s left) kms_cursor_crc (cursor-random-128x128) [175.274551] Starting subtest: cursor-random-128x128 [175.278941] Starting dynamic subtest: pipe-A-HDMI-A-3 [179.676533] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.397s) [179.710991] Starting dynamic subtest: pipe-D-HDMI-A-3 [184.026369] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.321s) [184.027168] Subtest cursor-random-128x128: SUCCESS (8.751s) [184.289349] [050/138] (816s left) api_intel_bb (lot-of-buffers) [184.340696] Starting subtest: lot-of-buffers [185.901103] Subtest lot-of-buffers: SUCCESS (1.555s) [186.029434] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1804 [max: 8192] direct dependencies: 17618 [max: 32768] indirect dependencies: 134433 all direct dependencies: 377336 dependency chains: 25837 [max: 131072] dependency chain hlocks used: 113247 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 257 in-softirq chains: 686 in-process chains: 24894 stack-trace entries: 167687 [max: 1048576] number of stack traces: 8489 number of stack hash chains: 6639 combined max dependencies: 117571874 hardirq-safe locks: 105 hardirq-unsafe locks: 1077 softirq-safe locks: 212 softirq-unsafe locks: 990 irq-safe locks: 229 irq-unsafe locks: 1077 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 311 softirq-read-safe locks: 7 softirq-read-unsafe locks: 306 irq-read-safe locks: 7 irq-read-unsafe locks: 311 uncategorized locks: 296 unused locks: 1 max locking depth: 18 max bfs queue depth: 395 max lock class index: 1803 chain lookup misses: 26053 chain lookup hits: 144121269 cyclic checks: 26099 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4350 find-mask backwards checks: 2686 hardirq on events: 70458810 hardirq off events: 70458804 redundant hardirq ons: 56 redundant hardirq offs: 15 softirq on events: 208628 softirq off events: 208628 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 111 large chain blocks: 1 [186.031463] Closing watchdogs Done.