[38.767233] Initializing watchdogs
[38.767287]   /dev/watchdog0
[38.772747] [001/138] (960s left) gem_exec_params (rel-constants-invalid-ring)
[38.831137] Starting subtest: rel-constants-invalid-ring
[38.831937] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[38.906522] [002/138] (960s left) kms_plane_lowres (tiling-yf)
[40.858110] Starting subtest: tiling-yf
[40.859838] Subtest tiling-yf: SKIP (0.000s)
[40.917823] [003/138] (958s left) drm_read (short-buffer-block)
[43.040121] Starting subtest: short-buffer-block
[43.041152] Subtest short-buffer-block: SUCCESS (0.000s)
[43.192891] [004/138] (956s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[43.284160] Starting subtest: yf-tiled-ccs-to-x-tiled
[43.285832] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[43.464327] [005/138] (955s left) kms_cursor_crc (cursor-offscreen-32x10)
[45.466772] Starting subtest: cursor-offscreen-32x10
[45.506747] Subtest cursor-offscreen-32x10: SKIP (0.038s)
[45.767498] [006/138] (953s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[45.853657] Starting subtest: multi-wait-all-for-submit-signaled
[45.854577] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[45.923446] [007/138] (953s left) vc4/vc4_wait_bo (used-bo-0ns)
[46.022198] Subtest used-bo-0ns: SKIP (0.000s)
[46.072531] [008/138] (953s left) gem_mmap (pf-nonblock)
[46.121221] Subtest pf-nonblock: SKIP (0.000s)
[46.144550] [009/138] (953s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[48.150915] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[48.152468] Subtest pipe-B-crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[48.284140] [010/138] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[50.239431] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[50.241120] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[50.301312] [011/138] (949s left) perf (blocking)
[50.703569] Starting subtest: blocking
[50.704477] Starting dynamic subtest: 0-rcs0
[60.765606] Dynamic subtest 0-rcs0: SUCCESS (10.028s)
[60.766743] Subtest blocking: SUCCESS (10.028s)
[60.777637] [012/138] (938s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[62.723134] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[62.724660] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[62.803271] [013/138] (936s left) gem_ccs (block-multicopy-inplace)
[62.943051] Starting subtest: block-multicopy-inplace
[62.944658] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0-multicopy
[62.993163] Dynamic subtest linear-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.050s)
[62.997561] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0-multicopy
[63.088199] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.095s)
[63.092623] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0-multicopy
[63.099976] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.011s)
[63.104403] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0-multicopy
[63.194782] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.095s)
[63.199200] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0-multicopy
[63.206245] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.011s)
[63.210621] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0-multicopy
[63.308074] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.102s)
[63.312434] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0-multicopy
[63.319482] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0-multicopy: SUCCESS (0.011s)
[63.323714] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0-multicopy
[63.414102] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0-multicopy: SUCCESS (0.095s)
[63.414998] Subtest block-multicopy-inplace: SUCCESS (0.472s)
[63.510279] [014/138] (935s left) prime_vgem (fence-flip-hang)
[63.625291] Subtest fence-flip-hang: SKIP (0.000s)
[63.725113] [015/138] (935s left) kms_hdr (invalid-hdr)
[65.703993] Starting subtest: invalid-hdr
[65.705565] Subtest invalid-hdr: SKIP (0.000s)
[65.768157] [016/138] (933s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[67.765213] Starting subtest: basic-flip-after-cursor-atomic
[68.746337] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.978s)
[68.878097] [017/138] (930s left) v3d/v3d_submit_csd (multiple-job-submission)
[68.945951] Subtest multiple-job-submission: SKIP (0.000s)
[68.993485] [018/138] (930s left) gem_userptr_blits (sync-unmap)
[69.049550] Starting subtest: sync-unmap
[69.067634] Subtest sync-unmap: SUCCESS (0.017s)
[69.176418] [019/138] (930s left) gem_exec_schedule (in-order)
[69.257923] Starting subtest: in-order
[69.258764] Starting dynamic subtest: rcs0
[69.512607] Dynamic subtest rcs0: SUCCESS (0.246s)
[69.517305] Starting dynamic subtest: bcs0
[69.692698] Dynamic subtest bcs0: SUCCESS (0.180s)
[69.697369] Starting dynamic subtest: vcs0
[69.883914] Dynamic subtest vcs0: SUCCESS (0.191s)
[69.888825] Starting dynamic subtest: vcs1
[70.078572] Dynamic subtest vcs1: SUCCESS (0.194s)
[70.083246] Starting dynamic subtest: vecs0
[70.268508] Dynamic subtest vecs0: SUCCESS (0.190s)
[70.273173] Starting dynamic subtest: vecs1
[70.503244] Dynamic subtest vecs1: SUCCESS (0.235s)
[70.507908] Starting dynamic subtest: ccs0
[70.684138] Dynamic subtest ccs0: SUCCESS (0.181s)
[70.688924] Starting dynamic subtest: ccs1
[70.867389] Dynamic subtest ccs1: SUCCESS (0.183s)
[70.871936] Starting dynamic subtest: ccs2
[71.051228] Dynamic subtest ccs2: SUCCESS (0.184s)
[71.055915] Starting dynamic subtest: ccs3
[71.234687] Dynamic subtest ccs3: SUCCESS (0.183s)
[71.235489] Subtest in-order: SUCCESS (1.968s)
[71.632122] [020/138] (927s left) v3d/v3d_submit_cl (single-in-sync)
[71.695531] Subtest single-in-sync: SKIP (0.000s)
[71.743834] [021/138] (927s left) gem_ctx_persistence (engines-hostile-preempt)
[71.803814] Starting subtest: engines-hostile-preempt
[71.804861] Starting dynamic subtest: rcs0
[71.863193] Dynamic subtest rcs0: SUCCESS (0.059s)
[71.867790] Starting dynamic subtest: bcs0
[71.884207] Dynamic subtest bcs0: SUCCESS (0.021s)
[71.889449] Starting dynamic subtest: vcs0
[71.946188] Dynamic subtest vcs0: SUCCESS (0.061s)
[71.966055] Starting dynamic subtest: vcs1
[72.001195] Dynamic subtest vcs1: SUCCESS (0.055s)
[72.020942] Starting dynamic subtest: vecs0
[72.050063] Dynamic subtest vecs0: SUCCESS (0.049s)
[72.069658] Starting dynamic subtest: vecs1
[72.100417] Dynamic subtest vecs1: SUCCESS (0.050s)
[72.120271] Starting dynamic subtest: ccs0
[72.157401] Dynamic subtest ccs0: SUCCESS (0.057s)
[72.177097] Starting dynamic subtest: ccs1
[72.213184] Dynamic subtest ccs1: SUCCESS (0.056s)
[72.233063] Starting dynamic subtest: ccs2
[72.267181] Dynamic subtest ccs2: SUCCESS (0.054s)
[72.285201] Starting dynamic subtest: ccs3
[72.322575] Dynamic subtest ccs3: SUCCESS (0.055s)
[72.324340] Subtest engines-hostile-preempt: SUCCESS (0.518s)
[72.442579] [022/138] (927s left) kms_ccs (pipe-c-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[74.478945] Starting subtest: pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[74.480802] Subtest pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[74.587676] [023/138] (925s left) i915_power (sanity)
[74.642297] Starting subtest: sanity
[78.689233] Subtest sanity: SUCCESS (4.038s)
[78.793150] [024/138] (920s left) gem_eio (context-create)
[79.016717] Starting subtest: context-create
[79.414576] Subtest context-create: SUCCESS (0.400s)
[81.355507] [025/138] (918s left) gem_exec_flush (basic-uc-rw-default)
[81.448729] Subtest basic-uc-rw-default: SKIP (0.000s)
[81.514179] [026/138] (918s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[81.600927] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[81.601796] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[81.656991] [027/138] (918s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[83.700881] Starting subtest: pipe-D-bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[83.701685] Subtest pipe-D-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SUCCESS (0.000s)
[83.802824] [028/138] (915s left) gem_lmem_swapping (massive-random)
[87.034065] Starting subtest: massive-random
[87.034845] Starting dynamic subtest: lmem0
[87.255769] Dynamic subtest lmem0: SUCCESS (0.222s)
[87.256479] Subtest massive-random: SUCCESS (0.222s)
[89.911898] [029/138] (909s left) syncobj_wait (reset-signaled)
[93.961045] Starting subtest: reset-signaled
[93.961874] Subtest reset-signaled: SUCCESS (0.000s)
[93.978077] [030/138] (905s left) sw_sync (sync_merge_same)
[94.025891] Starting subtest: sync_merge_same
[94.027059] Subtest sync_merge_same: SUCCESS (0.000s)
[94.064280] [031/138] (905s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[96.044444] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[96.096029] [032/138] (903s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[98.044906] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[98.046542] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[98.120364] [033/138] (901s left) kms_big_joiner (2x-modeset)
[100.139364] Subtest 2x-modeset: SKIP (0.000s)
[100.160944] [034/138] (899s left) gem_exec_whisper (basic-fds-priority)
[100.217048] Starting subtest: basic-fds-priority
[122.856484] Subtest basic-fds-priority: SUCCESS (22.629s)
[123.014851] [035/138] (876s left) kms_addfb_basic (addfb25-4-tiled)
[124.965035] Starting subtest: addfb25-4-tiled
[124.965879] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[125.037956] [036/138] (874s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[125.149456] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[125.150729] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[125.233665] [037/138] (874s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[127.254117] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-gen12-mc-ccs
[127.255921] Subtest pipe-A-missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[127.400530] [038/138] (872s left) gem_exec_balancer (parallel-contexts)
[127.707828] Starting subtest: parallel-contexts
[131.549159] Subtest parallel-contexts: SUCCESS (3.815s)
[131.585261] [039/138] (868s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[133.536356] Starting subtest: y-tiled-16bpp-rotate-90
[133.538316] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[133.621663] [040/138] (866s left) gem_exec_schedule (manyslice)
[133.758230] Starting subtest: manyslice
[133.759139] Starting dynamic subtest: rcs0
[138.728694] Dynamic subtest rcs0: SUCCESS (4.936s)
[138.736620] Starting dynamic subtest: bcs0
[143.191325] Dynamic subtest bcs0: SUCCESS (4.462s)
[143.198032] Starting dynamic subtest: vcs0
[147.873995] Dynamic subtest vcs0: SUCCESS (4.682s)
[147.880299] Starting dynamic subtest: vcs1
[152.554965] Dynamic subtest vcs1: SUCCESS (4.680s)
[152.560236] Starting dynamic subtest: vecs0
[156.702916] Dynamic subtest vecs0: SUCCESS (4.148s)
[156.708237] Starting dynamic subtest: vecs1
[161.885120] Dynamic subtest vecs1: SUCCESS (5.182s)
[161.890289] Starting dynamic subtest: ccs0
[165.838717] Dynamic subtest ccs0: SUCCESS (3.978s)
[165.844490] Starting dynamic subtest: ccs1
[170.338398] Dynamic subtest ccs1: SUCCESS (4.475s)
[170.343950] Starting dynamic subtest: ccs2
[174.812765] Dynamic subtest ccs2: SUCCESS (4.474s)
[174.818030] Starting dynamic subtest: ccs3
[179.772454] Dynamic subtest ccs3: SUCCESS (4.959s)
[179.773368] Subtest manyslice: SUCCESS (45.980s)
[180.048771] [041/138] (819s left) gem_exec_parallel (fds)
[180.145164] Starting subtest: fds
[180.146006] Starting dynamic subtest: rcs0
[184.474634] Dynamic subtest rcs0: SUCCESS (4.320s)
[184.480026] Starting dynamic subtest: bcs0
[188.716804] Dynamic subtest bcs0: SUCCESS (4.242s)
[188.722008] Starting dynamic subtest: vcs0
[193.156189] Dynamic subtest vcs0: SUCCESS (4.439s)
[193.161565] Starting dynamic subtest: vcs1
[197.249482] Dynamic subtest vcs1: SUCCESS (4.102s)
[197.254681] Starting dynamic subtest: vecs0
[201.318486] Dynamic subtest vecs0: SUCCESS (4.060s)
[201.324037] Starting dynamic subtest: vecs1
[205.241576] Dynamic subtest vecs1: SUCCESS (3.923s)
[205.247098] Starting dynamic subtest: ccs0
[209.311853] Dynamic subtest ccs0: SUCCESS (4.070s)
[209.317360] Starting dynamic subtest: ccs1
[213.270516] Dynamic subtest ccs1: SUCCESS (3.958s)
[213.276276] Starting dynamic subtest: ccs2
[217.112646] Dynamic subtest ccs2: SUCCESS (3.842s)
[217.117914] Starting dynamic subtest: ccs3
[221.458152] Dynamic subtest ccs3: SUCCESS (4.345s)
[221.459577] Subtest fds: SUCCESS (41.304s)
[221.678305] [042/138] (778s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[223.673353] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[223.674910] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[223.739173] [043/138] (776s left) perf_pmu (busy-start)
[223.868152] Starting subtest: busy-start
[223.869536] Starting dynamic subtest: rcs0
[226.455062] Dynamic subtest rcs0: SUCCESS (2.586s)
[226.464274] Starting dynamic subtest: bcs0
[229.001716] Dynamic subtest bcs0: SUCCESS (2.545s)
[229.010753] Starting dynamic subtest: vcs0
[231.548598] Dynamic subtest vcs0: SUCCESS (2.546s)
[231.557391] Starting dynamic subtest: vcs1
[234.095559] Dynamic subtest vcs1: SUCCESS (2.546s)
[234.106252] Starting dynamic subtest: vecs0
[236.642697] Dynamic subtest vecs0: SUCCESS (2.546s)
[236.653206] Starting dynamic subtest: vecs1
[239.191107] Dynamic subtest vecs1: SUCCESS (2.546s)
[239.199075] Starting dynamic subtest: ccs0
[241.736703] Dynamic subtest ccs0: SUCCESS (2.546s)
[241.745726] Starting dynamic subtest: ccs1
[244.282728] Dynamic subtest ccs1: SUCCESS (2.545s)
[244.293253] Starting dynamic subtest: ccs2
[246.829596] Dynamic subtest ccs2: SUCCESS (2.547s)
[246.839395] Starting dynamic subtest: ccs3
[249.377523] Dynamic subtest ccs3: SUCCESS (2.546s)
[249.379427] Subtest busy-start: SUCCESS (25.509s)
[249.450099] [044/138] (750s left) gem_exec_fence (parallel)
[249.624347] Starting subtest: parallel
[249.625220] Starting dynamic subtest: rcs0
[251.766582] Dynamic subtest rcs0: SUCCESS (2.151s)
[251.772619] Starting dynamic subtest: bcs0
[253.914580] Dynamic subtest bcs0: SUCCESS (2.148s)
[253.920827] Starting dynamic subtest: vcs0
[256.071718] Dynamic subtest vcs0: SUCCESS (2.157s)
[256.077738] Starting dynamic subtest: vcs1
[258.222219] Dynamic subtest vcs1: SUCCESS (2.150s)
[258.228121] Starting dynamic subtest: vecs0
[260.378481] Dynamic subtest vecs0: SUCCESS (2.156s)
[260.384618] Starting dynamic subtest: vecs1
[262.534530] Dynamic subtest vecs1: SUCCESS (2.156s)
[262.540486] Starting dynamic subtest: ccs0
[264.684624] Dynamic subtest ccs0: SUCCESS (2.150s)
[264.690594] Starting dynamic subtest: ccs1
[266.835918] Dynamic subtest ccs1: SUCCESS (2.151s)
[266.842016] Starting dynamic subtest: ccs2
[268.991965] Dynamic subtest ccs2: SUCCESS (2.156s)
[268.998198] Starting dynamic subtest: ccs3
[271.141819] Dynamic subtest ccs3: SUCCESS (2.150s)
[271.142615] Subtest parallel: SUCCESS (21.526s)
[272.129385] [045/138] (727s left) kms_psr (cursor_plane_onoff)
[272.180534] Subtest cursor_plane_onoff: SKIP (0.000s)
[272.198482] [046/138] (727s left) syncobj_basic (test-valid-cycle)
[272.247800] Starting subtest: test-valid-cycle
[272.248635] Subtest test-valid-cycle: SUCCESS (0.000s)
[272.325556] [047/138] (727s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[272.415057] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[272.521543] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[272.631123] [048/138] (727s left) vc4/vc4_perfmon (create-perfmon-0)
[272.725550] Subtest create-perfmon-0: SKIP (0.000s)
[272.783338] [049/138] (727s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[272.836848] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[272.867398] [050/138] (727s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[274.820847] Starting subtest: 4-tiled-64bpp-rotate-270
[274.880123] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.055s)
[275.002507] [051/138] (725s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-mtl-rc-ccs)
[277.005596] Starting subtest: pipe-A-bad-pixel-format-4-tiled-mtl-rc-ccs
[277.007428] Subtest pipe-A-bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[277.204622] [052/138] (723s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y-tiled-ccs)
[279.248238] Starting subtest: pipe-C-crc-sprite-planes-basic-y-tiled-ccs
[279.250810] Subtest pipe-C-crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.002s)
[279.356739] [053/138] (720s left) gem_vm_create (invalid-destroy)
[279.422071] Starting subtest: invalid-destroy
[279.424196] Subtest invalid-destroy: SUCCESS (0.001s)
[279.533644] [054/138] (720s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[281.514283] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[281.515197] Starting dynamic subtest: pipe-A-valid-mode
[281.565432] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s)
[281.567213] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.051s)
[281.653497] [055/138] (718s left) api_intel_bb (simple-bb-ctx)
[281.750103] Starting subtest: simple-bb-ctx
[281.774791] Subtest simple-bb-ctx: SUCCESS (0.026s)
[281.858302] [056/138] (718s left) syncobj_wait (wait-all-delayed-signal)
[281.935426] Starting subtest: wait-all-delayed-signal
[282.036719] Subtest wait-all-delayed-signal: SUCCESS (0.101s)
[282.135344] [057/138] (718s left) kms_prime (basic-crc-vgem)
[284.139619] Subtest basic-crc-vgem: SKIP (0.000s)
[284.233940] [058/138] (716s left) prime_self_import (reimport-vs-gem_close-race)
[284.341182] Starting subtest: reimport-vs-gem_close-race
[289.381945] Subtest reimport-vs-gem_close-race: SUCCESS (5.026s)
[289.418030] [059/138] (711s left) kms_flip (wf_vblank-ts-check)
[290.437377] Starting subtest: wf_vblank-ts-check
[290.442059] Starting dynamic subtest: A-HDMI-A3
[298.451039] Dynamic subtest A-HDMI-A3: SUCCESS (8.006s)
[298.458507] Starting dynamic subtest: B-HDMI-A3
[306.390276] Dynamic subtest B-HDMI-A3: SUCCESS (7.942s)
[306.396813] Starting dynamic subtest: C-HDMI-A3
[314.355398] Dynamic subtest C-HDMI-A3: SUCCESS (7.943s)
[314.361767] Starting dynamic subtest: D-HDMI-A3
[322.276234] Dynamic subtest D-HDMI-A3: SUCCESS (7.942s)
[322.277056] Subtest wf_vblank-ts-check: SUCCESS (31.841s)
[322.419905] [060/138] (678s left) kms_vblank (wait-forked)
[324.390470] Starting subtest: wait-forked
[324.391428] Starting dynamic subtest: pipe-A-HDMI-A-3
[326.706013] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.315s)
[326.715515] Starting dynamic subtest: pipe-D-HDMI-A-3
[328.916259] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.207s)
[328.917166] Subtest wait-forked: SUCCESS (4.527s)
[329.035974] [061/138] (671s left) kms_getfb (getfb-handle-zero)
[329.095152] Starting subtest: getfb-handle-zero
[329.096113] Subtest getfb-handle-zero: SUCCESS (0.000s)
[329.225375] [062/138] (671s left) kms_flip (dpms-vs-vblank-race)
[330.257249] Starting subtest: dpms-vs-vblank-race
[330.263188] Starting dynamic subtest: A-HDMI-A3
[333.276395] Dynamic subtest A-HDMI-A3: SUCCESS (3.013s)
[333.285423] Starting dynamic subtest: B-HDMI-A3
[336.242142] Dynamic subtest B-HDMI-A3: SUCCESS (2.964s)
[336.249660] Starting dynamic subtest: C-HDMI-A3
[339.184078] Dynamic subtest C-HDMI-A3: SUCCESS (2.940s)
[339.192361] Starting dynamic subtest: D-HDMI-A3
[342.135484] Dynamic subtest D-HDMI-A3: SUCCESS (2.950s)
[342.136385] Subtest dpms-vs-vblank-race: SUCCESS (11.878s)
[342.275349] [063/138] (658s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[344.337119] Starting subtest: cursor-rapid-movement-128x128
[344.341304] Starting dynamic subtest: pipe-A-HDMI-A-3
[344.732317] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.391s)
[344.763785] Starting dynamic subtest: pipe-D-HDMI-A-3
[345.046351] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.288s)
[345.047224] Subtest cursor-rapid-movement-128x128: SUCCESS (0.709s)
[345.307739] [064/138] (655s left) gem_exec_nop (basic-parallel)
[345.378839] Starting subtest: basic-parallel
[350.749720] Subtest basic-parallel: SUCCESS (5.372s)
[350.983710] [065/138] (649s left) kms_color (gamma)
[352.935971] Starting subtest: gamma
[352.936917] Starting dynamic subtest: pipe-A
[353.494695] Dynamic subtest pipe-A: SUCCESS (0.558s)
[353.501216] Starting dynamic subtest: pipe-B
[353.943104] Dynamic subtest pipe-B: SUCCESS (0.448s)
[353.949497] Starting dynamic subtest: pipe-C
[354.396137] Dynamic subtest pipe-C: SUCCESS (0.452s)
[354.402373] Starting dynamic subtest: pipe-D
[354.835087] Dynamic subtest pipe-D: SUCCESS (0.438s)
[354.835968] Subtest gamma: SUCCESS (1.901s)
[354.964199] [066/138] (645s left) drm_read (empty-nonblock)
[356.995490] Starting subtest: empty-nonblock
[356.996306] Subtest empty-nonblock: SUCCESS (0.000s)
[357.137641] [067/138] (643s left) kms_lease (lease-invalid-plane)
[359.125511] Starting subtest: lease-invalid-plane
[359.126429] Starting dynamic subtest: pipe-A-HDMI-A-3
[359.127374] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.000s)
[359.133875] Starting dynamic subtest: pipe-B-HDMI-A-3
[359.134635] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.000s)
[359.140736] Starting dynamic subtest: pipe-C-HDMI-A-3
[359.141524] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.000s)
[359.147535] Starting dynamic subtest: pipe-D-HDMI-A-3
[359.148347] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.000s)
[359.149136] Subtest lease-invalid-plane: SUCCESS (0.005s)
[359.193996] [068/138] (641s left) gem_mmap_gtt (cpuset-medium-copy)
[359.271400] Subtest cpuset-medium-copy: SKIP (0.000s)
[359.322808] [069/138] (641s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[361.294202] Starting subtest: psr-2p-primscrn-spr-indfb-move
[361.295878] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[361.384199] [070/138] (639s left) prime_mmap (test_forked)
[361.509998] Starting subtest: test_forked
[361.511009] Starting dynamic subtest: test_forked-smem
[361.559195] Dynamic subtest test_forked-smem: SUCCESS (0.050s)
[361.565531] Starting dynamic subtest: test_forked-lmem0
[361.734603] Dynamic subtest test_forked-lmem0: SUCCESS (0.166s)
[361.735736] Subtest test_forked: SUCCESS (0.217s)
[361.797055] [071/138] (638s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[363.742438] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[363.744215] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[363.824420] [072/138] (636s left) kms_addfb_basic (unused-handle)
[363.947638] Starting subtest: unused-handle
[363.948698] Subtest unused-handle: SUCCESS (0.000s)
[365.913281] [073/138] (634s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-dg2-rc-ccs)
[367.988413] Starting subtest: pipe-A-crc-primary-basic-4-tiled-dg2-rc-ccs
[368.366192] Subtest pipe-A-crc-primary-basic-4-tiled-dg2-rc-ccs: SUCCESS (0.377s)
[368.638881] [074/138] (632s left) perf (disabled-read-error)
[368.960677] Starting subtest: disabled-read-error
[368.987558] Subtest disabled-read-error: SUCCESS (0.027s)
[369.013166] [075/138] (631s left) kms_ccs (pipe-d-ccs-on-another-bo-yf-tiled-ccs)
[371.054557] Starting subtest: pipe-D-ccs-on-another-bo-yf-tiled-ccs
[371.056344] Subtest pipe-D-ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s)
[371.148459] [076/138] (629s left) api_intel_allocator (reloc-allocator)
[371.201770] Starting subtest: reloc-allocator
[371.202748] Starting dynamic subtest: basic
[371.224764] Dynamic subtest basic: SUCCESS (0.023s)
[371.231466] Starting dynamic subtest: parallel-one
[371.232235] Dynamic subtest parallel-one: SUCCESS (0.004s)
[371.238710] Starting dynamic subtest: print
[371.239569] Dynamic subtest print: SUCCESS (0.000s)
[371.245799] Starting dynamic subtest: reuse
[371.246692] Dynamic subtest reuse: SUCCESS (0.000s)
[371.252964] Starting dynamic subtest: fork-reopen-allocator
[371.253757] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[371.254517] Subtest reloc-allocator: SUCCESS (0.043s)
[371.381371] [077/138] (629s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[373.349923] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[373.354348] Starting dynamic subtest: pipe-A-HDMI-A-3
[402.149405] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (28.796s)
[402.160583] Starting dynamic subtest: pipe-B-HDMI-A-3
[429.574157] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (27.420s)
[429.585607] Starting dynamic subtest: pipe-C-HDMI-A-3
[429.797975] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.219s)
[429.811779] Starting dynamic subtest: pipe-D-HDMI-A-3
[430.021345] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.218s)
[430.022347] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (56.673s)
[430.212160] [078/138] (570s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[430.303216] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[430.319895] [079/138] (570s left) gem_userptr_blits (stress-mm-invalidate-close)
[430.377043] Starting subtest: stress-mm-invalidate-close
[432.560229] Subtest stress-mm-invalidate-close: SUCCESS (2.174s)
[432.712563] [080/138] (568s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[434.653881] Starting subtest: cursor-vs-flip-varying-size
[464.061463] Subtest cursor-vs-flip-varying-size: SUCCESS (29.406s)
[464.212539] [081/138] (536s left) gem_exec_schedule (semaphore-power)
[464.396498] Subtest semaphore-power: SKIP (0.000s)
[464.579886] [082/138] (536s left) kms_plane_scaling (planes-upscale-20x20)
[466.516394] Starting subtest: planes-upscale-20x20
[466.521351] Starting dynamic subtest: pipe-A-HDMI-A-3
[466.612446] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.092s)
[466.632807] Starting dynamic subtest: pipe-B-HDMI-A-3
[466.778447] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.159s)
[466.800699] Starting dynamic subtest: pipe-C-HDMI-A-3
[466.920886] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.134s)
[466.931369] Starting dynamic subtest: pipe-D-HDMI-A-3
[467.027262] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.102s)
[467.028246] Subtest planes-upscale-20x20: SUCCESS (0.512s)
[467.191467] [083/138] (533s left) gem_exec_alignment (pi-isolated)
[467.269031] Starting subtest: pi-isolated
[479.937183] Killing the test because the kernel is tainted.
[487.063130] Aborting: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         1819 [max: 8192]
 direct dependencies:                 18208 [max: 32768]
 indirect dependencies:              137417
 all direct dependencies:            393618
 dependency chains:                   27173 [max: 131072]
 dependency chain hlocks used:       115333 [max: 655360]
 dependency chain hlocks lost:            0
 in-hardirq chains:                     309
 in-softirq chains:                     747
 in-process chains:                   26117
 stack-trace entries:                199168 [max: 1048576]
 number of stack traces:               9944
 number of stack hash chains:          7429
 combined max dependencies:      1761274544
 hardirq-safe locks:                    111
 hardirq-unsafe locks:                 1085
 softirq-safe locks:                    214
 softirq-unsafe locks:                  995
 irq-safe locks:                        235
 irq-unsafe locks:                     1085
 hardirq-read-safe locks:                 3
 hardirq-read-unsafe locks:             313
 softirq-read-safe locks:                 7
 softirq-read-unsafe locks:             308
 irq-read-safe locks:                     7
 irq-read-unsafe locks:                 313
 uncategorized locks:                   300
 unused locks:                            1
 max locking depth:                      18
 max bfs queue depth:                   418
 max lock class index:                 1818
 chain lookup misses:                 33383
 chain lookup hits:               598988358
 cyclic checks:                       33884
 redundant checks:                        0
 redundant links:                         0
 find-mask forwards checks:            6121
 find-mask backwards checks:           3165
 hardirq on events:               295888223
 hardirq off events:              295888217
 redundant hardirq ons:                  58
 redundant hardirq offs:                 32
 softirq on events:                 1079122
 softirq off events:                1079122
 redundant softirq ons:                   0
 redundant softirq offs:                  0
 debug_locks:                             0

 zapped classes:                        339
 zapped lock chains:                   6105
 large chain blocks:                      1

[487.064800] Closing watchdogs
Done.