[42.861422] Initializing watchdogs [42.861589] /dev/watchdog0 [42.874164] [001/142] (960s left) gem_eio (in-flight-immediate) [43.168883] Starting subtest: in-flight-immediate [48.203576] Subtest in-flight-immediate: SUCCESS (5.035s) [48.337575] [002/142] (955s left) gem_pxp (create-valid-protected-context) [50.972749] Subtest create-valid-protected-context: SKIP (0.000s) [50.993653] [003/142] (952s left) prime_busy (before-wait) [51.057559] Starting subtest: before-wait [51.061382] Starting dynamic subtest: rcs0 [51.104833] Dynamic subtest rcs0: SUCCESS (0.043s) [51.110010] Starting dynamic subtest: bcs0 [51.146752] Dynamic subtest bcs0: SUCCESS (0.042s) [51.154413] Starting dynamic subtest: vcs0 [51.194617] Dynamic subtest vcs0: SUCCESS (0.047s) [51.218280] Starting dynamic subtest: vcs1 [51.242848] Dynamic subtest vcs1: SUCCESS (0.048s) [51.265590] Starting dynamic subtest: vecs0 [51.287641] Dynamic subtest vecs0: SUCCESS (0.045s) [51.303985] Starting dynamic subtest: vecs1 [51.332555] Dynamic subtest vecs1: SUCCESS (0.045s) [51.350112] Starting dynamic subtest: ccs0 [51.375863] Dynamic subtest ccs0: SUCCESS (0.043s) [51.392634] Starting dynamic subtest: ccs1 [51.419064] Dynamic subtest ccs1: SUCCESS (0.043s) [51.435611] Starting dynamic subtest: ccs2 [51.462981] Dynamic subtest ccs2: SUCCESS (0.044s) [51.479694] Starting dynamic subtest: ccs3 [51.506913] Dynamic subtest ccs3: SUCCESS (0.044s) [51.610062] Subtest before-wait: SUCCESS (0.552s) [51.732155] [004/142] (951s left) kms_atomic_transition (modeset-transition-fencing) [51.898095] Starting subtest: modeset-transition-fencing [51.898977] Starting dynamic subtest: 1x-outputs [57.730640] Dynamic subtest 1x-outputs: SUCCESS (5.833s) [57.807496] Subtest modeset-transition-fencing: SUCCESS (5.909s) [57.971771] [005/142] (945s left) kms_cursor_crc (cursor-rapid-movement-256x256) [58.242232] Starting subtest: cursor-rapid-movement-256x256 [58.246262] Starting dynamic subtest: pipe-A-DP-2 [58.612480] Dynamic subtest pipe-A-DP-2: SUCCESS (0.366s) [58.636136] Starting dynamic subtest: pipe-D-DP-2 [59.150490] Dynamic subtest pipe-D-DP-2: SUCCESS (0.519s) [59.151401] Subtest cursor-rapid-movement-256x256: SUCCESS (0.908s) [59.438099] [006/142] (944s left) prime_mmap_coherency (read) [59.502529] Starting subtest: read [64.948651] Subtest read: SUCCESS (5.401s) [65.018806] [007/142] (938s left) kms_cursor_crc (cursor-sliding-64x64) [65.264376] Starting subtest: cursor-sliding-64x64 [65.268507] Starting dynamic subtest: pipe-A-DP-2 [69.447585] Dynamic subtest pipe-A-DP-2: SUCCESS (4.179s) [69.473039] Starting dynamic subtest: pipe-D-DP-2 [73.871842] Dynamic subtest pipe-D-DP-2: SUCCESS (4.403s) [73.872757] Subtest cursor-sliding-64x64: SUCCESS (8.607s) [74.216518] [008/142] (929s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25) [74.350568] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25 [74.351554] Starting dynamic subtest: pipe-A-DP-2 [74.363479] Dynamic subtest pipe-A-DP-2: SKIP (0.012s) [74.368728] Starting dynamic subtest: pipe-B-DP-2 [74.389415] Dynamic subtest pipe-B-DP-2: SKIP (0.025s) [74.394721] Starting dynamic subtest: pipe-C-DP-2 [74.415041] Dynamic subtest pipe-C-DP-2: SKIP (0.024s) [74.420214] Starting dynamic subtest: pipe-D-DP-2 [74.439784] Dynamic subtest pipe-D-DP-2: SKIP (0.024s) [74.441570] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.090s) [74.512133] [009/142] (929s left) kms_addfb_basic (clobberred-modifier) [74.571903] Starting subtest: clobberred-modifier [74.573493] Subtest clobberred-modifier: SKIP (0.000s) [74.729201] [010/142] (928s left) gem_ppgtt (shrink-vs-evict-any) [74.794248] Starting subtest: shrink-vs-evict-any [80.426206] Subtest shrink-vs-evict-any: SUCCESS (5.622s) [80.474542] [011/142] (923s left) syncobj_timeline (wait-all-for-submit-snapshot) [80.540622] Starting subtest: wait-all-for-submit-snapshot [80.621886] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [80.705731] [012/142] (922s left) gem_mmap_gtt (isolation) [80.766859] Subtest isolation: SKIP (0.000s) [80.792126] [013/142] (922s left) kms_addfb_basic (too-wide) [80.923479] Starting subtest: too-wide [80.924475] Subtest too-wide: SUCCESS (0.000s) [80.995828] [014/142] (922s left) template (a) [81.055148] Starting subtest: A [81.056064] Subtest A: SUCCESS (0.000s) [81.118179] [015/142] (922s left) sw_sync (sync_expired_merge) [81.203238] Starting subtest: sync_expired_merge [82.288616] Subtest sync_expired_merge: SUCCESS (1.074s) [82.312194] [016/142] (921s left) gem_basic (bad-close) [82.373212] Starting subtest: bad-close [82.375319] Subtest bad-close: SUCCESS (0.000s) [82.432304] [017/142] (921s left) gem_exec_fair (basic-pace-solo) [82.519080] Subtest basic-pace-solo: SKIP (0.000s) [82.556200] [018/142] (921s left) gem_sync (basic-each) [82.624904] Starting subtest: basic-each [85.518336] Subtest basic-each: SUCCESS (2.894s) [85.724415] [019/142] (917s left) kms_flip (dpms-off-confusion) [85.876473] Starting subtest: dpms-off-confusion [85.879136] Starting dynamic subtest: A-DP2 [93.699735] Dynamic subtest A-DP2: SUCCESS (7.820s) [93.706429] Starting dynamic subtest: B-DP2 [101.447754] Dynamic subtest B-DP2: SUCCESS (7.747s) [101.453595] Starting dynamic subtest: C-DP2 [109.193446] Dynamic subtest C-DP2: SUCCESS (7.745s) [109.199184] Starting dynamic subtest: D-DP2 [116.939630] Dynamic subtest D-DP2: SUCCESS (7.746s) [116.942054] Subtest dpms-off-confusion: SUCCESS (31.067s) [117.174672] [020/142] (886s left) gem_exec_fence (syncobj-timeline-invalid-wait) [118.052019] Starting subtest: syncobj-timeline-invalid-wait [118.053087] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.002s) [118.279198] [021/142] (885s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_mc_ccs) [118.506366] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs [122.835618] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_mc_ccs: SUCCESS (4.330s) [123.201131] [022/142] (880s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_dg2_rc_ccs) [123.422415] Starting subtest: pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs [123.586291] Subtest pipe-A-random-ccs-data-4_tiled_dg2_rc_ccs: SUCCESS (0.164s) [123.895769] [023/142] (879s left) kms_frontbuffer_tracking (fbc-2p-rte) [124.031467] Starting subtest: fbc-2p-rte [124.033171] Subtest fbc-2p-rte: SKIP (0.000s) [124.095570] [024/142] (879s left) i915_module_load (resize-bar) [124.153318] Starting subtest: resize-bar [153.373459] Subtest resize-bar: SUCCESS (29.210s) [153.396863] [025/142] (850s left) prime_vgem (fence-read-hang) [154.108241] Subtest fence-read-hang: SKIP (0.000s) [154.182652] [026/142] (849s left) gem_ccs (suspend-resume) [154.252260] Starting subtest: suspend-resume [154.253139] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0 [171.306213] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (2.474s) [171.312309] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0 [188.358417] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (1.791s) [188.364639] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0 [205.262572] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (1.839s) [205.268572] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0 [222.359325] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (1.962s) [222.365519] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0 [239.254856] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (1.863s) [239.260749] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0 [256.359706] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (1.939s) [256.366066] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0 [273.287481] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (1.839s) [273.293516] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0 [290.352473] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (1.910s) [290.353390] Subtest suspend-resume: SUCCESS (15.623s) [296.456795] [027/142] (833s left) vc4/vc4_purgeable_bo (mark-unpurgeable-twice) [296.538006] Subtest mark-unpurgeable-twice: SKIP (0.000s) [296.590798] [028/142] (833s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [296.724360] Starting subtest: short-flip-before-cursor-toggle [297.730745] Subtest short-flip-before-cursor-toggle: SUCCESS (1.004s) [297.898419] [029/142] (832s left) gem_exec_balancer (bonded-pair) [297.968978] Starting subtest: bonded-pair [297.971193] Subtest bonded-pair: SKIP (0.000s) [298.249018] [030/142] (832s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [298.385550] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [298.387272] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [298.464698] [031/142] (831s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [298.602992] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [299.217697] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.614s) [299.337593] [032/142] (831s left) kms_force_connector_basic (force-connector-state) [299.432325] Starting subtest: force-connector-state [300.015544] Subtest force-connector-state: SUCCESS (0.582s) [300.330446] [033/142] (830s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [300.467667] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [300.469528] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [300.547092] [034/142] (829s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [300.683544] Starting subtest: yf-tiled-64bpp-rotate-180 [300.685506] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [300.764363] [035/142] (829s left) i915_pm_rps (thresholds-idle) [300.828414] Starting subtest: thresholds-idle [300.829420] Starting dynamic subtest: gt0 [300.850993] Dynamic subtest gt0: SKIP (0.021s) [300.853005] Subtest thresholds-idle: SKIP (0.022s) [300.947137] [036/142] (829s left) kms_lease (simple_lease) [301.079111] Starting subtest: simple_lease [301.080111] Starting dynamic subtest: pipe-A-DP-2 [301.489204] Dynamic subtest pipe-A-DP-2: SUCCESS (0.409s) [301.495486] Starting dynamic subtest: pipe-B-DP-2 [301.845800] Dynamic subtest pipe-B-DP-2: SUCCESS (0.355s) [301.853622] Starting dynamic subtest: pipe-C-DP-2 [302.189969] Dynamic subtest pipe-C-DP-2: SUCCESS (0.343s) [302.197635] Starting dynamic subtest: pipe-D-DP-2 [302.529754] Dynamic subtest pipe-D-DP-2: SUCCESS (0.338s) [302.530632] Subtest simple_lease: SUCCESS (1.451s) [302.715179] [037/142] (827s left) gem_caching (reads) [302.779658] Starting subtest: reads [305.183485] Subtest reads: SUCCESS (2.404s) [305.325751] [038/142] (825s left) gem_exec_schedule (pi-common) [305.553622] Starting subtest: pi-common [305.555593] Starting dynamic subtest: rcs0 [305.624714] Dynamic subtest rcs0: SUCCESS (0.089s) [305.651825] Starting dynamic subtest: bcs0 [305.719310] Dynamic subtest bcs0: SUCCESS (0.091s) [305.748152] Starting dynamic subtest: vcs0 [305.813146] Dynamic subtest vcs0: SUCCESS (0.091s) [305.819847] Starting dynamic subtest: vcs1 [305.902055] Dynamic subtest vcs1: SUCCESS (0.088s) [305.910490] Starting dynamic subtest: vecs0 [305.992907] Dynamic subtest vecs0: SUCCESS (0.089s) [306.001069] Starting dynamic subtest: vecs1 [306.064938] Dynamic subtest vecs1: SUCCESS (0.071s) [306.074108] Starting dynamic subtest: ccs0 [306.139738] Dynamic subtest ccs0: SUCCESS (0.074s) [306.146956] Starting dynamic subtest: ccs1 [306.212628] Dynamic subtest ccs1: SUCCESS (0.072s) [306.222049] Starting dynamic subtest: ccs2 [306.300966] Dynamic subtest ccs2: SUCCESS (0.087s) [306.320649] Starting dynamic subtest: ccs3 [306.385972] Dynamic subtest ccs3: SUCCESS (0.083s) [306.387163] Subtest pi-common: SUCCESS (0.853s) [306.616827] [039/142] (823s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [306.753557] Starting subtest: coverage-vs-premult-vs-constant [306.947762] Starting dynamic subtest: pipe-A-DP-2 [307.439763] Dynamic subtest pipe-A-DP-2: SUCCESS (0.491s) [307.446005] Starting dynamic subtest: pipe-D-DP-2 [307.919829] Dynamic subtest pipe-D-DP-2: SUCCESS (0.479s) [307.920752] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.166s) [308.090490] [040/142] (822s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [308.227625] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [308.229391] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [308.290582] [041/142] (822s left) kms_plane (pixel-format) [308.420539] Starting subtest: pixel-format [308.421525] Starting dynamic subtest: pipe-A-planes [320.566044] Dynamic subtest pipe-A-planes: SUCCESS (12.144s) [320.572641] Starting dynamic subtest: pipe-B-planes [333.014789] Dynamic subtest pipe-B-planes: SUCCESS (12.447s) [333.015649] Subtest pixel-format: SUCCESS (24.595s) [333.178833] [042/142] (797s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [333.240625] Starting subtest: etime-single-wait-all-for-submit-submitted [333.345056] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s) [333.462620] [043/142] (797s left) dumb_buffer (create-valid-dumb) [333.529037] Starting subtest: create-valid-dumb [333.529945] Subtest create-valid-dumb: SUCCESS (0.000s) [333.629561] [044/142] (796s left) gem_wait (invalid-buf) [333.713206] Starting subtest: invalid-buf [333.714400] Subtest invalid-buf: SUCCESS (0.000s) [333.939354] [045/142] (796s left) i915_selftest (mock) [335.991977] Starting subtest: mock [335.994002] Starting dynamic subtest: sanitycheck [336.181339] Dynamic subtest sanitycheck: SUCCESS (0.198s) [336.188435] Starting dynamic subtest: shmem [336.351200] Dynamic subtest shmem: SUCCESS (0.169s) [336.358726] Starting dynamic subtest: fence [343.938723] Dynamic subtest fence: SUCCESS (7.586s) [343.948900] Starting dynamic subtest: scatterlist [345.125364] Dynamic subtest scatterlist: SUCCESS (1.184s) [345.138610] Starting dynamic subtest: syncmap [347.543399] Dynamic subtest syncmap: SUCCESS (2.407s) [347.551554] Starting dynamic subtest: uncore [347.700516] Dynamic subtest uncore: SUCCESS (0.165s) [347.707941] Starting dynamic subtest: ring [347.883336] Dynamic subtest ring: SUCCESS (0.182s) [347.891357] Starting dynamic subtest: engine [348.060319] Dynamic subtest engine: SUCCESS (0.176s) [348.067592] Starting dynamic subtest: timelines [351.757716] Dynamic subtest timelines: SUCCESS (3.687s) [351.765441] Starting dynamic subtest: requests [353.864376] Dynamic subtest requests: SUCCESS (2.106s) [353.870687] Starting dynamic subtest: objects [354.145799] Dynamic subtest objects: SUCCESS (0.280s) [354.153985] Starting dynamic subtest: phys [354.429748] Dynamic subtest phys: SUCCESS (0.283s) [354.437363] Starting dynamic subtest: dmabuf [354.709834] Dynamic subtest dmabuf: SUCCESS (0.279s) [354.720131] Starting dynamic subtest: vma [362.809765] Dynamic subtest vma: SUCCESS (8.098s) [362.816820] Starting dynamic subtest: evict [363.793756] Dynamic subtest evict: FAIL (0.972s) [363.796595] Subtest mock: FAIL (27.792s) [363.944968] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1663 [max: 8192] direct dependencies: 16394 [max: 32768] indirect dependencies: 94311 all direct dependencies: 315152 dependency chains: 23315 [max: 131072] dependency chain hlocks used: 97777 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 195 in-softirq chains: 641 in-process chains: 22479 stack-trace entries: 234222 [max: 1048576] number of stack traces: 11443 number of stack hash chains: 8158 combined max dependencies: 2828703360 hardirq-safe locks: 96 hardirq-unsafe locks: 986 softirq-safe locks: 188 softirq-unsafe locks: 903 irq-safe locks: 207 irq-unsafe locks: 986 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 297 softirq-read-safe locks: 7 softirq-read-unsafe locks: 292 irq-read-safe locks: 7 irq-read-unsafe locks: 297 uncategorized locks: 279 unused locks: 1 max locking depth: 15 max bfs queue depth: 418 max lock class index: 1839 chain lookup misses: 58111 chain lookup hits: 236712264 cyclic checks: 58600 redundant checks: 0 redundant links: 0 find-mask forwards checks: 10345 find-mask backwards checks: 5460 hardirq on events: 151211335 hardirq off events: 151211329 redundant hardirq ons: 56 redundant hardirq offs: 15 softirq on events: 366150 softirq off events: 366150 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 2207 zapped lock chains: 34691 large chain blocks: 1 [363.946008] Closing watchdogs Done.