[34.322545] Initializing watchdogs [34.322599] /dev/watchdog0 [34.326947] [001/142] (960s left) gem_eio (in-flight-immediate) [34.381309] Starting subtest: in-flight-immediate [36.255614] Subtest in-flight-immediate: SUCCESS (1.874s) [36.403862] [002/142] (958s left) gem_pxp (create-valid-protected-context) [38.963197] Subtest create-valid-protected-context: SKIP (0.000s) [39.027806] [003/142] (955s left) prime_busy (before-wait) [39.085438] Starting subtest: before-wait [39.088693] Starting dynamic subtest: rcs0 [39.116307] Dynamic subtest rcs0: SUCCESS (0.027s) [39.122521] Starting dynamic subtest: bcs0 [39.152654] Dynamic subtest bcs0: SUCCESS (0.036s) [39.159792] Starting dynamic subtest: vcs0 [39.170789] Dynamic subtest vcs0: SUCCESS (0.018s) [39.183355] Starting dynamic subtest: vecs0 [39.193223] Dynamic subtest vecs0: SUCCESS (0.023s) [39.306724] Subtest before-wait: SUCCESS (0.219s) [39.372693] [004/142] (955s left) kms_atomic_transition (modeset-transition-fencing) [39.467803] Starting subtest: modeset-transition-fencing [39.468511] Starting dynamic subtest: 1x-outputs [40.348975] Dynamic subtest 1x-outputs: SUCCESS (0.881s) [40.410538] Subtest modeset-transition-fencing: SUCCESS (0.942s) [40.527354] [005/142] (954s left) kms_cursor_crc (cursor-rapid-movement-256x256) [40.606114] Starting subtest: cursor-rapid-movement-256x256 [40.608207] Starting dynamic subtest: pipe-A-HDMI-A-2 [40.938077] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.330s) [40.957806] Starting dynamic subtest: pipe-B-HDMI-A-2 [41.463260] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.508s) [41.463959] Subtest cursor-rapid-movement-256x256: SUCCESS (0.858s) [41.601727] [006/142] (953s left) prime_mmap_coherency (read) [41.646824] Starting subtest: read [47.019619] Subtest read: SUCCESS (5.372s) [47.114507] [007/142] (947s left) kms_cursor_crc (cursor-sliding-64x64) [47.211078] Starting subtest: cursor-sliding-64x64 [47.214607] Starting dynamic subtest: pipe-A-HDMI-A-2 [50.778033] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.563s) [50.797008] Starting dynamic subtest: pipe-B-HDMI-A-2 [54.521237] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.728s) [54.521932] Subtest cursor-sliding-64x64: SUCCESS (7.310s) [54.640376] [008/142] (940s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25) [54.717615] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25 [54.718379] Starting dynamic subtest: pipe-A-HDMI-A-2 [54.726497] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.008s) [54.731311] Starting dynamic subtest: pipe-B-HDMI-A-2 [54.750472] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.023s) [54.751820] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.033s) [54.822605] [009/142] (940s left) kms_addfb_basic (clobberred-modifier) [54.864752] Starting subtest: clobberred-modifier [54.865430] Subtest clobberred-modifier: SUCCESS (0.000s) [54.972621] [010/142] (939s left) gem_ppgtt (shrink-vs-evict-any) [55.015059] Starting subtest: shrink-vs-evict-any [60.105562] Subtest shrink-vs-evict-any: SUCCESS (5.089s) [60.169511] [011/142] (934s left) syncobj_timeline (wait-all-for-submit-snapshot) [60.221522] Starting subtest: wait-all-for-submit-snapshot [60.303468] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [60.374485] [012/142] (934s left) gem_mmap_gtt (isolation) [60.434240] Starting subtest: isolation [60.436369] Subtest isolation: SUCCESS (0.001s) [60.517920] [013/142] (934s left) kms_addfb_basic (too-wide) [60.614903] Starting subtest: too-wide [60.615609] Subtest too-wide: SUCCESS (0.000s) [60.710340] [014/142] (934s left) template (a) [60.759422] Starting subtest: A [60.760135] Subtest A: SUCCESS (0.000s) [60.816881] [015/142] (934s left) sw_sync (sync_expired_merge) [60.872546] Starting subtest: sync_expired_merge [61.946786] Subtest sync_expired_merge: SUCCESS (1.074s) [61.993452] [016/142] (933s left) gem_basic (bad-close) [62.039999] Starting subtest: bad-close [62.041413] Subtest bad-close: SUCCESS (0.000s) [62.101422] [017/142] (932s left) gem_exec_fair (basic-pace-solo) [62.173854] Starting subtest: basic-pace-solo [62.174615] Starting dynamic subtest: rcs0 [66.535318] Dynamic subtest rcs0: FAIL (4.343s) [66.536243] Subtest basic-pace-solo: FAIL (4.343s) [66.705311] [018/142] (928s left) gem_sync (basic-each) [66.769123] Starting subtest: basic-each [68.826806] Subtest basic-each: SUCCESS (2.058s) [69.013676] [019/142] (926s left) kms_flip (dpms-off-confusion) [69.100130] Starting subtest: dpms-off-confusion [69.100876] Starting dynamic subtest: A-HDMI-A2 [84.325725] Dynamic subtest A-HDMI-A2: SUCCESS (15.224s) [84.332321] Starting dynamic subtest: B-HDMI-A2 [99.520932] Dynamic subtest B-HDMI-A2: SUCCESS (15.194s) [99.521927] Subtest dpms-off-confusion: SUCCESS (30.422s) [99.703264] [020/142] (895s left) gem_exec_fence (syncobj-timeline-invalid-wait) [100.142446] Starting subtest: syncobj-timeline-invalid-wait [100.146709] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [100.334027] [021/142] (894s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_mc_ccs) [100.503647] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs [100.505012] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s) [100.694810] [022/142] (894s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs) [100.857359] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs [100.859380] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s) [101.037098] [023/142] (894s left) kms_frontbuffer_tracking (fbc-2p-rte) [101.116955] Starting subtest: fbc-2p-rte [101.118291] Subtest fbc-2p-rte: SKIP (0.000s) [101.187214] [024/142] (893s left) i915_module_load (resize-bar) [101.229008] Starting subtest: resize-bar [101.232955] Subtest resize-bar: SKIP (0.003s) [101.249549] [025/142] (893s left) prime_vgem (fence-read-hang) [101.326088] Subtest fence-read-hang: SKIP (0.000s) [101.420455] [026/142] (893s left) gem_ccs (suspend-resume) [101.476793] Starting subtest: suspend-resume [101.478177] Subtest suspend-resume: SKIP (0.000s) [101.544903] [027/142] (893s left) vc4/vc4_purgeable_bo (mark-unpurgeable-twice) [101.626828] Subtest mark-unpurgeable-twice: SKIP (0.000s) [101.683980] [028/142] (893s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [101.775685] Starting subtest: short-flip-before-cursor-toggle [102.747918] Subtest short-flip-before-cursor-toggle: SUCCESS (0.974s) [102.866581] [029/142] (892s left) gem_exec_balancer (bonded-pair) [102.915537] Starting subtest: bonded-pair [103.759300] Subtest bonded-pair: SUCCESS (0.843s) [104.740052] [030/142] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [104.824096] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [104.825427] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [104.903522] [031/142] (890s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [104.999066] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [105.000416] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [105.066825] [032/142] (890s left) kms_force_connector_basic (force-connector-state) [105.182995] Starting subtest: force-connector-state [105.949176] Subtest force-connector-state: SUCCESS (0.767s) [106.279781] [033/142] (889s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [106.358966] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [106.360290] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [106.446373] [034/142] (888s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [106.527158] Starting subtest: yf-tiled-64bpp-rotate-180 [106.528548] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [106.612986] [035/142] (888s left) i915_pm_rps (thresholds-idle) [106.656346] Starting subtest: thresholds-idle [106.657076] Starting dynamic subtest: gt0 [106.658450] Dynamic subtest gt0: SKIP (0.001s) [106.659821] Subtest thresholds-idle: SKIP (0.001s) [106.746301] [036/142] (888s left) kms_lease (simple_lease) [106.821406] Starting subtest: simple_lease [106.822115] Starting dynamic subtest: pipe-A-HDMI-A-2 [107.157099] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.335s) [107.160977] Starting dynamic subtest: pipe-B-HDMI-A-2 [107.442555] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.284s) [107.443329] Subtest simple_lease: SUCCESS (0.621s) [107.540300] [037/142] (887s left) gem_caching (reads) [107.584873] Starting subtest: reads [108.801732] Subtest reads: SUCCESS (1.217s) [108.909504] [038/142] (886s left) gem_exec_schedule (pi-common) [109.113713] Starting subtest: pi-common [109.114493] Starting dynamic subtest: rcs0 [109.187539] Dynamic subtest rcs0: SUCCESS (0.083s) [109.201564] Starting dynamic subtest: bcs0 [109.268856] Dynamic subtest bcs0: SUCCESS (0.080s) [109.285175] Starting dynamic subtest: vcs0 [109.350706] Dynamic subtest vcs0: SUCCESS (0.081s) [109.366527] Starting dynamic subtest: vecs0 [109.431998] Dynamic subtest vecs0: SUCCESS (0.080s) [109.433374] Subtest pi-common: SUCCESS (0.329s) [109.601595] [039/142] (885s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [109.680314] Starting subtest: coverage-vs-premult-vs-constant [109.735333] Starting dynamic subtest: pipe-A-HDMI-A-2 [110.166981] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.432s) [110.170888] Starting dynamic subtest: pipe-B-HDMI-A-2 [110.609199] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.442s) [110.609973] Subtest coverage-vs-premult-vs-constant: SUCCESS (0.930s) [110.745142] [040/142] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [110.823654] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [110.824996] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [110.895085] [041/142] (884s left) kms_plane (pixel-format) [110.971993] Starting subtest: pixel-format [110.972744] Starting dynamic subtest: pipe-A-planes [121.139312] Dynamic subtest pipe-A-planes: SUCCESS (10.167s) [121.144096] Starting dynamic subtest: pipe-B-planes [131.166929] Dynamic subtest pipe-B-planes: SUCCESS (10.027s) [131.167611] Subtest pixel-format: SUCCESS (20.195s) [131.307361] [042/142] (864s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [131.351941] Starting subtest: etime-single-wait-all-for-submit-submitted [131.467043] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s) [131.531650] [043/142] (863s left) dumb_buffer (create-valid-dumb) [131.586355] Starting subtest: create-valid-dumb [131.587069] Subtest create-valid-dumb: SUCCESS (0.000s) [131.674915] [044/142] (863s left) gem_wait (invalid-buf) [131.734784] Starting subtest: invalid-buf [131.735463] Subtest invalid-buf: SUCCESS (0.000s) [131.952256] [045/142] (863s left) i915_selftest (mock) [132.967732] Starting subtest: mock [132.969147] Starting dynamic subtest: sanitycheck [133.160735] Dynamic subtest sanitycheck: SUCCESS (0.193s) [133.173155] Starting dynamic subtest: shmem [133.326688] Dynamic subtest shmem: SUCCESS (0.164s) [133.339157] Starting dynamic subtest: fence [140.309766] Dynamic subtest fence: SUCCESS (6.981s) [140.322550] Starting dynamic subtest: scatterlist [141.476409] Dynamic subtest scatterlist: SUCCESS (1.165s) [141.483644] Starting dynamic subtest: syncmap [143.852147] Dynamic subtest syncmap: SUCCESS (2.374s) [143.859499] Starting dynamic subtest: uncore [144.022794] Dynamic subtest uncore: SUCCESS (0.170s) [144.033492] Starting dynamic subtest: ring [144.179715] Dynamic subtest ring: SUCCESS (0.156s) [144.190348] Starting dynamic subtest: engine [144.341727] Dynamic subtest engine: SUCCESS (0.161s) [144.352404] Starting dynamic subtest: timelines [147.765920] Dynamic subtest timelines: SUCCESS (3.423s) [147.773181] Starting dynamic subtest: requests [150.101252] Dynamic subtest requests: SUCCESS (2.334s) [150.108533] Starting dynamic subtest: objects [150.362881] Dynamic subtest objects: SUCCESS (0.260s) [150.373497] Starting dynamic subtest: phys [150.613898] Dynamic subtest phys: SUCCESS (0.250s) [150.623820] Starting dynamic subtest: dmabuf [150.869306] Dynamic subtest dmabuf: SUCCESS (0.254s) [150.880223] Starting dynamic subtest: vma [158.059840] Dynamic subtest vma: SUCCESS (7.189s) [158.066870] Starting dynamic subtest: evict [158.899092] Dynamic subtest evict: FAIL (0.827s) [158.900780] Subtest mock: FAIL (25.921s) [159.045858] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1624 [max: 8192] direct dependencies: 14834 [max: 32768] indirect dependencies: 79839 all direct dependencies: 300689 dependency chains: 19998 [max: 131072] dependency chain hlocks used: 78848 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 182 in-softirq chains: 629 in-process chains: 19187 stack-trace entries: 177151 [max: 1048576] number of stack traces: 8842 number of stack hash chains: 6758 combined max dependencies: 2212184520 hardirq-safe locks: 95 hardirq-unsafe locks: 969 softirq-safe locks: 174 softirq-unsafe locks: 885 irq-safe locks: 200 irq-unsafe locks: 969 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 289 softirq-read-safe locks: 7 softirq-read-unsafe locks: 284 irq-read-safe locks: 7 irq-read-unsafe locks: 289 uncategorized locks: 271 unused locks: 1 max locking depth: 16 max bfs queue depth: 386 max lock class index: 1779 chain lookup misses: 25614 chain lookup hits: 182100530 cyclic checks: 25288 redundant checks: 0 redundant links: 0 find-mask forwards checks: 3993 find-mask backwards checks: 2996 hardirq on events: 113203049 hardirq off events: 113203037 redundant hardirq ons: 50 redundant hardirq offs: 15 softirq on events: 897950 softirq off events: 897950 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 452 zapped lock chains: 5385 large chain blocks: 1 [159.047523] Closing watchdogs Done.