[46.436884] Initializing watchdogs [46.436965] /dev/watchdog0 [46.444317] [001/142] (960s left) gem_ctx_persistence (legacy-engines-cleanup) [46.531630] Starting subtest: legacy-engines-cleanup [46.533381] Starting dynamic subtest: render [46.588985] Dynamic subtest render: SUCCESS (0.057s) [46.595012] Starting dynamic subtest: bsd1 [46.622995] Dynamic subtest bsd1: SUCCESS (0.034s) [46.630772] Starting dynamic subtest: bsd2 [46.665711] Dynamic subtest bsd2: SUCCESS (0.041s) [46.689301] Starting dynamic subtest: blt [46.696324] Dynamic subtest blt: SUCCESS (0.027s) [46.714506] Starting dynamic subtest: vebox [46.737508] Dynamic subtest vebox: SUCCESS (0.039s) [46.739200] Subtest legacy-engines-cleanup: SUCCESS (0.201s) [46.856200] [002/142] (960s left) kms_vblank (pipe-b-query-busy) [48.848865] Starting subtest: pipe-B-query-busy [51.693601] Subtest pipe-B-query-busy: SUCCESS (2.844s) [51.815316] [003/142] (955s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_rc_ccs) [54.098153] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs [54.101850] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s) [54.317040] [004/142] (952s left) v3d/v3d_perfmon (get-values-invalid-perfmon) [54.418392] Subtest get-values-invalid-perfmon: SKIP (0.000s) [54.465832] [005/142] (952s left) kms_psr2_sf (primary-plane-update-sf-dmg-area-big-fb) [54.537888] Subtest primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [54.557902] [006/142] (952s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [56.536931] Starting subtest: basic-flip-before-cursor-legacy [57.593341] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.055s) [57.734021] [007/142] (949s left) gem_create (create-ext-cpu-access-sanity-check) [57.917262] Starting subtest: create-ext-cpu-access-sanity-check [57.921489] Subtest create-ext-cpu-access-sanity-check: SUCCESS (0.007s) [58.048034] [008/142] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [60.028769] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [60.031400] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [60.098977] [009/142] (946s left) i915_pm_rpm (gem-mmap-type) [64.481581] Starting subtest: gem-mmap-type [64.484780] Starting dynamic subtest: fixed-lmem0 [71.557676] Dynamic subtest fixed-lmem0: SUCCESS (7.076s) [71.563346] Starting dynamic subtest: fixed-smem0 [78.490896] Dynamic subtest fixed-smem0: SUCCESS (6.932s) [78.492544] Subtest gem-mmap-type: SUCCESS (14.009s) [79.535332] [010/142] (927s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt) [81.559958] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt [83.906337] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (2.349s) [84.040844] [011/142] (923s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [86.027729] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [86.029615] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [86.116784] [012/142] (920s left) v3d/v3d_wait_bo (unused-bo-0ns) [86.219024] Subtest unused-bo-0ns: SKIP (0.000s) [86.270671] [013/142] (920s left) syncobj_timeline (invalid-transfer-non-existent-point) [86.356801] Starting subtest: invalid-transfer-non-existent-point [86.357892] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [86.417611] [014/142] (920s left) api_intel_allocator (reloc-allocator) [86.488190] Starting subtest: reloc-allocator [86.489134] Starting dynamic subtest: basic [86.501514] Dynamic subtest basic: SUCCESS (0.014s) [86.507247] Starting dynamic subtest: parallel-one [86.508112] Dynamic subtest parallel-one: SUCCESS (0.006s) [86.513179] Starting dynamic subtest: print [86.514048] Dynamic subtest print: SUCCESS (0.000s) [86.519277] Starting dynamic subtest: reuse [86.520176] Dynamic subtest reuse: SUCCESS (0.000s) [86.525254] Starting dynamic subtest: fork-reopen-allocator [86.526131] Dynamic subtest fork-reopen-allocator: SUCCESS (0.017s) [86.526966] Subtest reloc-allocator: SUCCESS (0.037s) [86.652385] [015/142] (920s left) fbdev (info) [86.758275] Starting subtest: info [86.759321] Subtest info: SUCCESS (0.000s) [86.815249] [016/142] (920s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs) [89.053141] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs [89.055696] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s) [89.294188] [017/142] (917s left) gem_userptr_blits (map-fixed-invalidate) [89.378460] Starting subtest: map-fixed-invalidate [89.380429] Subtest map-fixed-invalidate: SKIP (0.000s) [89.477194] [018/142] (917s left) kms_psr (cursor_render) [89.546304] Subtest cursor_render: SKIP (0.000s) [89.568668] [019/142] (917s left) gem_ctx_engines (invalid-engines) [89.645420] Starting subtest: invalid-engines [89.663149] Subtest invalid-engines: SUCCESS (0.018s) [89.886340] [020/142] (917s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [91.864241] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [91.866220] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [91.943465] [021/142] (915s left) kms_big_fb (y-tiled-64bpp-rotate-90) [93.953452] Starting subtest: y-tiled-64bpp-rotate-90 [94.006962] Subtest y-tiled-64bpp-rotate-90: SKIP (0.053s) [94.093884] [022/142] (913s left) gem_exec_schedule (preempt-self) [94.175740] Starting subtest: preempt-self [94.176674] Starting dynamic subtest: rcs0 [94.210487] Dynamic subtest rcs0: SUCCESS (0.035s) [94.215749] Starting dynamic subtest: bcs0 [94.230753] Dynamic subtest bcs0: SUCCESS (0.020s) [94.236181] Starting dynamic subtest: vcs0 [94.249958] Dynamic subtest vcs0: SUCCESS (0.019s) [94.255387] Starting dynamic subtest: vcs1 [94.267856] Dynamic subtest vcs1: SUCCESS (0.018s) [94.273110] Starting dynamic subtest: vecs0 [94.289118] Dynamic subtest vecs0: SUCCESS (0.021s) [94.289953] Subtest preempt-self: SUCCESS (0.113s) [94.656361] [023/142] (912s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs_cc) [96.969446] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc [96.971085] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [97.134569] [024/142] (910s left) perf (stress-open-close) [97.280389] Starting subtest: stress-open-close [97.281257] Starting dynamic subtest: 0-rcs0 [99.501156] Dynamic subtest 0-rcs0: SUCCESS (2.221s) [99.502123] Subtest stress-open-close: SUCCESS (2.221s) [99.533043] [025/142] (907s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling) [101.510578] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling [101.511607] Starting dynamic subtest: pipe-A-valid-mode [101.561460] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s) [101.563557] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.050s) [101.647293] [026/142] (905s left) gen7_exec_parse (load-register-reg) [101.720733] Subtest load-register-reg: SKIP (0.000s) [101.739425] [027/142] (905s left) kms_universal_plane (universal-plane-pipe-a-functional) [103.713262] Starting subtest: universal-plane-pipe-A-functional [105.823399] Subtest universal-plane-pipe-A-functional: SUCCESS (2.111s) [105.937365] [028/142] (901s left) i915_pm_rpm (gem-execbuf) [110.400819] Starting subtest: gem-execbuf [110.402028] Starting dynamic subtest: lmem0 [122.154769] Dynamic subtest lmem0: SUCCESS (11.753s) [122.163148] Starting dynamic subtest: smem0 [131.243497] Dynamic subtest smem0: SUCCESS (9.089s) [131.244650] Subtest gem-execbuf: SUCCESS (20.843s) [132.371658] [029/142] (874s left) kms_pipe_crc_basic (read-crc) [134.344463] Starting subtest: read-crc [134.347165] Starting dynamic subtest: pipe-A-HDMI-A-4 [134.961332] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.615s) [134.970766] Starting dynamic subtest: pipe-B-HDMI-A-4 [135.803064] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.837s) [135.812350] Starting dynamic subtest: pipe-C-HDMI-A-4 [137.031509] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (1.222s) [137.037683] Starting dynamic subtest: pipe-D-HDMI-A-4 [138.625822] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (1.590s) [138.626825] Subtest read-crc: SUCCESS (4.278s) [138.742394] [030/142] (868s left) kms_vblank (pipe-a-wait-forked-busy-hang) [140.717516] Starting subtest: pipe-A-wait-forked-busy-hang [154.866248] Subtest pipe-A-wait-forked-busy-hang: SUCCESS (14.148s) [154.976525] [031/142] (852s left) kms_vblank (pipe-b-ts-continuation-dpms-suspend) [156.950399] Starting subtest: pipe-B-ts-continuation-dpms-suspend [178.461614] Subtest pipe-B-ts-continuation-dpms-suspend: SUCCESS (9.579s) [183.821334] [032/142] (840s left) kms_ccs (pipe-a-bad-aux-stride-yf_tiled_ccs) [185.915221] Starting subtest: pipe-A-bad-aux-stride-yf_tiled_ccs [185.917390] Subtest pipe-A-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s) [186.326981] [033/142] (838s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [188.306903] Starting subtest: primary-4-tiled-reflect-x-0 [188.410034] Subtest primary-4-tiled-reflect-x-0: SKIP (0.104s) [188.495697] [034/142] (836s left) kms_force_connector_basic (force-connector-state) [188.659143] Starting subtest: force-connector-state [192.363932] Subtest force-connector-state: SUCCESS (3.705s) [194.601984] [035/142] (830s left) kms_big_fb (x-tiled-8bpp-rotate-270) [196.592977] Starting subtest: x-tiled-8bpp-rotate-270 [196.663949] Subtest x-tiled-8bpp-rotate-270: SKIP (0.069s) [196.752439] [036/142] (827s left) gem_exec_fence (nb-await) [196.961828] Starting subtest: nb-await [196.963150] Starting dynamic subtest: rcs0 [197.051016] Dynamic subtest rcs0: SUCCESS (0.091s) [197.060006] Starting dynamic subtest: bcs0 [197.113046] Dynamic subtest bcs0: SUCCESS (0.061s) [197.136965] Starting dynamic subtest: vcs0 [197.194430] Dynamic subtest vcs0: SUCCESS (0.079s) [197.225669] Starting dynamic subtest: vcs1 [197.282843] Dynamic subtest vcs1: SUCCESS (0.085s) [197.317378] Starting dynamic subtest: vecs0 [197.372416] Dynamic subtest vecs0: SUCCESS (0.087s) [197.374903] Subtest nb-await: SUCCESS (0.413s) [198.008494] [037/142] (826s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [200.001162] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [200.003161] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [200.068443] [038/142] (824s left) kms_plane_multiple (tiling-none) [202.054735] Starting subtest: tiling-none [202.055891] Starting dynamic subtest: pipe-A-HDMI-A-4 [202.797271] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.742s) [202.804649] Starting dynamic subtest: pipe-B-HDMI-A-4 [203.464479] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.665s) [203.473394] Starting dynamic subtest: pipe-C-HDMI-A-4 [204.067595] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.600s) [204.078442] Starting dynamic subtest: pipe-D-HDMI-A-4 [204.693940] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.623s) [204.694779] Subtest tiling-none: SUCCESS (2.641s) [204.840071] [039/142] (819s left) kms_lease (lease_unleased_connector) [206.800451] Starting subtest: lease_unleased_connector [206.801278] Starting dynamic subtest: pipe-A-HDMI-A-4 [206.858281] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.057s) [206.867311] Starting dynamic subtest: pipe-B-HDMI-A-4 [206.917055] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.057s) [206.925945] Starting dynamic subtest: pipe-C-HDMI-A-4 [206.977133] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.057s) [206.986097] Starting dynamic subtest: pipe-D-HDMI-A-4 [207.035265] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.056s) [207.036192] Subtest lease_unleased_connector: SUCCESS (0.236s) [207.093817] [040/142] (817s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [209.078604] Starting subtest: yf-tiled-8bpp-rotate-90 [209.080675] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [209.157081] [041/142] (815s left) kms_setmode (basic-clone-single-crtc) [209.227646] Starting subtest: basic-clone-single-crtc [209.230905] Subtest basic-clone-single-crtc: SKIP (0.000s) [209.289892] [042/142] (815s left) api_intel_bb (intel-bb-blit-y) [209.360503] Starting subtest: intel-bb-blit-y [210.702259] Subtest intel-bb-blit-y: SUCCESS (1.338s) [210.797965] [043/142] (814s left) kms_chamelium_color (ctm-0-75) [212.775661] Subtest ctm-0-75: SKIP (0.000s) [212.798291] [044/142] (812s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [214.783038] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [214.784973] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [214.872426] [045/142] (809s left) i915_selftest (mock) [216.415975] Starting subtest: mock [216.418414] Starting dynamic subtest: sanitycheck [216.660768] Dynamic subtest sanitycheck: SUCCESS (0.246s) [216.669759] Starting dynamic subtest: shmem [216.890912] Dynamic subtest shmem: SUCCESS (0.229s) [216.901078] Starting dynamic subtest: fence [224.267423] Dynamic subtest fence: SUCCESS (7.375s) [224.278149] Starting dynamic subtest: scatterlist [225.478468] Dynamic subtest scatterlist: SUCCESS (1.209s) [225.484815] Starting dynamic subtest: syncmap [227.831754] Dynamic subtest syncmap: SUCCESS (2.349s) [227.839468] Starting dynamic subtest: uncore [228.036645] Dynamic subtest uncore: SUCCESS (0.207s) [228.043949] Starting dynamic subtest: ring [228.244481] Dynamic subtest ring: SUCCESS (0.207s) [228.251968] Starting dynamic subtest: engine [228.463518] Dynamic subtest engine: SUCCESS (0.218s) [228.471792] Starting dynamic subtest: timelines [233.078547] Dynamic subtest timelines: SUCCESS (4.611s) [233.085245] Starting dynamic subtest: requests [235.280524] Dynamic subtest requests: SUCCESS (2.201s) [235.286828] Starting dynamic subtest: objects [235.594698] Dynamic subtest objects: SUCCESS (0.313s) [235.602942] Starting dynamic subtest: phys [235.894756] Dynamic subtest phys: SUCCESS (0.299s) [235.902571] Starting dynamic subtest: dmabuf [236.197737] Dynamic subtest dmabuf: SUCCESS (0.302s) [236.206954] Starting dynamic subtest: vma [247.640683] Dynamic subtest vma: SUCCESS (11.442s) [247.648204] Starting dynamic subtest: evict [248.910574] Dynamic subtest evict: FAIL (1.256s) [248.912795] Subtest mock: FAIL (32.483s) [249.082580] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1693 [max: 8192] direct dependencies: 16516 [max: 32768] indirect dependencies: 102503 all direct dependencies: 295552 dependency chains: 22354 [max: 131072] dependency chain hlocks used: 92041 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 160 in-softirq chains: 638 in-process chains: 21556 stack-trace entries: 188433 [max: 1048576] number of stack traces: 9684 number of stack hash chains: 7340 combined max dependencies: 2217762603 hardirq-safe locks: 81 hardirq-unsafe locks: 1011 softirq-safe locks: 178 softirq-unsafe locks: 922 irq-safe locks: 195 irq-unsafe locks: 1011 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 300 softirq-read-safe locks: 8 softirq-read-unsafe locks: 295 irq-read-safe locks: 8 irq-read-unsafe locks: 300 uncategorized locks: 296 unused locks: 1 max locking depth: 15 max bfs queue depth: 429 max lock class index: 1869 chain lookup misses: 29271 chain lookup hits: 261234212 cyclic checks: 29285 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4848 find-mask backwards checks: 3099 hardirq on events: 137925348 hardirq off events: 137925342 redundant hardirq ons: 32 redundant hardirq offs: 16 softirq on events: 314876 softirq off events: 314876 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 462 zapped lock chains: 6802 large chain blocks: 1 [249.083684] Closing watchdogs Done.