[40.119719] Initializing watchdogs [40.120110] /dev/watchdog0 [40.142440] [001/143] (960s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [42.225293] Starting subtest: fbc-rgb565-draw-render [44.925050] Subtest fbc-rgb565-draw-render: SUCCESS (2.701s) [45.060745] [002/143] (955s left) i915_pm_rpm (gem-execbuf) [49.515919] Starting subtest: gem-execbuf [49.519083] Starting dynamic subtest: lmem0 [53.892966] Dynamic subtest lmem0: SUCCESS (4.376s) [53.910458] Starting dynamic subtest: smem0 [57.679116] Dynamic subtest smem0: SUCCESS (3.786s) [57.681838] Subtest gem-execbuf: SUCCESS (8.164s) [58.787656] [003/143] (941s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [60.927376] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [60.932267] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [61.056032] [004/143] (939s left) kms_ccs (pipe-b-ccs-on-another-bo-4-tiled-mtl-rc-ccs) [63.118508] Starting subtest: pipe-B-ccs-on-another-bo-4-tiled-mtl-rc-ccs [63.121512] Subtest pipe-B-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s) [63.286088] [005/143] (937s left) kms_frontbuffer_tracking (psr-suspend) [65.256056] Starting subtest: psr-suspend [65.259300] Subtest psr-suspend: SKIP (0.000s) [65.341694] [006/143] (935s left) kms_properties (get_properties-sanity-non-atomic) [67.381959] Starting subtest: get_properties-sanity-non-atomic [67.386455] Subtest get_properties-sanity-non-atomic: SUCCESS (0.005s) [67.454482] [007/143] (933s left) kms_lease (possible-crtcs-filtering) [69.469519] Starting subtest: possible-crtcs-filtering [69.477247] Subtest possible-crtcs-filtering: SUCCESS (0.007s) [69.538181] [008/143] (931s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [69.628049] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [69.630441] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s) [69.720814] [009/143] (931s left) kms_pm_lpsp (kms-lpsp) [72.719905] Starting subtest: kms-lpsp [72.723057] Subtest kms-lpsp: SKIP (0.000s) [73.018831] [010/143] (927s left) gem_pxp (reject-modify-context-protection-off-3) [75.647312] Subtest reject-modify-context-protection-off-3: SKIP (0.000s) [75.711486] [011/143] (925s left) gem_exec_balancer (full-pulse) [75.768242] Starting subtest: full-pulse [77.321588] Subtest full-pulse: SUCCESS (1.554s) [77.619293] [012/143] (923s left) kms_psr (fbc-psr-sprite-mmap-gtt) [79.581899] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [79.610690] [013/143] (921s left) gem_exec_schedule (preempt-contexts) [79.679755] Starting subtest: preempt-contexts [79.681514] Starting dynamic subtest: rcs0 [79.764413] Dynamic subtest rcs0: SUCCESS (0.081s) [79.770730] Starting dynamic subtest: bcs0 [79.815284] Dynamic subtest bcs0: SUCCESS (0.056s) [79.821506] Starting dynamic subtest: vcs0 [79.871986] Dynamic subtest vcs0: SUCCESS (0.057s) [79.878070] Starting dynamic subtest: vcs1 [79.928783] Dynamic subtest vcs1: SUCCESS (0.057s) [79.935186] Starting dynamic subtest: vecs0 [79.984250] Dynamic subtest vecs0: SUCCESS (0.055s) [79.985996] Subtest preempt-contexts: SUCCESS (0.306s) [80.396097] [014/143] (920s left) kms_cursor_crc (cursor-random-512x170) [82.563823] Starting subtest: cursor-random-512x170 [82.567349] Subtest cursor-random-512x170: SKIP (0.002s) [82.735057] [015/143] (918s left) syncobj_timeline (etime-single-wait-submitted) [82.823260] Starting subtest: etime-single-wait-submitted [82.933176] Subtest etime-single-wait-submitted: SUCCESS (0.106s) [83.020923] [016/143] (917s left) perf (missing-sample-flags) [83.129861] Starting subtest: missing-sample-flags [83.131424] Subtest missing-sample-flags: SUCCESS (0.000s) [83.148920] [017/143] (917s left) kms_addfb_basic (addfb25-y-tiled-legacy) [85.135519] Starting subtest: addfb25-y-tiled-legacy [85.137120] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [85.201898] [018/143] (915s left) syncobj_wait (wait-for-submit-snapshot) [85.279087] Starting subtest: wait-for-submit-snapshot [85.363325] Subtest wait-for-submit-snapshot: SUCCESS (0.083s) [85.477202] [019/143] (915s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt) [87.469100] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt [89.773712] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (2.308s) [89.903072] [020/143] (911s left) gem_mmap_wc (write-gtt-read-wc) [89.954796] Subtest write-gtt-read-wc: SKIP (0.000s) [89.976262] [021/143] (911s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [91.938504] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [91.941370] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [92.046790] [022/143] (909s left) prime_busy (hang) [92.183628] Starting subtest: hang [92.185152] Starting dynamic subtest: rcs0 [105.860458] Dynamic subtest rcs0: SUCCESS (13.675s) [105.866961] Starting dynamic subtest: bcs0 [112.946196] Dynamic subtest bcs0: SUCCESS (7.085s) [112.952831] Starting dynamic subtest: vcs0 [119.985209] Dynamic subtest vcs0: SUCCESS (7.041s) [119.992035] Starting dynamic subtest: vcs1 [126.963543] Dynamic subtest vcs1: SUCCESS (6.977s) [126.970039] Starting dynamic subtest: vecs0 [134.002430] Dynamic subtest vecs0: SUCCESS (7.039s) [134.004350] Subtest hang: SUCCESS (41.817s) [134.105058] [023/143] (867s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [136.058553] Starting subtest: flip-vs-cursor-crc-legacy [136.671091] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.611s) [136.788600] [024/143] (864s left) v3d/v3d_job_submission (threaded-job-submission) [136.856721] Subtest threaded-job-submission: SKIP (0.000s) [136.905781] [025/143] (864s left) gem_madvise (dontneed-after-mmap) [136.952309] Starting subtest: dontneed-after-mmap [136.955360] Subtest dontneed-after-mmap: SUCCESS (0.003s) [137.030545] [026/143] (864s left) syncobj_timeline (wait-all-complex) [137.112224] Starting subtest: wait-all-complex [137.330321] Subtest wait-all-complex: SUCCESS (0.215s) [137.413107] [027/143] (863s left) gem_partial_pwrite_pread (write) [137.465841] Subtest write: SKIP (0.000s) [137.513307] [028/143] (863s left) perf_pmu (rc6) [137.572929] Starting subtest: rc6 [137.574742] Starting dynamic subtest: gt0 [143.914830] Dynamic subtest gt0: SUCCESS (6.338s) [143.921827] Starting dynamic subtest: runtime-pm-gt0 [151.706301] Dynamic subtest runtime-pm-gt0: SUCCESS (7.795s) [151.714078] Starting dynamic subtest: runtime-pm-long-gt0 [164.455857] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.750s) [164.462659] Starting dynamic subtest: other-idle-gt0 [164.465947] Dynamic subtest other-idle-gt0: SKIP (0.000s) [164.467749] Subtest rc6: SUCCESS (26.884s) [164.519320] [029/143] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [166.490388] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [166.493726] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [166.529512] [030/143] (834s left) gem_fenced_exec_thrash (no-spare-fences-busy) [166.616547] Subtest no-spare-fences-busy: SKIP (0.000s) [166.671233] [031/143] (834s left) kms_ccs (pipe-c-ccs-on-another-bo-y-tiled-gen12-mc-ccs) [168.796216] Starting subtest: pipe-C-ccs-on-another-bo-y-tiled-gen12-mc-ccs [168.797919] Subtest pipe-C-ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.000s) [168.894926] [032/143] (832s left) gem_mmap_offset (basic-uaf) [168.940826] Starting subtest: basic-uaf [168.941696] Subtest basic-uaf: SUCCESS (0.000s) [168.976888] [033/143] (832s left) gem_userptr_blits (map-fixed-invalidate-busy) [169.034942] Starting subtest: map-fixed-invalidate-busy [169.036838] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [169.104228] [034/143] (832s left) gem_create (create-clear) [169.175856] Starting subtest: create-clear [169.176748] Starting dynamic subtest: lmem0 [202.217790] Dynamic subtest lmem0: SUCCESS (33.035s) [202.223985] Starting dynamic subtest: smem0 [239.042183] Dynamic subtest smem0: SUCCESS (36.826s) [239.043191] Subtest create-clear: SUCCESS (69.861s) [239.484042] [035/143] (761s left) gem_spin_batch (resubmit-all) [239.538160] Starting subtest: resubmit-all [239.539138] Starting dynamic subtest: rcs0 [239.558234] Dynamic subtest rcs0: SUCCESS (0.020s) [239.565211] Starting dynamic subtest: bcs0 [239.566174] Dynamic subtest bcs0: SUCCESS (0.002s) [239.572232] Starting dynamic subtest: vcs0 [239.573142] Dynamic subtest vcs0: SUCCESS (0.002s) [239.579130] Starting dynamic subtest: vcs1 [239.580030] Dynamic subtest vcs1: SUCCESS (0.002s) [239.586047] Starting dynamic subtest: vecs0 [239.586960] Dynamic subtest vecs0: SUCCESS (0.002s) [239.587859] Subtest resubmit-all: SUCCESS (0.028s) [239.767100] [036/143] (761s left) kms_chamelium_hpd (vga-hpd-without-ddc) [241.761156] Subtest vga-hpd-without-ddc: SKIP (0.000s) [241.812472] [037/143] (759s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25) [243.765560] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25 [243.769547] Starting dynamic subtest: pipe-A-HDMI-A-3 [243.783124] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.012s) [243.792229] Starting dynamic subtest: pipe-B-HDMI-A-3 [243.810228] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.022s) [243.818146] Starting dynamic subtest: pipe-C-HDMI-A-3 [243.836280] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.023s) [243.847708] Starting dynamic subtest: pipe-D-HDMI-A-3 [243.862852] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.023s) [243.864550] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.098s) [243.897999] [038/143] (757s left) kms_cursor_edge_walk (128x128-top-edge) [245.847558] Starting subtest: 128x128-top-edge [245.848539] Starting dynamic subtest: pipe-A-HDMI-A-3 [249.135007] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.286s) [249.142264] Starting dynamic subtest: pipe-D-HDMI-A-3 [252.338855] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.202s) [252.339716] Subtest 128x128-top-edge: SUCCESS (6.492s) [252.424274] [039/143] (749s left) kms_dirtyfb (psr-dirtyfb-ioctl) [254.371844] Starting subtest: psr-dirtyfb-ioctl [254.373923] Subtest psr-dirtyfb-ioctl: SKIP (0.000s) [254.406130] [040/143] (747s left) gem_softpin (invalid) [254.459529] Starting subtest: invalid [254.470572] Subtest invalid: SUCCESS (0.011s) [254.526935] [041/143] (746s left) syncobj_timeline (multi-wait-available-signaled) [254.605198] Starting subtest: multi-wait-available-signaled [254.606250] Subtest multi-wait-available-signaled: SUCCESS (0.001s) [254.621991] [042/143] (746s left) kms_chamelium_frames (hdmi-crc-fast) [256.616703] Subtest hdmi-crc-fast: SKIP (0.000s) [256.664883] [043/143] (744s left) kms_rotation_crc (primary-rotation-180) [258.616184] Starting subtest: primary-rotation-180 [269.219118] Subtest primary-rotation-180: SUCCESS (10.602s) [269.365134] [044/143] (732s left) gem_userptr_blits (stress-purge) [269.422771] Starting subtest: stress-purge [274.854702] Subtest stress-purge: SUCCESS (5.431s) [274.936112] [045/143] (726s left) perf_pmu (multi-client) [275.053250] Starting subtest: multi-client [275.054308] Starting dynamic subtest: rcs0 [276.110997] Dynamic subtest rcs0: SUCCESS (1.053s) [276.119056] Starting dynamic subtest: bcs0 [277.159746] Dynamic subtest bcs0: SUCCESS (1.047s) [277.167945] Starting dynamic subtest: vcs0 [278.208349] Dynamic subtest vcs0: SUCCESS (1.047s) [278.216057] Starting dynamic subtest: vcs1 [279.256625] Dynamic subtest vcs1: SUCCESS (1.046s) [279.264095] Starting dynamic subtest: vecs0 [280.304296] Dynamic subtest vecs0: SUCCESS (1.046s) [280.305244] Subtest multi-client: SUCCESS (5.248s) [280.377669] [046/143] (721s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [282.347241] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [283.520209] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.169s) [283.611432] [047/143] (717s left) kms_big_fb (linear-32bpp-rotate-270) [285.576106] Starting subtest: linear-32bpp-rotate-270 [285.651777] Subtest linear-32bpp-rotate-270: SKIP (0.075s) [285.712652] [048/143] (715s left) gem_exec_schedule (semaphore-noskip) [285.777624] Starting subtest: semaphore-noskip [286.311987] Subtest semaphore-noskip: SUCCESS (0.531s) [286.599058] [049/143] (715s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [288.561779] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [288.564245] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [288.595274] [050/143] (713s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [290.545526] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [290.547826] Starting dynamic subtest: pipe-A-valid-mode [290.587774] Dynamic subtest pipe-A-valid-mode: SKIP (0.040s) [290.589615] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.041s) [290.639070] [051/143] (710s left) i915_suspend (basic-s2idle-without-i915) [290.681480] Starting subtest: basic-s2idle-without-i915 [311.024556] Subtest basic-s2idle-without-i915: SUCCESS (4.841s) [313.063212] [052/143] (705s left) gem_exec_params (rsvd2-dirt) [313.122729] Starting subtest: rsvd2-dirt [313.124675] Subtest rsvd2-dirt: SKIP (0.000s) [313.179434] [053/143] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [315.143011] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [315.145047] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [315.187794] [054/143] (703s left) gen9_exec_parse (secure-batches) [315.261034] Subtest secure-batches: SKIP (0.000s) [315.290657] [055/143] (702s left) gem_exec_flush (basic-uc-pro-default) [315.376861] Subtest basic-uc-pro-default: SKIP (0.000s) [315.415928] [056/143] (702s left) gem_mmap (bad-object) [315.478405] Subtest bad-object: SKIP (0.000s) [315.500657] [057/143] (702s left) gem_ctx_isolation (preservation-s3) [315.563018] Starting subtest: preservation-S3 [315.564099] Starting dynamic subtest: rcs0 [341.874122] Dynamic subtest rcs0: SUCCESS (9.433s) [341.882853] Starting dynamic subtest: bcs0 [367.883240] Dynamic subtest bcs0: SUCCESS (9.168s) [367.890854] Starting dynamic subtest: vcs0 [393.874040] Dynamic subtest vcs0: SUCCESS (9.205s) [393.881761] Starting dynamic subtest: vcs1 [419.868815] Dynamic subtest vcs1: SUCCESS (9.192s) [419.876421] Starting dynamic subtest: vecs0 [445.900432] Dynamic subtest vecs0: SUCCESS (9.280s) [445.901409] Subtest preservation-S3: SUCCESS (46.281s) [449.100962] [058/143] (656s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf-tiled-ccs) [451.128487] Starting subtest: pipe-A-crc-sprite-planes-basic-yf-tiled-ccs [451.132837] Subtest pipe-A-crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.003s) [451.297406] [059/143] (654s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [453.254850] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [453.256575] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [453.295542] [060/143] (652s left) gem_exec_alignment (pi-isolated) [453.371037] Starting subtest: pi-isolated [466.239525] Killing the test because the kernel is tainted. [467.986837] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1863 [max: 8192] direct dependencies: 18560 [max: 32768] indirect dependencies: 148220 all direct dependencies: 390068 dependency chains: 27194 [max: 131072] dependency chain hlocks used: 118870 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 231 in-softirq chains: 696 in-process chains: 26267 stack-trace entries: 194282 [max: 1048576] number of stack traces: 9615 number of stack hash chains: 7286 combined max dependencies: 4247640672 hardirq-safe locks: 104 hardirq-unsafe locks: 1119 softirq-safe locks: 202 softirq-unsafe locks: 1026 irq-safe locks: 228 irq-unsafe locks: 1119 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 307 softirq-read-safe locks: 7 softirq-read-unsafe locks: 302 irq-read-safe locks: 7 irq-read-unsafe locks: 307 uncategorized locks: 325 unused locks: 1 max locking depth: 16 max bfs queue depth: 429 max lock class index: 1862 chain lookup misses: 31819 chain lookup hits: 551692054 cyclic checks: 32394 redundant checks: 0 redundant links: 0 find-mask forwards checks: 5488 find-mask backwards checks: 3001 hardirq on events: 346259945 hardirq off events: 346259939 redundant hardirq ons: 56 redundant hardirq offs: 53 softirq on events: 236055 softirq off events: 236055 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 177 zapped lock chains: 4510 large chain blocks: 1 [467.988150] Closing watchdogs Done.