[44.196500] Initializing watchdogs [44.196566] /dev/watchdog0 [44.202476] [001/142] (960s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [44.342165] Starting subtest: short-busy-flip-before-cursor-toggle [44.344095] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [44.398347] [002/142] (960s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs) [44.683976] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs [44.685709] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s) [44.874482] [003/142] (959s left) gem_softpin (reverse) [44.949237] Starting subtest: reverse [44.960172] Subtest reverse: SUCCESS (0.011s) [45.059992] [004/142] (959s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs) [45.316108] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs [45.317059] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs: SUCCESS (0.000s) [45.555167] [005/142] (959s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [45.613545] Starting subtest: etime-single-wait-for-submit-submitted [45.715860] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.101s) [45.801084] [006/142] (958s left) kms_selftest (drm_format) [45.895103] Starting subtest: drm_format [45.896941] Subtest drm_format: SKIP (0.001s) [45.939209] [007/142] (958s left) syncobj_timeline (invalid-signal-zero-handles) [46.009246] Starting subtest: invalid-signal-zero-handles [46.010231] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [46.072344] [008/142] (958s left) gem_ctx_isolation (nonpriv-switch) [46.138948] Starting subtest: nonpriv-switch [46.139897] Starting dynamic subtest: rcs0 [46.819931] Dynamic subtest rcs0: SUCCESS (0.681s) [46.824886] Starting dynamic subtest: bcs0 [47.573377] Dynamic subtest bcs0: SUCCESS (0.753s) [47.578178] Starting dynamic subtest: vcs0 [48.330500] Dynamic subtest vcs0: SUCCESS (0.757s) [48.335382] Starting dynamic subtest: vcs1 [49.075384] Dynamic subtest vcs1: SUCCESS (0.745s) [49.080183] Starting dynamic subtest: vecs0 [49.817523] Dynamic subtest vecs0: SUCCESS (0.742s) [49.822215] Starting dynamic subtest: vecs1 [50.548443] Dynamic subtest vecs1: SUCCESS (0.731s) [50.553145] Starting dynamic subtest: ccs0 [51.297427] Dynamic subtest ccs0: SUCCESS (0.749s) [51.302227] Starting dynamic subtest: ccs1 [52.057664] Dynamic subtest ccs1: SUCCESS (0.760s) [52.062353] Starting dynamic subtest: ccs2 [52.818830] Dynamic subtest ccs2: SUCCESS (0.761s) [52.823582] Starting dynamic subtest: ccs3 [53.577735] Dynamic subtest ccs3: SUCCESS (0.759s) [53.578758] Subtest nonpriv-switch: SUCCESS (7.439s) [53.823492] [009/142] (950s left) kms_addfb_basic (legacy-format) [53.898791] Starting subtest: legacy-format [53.944862] Subtest legacy-format: SUCCESS (0.031s) [54.072298] [010/142] (950s left) api_intel_allocator (open-vm) [54.131782] Starting subtest: open-vm [54.151956] Subtest open-vm: SUCCESS (0.020s) [54.255030] [011/142] (950s left) vc4/vc4_tiling (set-bad-handle) [54.344254] Subtest set-bad-handle: SKIP (0.000s) [54.388737] [012/142] (950s left) gem_exec_reloc (basic-wc-active) [54.451496] Subtest basic-wc-active: SKIP (0.000s) [54.483413] [013/142] (950s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-75) [54.615554] Starting subtest: plane-downscale-with-rotation-factor-0-75 [54.616517] Starting dynamic subtest: pipe-A-DP-2 [55.026508] Dynamic subtest pipe-A-DP-2: SUCCESS (0.411s) [55.031294] Starting dynamic subtest: pipe-B-DP-2 [55.515736] Dynamic subtest pipe-B-DP-2: SUCCESS (0.488s) [55.520371] Starting dynamic subtest: pipe-C-DP-2 [55.988411] Dynamic subtest pipe-C-DP-2: SUCCESS (0.472s) [55.993899] Starting dynamic subtest: pipe-D-DP-2 [56.494664] Dynamic subtest pipe-D-DP-2: SUCCESS (0.505s) [56.495619] Subtest plane-downscale-with-rotation-factor-0-75: SUCCESS (1.880s) [56.710763] [014/142] (948s left) gem_exec_reloc (basic-cpu-wc) [56.773857] Subtest basic-cpu-wc: SKIP (0.000s) [56.821394] [015/142] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [56.954301] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [56.956216] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [57.010744] [016/142] (947s left) kms_psr (sprite_mmap_cpu) [57.070579] Subtest sprite_mmap_cpu: SKIP (0.000s) [57.088172] [017/142] (947s left) gem_pread (snoop) [57.146703] Subtest snoop: SKIP (0.000s) [57.171378] [018/142] (947s left) kms_fbcon_fbt (psr) [57.232146] Starting subtest: psr [57.234006] Subtest psr: SKIP (0.000s) [57.307995] [019/142] (947s left) kms_cursor_crc (cursor-rapid-movement-256x256) [57.569732] Starting subtest: cursor-rapid-movement-256x256 [57.574046] Starting dynamic subtest: pipe-A-DP-2 [58.004908] Dynamic subtest pipe-A-DP-2: SUCCESS (0.431s) [58.030291] Starting dynamic subtest: pipe-D-DP-2 [58.543658] Dynamic subtest pipe-D-DP-2: SUCCESS (0.518s) [58.544556] Subtest cursor-rapid-movement-256x256: SUCCESS (0.973s) [58.832373] [020/142] (946s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [58.965646] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [61.152230] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.190s) [61.281654] [021/142] (943s left) kms_hdmi_inject (inject-4k) [61.414272] Starting subtest: inject-4k [61.562923] Subtest inject-4k: SUCCESS (0.149s) [61.771070] [022/142] (943s left) kms_big_fb (4-tiled-64bpp-rotate-180) [61.907948] Starting subtest: 4-tiled-64bpp-rotate-180 [63.651276] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.734s) [63.755677] [023/142] (941s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs) [64.026566] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs [65.213034] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SUCCESS (1.187s) [65.533670] [024/142] (939s left) kms_frontbuffer_tracking (psr-suspend) [65.667746] Starting subtest: psr-suspend [65.669619] Subtest psr-suspend: SKIP (0.000s) [65.750241] [025/142] (939s left) syncobj_timeline (single-wait-all-for-submit-signaled) [65.807722] Starting subtest: single-wait-all-for-submit-signaled [65.808718] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [65.902547] [026/142] (939s left) gem_lmem_swapping (heavy-verify-random-ccs) [68.495624] Starting subtest: heavy-verify-random-ccs [68.496531] Starting dynamic subtest: lmem0 [80.904205] Dynamic subtest lmem0: SUCCESS (12.362s) [80.905241] Subtest heavy-verify-random-ccs: SUCCESS (12.362s) [82.788526] [027/142] (922s left) syncobj_wait (reset-multiple-signaled) [84.127533] Starting subtest: reset-multiple-signaled [84.128408] Subtest reset-multiple-signaled: SUCCESS (0.000s) [84.222728] [028/142] (920s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [84.358935] Starting subtest: basic-flip-after-cursor-legacy [85.411430] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.052s) [85.586325] [029/142] (919s left) gem_partial_pwrite_pread (reads) [85.652118] Subtest reads: SKIP (0.000s) [85.697568] [030/142] (919s left) prime_vgem (basic-fence-blt) [85.807330] Starting subtest: basic-fence-blt [85.910547] Subtest basic-fence-blt: SUCCESS (0.103s) [86.060560] [031/142] (919s left) gem_unfence_active_buffers [86.247893] [032/142] (918s left) kms_flip (2x-dpms-vs-vblank-race-interruptible) [86.372196] Starting subtest: 2x-dpms-vs-vblank-race-interruptible [86.391307] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.018s) [86.452834] [033/142] (918s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k) [86.663472] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s) [86.767165] [034/142] (918s left) gem_exec_reloc (basic-wc-cpu) [86.830605] Subtest basic-wc-cpu: SKIP (0.000s) [86.883356] [035/142] (918s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_rc_ccs_cc) [87.162217] Starting subtest: pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs_cc [87.329212] Subtest pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SUCCESS (0.167s) [87.547730] [036/142] (917s left) vc4/vc4_label_bo (set-bad-name) [87.634600] Subtest set-bad-name: SKIP (0.000s) [87.690264] [037/142] (917s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [87.826734] Starting subtest: psr-1p-pri-indfb-multidraw [87.828776] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s) [87.897260] [038/142] (917s left) gem_exec_schedule (wide) [88.103858] Starting subtest: wide [88.105763] Starting dynamic subtest: rcs0 [96.312694] Dynamic subtest rcs0: SUCCESS (8.209s) [96.318341] Starting dynamic subtest: bcs0 [105.584441] Dynamic subtest bcs0: SUCCESS (9.233s) [105.589855] Starting dynamic subtest: vcs0 [114.709042] Dynamic subtest vcs0: SUCCESS (9.161s) [114.714737] Starting dynamic subtest: vcs1 [123.971026] Dynamic subtest vcs1: SUCCESS (9.267s) [123.980244] Starting dynamic subtest: vecs0 [132.687093] Dynamic subtest vecs0: SUCCESS (8.716s) [132.692739] Starting dynamic subtest: vecs1 [141.934816] Dynamic subtest vecs1: SUCCESS (9.204s) [141.940379] Starting dynamic subtest: ccs0 [150.899203] Dynamic subtest ccs0: SUCCESS (9.000s) [150.905300] Starting dynamic subtest: ccs1 [160.339829] Dynamic subtest ccs1: SUCCESS (9.439s) [160.345435] Starting dynamic subtest: ccs2 [169.621357] Dynamic subtest ccs2: SUCCESS (9.281s) [169.627153] Starting dynamic subtest: ccs3 [178.722076] Dynamic subtest ccs3: SUCCESS (9.100s) [178.723039] Subtest wide: SUCCESS (90.619s) [180.257701] [039/142] (824s left) perf (gen8-unprivileged-single-ctx-counters) [180.609767] Starting subtest: gen8-unprivileged-single-ctx-counters [180.611570] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [180.633288] [040/142] (824s left) kms_big_fb (y-tiled-32bpp-rotate-180) [180.771775] Starting subtest: y-tiled-32bpp-rotate-180 [180.773649] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [180.850844] [041/142] (824s left) gem_exec_reloc (basic-cpu-read) [180.916061] Subtest basic-cpu-read: SKIP (0.000s) [180.944783] [042/142] (824s left) perf (polling-small-buf) [181.091626] Starting subtest: polling-small-buf [181.187040] Subtest polling-small-buf: SUCCESS (0.095s) [181.217357] [043/142] (824s left) gem_exec_alignment (pi) [181.284290] Starting subtest: pi [193.964054] Killing the test because the kernel is tainted. [201.180842] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1803 [max: 8192] direct dependencies: 17654 [max: 32768] indirect dependencies: 124494 all direct dependencies: 372632 dependency chains: 25344 [max: 131072] dependency chain hlocks used: 105788 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 266 in-softirq chains: 681 in-process chains: 24397 stack-trace entries: 209848 [max: 1048576] number of stack traces: 10268 number of stack hash chains: 7650 combined max dependencies: 147762116 hardirq-safe locks: 109 hardirq-unsafe locks: 1066 softirq-safe locks: 201 softirq-unsafe locks: 982 irq-safe locks: 224 irq-unsafe locks: 1066 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 319 softirq-read-safe locks: 7 softirq-read-unsafe locks: 314 irq-read-safe locks: 7 irq-read-unsafe locks: 319 uncategorized locks: 303 unused locks: 1 max locking depth: 16 max bfs queue depth: 406 max lock class index: 1802 chain lookup misses: 33204 chain lookup hits: 257106602 cyclic checks: 33617 redundant checks: 0 redundant links: 0 find-mask forwards checks: 5772 find-mask backwards checks: 3165 hardirq on events: 131807312 hardirq off events: 131807306 redundant hardirq ons: 38 redundant hardirq offs: 22 softirq on events: 298332 softirq off events: 298332 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 354 zapped lock chains: 7755 large chain blocks: 1 [201.182275] Closing watchdogs Done.