[25.092377] Initializing watchdogs [25.092436] /dev/watchdog0 [25.096959] [001/141] (960s left) gem_create (create-massive) [25.146995] Starting subtest: create-massive [25.147733] Subtest create-massive: SUCCESS (0.000s) [25.307404] [002/141] (960s left) syncobj_timeline (wait-all-complex) [25.374093] Starting subtest: wait-all-complex [25.598346] Subtest wait-all-complex: SUCCESS (0.215s) [25.629476] [003/141] (959s left) kms_big_fb (y-tiled-addfb) [25.746476] Starting subtest: y-tiled-addfb [25.747213] Subtest y-tiled-addfb: SUCCESS (0.000s) [25.804267] [004/141] (959s left) gem_ctx_persistence (engines-mixed) [25.854299] Starting subtest: engines-mixed [25.855028] Starting dynamic subtest: rcs0 [25.900656] Dynamic subtest rcs0: SUCCESS (0.046s) [25.908035] Starting dynamic subtest: bcs0 [25.950671] Dynamic subtest bcs0: SUCCESS (0.050s) [25.959774] Starting dynamic subtest: vcs0 [25.999581] Dynamic subtest vcs0: SUCCESS (0.049s) [26.008316] Starting dynamic subtest: vcs1 [26.055891] Dynamic subtest vcs1: SUCCESS (0.056s) [26.064208] Starting dynamic subtest: vecs0 [26.100070] Dynamic subtest vecs0: SUCCESS (0.044s) [26.101242] Subtest engines-mixed: SUCCESS (0.245s) [26.145423] [005/141] (959s left) kms_psr (sprite_plane_move) [26.204607] Subtest sprite_plane_move: SKIP (0.000s) [26.223153] [006/141] (959s left) vc4/vc4_purgeable_bo (mark-willneed) [26.303305] Subtest mark-willneed: SKIP (0.000s) [26.331907] [007/141] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [26.443058] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [27.519723] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.078s) [27.607435] [008/141] (958s left) kms_getfb (getfb-handle-not-fb) [27.670031] Starting subtest: getfb-handle-not-fb [27.718597] Subtest getfb-handle-not-fb: SUCCESS (0.049s) [27.780014] [009/141] (957s left) kms_vblank (pipe-b-ts-continuation-modeset-rpm) [27.876154] Starting subtest: pipe-B-ts-continuation-modeset-rpm [39.675812] Subtest pipe-B-ts-continuation-modeset-rpm: SUCCESS (11.794s) [39.819648] [010/141] (945s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_ccs) [40.139560] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_ccs [40.140999] Subtest pipe-C-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.000s) [40.339525] [011/141] (945s left) gen7_exec_parse (basic-rejected) [40.391271] Subtest basic-rejected: SKIP (0.000s) [40.407431] [012/141] (945s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [40.509713] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [40.511153] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [40.564628] [013/141] (945s left) gem_exec_balancer (busy) [40.617862] Starting subtest: busy [41.037838] Subtest busy: SUCCESS (0.420s) [41.265494] [014/141] (944s left) kms_universal_plane (cursor-fb-leak-pipe-b) [41.359436] Starting subtest: cursor-fb-leak-pipe-B [41.884235] Subtest cursor-fb-leak-pipe-B: SUCCESS (0.525s) [41.982889] [015/141] (943s left) syncobj_wait (invalid-reset-bad-pad) [42.037152] Starting subtest: invalid-reset-bad-pad [42.037995] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [42.075060] [016/141] (943s left) kms_addfb_basic (unused-handle) [42.127563] Starting subtest: unused-handle [42.128474] Subtest unused-handle: SUCCESS (0.000s) [42.242108] [017/141] (943s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_mc_ccs) [42.576902] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs [42.578767] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s) [42.758746] [018/141] (943s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [42.866498] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [42.867937] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [42.916109] [019/141] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [43.017915] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [43.019669] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [43.058970] [020/141] (942s left) kms_vblank (pipe-d-query-idle-hang) [43.159375] Starting subtest: pipe-D-query-idle-hang [57.824778] Subtest pipe-D-query-idle-hang: SUCCESS (14.666s) [57.924418] [021/141] (927s left) gem_exec_create (legacy) [57.982298] Starting subtest: legacy [57.983069] Starting dynamic subtest: smem [60.028047] Dynamic subtest smem: SUCCESS (2.046s) [60.028923] Subtest legacy: SUCCESS (2.046s) [60.184881] [022/141] (925s left) kms_color (invalid-ctm-matrix-sizes) [60.295150] Starting subtest: invalid-ctm-matrix-sizes [60.295897] Starting dynamic subtest: pipe-A [60.298539] Dynamic subtest pipe-A: SUCCESS (0.004s) [60.301929] Starting dynamic subtest: pipe-B [60.304756] Dynamic subtest pipe-B: SUCCESS (0.006s) [60.308230] Starting dynamic subtest: pipe-C [60.311845] Dynamic subtest pipe-C: SUCCESS (0.007s) [60.315150] Starting dynamic subtest: pipe-D [60.319854] Dynamic subtest pipe-D: SUCCESS (0.008s) [60.320597] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.025s) [60.356764] [023/141] (925s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [60.451367] Starting subtest: plane-scaler-with-clipping-clamping-rotation [60.452957] Starting dynamic subtest: pipe-A-HDMI-A-1 [60.496315] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.042s) [60.499786] Starting dynamic subtest: pipe-B-HDMI-A-1 [60.588065] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.091s) [60.591958] Starting dynamic subtest: pipe-C-HDMI-A-1 [60.677924] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.088s) [60.681495] Starting dynamic subtest: pipe-D-HDMI-A-1 [60.770063] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.090s) [60.771496] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (0.318s) [60.889100] [024/141] (924s left) gem_exec_balancer (parallel-contexts) [61.134924] Starting subtest: parallel-contexts [62.610995] Subtest parallel-contexts: SUCCESS (1.476s) [62.639472] [025/141] (923s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [62.739621] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [62.740991] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [62.789243] [026/141] (923s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [62.837480] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [62.940858] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s) [62.989128] [027/141] (922s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [63.104862] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [63.106298] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [63.164108] [028/141] (922s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [63.264419] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [63.627885] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.363s) [63.720106] [029/141] (922s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_rc_ccs_cc) [63.982144] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs_cc [63.984417] Subtest pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [64.249841] [030/141] (921s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [64.347521] Starting subtest: cursorB-vs-flipA-legacy [64.350485] Subtest cursorB-vs-flipA-legacy: SKIP (0.003s) [64.383347] [031/141] (921s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs_cc) [64.542182] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc [64.543748] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [64.904453] [032/141] (921s left) gem_render_copy (yf-tiled) [64.958106] Starting subtest: yf-tiled [64.958978] Starting dynamic subtest: smem [65.029706] Dynamic subtest smem: SUCCESS (0.071s) [65.030471] Subtest yf-tiled: SUCCESS (0.071s) [65.176973] [033/141] (920s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [65.284575] Starting subtest: yf-tiled-64bpp-rotate-0 [65.285997] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [65.337650] [034/141] (920s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [65.432718] Starting subtest: plane-use-after-nonblocking-unbind [65.434271] Starting dynamic subtest: pipe-A-HDMI-A-1 [65.492413] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.058s) [65.556659] Starting dynamic subtest: pipe-B-HDMI-A-1 [65.687979] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.134s) [65.736884] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.304s) [65.830797] [035/141] (920s left) kms_busy (extended-pageflip-hang-newfb) [65.934398] Starting subtest: extended-pageflip-hang-newfb [65.936051] Starting dynamic subtest: pipe-A [67.342594] Dynamic subtest pipe-A: SUCCESS (1.407s) [67.353983] Starting dynamic subtest: pipe-D [68.762685] Dynamic subtest pipe-D: SUCCESS (1.412s) [68.763473] Subtest extended-pageflip-hang-newfb: SUCCESS (2.829s) [68.865743] [036/141] (917s left) gem_ctx_exec (basic-close-race) [68.914653] Starting subtest: basic-close-race [74.342775] Subtest basic-close-race: SUCCESS (5.419s) [75.398646] [037/141] (910s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [75.489442] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [75.502654] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.013s) [75.541270] [038/141] (910s left) gem_lmem_swapping (parallel-random-verify) [75.590884] Subtest parallel-random-verify: SKIP (0.000s) [75.609664] [039/141] (910s left) gem_workarounds (suspend-resume-context) [75.663901] Starting subtest: suspend-resume-context [92.174760] Subtest suspend-resume-context: SUCCESS (1.326s) [98.263867] [040/141] (908s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [98.376221] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [98.377856] Starting dynamic subtest: pipe-A-valid-mode [98.427261] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s) [98.428692] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.051s) [98.497239] [041/141] (908s left) v3d/v3d_submit_cl (valid-multisync-submission) [98.560612] Subtest valid-multisync-submission: SKIP (0.000s) [98.588716] [042/141] (908s left) gem_softpin (evict-prime) [98.636324] Starting subtest: evict-prime [98.637117] Starting dynamic subtest: rcs0 [99.758242] Dynamic subtest rcs0: SUCCESS (1.121s) [99.769888] Starting dynamic subtest: bcs0 [100.868052] Dynamic subtest bcs0: SUCCESS (1.110s) [100.878926] Starting dynamic subtest: vcs0 [101.973824] Dynamic subtest vcs0: SUCCESS (1.106s) [101.983693] Starting dynamic subtest: vcs1 [103.089121] Dynamic subtest vcs1: SUCCESS (1.115s) [103.101856] Starting dynamic subtest: vecs0 [104.201076] Dynamic subtest vecs0: SUCCESS (1.112s) [104.212747] Starting dynamic subtest: all [105.323169] Dynamic subtest all: SUCCESS (1.122s) [105.324550] Subtest evict-prime: SUCCESS (6.686s) [105.371152] [043/141] (901s left) kms_cursor_crc (cursor-offscreen-32x10) [105.493904] Starting subtest: cursor-offscreen-32x10 [105.536449] Subtest cursor-offscreen-32x10: SKIP (0.040s) [105.590422] [044/141] (901s left) syncobj_basic (bad-flags-handle-to-fd) [105.638197] Starting subtest: bad-flags-handle-to-fd [105.638914] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [105.673762] [045/141] (901s left) gem_exec_schedule (u-submit-early-slice) [105.730018] Starting subtest: u-submit-early-slice [105.730770] Starting dynamic subtest: rcs0 [105.759152] Dynamic subtest rcs0: SUCCESS (0.029s) [105.763451] Starting dynamic subtest: bcs0 [105.784974] Dynamic subtest bcs0: SUCCESS (0.026s) [105.789546] Starting dynamic subtest: vcs0 [105.809063] Dynamic subtest vcs0: SUCCESS (0.024s) [105.813385] Starting dynamic subtest: vcs1 [105.835102] Dynamic subtest vcs1: SUCCESS (0.026s) [105.839539] Starting dynamic subtest: vecs0 [105.860308] Dynamic subtest vecs0: SUCCESS (0.025s) [105.861040] Subtest u-submit-early-slice: SUCCESS (0.130s) [106.142375] [046/141] (901s left) gem_exec_reloc (basic-wc-read-active) [106.203069] Starting subtest: basic-wc-read-active [106.319774] Subtest basic-wc-read-active: SUCCESS (0.116s) [106.415616] [047/141] (900s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [106.517303] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [106.518751] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [106.582235] [048/141] (900s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [106.678794] Starting subtest: flip-vs-cursor-crc-atomic [106.986121] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.308s) [107.076823] [049/141] (900s left) kms_plane (plane-panning-bottom-right) [107.172871] Starting subtest: plane-panning-bottom-right [107.174667] Starting dynamic subtest: pipe-A-planes [107.487887] Dynamic subtest pipe-A-planes: SUCCESS (0.314s) [107.495005] Starting dynamic subtest: pipe-B-planes [108.084841] Dynamic subtest pipe-B-planes: SUCCESS (0.593s) [108.085687] Subtest plane-panning-bottom-right: SUCCESS (0.912s) [108.179056] [050/141] (899s left) gem_userptr_blits (sync-unmap-cycles) [108.236698] Starting subtest: sync-unmap-cycles [113.607211] Subtest sync-unmap-cycles: SUCCESS (5.370s) [113.686112] [051/141] (893s left) gem_exec_fence (basic-busy-all) [113.741708] Starting subtest: basic-busy-all [113.776754] Subtest basic-busy-all: SUCCESS (0.035s) [114.338635] [052/141] (893s left) kms_addfb_basic (bad-pitch-0) [114.397649] Starting subtest: bad-pitch-0 [114.398443] Subtest bad-pitch-0: SUCCESS (0.000s) [114.496786] [053/141] (892s left) gem_exec_fence (syncobj-signal) [114.820324] Starting subtest: syncobj-signal [114.822258] Subtest syncobj-signal: SUCCESS (0.002s) [115.090789] [054/141] (892s left) perf (gen12-oa-tlb-invalidate) [115.197054] Starting subtest: gen12-oa-tlb-invalidate [115.197833] Starting dynamic subtest: 0-rcs0 [125.256255] Dynamic subtest 0-rcs0: SUCCESS (10.059s) [125.257169] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.059s) [125.271628] [055/141] (882s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc) [125.688452] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc [125.689825] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [125.811095] [056/141] (881s left) kms_pipe_crc_basic (read-crc-frame-sequence) [125.909474] Starting subtest: read-crc-frame-sequence [125.910270] Starting dynamic subtest: pipe-A-HDMI-A-1 [126.198108] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.288s) [126.204826] Starting dynamic subtest: pipe-B-HDMI-A-1 [126.752079] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.551s) [126.759670] Starting dynamic subtest: pipe-C-HDMI-A-1 [127.568351] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.812s) [127.575098] Starting dynamic subtest: pipe-D-HDMI-A-1 [128.644888] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.074s) [128.645656] Subtest read-crc-frame-sequence: SUCCESS (2.735s) [128.716880] [057/141] (878s left) i915_getparams_basic (basic-subslice-total) [128.769483] Starting subtest: basic-subslice-total [128.771089] Subtest basic-subslice-total: SUCCESS (0.000s) [128.808439] [058/141] (878s left) gem_mmap_wc (write-gtt-read-wc) [128.861201] Starting subtest: write-gtt-read-wc [129.177373] Subtest write-gtt-read-wc: SUCCESS (0.317s) [129.234032] [059/141] (878s left) gem_workarounds (basic-read-fd) [129.290806] Starting subtest: basic-read-fd [129.297744] Subtest basic-read-fd: SUCCESS (0.007s) [129.365668] [060/141] (878s left) i915_pm_rc6_residency (rc6-idle) [129.417117] Starting subtest: rc6-idle [129.417819] Starting dynamic subtest: rcs0 [141.626441] Dynamic subtest rcs0: SUCCESS (12.211s) [141.633237] Starting dynamic subtest: bcs0 [153.878637] Dynamic subtest bcs0: FAIL (12.228s) [153.886769] Starting dynamic subtest: vcs0 [166.065313] Dynamic subtest vcs0: SUCCESS (12.210s) [166.072921] Starting dynamic subtest: vecs0 [178.277545] Dynamic subtest vecs0: SUCCESS (12.212s) [178.278961] Subtest rc6-idle: FAIL (48.865s) [178.514949] [061/141] (828s left) i915_selftest (mock) [179.336685] Starting subtest: mock [179.337926] Starting dynamic subtest: sanitycheck [179.527502] Dynamic subtest sanitycheck: SUCCESS (0.191s) [179.535457] Starting dynamic subtest: shmem [179.689445] Dynamic subtest shmem: SUCCESS (0.161s) [179.697399] Starting dynamic subtest: fence [186.458559] Dynamic subtest fence: SUCCESS (6.768s) [186.465700] Starting dynamic subtest: scatterlist [187.613496] Dynamic subtest scatterlist: SUCCESS (1.154s) [187.618814] Starting dynamic subtest: syncmap [190.004865] Dynamic subtest syncmap: SUCCESS (2.390s) [190.011871] Starting dynamic subtest: uncore [190.160610] Dynamic subtest uncore: SUCCESS (0.155s) [190.168346] Starting dynamic subtest: ring [190.319405] Dynamic subtest ring: SUCCESS (0.158s) [190.326957] Starting dynamic subtest: engine [190.480453] Dynamic subtest engine: SUCCESS (0.160s) [190.488566] Starting dynamic subtest: timelines [194.141996] Dynamic subtest timelines: SUCCESS (3.660s) [194.149112] Starting dynamic subtest: requests [196.314064] Dynamic subtest requests: SUCCESS (2.171s) [196.321768] Starting dynamic subtest: objects [196.555882] Dynamic subtest objects: SUCCESS (0.241s) [196.563356] Starting dynamic subtest: phys [196.797820] Dynamic subtest phys: SUCCESS (0.241s) [196.806093] Starting dynamic subtest: dmabuf [197.049875] Dynamic subtest dmabuf: SUCCESS (0.251s) [197.057457] Starting dynamic subtest: vma [204.592480] Dynamic subtest vma: SUCCESS (7.542s) [204.598974] Starting dynamic subtest: evict [205.452694] Dynamic subtest evict: FAIL (0.847s) [205.454213] Subtest mock: FAIL (26.104s) [205.565564] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1640 [max: 8192] direct dependencies: 15252 [max: 32768] indirect dependencies: 84589 all direct dependencies: 296390 dependency chains: 20093 [max: 131072] dependency chain hlocks used: 78646 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 159 in-softirq chains: 633 in-process chains: 19301 stack-trace entries: 172744 [max: 1048576] number of stack traces: 9046 number of stack hash chains: 6901 combined max dependencies: 1957994880 hardirq-safe locks: 87 hardirq-unsafe locks: 983 softirq-safe locks: 177 softirq-unsafe locks: 896 irq-safe locks: 199 irq-unsafe locks: 983 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 291 softirq-read-safe locks: 7 softirq-read-unsafe locks: 286 irq-read-safe locks: 7 irq-read-unsafe locks: 291 uncategorized locks: 274 unused locks: 1 max locking depth: 15 max bfs queue depth: 397 max lock class index: 1816 chain lookup misses: 26455 chain lookup hits: 204171425 cyclic checks: 26344 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4397 find-mask backwards checks: 3042 hardirq on events: 120385360 hardirq off events: 120385352 redundant hardirq ons: 36 redundant hardirq offs: 13 softirq on events: 490082 softirq off events: 490082 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 463 zapped lock chains: 6194 large chain blocks: 1 [205.566685] Closing watchdogs Done.