[27.714936] Initializing watchdogs [27.714993] /dev/watchdog0 [27.719521] [001/142] (960s left) gem_ctx_persistence (legacy-engines-cleanup) [27.774254] Starting subtest: legacy-engines-cleanup [27.775030] Starting dynamic subtest: render [27.809804] Dynamic subtest render: SUCCESS (0.034s) [27.818836] Starting dynamic subtest: bsd1 [27.847796] Dynamic subtest bsd1: SUCCESS (0.038s) [27.856518] Starting dynamic subtest: bsd2 [27.880675] Dynamic subtest bsd2: SUCCESS (0.033s) [27.889324] Starting dynamic subtest: blt [27.914554] Dynamic subtest blt: SUCCESS (0.033s) [27.922569] Starting dynamic subtest: vebox [27.949877] Dynamic subtest vebox: SUCCESS (0.035s) [27.951166] Subtest legacy-engines-cleanup: SUCCESS (0.175s) [27.996180] [002/142] (960s left) kms_vblank (pipe-b-query-busy) [28.104837] Starting subtest: pipe-B-query-busy [29.451651] Subtest pipe-B-query-busy: SUCCESS (1.346s) [29.546733] [003/142] (958s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_rc_ccs) [29.871555] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs [29.873015] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s) [30.042182] [004/142] (958s left) v3d/v3d_perfmon (get-values-invalid-perfmon) [30.114138] Subtest get-values-invalid-perfmon: SKIP (0.000s) [30.142309] [005/142] (958s left) kms_psr2_sf (primary-plane-update-sf-dmg-area-big-fb) [30.191859] Subtest primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [30.210053] [006/142] (958s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [30.305819] Starting subtest: basic-flip-before-cursor-legacy [30.887277] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.582s) [30.983399] [007/142] (957s left) gem_create (create-ext-cpu-access-sanity-check) [31.138730] Starting subtest: create-ext-cpu-access-sanity-check [31.140182] Subtest create-ext-cpu-access-sanity-check: SKIP (0.000s) [31.173898] [008/142] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [31.273687] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [31.275062] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [31.332238] [009/142] (956s left) i915_pm_rpm (gem-mmap-type) [32.850703] Starting subtest: gem-mmap-type [32.852100] Starting dynamic subtest: gtt-smem0 [35.043011] Dynamic subtest gtt-smem0: SUCCESS (2.193s) [35.047373] Starting dynamic subtest: wb-smem0 [35.746111] Dynamic subtest wb-smem0: SUCCESS (0.702s) [35.750400] Starting dynamic subtest: wc-smem0 [36.460151] Dynamic subtest wc-smem0: SUCCESS (0.714s) [36.466196] Starting dynamic subtest: uc-smem0 [37.164657] Dynamic subtest uc-smem0: SUCCESS (0.705s) [37.165422] Subtest gem-mmap-type: SUCCESS (4.315s) [37.240483] [010/142] (951s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt) [37.341442] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt [38.246909] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (0.907s) [38.335949] [011/142] (949s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [38.436681] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [38.438170] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [38.490549] [012/142] (949s left) v3d/v3d_wait_bo (unused-bo-0ns) [38.553973] Subtest unused-bo-0ns: SKIP (0.000s) [38.581702] [013/142] (949s left) syncobj_timeline (invalid-transfer-non-existent-point) [38.635508] Starting subtest: invalid-transfer-non-existent-point [38.636282] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [38.674661] [014/142] (949s left) api_intel_allocator (reloc-allocator) [38.731701] Starting subtest: reloc-allocator [38.732501] Starting dynamic subtest: basic [38.733279] Dynamic subtest basic: SUCCESS (0.001s) [38.737275] Starting dynamic subtest: parallel-one [38.738041] Dynamic subtest parallel-one: SUCCESS (0.005s) [38.741541] Starting dynamic subtest: print [38.742286] Dynamic subtest print: SUCCESS (0.000s) [38.745791] Starting dynamic subtest: reuse [38.746503] Dynamic subtest reuse: SUCCESS (0.000s) [38.753823] Starting dynamic subtest: fork-reopen-allocator [38.754684] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [38.755455] Subtest reloc-allocator: SUCCESS (0.019s) [38.823307] [015/142] (949s left) fbdev (info) [38.881310] Starting subtest: info [38.882103] Subtest info: SUCCESS (0.000s) [38.915048] [016/142] (949s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs) [39.236840] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs [39.239043] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s) [39.429570] [017/142] (948s left) gem_userptr_blits (map-fixed-invalidate) [39.487015] Starting subtest: map-fixed-invalidate [39.487813] Starting dynamic subtest: gtt [39.569707] Dynamic subtest gtt: SUCCESS (0.082s) [39.573587] Starting dynamic subtest: wb [39.629729] Dynamic subtest wb: SUCCESS (0.060s) [39.633418] Starting dynamic subtest: wc [39.690591] Dynamic subtest wc: SUCCESS (0.061s) [39.694384] Starting dynamic subtest: uc [39.749894] Dynamic subtest uc: SUCCESS (0.059s) [39.750714] Subtest map-fixed-invalidate: SUCCESS (0.263s) [39.826575] [018/142] (948s left) kms_psr (cursor_render) [39.888094] Subtest cursor_render: SKIP (0.000s) [39.905409] [019/142] (948s left) gem_ctx_engines (invalid-engines) [39.967220] Starting subtest: invalid-engines [39.970868] Subtest invalid-engines: SUCCESS (0.004s) [40.126140] [020/142] (948s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [40.239281] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [40.240789] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [40.296735] [021/142] (948s left) kms_big_fb (y-tiled-64bpp-rotate-90) [40.399054] Starting subtest: y-tiled-64bpp-rotate-90 [40.429499] Subtest y-tiled-64bpp-rotate-90: SKIP (0.030s) [40.496297] [022/142] (947s left) gem_exec_schedule (preempt-self) [40.553303] Starting subtest: preempt-self [40.554053] Starting dynamic subtest: rcs0 [40.563770] Dynamic subtest rcs0: SUCCESS (0.010s) [40.567690] Starting dynamic subtest: bcs0 [40.572146] Dynamic subtest bcs0: SUCCESS (0.008s) [40.576110] Starting dynamic subtest: vcs0 [40.580870] Dynamic subtest vcs0: SUCCESS (0.009s) [40.585102] Starting dynamic subtest: vcs1 [40.590100] Dynamic subtest vcs1: SUCCESS (0.009s) [40.594332] Starting dynamic subtest: vecs0 [40.599910] Dynamic subtest vecs0: SUCCESS (0.010s) [40.600737] Subtest preempt-self: SUCCESS (0.047s) [40.870707] [023/142] (947s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs_cc) [41.250330] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc [41.251782] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [41.380567] [024/142] (947s left) perf (stress-open-close) [41.469685] Starting subtest: stress-open-close [41.470447] Starting dynamic subtest: 0-rcs0 [43.643428] Dynamic subtest 0-rcs0: SUCCESS (2.174s) [43.644162] Subtest stress-open-close: SUCCESS (2.174s) [43.661195] [025/142] (944s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling) [43.760461] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling [43.761180] Starting dynamic subtest: pipe-A-valid-mode [43.811357] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s) [43.812916] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.051s) [43.881269] [026/142] (944s left) gen7_exec_parse (load-register-reg) [43.930710] Subtest load-register-reg: SKIP (0.000s) [43.949268] [027/142] (944s left) kms_universal_plane (universal-plane-pipe-a-functional) [44.046875] Starting subtest: universal-plane-pipe-A-functional [45.179321] Subtest universal-plane-pipe-A-functional: SUCCESS (1.133s) [45.249189] [028/142] (943s left) i915_pm_rpm (gem-execbuf) [46.767699] Starting subtest: gem-execbuf [46.769120] Starting dynamic subtest: smem0 [47.801878] Dynamic subtest smem0: SUCCESS (1.034s) [47.802624] Subtest gem-execbuf: SUCCESS (1.035s) [47.934160] [029/142] (940s left) kms_pipe_crc_basic (read-crc) [48.031646] Starting subtest: read-crc [48.033954] Starting dynamic subtest: pipe-A-HDMI-A-1 [48.317892] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.283s) [48.332446] Starting dynamic subtest: pipe-B-HDMI-A-1 [48.591598] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.271s) [48.596905] Starting dynamic subtest: pipe-C-HDMI-A-1 [48.863539] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.269s) [48.869494] Starting dynamic subtest: pipe-D-HDMI-A-1 [49.142067] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.277s) [49.142856] Subtest read-crc: SUCCESS (1.110s) [49.213590] [030/142] (939s left) kms_vblank (pipe-a-wait-forked-busy-hang) [49.319322] Starting subtest: pipe-A-wait-forked-busy-hang [62.952422] Subtest pipe-A-wait-forked-busy-hang: SUCCESS (13.633s) [63.056348] [031/142] (925s left) kms_vblank (pipe-b-ts-continuation-dpms-suspend) [63.161967] Starting subtest: pipe-B-ts-continuation-dpms-suspend [79.401631] Subtest pipe-B-ts-continuation-dpms-suspend: SUCCESS (1.595s) [84.714076] [032/142] (923s left) kms_ccs (pipe-a-bad-aux-stride-yf_tiled_ccs) [84.908418] Starting subtest: pipe-A-bad-aux-stride-yf_tiled_ccs [84.910721] Subtest pipe-A-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s) [85.239820] [033/142] (923s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [85.360448] Starting subtest: primary-4-tiled-reflect-x-0 [85.408718] Subtest primary-4-tiled-reflect-x-0: SKIP (0.048s) [85.447744] [034/142] (922s left) kms_force_connector_basic (force-connector-state) [85.588122] Starting subtest: force-connector-state [86.010891] Subtest force-connector-state: SUCCESS (0.423s) [86.449529] [035/142] (921s left) kms_big_fb (x-tiled-8bpp-rotate-270) [86.552093] Starting subtest: x-tiled-8bpp-rotate-270 [86.597024] Subtest x-tiled-8bpp-rotate-270: SKIP (0.044s) [86.681601] [036/142] (921s left) gem_exec_fence (nb-await) [86.849427] Starting subtest: nb-await [86.850247] Starting dynamic subtest: rcs0 [86.900492] Dynamic subtest rcs0: SUCCESS (0.056s) [86.905313] Starting dynamic subtest: bcs0 [86.955404] Dynamic subtest bcs0: SUCCESS (0.055s) [86.960093] Starting dynamic subtest: vcs0 [87.010815] Dynamic subtest vcs0: SUCCESS (0.055s) [87.016411] Starting dynamic subtest: vcs1 [87.065554] Dynamic subtest vcs1: SUCCESS (0.055s) [87.071246] Starting dynamic subtest: vecs0 [87.120604] Dynamic subtest vecs0: SUCCESS (0.055s) [87.121388] Subtest nb-await: SUCCESS (0.277s) [87.564933] [037/142] (920s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [87.676050] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [87.677546] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [87.733221] [038/142] (920s left) kms_plane_multiple (tiling-none) [87.831843] Starting subtest: tiling-none [87.833728] Starting dynamic subtest: pipe-A-HDMI-A-1 [88.368182] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.535s) [88.373663] Starting dynamic subtest: pipe-B-HDMI-A-1 [88.866385] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.496s) [88.871924] Starting dynamic subtest: pipe-C-HDMI-A-1 [89.347455] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.481s) [89.353488] Starting dynamic subtest: pipe-D-HDMI-A-1 [89.875370] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.527s) [89.876111] Subtest tiling-none: SUCCESS (2.044s) [89.969607] [039/142] (918s left) kms_lease (lease_unleased_connector) [90.070112] Starting subtest: lease_unleased_connector [90.071875] Starting dynamic subtest: pipe-A-HDMI-A-1 [90.133233] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.061s) [90.139327] Starting dynamic subtest: pipe-B-HDMI-A-1 [90.198031] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.062s) [90.202499] Starting dynamic subtest: pipe-C-HDMI-A-1 [90.260871] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.061s) [90.265273] Starting dynamic subtest: pipe-D-HDMI-A-1 [90.324135] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.062s) [90.324848] Subtest lease_unleased_connector: SUCCESS (0.253s) [90.362136] [040/142] (918s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [90.465745] Starting subtest: yf-tiled-8bpp-rotate-90 [90.467211] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [90.519765] [041/142] (917s left) kms_setmode (basic-clone-single-crtc) [90.569519] Starting subtest: basic-clone-single-crtc [90.577137] Subtest basic-clone-single-crtc: SKIP (0.000s) [90.606044] [042/142] (917s left) api_intel_bb (intel-bb-blit-y) [90.664052] Starting subtest: intel-bb-blit-y [93.602672] Subtest intel-bb-blit-y: SUCCESS (2.939s) [93.670382] [043/142] (914s left) kms_chamelium_color (ctm-0-75) [93.778829] Subtest ctm-0-75: SKIP (0.000s) [93.796359] [044/142] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [93.898060] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [93.899455] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [93.953307] [045/142] (914s left) i915_selftest (mock) [94.926337] Starting subtest: mock [94.927308] Starting dynamic subtest: sanitycheck [95.099044] Dynamic subtest sanitycheck: SUCCESS (0.173s) [95.102744] Starting dynamic subtest: shmem [95.250959] Dynamic subtest shmem: SUCCESS (0.152s) [95.254480] Starting dynamic subtest: fence [102.903809] Dynamic subtest fence: SUCCESS (7.652s) [102.912763] Starting dynamic subtest: scatterlist [104.066790] Dynamic subtest scatterlist: SUCCESS (1.162s) [104.075852] Starting dynamic subtest: syncmap [106.414258] Dynamic subtest syncmap: SUCCESS (2.342s) [106.425463] Starting dynamic subtest: uncore [106.578818] Dynamic subtest uncore: SUCCESS (0.168s) [106.587973] Starting dynamic subtest: ring [106.740768] Dynamic subtest ring: SUCCESS (0.161s) [106.750042] Starting dynamic subtest: engine [106.903790] Dynamic subtest engine: SUCCESS (0.162s) [106.911834] Starting dynamic subtest: timelines [110.494129] Dynamic subtest timelines: SUCCESS (3.589s) [110.501065] Starting dynamic subtest: requests [112.648193] Dynamic subtest requests: SUCCESS (2.153s) [112.655455] Starting dynamic subtest: objects [112.892230] Dynamic subtest objects: SUCCESS (0.243s) [112.900709] Starting dynamic subtest: phys [113.147196] Dynamic subtest phys: SUCCESS (0.254s) [113.154884] Starting dynamic subtest: dmabuf [113.396220] Dynamic subtest dmabuf: SUCCESS (0.248s) [113.403443] Starting dynamic subtest: vma [120.881191] Dynamic subtest vma: SUCCESS (7.484s) [120.888317] Starting dynamic subtest: evict [121.722885] Dynamic subtest evict: FAIL (0.831s) [121.724092] Subtest mock: FAIL (26.786s) [121.844577] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1662 [max: 8192] direct dependencies: 15684 [max: 32768] indirect dependencies: 85592 all direct dependencies: 298684 dependency chains: 20969 [max: 131072] dependency chain hlocks used: 83741 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 162 in-softirq chains: 610 in-process chains: 20197 stack-trace entries: 175482 [max: 1048576] number of stack traces: 9146 number of stack hash chains: 6975 combined max dependencies: 2011579414 hardirq-safe locks: 86 hardirq-unsafe locks: 1000 softirq-safe locks: 179 softirq-unsafe locks: 912 irq-safe locks: 197 irq-unsafe locks: 1000 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 296 softirq-read-safe locks: 7 softirq-read-unsafe locks: 291 irq-read-safe locks: 7 irq-read-unsafe locks: 296 uncategorized locks: 278 unused locks: 1 max locking depth: 16 max bfs queue depth: 411 max lock class index: 1826 chain lookup misses: 27061 chain lookup hits: 134794070 cyclic checks: 26767 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4281 find-mask backwards checks: 3071 hardirq on events: 80934330 hardirq off events: 80934322 redundant hardirq ons: 46 redundant hardirq offs: 12 softirq on events: 226276 softirq off events: 226276 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 453 zapped lock chains: 5924 large chain blocks: 1 [121.845578] Closing watchdogs Done.