[47.031510] Initializing watchdogs [47.031964] /dev/watchdog0 [47.062687] [001/142] (960s left) i915_pm_rps (min-max-config-loaded) [47.524097] Starting subtest: min-max-config-loaded [47.530303] Subtest min-max-config-loaded: SKIP (0.003s) [47.674522] [002/142] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render) [48.177694] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render [48.185412] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [48.340874] [003/142] (959s left) prime_busy (after) [48.735320] Starting subtest: after [48.766111] Starting dynamic subtest: rcs0 [48.806898] Dynamic subtest rcs0: SUCCESS (0.041s) [48.848987] Starting dynamic subtest: bcs0 [48.870350] Dynamic subtest bcs0: SUCCESS (0.062s) [48.898673] Starting dynamic subtest: vcs0 [48.921297] Dynamic subtest vcs0: SUCCESS (0.050s) [48.948553] Starting dynamic subtest: vcs1 [48.952300] Dynamic subtest vcs1: SUCCESS (0.025s) [48.977088] Starting dynamic subtest: vecs0 [48.980637] Dynamic subtest vecs0: SUCCESS (0.033s) [49.008981] Starting dynamic subtest: ccs0 [49.011309] Dynamic subtest ccs0: SUCCESS (0.023s) [49.128523] Subtest after: SUCCESS (0.392s) [49.241742] [004/142] (958s left) kms_pipe_crc_basic (nonblocking-crc) [49.636672] Starting subtest: nonblocking-crc [49.644852] Starting dynamic subtest: pipe-A-eDP-1 [50.890547] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.248s) [50.917785] Starting dynamic subtest: pipe-B-eDP-1 [52.690846] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.793s) [52.718984] Starting dynamic subtest: pipe-C-eDP-1 [54.622323] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.923s) [54.656630] Starting dynamic subtest: pipe-D-eDP-1 [56.307977] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.680s) [56.311521] Subtest nonblocking-crc: SUCCESS (6.672s) [57.250049] [005/142] (950s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [57.677404] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [57.845533] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.164s) [57.998500] [006/142] (949s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [58.502281] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [64.010778] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (5.518s) [64.267724] [007/142] (943s left) testdisplay [65.737418] [008/142] (942s left) i915_module_load (load) [66.097174] Starting subtest: load [66.103443] Subtest load: SKIP (0.005s) [66.217931] [009/142] (941s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [66.716915] Starting subtest: psr-rgb565-draw-mmap-gtt [66.723440] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [66.840859] [010/142] (941s left) kms_cursor_legacy (flip-vs-cursor-toggle) [67.406955] Starting subtest: flip-vs-cursor-toggle [77.330839] Subtest flip-vs-cursor-toggle: SUCCESS (9.923s) [78.272623] [011/142] (929s left) gem_ctx_create (basic-files) [78.696314] Starting subtest: basic-files [80.768445] Subtest basic-files: SUCCESS (2.072s) [82.718800] [012/142] (925s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf_tiled_ccs) [83.822437] Starting subtest: pipe-A-crc-sprite-planes-basic-yf_tiled_ccs [83.838644] Subtest pipe-A-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.013s) [85.146080] [013/142] (923s left) api_intel_bb (purge-bb) [85.520085] Starting subtest: purge-bb [85.528886] Subtest purge-bb: SUCCESS (0.012s) [85.683124] [014/142] (922s left) sw_sync (sync_busy_fork) [86.053980] Starting subtest: sync_busy_fork [87.120129] Subtest sync_busy_fork: SUCCESS (1.064s) [87.242199] [015/142] (921s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [87.617260] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [87.880405] [016/142] (920s left) gem_exec_schedule (preempt-queue-chain) [88.321277] Subtest preempt-queue-chain: SKIP (0.000s) [88.724573] [017/142] (919s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs) [89.845478] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs [89.852844] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s) [91.076764] [018/142] (917s left) syncobj_timeline (device-submit-unordered) [91.447607] Starting subtest: device-submit-unordered [91.451366] Subtest device-submit-unordered: SUCCESS (0.002s) [91.570880] [019/142] (917s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [91.941800] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [91.945554] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.003s) [92.066796] [020/142] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [92.573106] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [92.579770] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [92.721931] [021/142] (916s left) gem_mmap (basic-small-bo) [93.093891] Subtest basic-small-bo: SKIP (0.000s) [93.195143] [022/142] (915s left) i915_pm_freq_api (freq-reset) [93.591418] Starting subtest: freq-reset [93.595708] Starting dynamic subtest: gt0 [94.238056] Dynamic subtest gt0: SUCCESS (0.645s) [94.274343] Starting dynamic subtest: gt1 [94.657775] Dynamic subtest gt1: SUCCESS (0.418s) [94.661056] Subtest freq-reset: SUCCESS (1.066s) [94.790738] [023/142] (914s left) v3d/v3d_submit_cl (bad-in-sync) [95.278258] Subtest bad-in-sync: SKIP (0.000s) [95.398139] [024/142] (913s left) kms_chamelium_frames (dp-crc-fast) [96.278817] Subtest dp-crc-fast: SKIP (0.000s) [97.137100] [025/142] (912s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs) [98.554321] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs [98.561051] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.002s) [99.468622] [026/142] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [99.969410] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [111.153992] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (11.191s) [111.435685] [027/142] (897s left) kms_draw_crc (draw-method-mmap-gtt) [111.930314] Starting subtest: draw-method-mmap-gtt [111.937231] Subtest draw-method-mmap-gtt: SKIP (0.000s) [112.085609] [028/142] (897s left) i915_pm_rpm (i2c) [114.726615] Starting subtest: i2c [120.791119] Subtest i2c: SUCCESS (6.061s) [120.973812] [029/142] (888s left) syncobj_wait (single-wait-all-signaled) [121.340996] Starting subtest: single-wait-all-signaled [121.345256] Subtest single-wait-all-signaled: SUCCESS (0.001s) [121.478179] [030/142] (888s left) perf (blocking-parameterized) [122.302270] Starting subtest: blocking-parameterized [142.366457] Subtest blocking-parameterized: SUCCESS (20.067s) [142.438623] [031/142] (867s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_rc_ccs_cc) [143.836305] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs_cc [143.843064] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s) [144.816646] [032/142] (864s left) gem_ctx_isolation (dirty-switch) [145.241249] Starting subtest: dirty-switch [145.245201] Starting dynamic subtest: rcs0 [146.045559] Dynamic subtest rcs0: SUCCESS (0.804s) [146.098128] Starting dynamic subtest: bcs0 [146.892402] Dynamic subtest bcs0: SUCCESS (0.844s) [146.925866] Starting dynamic subtest: vcs0 [147.759401] Dynamic subtest vcs0: SUCCESS (0.865s) [147.802915] Starting dynamic subtest: vcs1 [149.364674] Dynamic subtest vcs1: SUCCESS (1.603s) [149.401543] Starting dynamic subtest: vecs0 [151.376741] Dynamic subtest vecs0: SUCCESS (2.010s) [151.420579] Starting dynamic subtest: ccs0 [153.394536] Dynamic subtest ccs0: SUCCESS (2.015s) [153.398765] Subtest dirty-switch: SUCCESS (8.155s) [153.767884] [033/142] (856s left) prime_self_import (reimport-vs-gem_close-race) [154.128484] Starting subtest: reimport-vs-gem_close-race [159.196786] Subtest reimport-vs-gem_close-race: SUCCESS (5.065s) [159.366785] [034/142] (850s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [159.876757] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [159.884236] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [160.036813] [035/142] (849s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [160.539303] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [160.546851] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [160.704773] [036/142] (849s left) kms_vblank (pipe-a-ts-continuation-idle-hang) [161.192195] Starting subtest: pipe-A-ts-continuation-idle-hang [175.883513] Subtest pipe-A-ts-continuation-idle-hang: SUCCESS (14.693s) [176.851182] [037/142] (833s left) gem_exec_schedule (submit-golden-slice) [177.286830] Starting subtest: submit-golden-slice [177.290571] Starting dynamic subtest: rcs0 [177.428506] Dynamic subtest rcs0: SUCCESS (0.140s) [177.468896] Starting dynamic subtest: bcs0 [177.552188] Dynamic subtest bcs0: SUCCESS (0.122s) [177.589178] Starting dynamic subtest: vcs0 [177.676314] Dynamic subtest vcs0: SUCCESS (0.122s) [177.712798] Starting dynamic subtest: vcs1 [177.800775] Dynamic subtest vcs1: SUCCESS (0.122s) [177.836887] Starting dynamic subtest: vecs0 [177.925577] Dynamic subtest vecs0: SUCCESS (0.122s) [177.965409] Starting dynamic subtest: ccs0 [178.051798] Dynamic subtest ccs0: SUCCESS (0.124s) [178.055493] Subtest submit-golden-slice: SUCCESS (0.766s) [178.735188] [038/142] (831s left) kms_vblank (pipe-a-ts-continuation-idle) [179.220561] Starting subtest: pipe-A-ts-continuation-idle [179.830207] Subtest pipe-A-ts-continuation-idle: SUCCESS (0.607s) [180.771690] [039/142] (829s left) kms_invalid_mode (zero-hdisplay) [181.252725] Starting subtest: zero-hdisplay [181.256389] Starting dynamic subtest: eDP-1-pipe-A [181.677774] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.424s) [181.721110] Starting dynamic subtest: eDP-1-pipe-B [181.724739] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.039s) [181.773163] Starting dynamic subtest: eDP-1-pipe-C [181.776811] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.039s) [181.813310] Starting dynamic subtest: eDP-1-pipe-D [181.825147] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.039s) [181.828340] Subtest zero-hdisplay: SUCCESS (0.571s) [182.567711] [040/142] (827s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [183.117608] Starting subtest: basic-flip-after-cursor-varying-size [184.521252] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.401s) [185.467709] [041/142] (824s left) kms_chamelium_hpd (vga-hpd-without-ddc) [186.341910] Subtest vga-hpd-without-ddc: SKIP (0.000s) [187.208872] [042/142] (823s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [187.713816] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [187.720730] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [187.872828] [043/142] (822s left) v3d/v3d_submit_csd (multi-and-single-sync) [188.337197] Subtest multi-and-single-sync: SKIP (0.000s) [188.458676] [044/142] (822s left) syncobj_wait (wait-delayed-signal) [188.825369] Starting subtest: wait-delayed-signal [188.931633] Subtest wait-delayed-signal: SUCCESS (0.106s) [189.080825] [045/142] (821s left) kms_cursor_crc (cursor-alpha-opaque) [189.561495] Starting subtest: cursor-alpha-opaque [189.566340] Starting dynamic subtest: pipe-A-eDP-1 [190.948414] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.379s) [190.986970] Starting dynamic subtest: pipe-D-eDP-1 [193.497316] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s) [193.500639] Subtest cursor-alpha-opaque: SUCCESS (3.936s) [195.050533] [046/142] (815s left) gem_eio (unwedge-stress) [196.780269] Starting subtest: unwedge-stress [271.575341] Subtest unwedge-stress: SUCCESS (74.792s) [273.670860] [047/142] (737s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [274.230380] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [274.237976] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [274.393234] [048/142] (736s left) gem_exec_whisper (basic-sync) [274.817334] Starting subtest: basic-sync [292.547065] Subtest basic-sync: SUCCESS (17.725s) [292.846351] [049/142] (718s left) gem_partial_pwrite_pread (write) [293.252550] Subtest write: SKIP (0.000s) [293.406278] [050/142] (717s left) api_intel_bb (lot-of-buffers) [293.779629] Starting subtest: lot-of-buffers [298.320378] Subtest lot-of-buffers: SUCCESS (4.545s) [298.633343] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1781 [max: 8192] direct dependencies: 17308 [max: 32768] indirect dependencies: 133788 all direct dependencies: 361639 dependency chains: 25058 [max: 131072] dependency chain hlocks used: 104585 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 223 in-softirq chains: 510 in-process chains: 24325 stack-trace entries: 164949 [max: 1048576] number of stack traces: 8352 number of stack hash chains: 6546 combined max dependencies: 2784451264 hardirq-safe locks: 109 hardirq-unsafe locks: 1053 softirq-safe locks: 194 softirq-unsafe locks: 970 irq-safe locks: 218 irq-unsafe locks: 1053 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 322 softirq-read-safe locks: 7 softirq-read-unsafe locks: 317 irq-read-safe locks: 7 irq-read-unsafe locks: 322 uncategorized locks: 291 unused locks: 1 max locking depth: 16 max bfs queue depth: 385 max lock class index: 1780 chain lookup misses: 25657 chain lookup hits: 138343401 cyclic checks: 25317 redundant checks: 0 redundant links: 0 find-mask forwards checks: 3941 find-mask backwards checks: 2664 hardirq on events: 73872999 hardirq off events: 73872977 redundant hardirq ons: 54 redundant hardirq offs: 22 softirq on events: 366046 softirq off events: 366046 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 1 zapped lock chains: 116 large chain blocks: 1 [298.636830] Closing watchdogs Done.