[39.092894] Initializing watchdogs [39.092950] /dev/watchdog0 [39.098234] [001/143] (960s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [41.104313] Starting subtest: fbc-rgb565-draw-render [43.596784] Subtest fbc-rgb565-draw-render: SUCCESS (2.492s) [43.716603] [002/143] (955s left) i915_pm_rpm (gem-execbuf) [48.475363] Starting subtest: gem-execbuf [48.476632] Starting dynamic subtest: lmem0 [53.606354] Dynamic subtest lmem0: SUCCESS (5.130s) [53.613418] Starting dynamic subtest: smem0 [58.593551] Dynamic subtest smem0: SUCCESS (4.988s) [58.595051] Subtest gem-execbuf: SUCCESS (10.118s) [59.739949] [003/143] (939s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [61.823203] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [63.074671] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SUCCESS (1.250s) [63.295654] [004/143] (936s left) kms_ccs (pipe-b-ccs-on-another-bo-4-tiled-mtl-rc-ccs) [65.313939] Starting subtest: pipe-B-ccs-on-another-bo-4-tiled-mtl-rc-ccs [65.315491] Subtest pipe-B-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s) [65.442142] [005/143] (934s left) kms_frontbuffer_tracking (psr-suspend) [67.404534] Starting subtest: psr-suspend [67.406218] Subtest psr-suspend: SKIP (0.000s) [67.477465] [006/143] (932s left) kms_properties (get_properties-sanity-non-atomic) [69.495190] Starting subtest: get_properties-sanity-non-atomic [69.497563] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s) [69.558626] [007/143] (930s left) kms_lease (possible-crtcs-filtering) [71.545162] Starting subtest: possible-crtcs-filtering [71.550356] Subtest possible-crtcs-filtering: SUCCESS (0.005s) [71.609120] [008/143] (928s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [71.713693] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [71.717429] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s) [71.786251] [009/143] (927s left) kms_pm_lpsp (kms-lpsp) [74.736268] Starting subtest: kms-lpsp [74.738075] Subtest kms-lpsp: SKIP (0.000s) [74.847360] [010/143] (924s left) gem_pxp (reject-modify-context-protection-off-3) [77.499519] Subtest reject-modify-context-protection-off-3: SKIP (0.000s) [77.558834] [011/143] (922s left) gem_exec_balancer (full-pulse) [77.607668] Starting subtest: full-pulse [78.974410] Subtest full-pulse: SUCCESS (1.367s) [79.281277] [012/143] (920s left) kms_psr (fbc-psr-sprite-mmap-gtt) [81.221494] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [81.235254] [013/143] (918s left) gem_exec_schedule (preempt-contexts) [81.288145] Starting subtest: preempt-contexts [81.289023] Starting dynamic subtest: rcs0 [81.355888] Dynamic subtest rcs0: SUCCESS (0.068s) [81.361587] Starting dynamic subtest: bcs0 [81.401469] Dynamic subtest bcs0: SUCCESS (0.045s) [81.407367] Starting dynamic subtest: vcs0 [81.448065] Dynamic subtest vcs0: SUCCESS (0.047s) [81.453855] Starting dynamic subtest: vcs1 [81.493348] Dynamic subtest vcs1: SUCCESS (0.045s) [81.499006] Starting dynamic subtest: vecs0 [81.538252] Dynamic subtest vecs0: SUCCESS (0.045s) [81.544061] Starting dynamic subtest: vecs1 [81.582989] Dynamic subtest vecs1: SUCCESS (0.045s) [81.588634] Starting dynamic subtest: ccs0 [81.626741] Dynamic subtest ccs0: SUCCESS (0.044s) [81.632428] Starting dynamic subtest: ccs1 [81.670890] Dynamic subtest ccs1: SUCCESS (0.044s) [81.676699] Starting dynamic subtest: ccs2 [81.714856] Dynamic subtest ccs2: SUCCESS (0.044s) [81.720701] Starting dynamic subtest: ccs3 [81.758936] Dynamic subtest ccs3: SUCCESS (0.044s) [81.759824] Subtest preempt-contexts: SUCCESS (0.471s) [82.208552] [014/143] (917s left) kms_cursor_crc (cursor-random-512x170) [84.319786] Starting subtest: cursor-random-512x170 [84.321421] Subtest cursor-random-512x170: SKIP (0.001s) [84.470450] [015/143] (915s left) syncobj_timeline (etime-single-wait-submitted) [84.552369] Starting subtest: etime-single-wait-submitted [84.656581] Subtest etime-single-wait-submitted: SUCCESS (0.104s) [84.727287] [016/143] (915s left) perf (missing-sample-flags) [85.015974] Starting subtest: missing-sample-flags [85.016882] Subtest missing-sample-flags: SUCCESS (0.000s) [85.040413] [017/143] (914s left) kms_addfb_basic (addfb25-y-tiled-legacy) [86.976228] Starting subtest: addfb25-y-tiled-legacy [86.977226] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [87.044766] [018/143] (912s left) syncobj_wait (wait-for-submit-snapshot) [87.150819] Starting subtest: wait-for-submit-snapshot [87.234239] Subtest wait-for-submit-snapshot: SUCCESS (0.083s) [87.319941] [019/143] (912s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt) [89.308616] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt [91.382497] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (2.074s) [91.498122] [020/143] (908s left) gem_mmap_wc (write-gtt-read-wc) [91.542058] Subtest write-gtt-read-wc: SKIP (0.000s) [91.568587] [021/143] (908s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [93.511569] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [93.513353] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [93.578504] [022/143] (906s left) prime_busy (hang) [93.697130] Starting subtest: hang [93.699542] Starting dynamic subtest: rcs0 [106.962399] Dynamic subtest rcs0: SUCCESS (13.263s) [106.968464] Starting dynamic subtest: bcs0 [114.121267] Dynamic subtest bcs0: SUCCESS (7.159s) [114.127195] Starting dynamic subtest: vcs0 [121.097137] Dynamic subtest vcs0: SUCCESS (6.976s) [121.102882] Starting dynamic subtest: vcs1 [128.136909] Dynamic subtest vcs1: SUCCESS (7.039s) [128.142887] Starting dynamic subtest: vecs0 [135.119255] Dynamic subtest vecs0: SUCCESS (6.976s) [135.125217] Starting dynamic subtest: vecs1 [142.098232] Dynamic subtest vecs1: SUCCESS (6.985s) [142.104181] Starting dynamic subtest: ccs0 [155.991307] Dynamic subtest ccs0: SUCCESS (13.893s) [155.997492] Starting dynamic subtest: ccs1 [169.944619] Dynamic subtest ccs1: SUCCESS (13.954s) [169.950436] Starting dynamic subtest: ccs2 [183.952788] Dynamic subtest ccs2: SUCCESS (14.008s) [183.958723] Starting dynamic subtest: ccs3 [197.974602] Dynamic subtest ccs3: SUCCESS (14.021s) [197.975743] Subtest hang: SUCCESS (104.277s) [198.069096] [023/143] (801s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [200.010010] Starting subtest: flip-vs-cursor-crc-legacy [200.521669] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.511s) [200.656906] [024/143] (799s left) v3d/v3d_job_submission (threaded-job-submission) [200.739501] Subtest threaded-job-submission: SKIP (0.000s) [200.788093] [025/143] (799s left) gem_madvise (dontneed-after-mmap) [200.832200] Starting subtest: dontneed-after-mmap [200.835109] Subtest dontneed-after-mmap: SUCCESS (0.003s) [200.904606] [026/143] (799s left) syncobj_timeline (wait-all-complex) [200.951522] Starting subtest: wait-all-complex [201.170186] Subtest wait-all-complex: SUCCESS (0.218s) [201.245295] [027/143] (798s left) gem_partial_pwrite_pread (write) [201.291637] Subtest write: SKIP (0.000s) [201.329577] [028/143] (798s left) perf_pmu (rc6) [201.374721] Starting subtest: rc6 [201.375587] Starting dynamic subtest: gt0 [207.715182] Dynamic subtest gt0: SUCCESS (6.339s) [207.722985] Starting dynamic subtest: runtime-pm-gt0 [215.446581] Dynamic subtest runtime-pm-gt0: SUCCESS (7.732s) [215.455127] Starting dynamic subtest: runtime-pm-long-gt0 [228.128403] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.682s) [228.135906] Starting dynamic subtest: other-idle-gt0 [228.137753] Dynamic subtest other-idle-gt0: SKIP (0.000s) [228.138549] Subtest rc6: SUCCESS (26.753s) [228.630398] [029/143] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [230.581146] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [230.582886] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [230.617288] [030/143] (769s left) gem_fenced_exec_thrash (no-spare-fences-busy) [230.675976] Subtest no-spare-fences-busy: SKIP (0.000s) [230.698747] [031/143] (769s left) kms_ccs (pipe-c-ccs-on-another-bo-y-tiled-gen12-mc-ccs) [232.775119] Starting subtest: pipe-C-ccs-on-another-bo-y-tiled-gen12-mc-ccs [232.776704] Subtest pipe-C-ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.000s) [232.849972] [032/143] (767s left) gem_mmap_offset (basic-uaf) [232.891769] Starting subtest: basic-uaf [232.892713] Subtest basic-uaf: SUCCESS (0.000s) [232.931620] [033/143] (767s left) gem_userptr_blits (map-fixed-invalidate-busy) [232.990653] Starting subtest: map-fixed-invalidate-busy [232.992262] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [233.052072] [034/143] (767s left) gem_create (create-clear) [233.111782] Starting subtest: create-clear [233.112612] Starting dynamic subtest: lmem0 [267.231386] Dynamic subtest lmem0: SUCCESS (34.116s) [267.237479] Starting dynamic subtest: smem0 [302.775775] Dynamic subtest smem0: SUCCESS (35.545s) [302.776582] Subtest create-clear: SUCCESS (69.662s) [303.183765] [035/143] (696s left) gem_spin_batch (resubmit-all) [303.274984] Starting subtest: resubmit-all [303.276024] Starting dynamic subtest: rcs0 [303.298667] Dynamic subtest rcs0: SUCCESS (0.024s) [303.304736] Starting dynamic subtest: bcs0 [303.305537] Dynamic subtest bcs0: SUCCESS (0.004s) [303.311516] Starting dynamic subtest: vcs0 [303.312346] Dynamic subtest vcs0: SUCCESS (0.004s) [303.318245] Starting dynamic subtest: vcs1 [303.319153] Dynamic subtest vcs1: SUCCESS (0.004s) [303.325689] Starting dynamic subtest: vecs0 [303.326466] Dynamic subtest vecs0: SUCCESS (0.002s) [303.332409] Starting dynamic subtest: vecs1 [303.333192] Dynamic subtest vecs1: SUCCESS (0.003s) [303.339128] Starting dynamic subtest: ccs0 [303.340038] Dynamic subtest ccs0: SUCCESS (0.003s) [303.345857] Starting dynamic subtest: ccs1 [303.346748] Dynamic subtest ccs1: SUCCESS (0.002s) [303.352474] Starting dynamic subtest: ccs2 [303.353379] Dynamic subtest ccs2: SUCCESS (0.002s) [303.359130] Starting dynamic subtest: ccs3 [303.360085] Dynamic subtest ccs3: SUCCESS (0.003s) [303.361023] Subtest resubmit-all: SUCCESS (0.051s) [303.539443] [036/143] (696s left) kms_chamelium_hpd (vga-hpd-without-ddc) [305.513284] Subtest vga-hpd-without-ddc: SKIP (0.000s) [305.566016] [037/143] (694s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25) [307.510125] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25 [307.514353] Starting dynamic subtest: pipe-A-HDMI-A-3 [307.526853] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.012s) [307.535734] Starting dynamic subtest: pipe-B-HDMI-A-3 [307.555904] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.024s) [307.564821] Starting dynamic subtest: pipe-C-HDMI-A-3 [307.583157] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.023s) [307.591872] Starting dynamic subtest: pipe-D-HDMI-A-3 [307.613231] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.024s) [307.614958] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.101s) [307.650268] [038/143] (692s left) kms_cursor_edge_walk (128x128-top-edge) [309.585241] Starting subtest: 128x128-top-edge [309.586171] Starting dynamic subtest: pipe-A-HDMI-A-3 [312.883879] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.298s) [312.890130] Starting dynamic subtest: pipe-D-HDMI-A-3 [316.103582] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.219s) [316.104440] Subtest 128x128-top-edge: SUCCESS (6.519s) [316.181520] [039/143] (684s left) kms_dirtyfb (psr-dirtyfb-ioctl) [318.118264] Starting subtest: psr-dirtyfb-ioctl [318.119848] Subtest psr-dirtyfb-ioctl: SKIP (0.000s) [318.145908] [040/143] (682s left) gem_softpin (invalid) [318.193766] Starting subtest: invalid [318.203789] Subtest invalid: SUCCESS (0.010s) [318.273645] [041/143] (681s left) syncobj_timeline (multi-wait-available-signaled) [318.364266] Starting subtest: multi-wait-available-signaled [318.365172] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [318.379615] [042/143] (681s left) kms_chamelium_frames (hdmi-crc-fast) [320.358461] Subtest hdmi-crc-fast: SKIP (0.000s) [320.408786] [043/143] (679s left) kms_rotation_crc (primary-rotation-180) [322.351375] Starting subtest: primary-rotation-180 [332.008359] Subtest primary-rotation-180: SUCCESS (9.657s) [332.178468] [044/143] (668s left) gem_userptr_blits (stress-purge) [332.233371] Starting subtest: stress-purge [337.633621] Subtest stress-purge: SUCCESS (5.400s) [337.707552] [045/143] (662s left) perf_pmu (multi-client) [337.799381] Starting subtest: multi-client [337.800378] Starting dynamic subtest: rcs0 [338.873715] Dynamic subtest rcs0: SUCCESS (1.073s) [338.883214] Starting dynamic subtest: bcs0 [339.921324] Dynamic subtest bcs0: SUCCESS (1.046s) [339.930884] Starting dynamic subtest: vcs0 [340.968431] Dynamic subtest vcs0: SUCCESS (1.046s) [340.977948] Starting dynamic subtest: vcs1 [342.016550] Dynamic subtest vcs1: SUCCESS (1.047s) [342.026143] Starting dynamic subtest: vecs0 [343.064278] Dynamic subtest vecs0: SUCCESS (1.047s) [343.073836] Starting dynamic subtest: vecs1 [344.112340] Dynamic subtest vecs1: SUCCESS (1.047s) [344.121747] Starting dynamic subtest: ccs0 [345.159067] Dynamic subtest ccs0: SUCCESS (1.046s) [345.167390] Starting dynamic subtest: ccs1 [346.205526] Dynamic subtest ccs1: SUCCESS (1.045s) [346.216434] Starting dynamic subtest: ccs2 [347.255106] Dynamic subtest ccs2: SUCCESS (1.048s) [347.265508] Starting dynamic subtest: ccs3 [348.303622] Dynamic subtest ccs3: SUCCESS (1.047s) [348.305490] Subtest multi-client: SUCCESS (10.503s) [348.367603] [046/143] (651s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [350.315376] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [351.565221] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.250s) [351.653607] [047/143] (648s left) kms_big_fb (linear-32bpp-rotate-270) [353.601305] Starting subtest: linear-32bpp-rotate-270 [353.648592] Subtest linear-32bpp-rotate-270: SKIP (0.047s) [353.713989] [048/143] (646s left) gem_exec_schedule (semaphore-noskip) [353.826567] Starting subtest: semaphore-noskip [355.803915] Subtest semaphore-noskip: SUCCESS (1.977s) [356.085661] [049/143] (644s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [358.033755] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [358.948457] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.914s) [359.065697] [050/143] (641s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [361.035248] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [361.036191] Starting dynamic subtest: pipe-A-valid-mode [361.071220] Dynamic subtest pipe-A-valid-mode: SKIP (0.034s) [361.072931] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.035s) [361.121663] [051/143] (639s left) i915_suspend (basic-s2idle-without-i915) [361.164660] Starting subtest: basic-s2idle-without-i915 [381.711405] Subtest basic-s2idle-without-i915: SUCCESS (5.654s) [383.708789] [052/143] (632s left) gem_exec_params (rsvd2-dirt) [383.765409] Starting subtest: rsvd2-dirt [383.767113] Subtest rsvd2-dirt: SKIP (0.000s) [383.806320] [053/143] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [385.744209] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [385.745849] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [385.787195] [054/143] (630s left) gen9_exec_parse (secure-batches) [385.841433] Subtest secure-batches: SKIP (0.000s) [385.869178] [055/143] (630s left) gem_exec_flush (basic-uc-pro-default) [385.960937] Subtest basic-uc-pro-default: SKIP (0.000s) [385.998735] [056/143] (630s left) gem_mmap (bad-object) [386.046583] Subtest bad-object: SKIP (0.000s) [386.072409] [057/143] (630s left) gem_ctx_isolation (preservation-s3) [386.127738] Starting subtest: preservation-S3 [386.128695] Starting dynamic subtest: rcs0 [405.938265] Dynamic subtest rcs0: SUCCESS (3.953s) [405.945655] Starting dynamic subtest: bcs0 [425.943813] Dynamic subtest bcs0: SUCCESS (3.566s) [425.951198] Starting dynamic subtest: vcs0 [445.877627] Dynamic subtest vcs0: SUCCESS (3.571s) [445.885033] Starting dynamic subtest: vcs1 [466.011162] Dynamic subtest vcs1: SUCCESS (3.675s) [466.018968] Starting dynamic subtest: vecs0 [485.943671] Dynamic subtest vecs0: SUCCESS (3.674s) [485.951088] Starting dynamic subtest: vecs1 [505.873091] Dynamic subtest vecs1: SUCCESS (3.530s) [505.880999] Starting dynamic subtest: ccs0 [525.929482] Dynamic subtest ccs0: SUCCESS (3.608s) [525.937436] Starting dynamic subtest: ccs1 [545.947363] Dynamic subtest ccs1: SUCCESS (3.625s) [545.955101] Starting dynamic subtest: ccs2 [565.972336] Dynamic subtest ccs2: SUCCESS (3.703s) [565.980153] Starting dynamic subtest: ccs3 [585.907079] Dynamic subtest ccs3: SUCCESS (3.633s) [585.907946] Subtest preservation-S3: SUCCESS (36.542s) [590.147489] [058/143] (593s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf-tiled-ccs) [592.154745] Starting subtest: pipe-A-crc-sprite-planes-basic-yf-tiled-ccs [592.157605] Subtest pipe-A-crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.002s) [592.270519] [059/143] (591s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [594.215080] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [594.216739] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [594.253497] [060/143] (589s left) gem_exec_alignment (pi-isolated) [594.313653] Starting subtest: pi-isolated [606.581284] Killing the test because the kernel is tainted. [613.347519] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1854 [max: 8192] direct dependencies: 19004 [max: 32768] indirect dependencies: 156651 all direct dependencies: 387932 dependency chains: 28226 [max: 131072] dependency chain hlocks used: 124685 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 238 in-softirq chains: 755 in-process chains: 27233 stack-trace entries: 203590 [max: 1048576] number of stack traces: 10137 number of stack hash chains: 7564 combined max dependencies: 625780760 hardirq-safe locks: 107 hardirq-unsafe locks: 1098 softirq-safe locks: 204 softirq-unsafe locks: 1009 irq-safe locks: 229 irq-unsafe locks: 1098 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 316 softirq-read-safe locks: 7 softirq-read-unsafe locks: 311 irq-read-safe locks: 7 irq-read-unsafe locks: 316 uncategorized locks: 325 unused locks: 1 max locking depth: 16 max bfs queue depth: 428 max lock class index: 1853 chain lookup misses: 32877 chain lookup hits: 933454512 cyclic checks: 33554 redundant checks: 0 redundant links: 0 find-mask forwards checks: 5686 find-mask backwards checks: 2985 hardirq on events: 690568448 hardirq off events: 690568442 redundant hardirq ons: 64 redundant hardirq offs: 135 softirq on events: 256332 softirq off events: 256332 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 178 zapped lock chains: 4546 large chain blocks: 1 [613.348676] Closing watchdogs Done.