[54.124336] Initializing watchdogs [54.124687] /dev/watchdog0 [54.139742] [001/137] (960s left) kms_vblank (pipe-b-ts-continuation-suspend) [54.671261] Starting subtest: pipe-B-ts-continuation-suspend [73.334816] Subtest pipe-B-ts-continuation-suspend: SUCCESS (2.048s) [78.676264] [002/137] (957s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_ccs) [79.396134] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.000s) [79.716486] [003/137] (956s left) kms_big_fb (x-tiled-64bpp-rotate-180) [80.047885] Starting subtest: x-tiled-64bpp-rotate-180 [87.598758] Subtest x-tiled-64bpp-rotate-180: SUCCESS (7.549s) [88.519336] [004/137] (947s left) kms_big_fb (y-tiled-32bpp-rotate-180) [88.840049] Starting subtest: y-tiled-32bpp-rotate-180 [94.965015] Subtest y-tiled-32bpp-rotate-180: SUCCESS (6.124s) [95.469254] [005/137] (940s left) gem_exec_capture (capture-invisible) [95.681765] Starting subtest: capture-invisible [95.683068] Starting dynamic subtest: smem0 [95.685601] Dynamic subtest smem0: SKIP (0.000s) [95.688008] Subtest capture-invisible: SKIP (0.001s) [95.783549] [006/137] (940s left) gem_exec_fence (syncobj-channel) [96.511799] Starting subtest: syncobj-channel [97.581205] Subtest syncobj-channel: SUCCESS (1.067s) [97.903889] [007/137] (938s left) drm_fdinfo (virtual-busy) [98.107210] Starting subtest: virtual-busy [100.284456] Subtest virtual-busy: SUCCESS (2.177s) [100.368363] [008/137] (936s left) i915_hangman (engine-error-state-capture) [100.583809] Starting subtest: engine-error-state-capture [100.585150] Starting dynamic subtest: rcs0 [104.364282] Dynamic subtest rcs0: SUCCESS (3.780s) [104.384410] Starting dynamic subtest: bcs0 [108.395911] Dynamic subtest bcs0: SUCCESS (4.031s) [108.413920] Starting dynamic subtest: vcs0 [112.360166] Dynamic subtest vcs0: SUCCESS (3.964s) [112.377688] Starting dynamic subtest: vecs0 [116.386735] Dynamic subtest vecs0: SUCCESS (4.026s) [116.388219] Subtest engine-error-state-capture: SUCCESS (15.802s) [116.501638] [009/137] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [116.806749] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [118.897261] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.094s) [119.035547] [010/137] (917s left) syncobj_timeline (multi-wait-for-submit-available-signaled) [119.233299] Starting subtest: multi-wait-for-submit-available-signaled [119.236876] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.002s) [119.318237] [011/137] (917s left) kms_async_flips (test-cursor) [119.610076] Starting subtest: test-cursor [119.611441] Starting dynamic subtest: pipe-A-DP-1 [120.397916] Dynamic subtest pipe-A-DP-1: SUCCESS (0.788s) [120.416784] Starting dynamic subtest: pipe-B-DP-1 [121.103780] Dynamic subtest pipe-B-DP-1: SUCCESS (0.703s) [121.122292] Starting dynamic subtest: pipe-C-DP-1 [121.780732] Dynamic subtest pipe-C-DP-1: SUCCESS (0.675s) [121.782095] Subtest test-cursor: SUCCESS (2.174s) [122.370177] [012/137] (914s left) syncobj_timeline (device-signal-unordered) [122.569750] Starting subtest: device-signal-unordered [122.572654] Subtest device-signal-unordered: SUCCESS (0.002s) [122.652468] [013/137] (914s left) kms_psr2_sf (cursor-plane-move-continuous-sf) [122.844700] Subtest cursor-plane-move-continuous-sf: SKIP (0.000s) [122.901839] [014/137] (913s left) api_intel_bb (render) [123.092674] Starting subtest: render [123.094087] Starting dynamic subtest: render-none-512 [123.200716] Dynamic subtest render-none-512: SUCCESS (0.108s) [123.220106] Starting dynamic subtest: render-none-reloc-512 [123.307468] Dynamic subtest render-none-reloc-512: SUCCESS (0.106s) [123.327248] Starting dynamic subtest: render-none-1024 [123.670163] Dynamic subtest render-none-1024: SUCCESS (0.363s) [123.689139] Starting dynamic subtest: render-none-reloc-1024 [124.037551] Dynamic subtest render-none-reloc-1024: SUCCESS (0.367s) [124.057452] Starting dynamic subtest: render-x-512 [124.139172] Dynamic subtest render-x-512: SUCCESS (0.101s) [124.159475] Starting dynamic subtest: render-x-reloc-512 [124.228381] Dynamic subtest render-x-reloc-512: SUCCESS (0.088s) [124.248055] Starting dynamic subtest: render-x-1024 [124.537684] Dynamic subtest render-x-1024: SUCCESS (0.310s) [124.557485] Starting dynamic subtest: render-x-reloc-1024 [124.863286] Dynamic subtest render-x-reloc-1024: SUCCESS (0.325s) [124.883051] Starting dynamic subtest: render-y-512 [124.958643] Dynamic subtest render-y-512: SUCCESS (0.095s) [124.978240] Starting dynamic subtest: render-y-reloc-512 [125.049441] Dynamic subtest render-y-reloc-512: SUCCESS (0.090s) [125.069297] Starting dynamic subtest: render-y-1024 [125.361981] Dynamic subtest render-y-1024: SUCCESS (0.312s) [125.380960] Starting dynamic subtest: render-y-reloc-1024 [125.688262] Dynamic subtest render-y-reloc-1024: SUCCESS (0.326s) [125.689648] Subtest render: SUCCESS (2.596s) [125.786290] [015/137] (910s left) kms_plane_multiple (tiling-y) [126.077753] Starting subtest: tiling-y [126.079154] Starting dynamic subtest: pipe-A-DP-1 [127.854043] Dynamic subtest pipe-A-DP-1: SUCCESS (1.778s) [127.875927] Starting dynamic subtest: pipe-B-DP-1 [129.890813] Dynamic subtest pipe-B-DP-1: SUCCESS (2.032s) [129.911185] Starting dynamic subtest: pipe-C-DP-1 [132.050888] Dynamic subtest pipe-C-DP-1: SUCCESS (2.157s) [132.052143] Subtest tiling-y: SUCCESS (5.977s) [132.410992] [016/137] (904s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [132.629855] Starting subtest: y-tiled-ccs-to-yf-tiled [132.631201] Starting dynamic subtest: smem [133.024090] Dynamic subtest smem: SUCCESS (0.393s) [133.025445] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.394s) [133.229861] [017/137] (903s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [133.532963] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [133.536043] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [133.627393] [018/137] (903s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs) [134.189603] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs [134.192373] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s) [134.647043] [019/137] (902s left) gem_exec_params (no-blt) [134.849420] Starting subtest: no-blt [134.852785] Subtest no-blt: SUCCESS (0.003s) [134.963785] [020/137] (901s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs) [135.654137] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs [135.659332] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.004s) [135.968595] [021/137] (901s left) gem_exec_params (rs-invalid) [136.181161] Starting subtest: rs-invalid [136.189752] Subtest rs-invalid: SUCCESS (0.009s) [136.301599] [022/137] (900s left) kms_vblank (pipe-d-wait-forked-busy) [136.595603] Subtest pipe-D-wait-forked-busy: SKIP (0.000s) [136.667881] [023/137] (900s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [136.960520] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [136.963011] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [137.055278] [024/137] (900s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_ccs) [137.566104] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_ccs [138.230041] Subtest pipe-B-crc-primary-rotation-180-y_tiled_ccs: SUCCESS (0.664s) [138.866804] [025/137] (898s left) prime_mmap (test_aperture_limit) [139.061601] Starting subtest: test_aperture_limit [139.062968] Starting dynamic subtest: test_aperture_limit-smem [139.088222] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.026s) [139.089649] Subtest test_aperture_limit: SUCCESS (0.027s) [139.180972] [026/137] (897s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [139.481814] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [139.484306] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [139.564965] [027/137] (897s left) kms_cursor_legacy (torture-bo) [139.859148] Starting subtest: torture-bo [139.860501] Starting dynamic subtest: pipe-A [161.783503] Dynamic subtest pipe-A: SUCCESS (21.923s) [161.804407] Starting dynamic subtest: pipe-B [183.634542] Dynamic subtest pipe-B: SUCCESS (21.852s) [183.658057] Starting dynamic subtest: pipe-C [205.389328] Dynamic subtest pipe-C: SUCCESS (21.755s) [205.408250] Starting dynamic subtest: all-pipes [227.134810] Dynamic subtest all-pipes: SUCCESS (21.745s) [227.136422] Subtest torture-bo: SUCCESS (87.276s) [227.217741] [028/137] (810s left) gem_mmap_wc (bad-offset) [227.412199] Starting subtest: bad-offset [227.413714] Subtest bad-offset: SUCCESS (0.001s) [227.517200] [029/137] (809s left) perf (gen12-mi-rpc) [227.827239] Subtest gen12-mi-rpc: SKIP (0.000s) [227.879852] [030/137] (809s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [228.199601] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [229.676043] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.476s) [229.817764] [031/137] (807s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [230.128999] Starting subtest: yf-tiled-16bpp-rotate-180 [233.792810] Subtest yf-tiled-16bpp-rotate-180: SUCCESS (3.663s) [234.152373] [032/137] (803s left) api_intel_bb (object-noreloc-keep-cache-simple) [234.351521] Starting subtest: object-noreloc-keep-cache-simple [234.358429] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.008s) [234.499826] [033/137] (802s left) gem_ctx_shared (create-shared-gtt) [234.716938] Starting subtest: create-shared-gtt [236.870400] Subtest create-shared-gtt: SUCCESS (2.152s) [237.082734] [034/137] (800s left) syncobj_timeline (etime-single-wait-all-submitted) [237.277441] Starting subtest: etime-single-wait-all-submitted [237.388704] Subtest etime-single-wait-all-submitted: SUCCESS (0.109s) [237.484502] [035/137] (800s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [237.786115] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [237.788841] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [237.882791] [036/137] (799s left) kms_flip (2x-busy-flip) [238.158500] Starting subtest: 2x-busy-flip [238.161017] Subtest 2x-busy-flip: SKIP (0.003s) [238.266769] [037/137] (799s left) gem_ringfill (basic-all) [238.723524] Starting subtest: basic-all [239.931898] Subtest basic-all: SUCCESS (1.206s) [240.049925] [038/137] (797s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [240.337699] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [240.339079] Starting dynamic subtest: pipe-A-valid-mode [240.444790] Dynamic subtest pipe-A-valid-mode: SKIP (0.105s) [240.447790] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.108s) [240.777848] [039/137] (796s left) kms_atomic (crtc-invalid-params-fence) [241.192366] Starting subtest: crtc-invalid-params-fence [241.372285] Subtest crtc-invalid-params-fence: SUCCESS (0.181s) [241.784926] [040/137] (795s left) kms_hdr (static-toggle-suspend) [242.073804] Starting subtest: static-toggle-suspend [242.076328] Subtest static-toggle-suspend: SKIP (0.000s) [242.150708] [041/137] (795s left) kms_lease (empty_lease) [242.441546] Starting subtest: empty_lease [242.443905] Starting dynamic subtest: pipe-A-DP-1 [242.445860] Dynamic subtest pipe-A-DP-1: SUCCESS (0.002s) [242.468255] Starting dynamic subtest: pipe-B-DP-1 [242.469610] Dynamic subtest pipe-B-DP-1: SUCCESS (0.001s) [242.489125] Starting dynamic subtest: pipe-C-DP-1 [242.490477] Dynamic subtest pipe-C-DP-1: SUCCESS (0.001s) [242.491709] Subtest empty_lease: SUCCESS (0.013s) [242.550416] [042/137] (795s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [242.856410] Starting subtest: psr-rgb101010-draw-blt [242.858929] Subtest psr-rgb101010-draw-blt: SKIP (0.000s) [242.950718] [043/137] (794s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [243.145456] Starting subtest: single-wait-all-for-submit-available-submitted [243.146818] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s) [243.233432] [044/137] (794s left) kms_addfb_basic (bad-pitch-65536) [243.427262] Starting subtest: bad-pitch-65536 [243.428968] Subtest bad-pitch-65536: SUCCESS (0.001s) [243.616989] [045/137] (794s left) kms_chamelium_color (ctm-max) [243.916449] Subtest ctm-max: SKIP (0.000s) [243.966469] [046/137] (793s left) kms_big_fb (4-tiled-addfb) [244.282987] Starting subtest: 4-tiled-addfb [244.285711] Subtest 4-tiled-addfb: SKIP (0.000s) [244.383471] [047/137] (793s left) gem_exec_schedule (submit-late-slice) [244.608740] Starting subtest: submit-late-slice [244.610160] Starting dynamic subtest: rcs0 [244.668457] Dynamic subtest rcs0: SUCCESS (0.058s) [244.695756] Starting dynamic subtest: bcs0 [244.723292] Dynamic subtest bcs0: SUCCESS (0.053s) [244.746138] Starting dynamic subtest: vcs0 [244.774643] Dynamic subtest vcs0: SUCCESS (0.051s) [244.796783] Starting dynamic subtest: vecs0 [244.824564] Dynamic subtest vecs0: SUCCESS (0.049s) [244.825872] Subtest submit-late-slice: SUCCESS (0.216s) [245.168248] [048/137] (792s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [245.469041] Starting subtest: fbc-rgb565-draw-mmap-gtt [247.626597] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (2.160s) [247.768126] [049/137] (790s left) gem_exec_reloc (basic-wc-read) [247.972845] Starting subtest: basic-wc-read [247.995498] Subtest basic-wc-read: SUCCESS (0.022s) [248.184837] [050/137] (789s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [248.475894] Starting subtest: short-flip-after-cursor-toggle [249.526184] Subtest short-flip-after-cursor-toggle: SUCCESS (1.050s) [249.865750] [051/137] (788s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [250.070820] Starting subtest: basic-cpu-gtt-noreloc [250.084567] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.013s) [250.265512] [052/137] (787s left) fbdev (read) [250.475743] Starting subtest: read [251.887058] Subtest read: SUCCESS (1.411s) [251.964576] [053/137] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [252.268154] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [252.270950] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [252.364866] [054/137] (785s left) kms_addfb_basic (bad-pitch-32) [252.562075] Starting subtest: bad-pitch-32 [252.563362] Subtest bad-pitch-32: SUCCESS (0.000s) [252.764250] [055/137] (785s left) gem_exec_balancer (bonded-sync) [252.983841] Starting subtest: bonded-sync [256.773305] Subtest bonded-sync: SUCCESS (3.788s) [260.715435] [056/137] (777s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_mc_ccs) [261.259359] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_mc_ccs [261.263993] Subtest pipe-B-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s) [261.778061] [057/137] (776s left) kms_vblank (pipe-c-wait-forked-hang) [262.077582] Starting subtest: pipe-C-wait-forked-hang [269.590166] Subtest pipe-C-wait-forked-hang: SUCCESS (7.514s) [269.919572] [058/137] (768s left) kms_prime (basic-modeset-hybrid) [271.900334] Subtest basic-modeset-hybrid: SKIP (0.000s) [272.040286] [059/137] (766s left) sw_sync (sync_random_merge) [272.236046] Starting subtest: sync_random_merge [272.391320] Subtest sync_random_merge: SUCCESS (0.155s) [272.467731] [060/137] (765s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [272.759917] Starting subtest: basic-busy-flip-before-cursor-atomic [272.762517] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [272.851629] [061/137] (765s left) gem_partial_pwrite_pread (reads-uncached) [273.057948] Starting subtest: reads-uncached [279.515939] Subtest reads-uncached: SUCCESS (6.458s) [279.618613] [062/137] (758s left) vgem_basic (sysfs) [279.829701] Starting subtest: sysfs [279.831285] Subtest sysfs: SUCCESS (0.001s) [279.904767] [063/137] (758s left) v3d/v3d_submit_csd (job-perfmon) [280.164709] Subtest job-perfmon: SKIP (0.000s) [280.235695] [064/137] (758s left) i915_selftest (mock) [281.935457] Starting subtest: mock [281.936778] Starting dynamic subtest: sanitycheck [282.384734] Dynamic subtest sanitycheck: SUCCESS (0.449s) [282.399583] Starting dynamic subtest: shmem [282.826290] Dynamic subtest shmem: SUCCESS (0.440s) [282.841252] Starting dynamic subtest: fence [290.925963] Dynamic subtest fence: SUCCESS (8.099s) [290.943279] Starting dynamic subtest: scatterlist [292.378018] Dynamic subtest scatterlist: SUCCESS (1.450s) [292.394851] Starting dynamic subtest: syncmap [294.899011] Dynamic subtest syncmap: SUCCESS (2.520s) [294.913846] Starting dynamic subtest: uncore [295.336733] Dynamic subtest uncore: SUCCESS (0.436s) [295.351544] Starting dynamic subtest: ring [295.779482] Dynamic subtest ring: SUCCESS (0.441s) [295.795441] Starting dynamic subtest: engine [296.219042] Dynamic subtest engine: SUCCESS (0.439s) [296.233746] Starting dynamic subtest: timelines [306.611397] Dynamic subtest timelines: SUCCESS (10.391s) [306.626264] Starting dynamic subtest: requests [309.532631] Dynamic subtest requests: SUCCESS (2.920s) [309.547429] Starting dynamic subtest: objects [310.117824] Dynamic subtest objects: SUCCESS (0.583s) [310.136096] Starting dynamic subtest: phys [310.705704] Dynamic subtest phys: SUCCESS (0.586s) [310.720771] Starting dynamic subtest: dmabuf [311.295584] Dynamic subtest dmabuf: SUCCESS (0.588s) [311.313824] Starting dynamic subtest: vma [342.002301] Dynamic subtest vma: SUCCESS (30.705s) [342.017163] Starting dynamic subtest: evict [345.203420] Dynamic subtest evict: FAIL (3.186s) [345.205493] Subtest mock: FAIL (63.254s) [345.375964] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1644 [max: 8192] direct dependencies: 15776 [max: 32768] indirect dependencies: 102641 all direct dependencies: 276456 dependency chains: 21219 [max: 131072] dependency chain hlocks used: 85171 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 133 in-softirq chains: 595 in-process chains: 20491 stack-trace entries: 177958 [max: 1048576] number of stack traces: 9216 number of stack hash chains: 7096 combined max dependencies: 1636573088 hardirq-safe locks: 75 hardirq-unsafe locks: 980 softirq-safe locks: 173 softirq-unsafe locks: 896 irq-safe locks: 191 irq-unsafe locks: 980 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 290 softirq-read-safe locks: 7 softirq-read-unsafe locks: 285 irq-read-safe locks: 7 irq-read-unsafe locks: 290 uncategorized locks: 291 unused locks: 1 max locking depth: 16 max bfs queue depth: 407 max lock class index: 1803 chain lookup misses: 27409 chain lookup hits: 131179983 cyclic checks: 27084 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4265 find-mask backwards checks: 3009 hardirq on events: 76275521 hardirq off events: 76275517 redundant hardirq ons: 36 redundant hardirq offs: 59 softirq on events: 446262 softirq off events: 446262 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 448 zapped lock chains: 6121 large chain blocks: 1 [345.378041] Closing watchdogs Done.