[43.291868] Initializing watchdogs [43.292249] /dev/watchdog0 [43.308917] [001/142] (960s left) kms_big_fb (linear-32bpp-rotate-270) [43.600695] Starting subtest: linear-32bpp-rotate-270 [43.726160] Subtest linear-32bpp-rotate-270: SKIP (0.121s) [43.843167] [002/142] (959s left) i915_pm_rpm (drm-resources-equal) [45.796942] Starting subtest: drm-resources-equal [47.395410] Subtest drm-resources-equal: SUCCESS (1.597s) [47.572272] [003/142] (956s left) kms_chamelium_frames (hdmi-crc-multiple) [47.903344] Subtest hdmi-crc-multiple: SKIP (0.000s) [48.190309] [004/142] (955s left) kms_vblank (pipe-d-ts-continuation-modeset) [48.435708] Subtest pipe-D-ts-continuation-modeset: SKIP (0.000s) [48.516563] [005/142] (955s left) gem_ctx_isolation (nonpriv-switch) [48.691939] Starting subtest: nonpriv-switch [48.693553] Starting dynamic subtest: rcs0 [51.226117] Dynamic subtest rcs0: SUCCESS (2.532s) [51.239957] Starting dynamic subtest: bcs0 [54.470270] Dynamic subtest bcs0: SUCCESS (3.242s) [54.484297] Starting dynamic subtest: vcs0 [56.884228] Dynamic subtest vcs0: SUCCESS (2.416s) [56.898676] Starting dynamic subtest: vecs0 [59.304933] Dynamic subtest vecs0: SUCCESS (2.418s) [59.306291] Subtest nonpriv-switch: SUCCESS (10.610s) [59.504762] [006/142] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [59.755312] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [59.757865] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [59.850760] [007/142] (944s left) gem_exec_schedule (smoketest) [60.166358] Starting subtest: smoketest [60.167667] Starting dynamic subtest: rcs0 [65.635267] Dynamic subtest rcs0: SUCCESS (5.462s) [65.649235] Starting dynamic subtest: bcs0 [71.103081] Dynamic subtest bcs0: SUCCESS (5.468s) [71.121451] Starting dynamic subtest: vcs0 [76.569748] Dynamic subtest vcs0: SUCCESS (5.464s) [76.584475] Starting dynamic subtest: vecs0 [82.027462] Dynamic subtest vecs0: SUCCESS (5.460s) [82.028930] Subtest smoketest: SUCCESS (21.856s) [82.255779] [008/142] (921s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_ccs) [82.599940] Starting subtest: pipe-A-bad-rotation-90-y_tiled_ccs [83.060955] Subtest pipe-A-bad-rotation-90-y_tiled_ccs: SUCCESS (0.460s) [83.643736] [009/142] (920s left) kms_cursor_legacy (flip-vs-cursor-toggle) [83.880953] Starting subtest: flip-vs-cursor-toggle [102.939403] Subtest flip-vs-cursor-toggle: SUCCESS (19.056s) [103.272085] [010/142] (900s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs) [103.752212] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs [103.756657] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.004s) [104.072954] [011/142] (900s left) gem_lmem_swapping (heavy-verify-random) [104.226165] Subtest heavy-verify-random: SKIP (0.000s) [104.272927] [012/142] (899s left) gem_exec_parallel (engines) [104.435853] Starting subtest: engines [104.437378] Starting dynamic subtest: basic [107.746601] Dynamic subtest basic: SUCCESS (3.310s) [107.762454] Starting dynamic subtest: contexts [115.262615] Dynamic subtest contexts: SUCCESS (7.516s) [115.278333] Starting dynamic subtest: fds [125.063194] Dynamic subtest fds: SUCCESS (9.799s) [125.080156] Starting dynamic subtest: userptr [128.432261] Dynamic subtest userptr: SUCCESS (3.370s) [128.433750] Subtest engines: SUCCESS (23.997s) [128.649125] [013/142] (875s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [128.885807] Starting subtest: plane-upscale-20x20-with-modifiers [128.890110] Starting dynamic subtest: pipe-A-DP-1 [129.357071] Dynamic subtest pipe-A-DP-1: SUCCESS (0.468s) [129.376230] Starting dynamic subtest: pipe-B-DP-1 [130.112031] Dynamic subtest pipe-B-DP-1: SUCCESS (0.752s) [130.131327] Starting dynamic subtest: pipe-C-DP-1 [130.721835] Dynamic subtest pipe-C-DP-1: SUCCESS (0.607s) [130.723863] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (1.837s) [131.129054] [014/142] (873s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_rc_ccs_cc) [131.563742] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs_cc [131.566509] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [131.908536] [015/142] (872s left) sysfs_preempt_timeout (idempotent) [132.057863] Starting subtest: idempotent [132.059212] Starting dynamic subtest: vecs0 [132.060522] Dynamic subtest vecs0: SUCCESS (0.001s) [132.076169] Starting dynamic subtest: vcs0 [132.077537] Dynamic subtest vcs0: SUCCESS (0.002s) [132.093692] Starting dynamic subtest: bcs0 [132.095102] Dynamic subtest bcs0: SUCCESS (0.001s) [132.110776] Starting dynamic subtest: rcs0 [132.112071] Dynamic subtest rcs0: SUCCESS (0.002s) [132.113496] Subtest idempotent: SUCCESS (0.010s) [132.171422] [016/142] (872s left) kms_flip (flip-vs-fences) [132.395142] Starting subtest: flip-vs-fences [132.396423] Starting dynamic subtest: A-DP1 [142.937716] Dynamic subtest A-DP1: SUCCESS (10.538s) [142.953058] Starting dynamic subtest: B-DP1 [153.531949] Dynamic subtest B-DP1: SUCCESS (10.595s) [153.547550] Starting dynamic subtest: C-DP1 [164.150718] Dynamic subtest C-DP1: SUCCESS (10.613s) [164.152126] Subtest flip-vs-fences: SUCCESS (31.754s) [164.605412] [017/142] (839s left) gem_ctx_param (invalid-size-set) [164.749997] Starting subtest: invalid-size-set [164.751407] Subtest invalid-size-set: SUCCESS (0.000s) [164.832608] [018/142] (839s left) api_intel_allocator (standalone) [164.976849] Starting subtest: standalone [165.031667] Subtest standalone: SUCCESS (0.057s) [165.117061] [019/142] (839s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [165.370338] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [165.372906] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [165.466107] [020/142] (839s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [165.709270] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [168.000171] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.293s) [168.133842] [021/142] (836s left) kms_psr (sprite_mmap_gtt) [168.277990] Subtest sprite_mmap_gtt: SKIP (0.000s) [168.318082] [022/142] (836s left) kms_rotation_crc (exhaust-fences) [168.556832] Starting subtest: exhaust-fences [170.233125] Subtest exhaust-fences: SUCCESS (1.678s) [170.383140] [023/142] (834s left) gem_mmap_gtt (basic-write) [170.525196] Starting subtest: basic-write [170.955329] Subtest basic-write: SUCCESS (0.429s) [171.082952] [024/142] (833s left) gem_close_race (multigpu-basic-threads) [171.257216] Starting subtest: multigpu-basic-threads [171.260117] Subtest multigpu-basic-threads: SKIP (0.000s) [171.450946] [025/142] (833s left) i915_query (engine-info-invalid) [171.590531] Starting subtest: engine-info-invalid [171.592124] Subtest engine-info-invalid: SUCCESS (0.000s) [171.669964] [026/142] (833s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [171.815041] Starting subtest: etime-single-wait-for-submit-unsubmitted [171.923814] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.106s) [172.000662] [027/142] (832s left) perf_pmu (invalid-init) [172.148270] Starting subtest: invalid-init [172.149907] Subtest invalid-init: SUCCESS (0.001s) [172.249326] [028/142] (832s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [172.498937] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [172.501596] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [172.600103] [029/142] (832s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [172.848454] Starting subtest: psr-farfromfence-mmap-gtt [172.851630] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [172.950803] [030/142] (831s left) gem_exec_params (rel-constants-invalid) [173.097962] Starting subtest: rel-constants-invalid [173.099858] Subtest rel-constants-invalid: SUCCESS (0.001s) [173.199623] [031/142] (831s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [173.441211] Starting subtest: cursorB-vs-flipB-atomic [173.446235] Subtest cursorB-vs-flipB-atomic: SKIP (0.003s) [173.533822] [032/142] (831s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc) [173.874829] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc [173.877880] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s) [174.329872] [033/142] (830s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [174.604184] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [176.045790] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.440s) [176.180972] [034/142] (828s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_mc_ccs) [176.629541] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs [176.633325] Subtest pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s) [176.972125] [035/142] (828s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc) [177.452702] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s) [177.765992] [036/142] (827s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [178.007755] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [178.009552] Starting dynamic subtest: pipe-A-valid-mode [178.681943] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.673s) [178.683336] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (0.676s) [179.007278] [037/142] (826s left) gem_ppgtt (blt-vs-render-ctxn) [179.158536] Starting subtest: blt-vs-render-ctxN [212.787348] Subtest blt-vs-render-ctxN: SUCCESS (33.629s) [212.908469] [038/142] (792s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [213.279610] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [213.282076] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [213.371984] [039/142] (791s left) gem_spin_batch (engines) [213.537526] Starting subtest: engines [213.538952] Starting dynamic subtest: rcs0 [216.863209] Dynamic subtest rcs0: SUCCESS (3.322s) [216.879964] Starting dynamic subtest: bcs0 [220.184482] Dynamic subtest bcs0: SUCCESS (3.321s) [220.201699] Starting dynamic subtest: vcs0 [223.504407] Dynamic subtest vcs0: SUCCESS (3.319s) [223.521269] Starting dynamic subtest: vecs0 [226.825316] Dynamic subtest vecs0: SUCCESS (3.319s) [226.826662] Subtest engines: SUCCESS (13.286s) [227.023962] [040/142] (778s left) core_getversion [227.242423] [041/142] (778s left) kms_dither (fb-8bpc-vs-panel-6bpc) [227.479273] Starting subtest: fb-8bpc-vs-panel-6bpc [227.480737] Starting dynamic subtest: pipe-A-DP-1 [227.944458] Dynamic subtest pipe-A-DP-1: SUCCESS (0.464s) [227.945923] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (0.466s) [228.258090] [042/142] (777s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [228.501871] Starting subtest: nonblocking-crc-frame-sequence [228.506774] Starting dynamic subtest: pipe-A-DP-1 [229.099110] Dynamic subtest pipe-A-DP-1: SUCCESS (0.594s) [229.119736] Starting dynamic subtest: pipe-B-DP-1 [229.885963] Dynamic subtest pipe-B-DP-1: SUCCESS (0.781s) [229.904888] Starting dynamic subtest: pipe-C-DP-1 [230.656713] Dynamic subtest pipe-C-DP-1: SUCCESS (0.768s) [230.657979] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.155s) [230.968401] [043/142] (774s left) kms_vblank (pipe-c-wait-forked-busy) [231.212816] Starting subtest: pipe-C-wait-forked-busy [233.998358] Subtest pipe-C-wait-forked-busy: SUCCESS (2.786s) [234.323043] [044/142] (771s left) kms_cursor_edge_walk (256x256-right-edge) [234.559494] Starting subtest: 256x256-right-edge [234.563720] Starting dynamic subtest: pipe-A-DP-1 [238.393735] Dynamic subtest pipe-A-DP-1: SUCCESS (3.831s) [238.412949] Starting dynamic subtest: pipe-C-DP-1 [241.860908] Dynamic subtest pipe-C-DP-1: SUCCESS (3.463s) [241.862241] Subtest 256x256-right-edge: SUCCESS (7.302s) [242.185347] [045/142] (763s left) kms_frontbuffer_tracking (fbc-badstride) [242.442412] Starting subtest: fbc-badstride [250.377256] Subtest fbc-badstride: SUCCESS (7.938s) [250.518312] [046/142] (754s left) vc4/vc4_mmap (mmap-bo) [250.729830] Subtest mmap-bo: SKIP (0.000s) [250.797607] [047/142] (754s left) i915_selftest (mock) [252.229204] Starting subtest: mock [252.230655] Starting dynamic subtest: sanitycheck [253.125141] Dynamic subtest sanitycheck: SUCCESS (0.893s) [253.138167] Starting dynamic subtest: shmem [253.645336] Dynamic subtest shmem: SUCCESS (0.519s) [253.658257] Starting dynamic subtest: fence [261.324490] Dynamic subtest fence: SUCCESS (7.678s) [261.339466] Starting dynamic subtest: scatterlist [262.784069] Dynamic subtest scatterlist: SUCCESS (1.457s) [262.797184] Starting dynamic subtest: syncmap [265.366679] Dynamic subtest syncmap: SUCCESS (2.580s) [265.381348] Starting dynamic subtest: uncore [265.809723] Dynamic subtest uncore: SUCCESS (0.441s) [265.823693] Starting dynamic subtest: ring [266.260810] Dynamic subtest ring: SUCCESS (0.449s) [266.273798] Starting dynamic subtest: engine [266.709029] Dynamic subtest engine: SUCCESS (0.446s) [266.722187] Starting dynamic subtest: timelines [277.153654] Dynamic subtest timelines: SUCCESS (10.443s) [277.168647] Starting dynamic subtest: requests [280.155809] Dynamic subtest requests: SUCCESS (2.998s) [280.168978] Starting dynamic subtest: objects [280.795856] Dynamic subtest objects: SUCCESS (0.637s) [280.809073] Starting dynamic subtest: phys [281.384685] Dynamic subtest phys: SUCCESS (0.586s) [281.397731] Starting dynamic subtest: dmabuf [281.984366] Dynamic subtest dmabuf: SUCCESS (0.596s) [281.997499] Starting dynamic subtest: vma [314.040331] Dynamic subtest vma: SUCCESS (32.054s) [314.053502] Starting dynamic subtest: evict [317.320258] Dynamic subtest evict: FAIL (3.264s) [317.322318] Subtest mock: FAIL (65.077s) [317.338745] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1605 [max: 8192] direct dependencies: 15162 [max: 32768] indirect dependencies: 86579 all direct dependencies: 243780 dependency chains: 20943 [max: 131072] dependency chain hlocks used: 83424 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 125 in-softirq chains: 547 in-process chains: 20271 stack-trace entries: 179329 [max: 1048576] number of stack traces: 8902 number of stack hash chains: 6868 combined max dependencies: 1399741056 hardirq-safe locks: 60 hardirq-unsafe locks: 977 softirq-safe locks: 160 softirq-unsafe locks: 894 irq-safe locks: 174 irq-unsafe locks: 977 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 283 softirq-read-safe locks: 7 softirq-read-unsafe locks: 278 irq-read-safe locks: 7 irq-read-unsafe locks: 283 uncategorized locks: 278 unused locks: 1 max locking depth: 15 max bfs queue depth: 407 max lock class index: 1755 chain lookup misses: 26603 chain lookup hits: 203265433 cyclic checks: 26617 redundant checks: 0 redundant links: 0 find-mask forwards checks: 4052 find-mask backwards checks: 2987 hardirq on events: 122653006 hardirq off events: 122653002 redundant hardirq ons: 30 redundant hardirq offs: 68 softirq on events: 812362 softirq off events: 812362 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 443 zapped lock chains: 5597 large chain blocks: 1 [317.340493] Closing watchdogs Done.