[49.217280] Initializing watchdogs [49.217764] /dev/watchdog0 [49.250707] [001/142] (960s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [49.739383] Starting subtest: plane-all-transition-nonblocking-fencing [49.742655] Starting dynamic subtest: pipe-A-eDP-1 [53.151637] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.408s) [53.588406] Starting dynamic subtest: pipe-B-eDP-1 [58.644715] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.076s) [59.046814] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (9.308s) [59.998969] [002/142] (949s left) vgem_basic (setversion) [60.486654] Starting subtest: setversion [60.493842] Subtest setversion: SUCCESS (0.000s) [60.559950] [003/142] (949s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_mc_ccs) [61.762382] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs [65.902480] Subtest pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs: SUCCESS (4.139s) [67.457106] [004/142] (942s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted) [67.843418] Starting subtest: invalid-multi-wait-all-available-unsubmitted [67.847660] Subtest invalid-multi-wait-all-available-unsubmitted: SUCCESS (0.001s) [67.969551] [005/142] (942s left) kms_atomic (plane-primary-legacy) [69.034406] Starting subtest: plane-primary-legacy [69.335474] Subtest plane-primary-legacy: SUCCESS (0.301s) [70.664805] [006/142] (939s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [71.047374] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [71.151818] [007/142] (939s left) gem_fenced_exec_thrash (2-spare-fences) [71.555109] Subtest 2-spare-fences: SKIP (0.000s) [71.657156] [008/142] (938s left) gem_userptr_blits (unsync-unmap) [72.063753] Subtest unsync-unmap: SKIP (0.000s) [72.322993] [009/142] (937s left) v3d/v3d_perfmon (destroy-valid-perfmon) [72.792478] Subtest destroy-valid-perfmon: SKIP (0.000s) [72.893866] [010/142] (937s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs_cc) [74.626128] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc [74.636220] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [75.303446] [011/142] (935s left) kms_plane_alpha_blend (constant-alpha-mid) [75.791425] Starting subtest: constant-alpha-mid [77.564383] Starting dynamic subtest: pipe-A-eDP-1 [79.312790] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.748s) [79.348187] Starting dynamic subtest: pipe-D-eDP-1 [81.732532] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.408s) [81.736319] Subtest constant-alpha-mid: SUCCESS (5.940s) [82.663398] [012/142] (927s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [83.083812] Starting subtest: blocking-absolute-wf_vblank-interruptible [83.111470] Starting dynamic subtest: A-eDP1 [92.415291] Dynamic subtest A-eDP1: SUCCESS (9.303s) [92.441180] Starting dynamic subtest: B-eDP1 [101.549712] Dynamic subtest B-eDP1: SUCCESS (9.131s) [101.585427] Starting dynamic subtest: C-eDP1 [110.667761] Dynamic subtest C-eDP1: SUCCESS (9.115s) [110.704710] Starting dynamic subtest: D-eDP1 [119.795804] Dynamic subtest D-eDP1: SUCCESS (9.126s) [119.822266] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (36.741s) [121.325634] [013/142] (889s left) vc4/vc4_wait_bo (used-bo-0ns) [121.792721] Subtest used-bo-0ns: SKIP (0.000s) [121.895146] [014/142] (888s left) v3d/v3d_submit_csd (single-out-sync) [122.356608] Subtest single-out-sync: SKIP (0.000s) [122.463328] [015/142] (888s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs) [123.796353] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs [123.812927] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.013s) [124.869197] [016/142] (885s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [125.429891] Starting subtest: basic-flip-after-cursor-atomic [126.805315] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.374s) [127.742427] [017/142] (883s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [128.612850] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [129.473924] [018/142] (881s left) kms_cursor_edge_walk (64x64-top-bottom) [129.948359] Starting subtest: 64x64-top-bottom [129.955774] Starting dynamic subtest: pipe-A-eDP-1 [133.847337] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.891s) [133.882374] Starting dynamic subtest: pipe-D-eDP-1 [137.306383] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.450s) [137.310103] Subtest 64x64-top-bottom: SUCCESS (7.358s) [138.240418] [019/142] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite) [138.757701] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite [144.273624] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (5.522s) [144.529862] [020/142] (866s left) gem_exec_balancer (parallel-ordering) [145.793657] Starting subtest: parallel-ordering [149.205820] Subtest parallel-ordering: SUCCESS (3.414s) [149.318353] [021/142] (861s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [152.282626] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s) [152.431616] [022/142] (858s left) i915_suspend (basic-s3-without-i915) [152.800199] Starting subtest: basic-s3-without-i915 [156.220135] Subtest basic-s3-without-i915: SKIP (3.412s) [158.761472] [023/142] (852s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc) [160.973882] Starting subtest: pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc [160.978181] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.003s) [161.574649] [024/142] (849s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_mc_ccs) [163.082335] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_mc_ccs [163.089032] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s) [163.946419] [025/142] (847s left) feature_discovery (chamelium) [164.447242] Starting subtest: chamelium [164.454390] Subtest chamelium: SKIP (0.001s) [164.582450] [026/142] (846s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_rc_ccs) [166.052274] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs [166.055813] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SUCCESS (0.001s) [166.946514] [027/142] (844s left) gem_mmap_gtt (cpuset-big-copy-xy) [167.319375] Subtest cpuset-big-copy-XY: SKIP (0.000s) [167.421873] [028/142] (844s left) kms_prop_blob (invalid-get-prop) [167.794980] Starting subtest: invalid-get-prop [167.798588] Subtest invalid-get-prop: SUCCESS (0.000s) [167.926114] [029/142] (843s left) kms_vblank (pipe-d-ts-continuation-modeset) [168.407943] Starting subtest: pipe-D-ts-continuation-modeset [172.156744] Subtest pipe-D-ts-continuation-modeset: SUCCESS (3.747s) [173.093314] [030/142] (838s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_rc_ccs_cc) [173.575349] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc [173.578999] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.002s) [175.427173] [031/142] (836s left) gem_lmem_swapping (random-engines) [175.829850] Subtest random-engines: SKIP (0.000s) [175.932472] [032/142] (836s left) gem_mmap_gtt (basic-write) [176.296247] Subtest basic-write: SKIP (0.000s) [176.400965] [033/142] (835s left) syncobj_wait (invalid-reset-bad-pad) [176.772879] Starting subtest: invalid-reset-bad-pad [176.776683] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [176.900955] [034/142] (835s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [177.431317] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [182.660347] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: FAIL (4.438s) [182.721727] [035/142] (829s left) syncobj_wait (single-wait-all-signaled) [183.094667] Starting subtest: single-wait-all-signaled [183.098913] Subtest single-wait-all-signaled: SUCCESS (0.001s) [183.230202] [036/142] (829s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [183.734653] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [195.582195] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (11.849s) [195.838443] [037/142] (816s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [196.387786] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [200.166422] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (3.777s) [200.548288] [038/142] (811s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [201.062168] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [215.996138] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (14.943s) [216.268129] [039/142] (796s left) kms_properties (connector-properties-legacy) [216.752898] Starting subtest: connector-properties-legacy [227.092896] Subtest connector-properties-legacy: SUCCESS (10.339s) [227.680768] [040/142] (784s left) kms_frontbuffer_tracking (psr-suspend) [228.195790] Starting subtest: psr-suspend [270.539884] Subtest psr-suspend: SUCCESS (42.346s) [270.727764] [041/142] (741s left) i915_pm_rpm (universal-planes-dpms) [276.806406] Starting subtest: universal-planes-dpms [276.810099] Starting dynamic subtest: plane-31 [301.551320] Dynamic subtest plane-31: SUCCESS (24.742s) [301.599160] Starting dynamic subtest: plane-40 [326.240888] Dynamic subtest plane-40: SUCCESS (24.685s) [326.288638] Starting dynamic subtest: plane-49 [350.823080] Dynamic subtest plane-49: SUCCESS (24.578s) [350.871536] Starting dynamic subtest: plane-58 [375.458251] Dynamic subtest plane-58: SUCCESS (24.630s) [375.506100] Starting dynamic subtest: plane-67 [400.192590] Dynamic subtest plane-67: SUCCESS (24.728s) [400.245698] Starting dynamic subtest: plane-76 [424.867817] Dynamic subtest plane-76: SUCCESS (24.670s) [424.871397] Subtest universal-planes-dpms: SUCCESS (148.065s) [426.095963] [042/142] (586s left) gem_ctx_persistence (saturated-hostile) [426.492939] Starting subtest: saturated-hostile [426.497273] Starting dynamic subtest: rcs0 [426.628202] Dynamic subtest rcs0: SUCCESS (0.134s) [426.677525] Starting dynamic subtest: bcs0 [426.751300] Dynamic subtest bcs0: SUCCESS (0.110s) [426.793349] Starting dynamic subtest: vcs0 [426.840206] Dynamic subtest vcs0: SUCCESS (0.091s) [426.885823] Starting dynamic subtest: vcs1 [426.950236] Dynamic subtest vcs1: SUCCESS (0.106s) [426.996858] Starting dynamic subtest: vecs0 [427.058575] Dynamic subtest vecs0: SUCCESS (0.105s) [427.100609] Starting dynamic subtest: ccs0 [427.154191] Dynamic subtest ccs0: SUCCESS (0.092s) [427.157916] Subtest saturated-hostile: SUCCESS (0.664s) [427.309678] [043/142] (585s left) gem_pxp (verify-pxp-stale-ctx-execution) [430.230640] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s) [430.395994] [044/142] (582s left) gem_exec_schedule (preempt-contexts) [430.850273] Starting subtest: preempt-contexts [430.855756] Starting dynamic subtest: rcs0 [431.108713] Dynamic subtest rcs0: SUCCESS (0.257s) [431.160467] Starting dynamic subtest: bcs0 [431.355308] Dynamic subtest bcs0: SUCCESS (0.243s) [431.403879] Starting dynamic subtest: vcs0 [431.562195] Dynamic subtest vcs0: SUCCESS (0.202s) [431.610471] Starting dynamic subtest: vcs1 [431.770814] Dynamic subtest vcs1: SUCCESS (0.204s) [431.818890] Starting dynamic subtest: vecs0 [431.982614] Dynamic subtest vecs0: SUCCESS (0.207s) [432.030881] Starting dynamic subtest: ccs0 [432.232688] Dynamic subtest ccs0: SUCCESS (0.245s) [432.235910] Subtest preempt-contexts: SUCCESS (1.385s) [432.905199] [045/142] (580s left) i915_pm_rpm (modeset-non-lpsp-stress) [439.006920] Starting subtest: modeset-non-lpsp-stress [443.000480] Subtest modeset-non-lpsp-stress: SKIP (3.989s) [443.882215] [046/142] (569s left) kms_hdr (invalid-metadata-sizes) [444.357783] Starting subtest: invalid-metadata-sizes [444.364718] Subtest invalid-metadata-sizes: SKIP (0.001s) [444.504526] [047/142] (568s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [444.903416] Starting subtest: invalid-bsd1-flag-on-vebox [444.907179] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.002s) [445.076418] [048/142] (568s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [445.581296] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [445.587771] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [445.761787] [049/142] (567s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_mc_ccs) [447.438101] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_gen12_mc_ccs [447.444952] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s) [448.087497] [050/142] (565s left) syncobj_timeline (invalid-signal-one-illegal-handle) [448.470585] Starting subtest: invalid-signal-one-illegal-handle [448.474305] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.002s) [448.609134] [051/142] (564s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs_cc) [449.712286] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc [449.718515] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [450.996339] [052/142] (562s left) dmabuf_sync_file (import-multiple-read-write) [451.380470] Starting subtest: import-multiple-read-write [451.402987] Subtest import-multiple-read-write: SUCCESS (0.024s) [451.532103] [053/142] (562s left) device_reset (unbind-reset-rebind) [452.334987] Starting subtest: unbind-reset-rebind [456.899060] Subtest unbind-reset-rebind: SUCCESS (4.563s) [457.110645] [054/142] (556s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [457.629391] Starting subtest: fbc-1p-primscrn-cur-indfb-move [463.892296] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (6.264s) [464.203425] [055/142] (549s left) kms_vblank (pipe-b-ts-continuation-dpms-suspend) [464.691508] Starting subtest: pipe-B-ts-continuation-dpms-suspend [483.598836] Subtest pipe-B-ts-continuation-dpms-suspend: SUCCESS (18.909s) [484.557364] [056/142] (529s left) gem_exec_reloc (basic-gtt-wc-active) [484.977472] Subtest basic-gtt-wc-active: SKIP (0.000s) [485.120220] [057/142] (528s left) i915_pm_dc (dc5-psr) [486.618152] Starting subtest: dc5-psr [490.233860] Subtest dc5-psr: SUCCESS (3.613s) [491.562711] [058/142] (522s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [492.084674] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [492.091348] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [492.250348] [059/142] (521s left) kms_chamelium_hpd (dp-hpd) [493.138135] Subtest dp-hpd: SKIP (0.000s) [494.012290] [060/142] (520s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [494.490871] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [494.500268] Starting dynamic subtest: pipe-A-eDP-1 [494.593341] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s) [494.642883] Starting dynamic subtest: pipe-B-eDP-1 [494.783800] Dynamic subtest pipe-B-eDP-1: SKIP (0.177s) [494.830534] Starting dynamic subtest: pipe-C-eDP-1 [494.980530] Dynamic subtest pipe-C-eDP-1: SKIP (0.187s) [495.033964] Starting dynamic subtest: pipe-D-eDP-1 [495.166772] Dynamic subtest pipe-D-eDP-1: SKIP (0.178s) [495.173199] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.674s) [495.341144] [061/142] (519s left) gem_create (create-ext-placement-all) [495.874199] Starting subtest: create-ext-placement-all [495.877800] Subtest create-ext-placement-all: SUCCESS (0.000s) [496.051424] [062/142] (518s left) v3d/v3d_submit_csd (bad-bo) [496.531635] Subtest bad-bo: SKIP (0.000s) [496.663166] [063/142] (517s left) gem_exec_fair (basic-throttle) [497.079700] Subtest basic-throttle: SKIP (0.000s) [497.217077] [064/142] (517s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [497.745657] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [497.752580] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [497.921777] [065/142] (516s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [498.424171] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [498.431056] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [498.594362] [066/142] (516s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [499.081952] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [499.091761] Starting dynamic subtest: pipe-A-default-mode [499.566712] Dynamic subtest pipe-A-default-mode: SKIP (0.472s) [499.573605] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.486s) [500.451633] [067/142] (514s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [500.831313] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [500.835215] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.003s) [500.988783] [068/142] (514s left) kms_addfb_basic (invalid-set-prop) [501.357382] Starting subtest: invalid-set-prop [501.360427] Subtest invalid-set-prop: SUCCESS (0.000s) [501.633856] [069/142] (513s left) kms_busy (extended-modeset-hang-newfb-with-reset) [502.212872] Starting subtest: extended-modeset-hang-newfb-with-reset [502.226663] Starting dynamic subtest: pipe-A [509.442791] Dynamic subtest pipe-A: SUCCESS (7.217s) [509.506125] Starting dynamic subtest: pipe-D [517.024114] Dynamic subtest pipe-D: SUCCESS (7.556s) [517.028466] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (14.809s) [517.971167] [070/142] (497s left) perf_pmu (most-busy-check-all) [518.361708] Starting subtest: most-busy-check-all [518.365617] Starting dynamic subtest: rcs0 [520.504074] Dynamic subtest rcs0: SUCCESS (2.139s) [520.556185] Starting dynamic subtest: bcs0 [522.550819] Dynamic subtest bcs0: SUCCESS (2.043s) [522.603165] Starting dynamic subtest: vcs0 [524.533415] Dynamic subtest vcs0: SUCCESS (1.978s) [524.586336] Starting dynamic subtest: vcs1 [526.517432] Dynamic subtest vcs1: SUCCESS (1.979s) [526.569720] Starting dynamic subtest: vecs0 [528.501178] Dynamic subtest vecs0: SUCCESS (1.980s) [528.552622] Starting dynamic subtest: ccs0 [530.548864] Dynamic subtest ccs0: SUCCESS (2.044s) [530.552669] Subtest most-busy-check-all: SUCCESS (12.189s) [530.744332] [071/142] (484s left) kms_cursor_crc (cursor-rapid-movement-512x170) [531.999205] Starting subtest: cursor-rapid-movement-512x170 [532.010739] Subtest cursor-rapid-movement-512x170: SKIP (0.007s) [532.336537] [072/142] (483s left) prime_mmap_coherency (write) [532.738380] Starting subtest: write [538.136714] Subtest write: SUCCESS (5.395s) [538.631528] [073/142] (476s left) syncobj_timeline (wait-all-for-submit-snapshot) [539.003586] Starting subtest: wait-all-for-submit-snapshot [539.088277] Subtest wait-all-for-submit-snapshot: SUCCESS (0.085s) [539.277466] [074/142] (476s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render) [539.790653] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render [539.797514] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [539.969634] [075/142] (475s left) gen9_exec_parse (bb-start-cmd) [540.369419] Subtest bb-start-cmd: SKIP (0.000s) [540.492550] [076/142] (475s left) gem_ctx_engines (execute-one) [540.913839] Starting subtest: execute-one [549.204781] Subtest execute-one: SUCCESS (8.291s) [549.666543] [077/142] (466s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_rc_ccs) [551.189460] Starting subtest: pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs [551.193130] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs: SUCCESS (0.001s) [551.648743] [078/142] (464s left) kms_plane (plane-panning-bottom-right) [552.125155] Starting subtest: plane-panning-bottom-right [552.133300] Starting dynamic subtest: pipe-A-planes [554.427490] Dynamic subtest pipe-A-planes: SUCCESS (2.291s) [554.478480] Starting dynamic subtest: pipe-B-planes [557.389682] Dynamic subtest pipe-B-planes: SUCCESS (2.949s) [557.393774] Subtest plane-panning-bottom-right: SUCCESS (5.261s) [558.307705] [079/142] (457s left) gem_softpin (reverse) [558.699887] Starting subtest: reverse [558.735104] Subtest reverse: SUCCESS (0.034s) [558.929337] [080/142] (457s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [559.435378] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [559.442648] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [559.610763] [081/142] (456s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [560.156849] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [560.163916] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [560.339302] [082/142] (455s left) gem_linear_blits (basic) [564.059296] Starting subtest: basic [564.085191] Subtest basic: SUCCESS (0.034s) [564.345510] [083/142] (451s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_ccs) [565.414532] Starting subtest: pipe-A-crc-primary-basic-y_tiled_ccs [565.421348] Subtest pipe-A-crc-primary-basic-y_tiled_ccs: SKIP (0.002s) [566.859556] [084/142] (449s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [567.374059] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [572.712061] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (5.347s) [573.005869] [085/142] (443s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs) [574.195405] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs [575.825889] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.630s) [577.395313] [086/142] (439s left) kms_scaling_modes (scaling-mode-full-aspect) [577.901351] Starting subtest: scaling-mode-full-aspect [577.904857] Starting dynamic subtest: eDP-1-pipe-A [578.253830] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.350s) [578.313574] Starting dynamic subtest: eDP-1-pipe-B [579.875826] Dynamic subtest eDP-1-pipe-B: SUCCESS (1.613s) [579.936081] Starting dynamic subtest: eDP-1-pipe-C [581.492392] Dynamic subtest eDP-1-pipe-C: SUCCESS (1.607s) [581.553443] Starting dynamic subtest: eDP-1-pipe-D [583.159449] Dynamic subtest eDP-1-pipe-D: SUCCESS (1.653s) [583.162878] Subtest scaling-mode-full-aspect: SUCCESS (5.261s) [584.706884] [087/142] (432s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [585.265778] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip [585.272586] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [585.458791] [088/142] (431s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area) [592.706692] Starting subtest: overlay-primary-update-sf-dmg-area [592.715517] Starting dynamic subtest: pipe-A-eDP-1 [600.378210] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.663s) [600.434495] Starting dynamic subtest: pipe-B-eDP-1 [608.514385] Dynamic subtest pipe-B-eDP-1: SUCCESS (8.129s) [608.517776] Subtest overlay-primary-update-sf-dmg-area: SUCCESS (15.809s) [609.475117] [089/142] (407s left) syncobj_timeline (wait-for-submit-delayed-submit) [609.874684] Starting subtest: wait-for-submit-delayed-submit [609.976127] Subtest wait-for-submit-delayed-submit: SUCCESS (0.106s) [610.147935] [090/142] (406s left) kms_flip (2x-flip-vs-suspend-interruptible) [610.570460] Starting subtest: 2x-flip-vs-suspend-interruptible [610.741926] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.167s) [610.921817] [091/142] (406s left) vc4/vc4_purgeable_bo (mark-purgeable) [611.413056] Subtest mark-purgeable: SKIP (0.000s) [611.554121] [092/142] (405s left) syncobj_wait (invalid-reset-zero-handles) [611.942498] Starting subtest: invalid-reset-zero-handles [611.946701] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [612.100942] [093/142] (405s left) kms_cursor_crc (cursor-onscreen-512x170) [613.348273] Starting subtest: cursor-onscreen-512x170 [613.360555] Subtest cursor-onscreen-512x170: SKIP (0.007s) [613.685680] [094/142] (403s left) kms_big_fb (4-tiled-8bpp-rotate-180) [614.228453] Starting subtest: 4-tiled-8bpp-rotate-180 [618.270713] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (4.038s) [618.618784] [095/142] (398s left) gem_exec_whisper (basic-fds-forked-all) [619.038439] Starting subtest: basic-fds-forked-all [665.839710] Subtest basic-fds-forked-all: SUCCESS (46.796s) [666.145329] [096/142] (351s left) prime_vgem (fence-read-hang) [666.571472] Subtest fence-read-hang: SKIP (0.000s) [666.784330] [097/142] (350s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs) [668.386918] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs [669.644993] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.254s) [671.061309] [098/142] (346s left) kms_ccs (pipe-a-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc) [672.081397] Starting subtest: pipe-A-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc [672.085068] Subtest pipe-A-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.002s) [673.462354] [099/142] (344s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [673.997839] Starting subtest: fbc-rgb565-draw-mmap-wc [688.802778] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (14.807s) [689.119430] [100/142] (328s left) gem_ctx_param (vm) [689.499373] Starting subtest: vm [689.638242] Subtest vm: SUCCESS (0.142s) [689.855130] [101/142] (328s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [690.339923] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [690.350329] Starting dynamic subtest: pipe-A-default-mode [690.752867] Dynamic subtest pipe-A-default-mode: SKIP (0.399s) [690.759921] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.412s) [691.705052] [102/142] (326s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [692.281636] Starting subtest: cursorB-vs-flipA-atomic-transitions [692.299642] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.016s) [692.647179] [103/142] (325s left) gen7_exec_parse (bitmasks) [693.047401] Subtest bitmasks: SKIP (0.000s) [693.179329] [104/142] (325s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [693.695144] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [693.702374] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [693.873386] [105/142] (324s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [694.418343] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [699.840288] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: FAIL (4.612s) [699.927799] [106/142] (318s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [700.354316] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [700.386571] Starting dynamic subtest: A-eDP1 [704.928122] Dynamic subtest A-eDP1: SUCCESS (4.537s) [704.984144] Starting dynamic subtest: B-eDP1 [708.580583] Dynamic subtest B-eDP1: SUCCESS (3.649s) [708.636588] Starting dynamic subtest: C-eDP1 [712.235997] Dynamic subtest C-eDP1: SUCCESS (3.654s) [712.297434] Starting dynamic subtest: D-eDP1 [715.890885] Dynamic subtest D-eDP1: SUCCESS (3.649s) [715.914757] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (15.561s) [716.861566] [107/142] (301s left) gem_userptr_blits (map-fixed-invalidate) [717.336136] Starting subtest: map-fixed-invalidate [717.342873] Subtest map-fixed-invalidate: SKIP (0.000s) [717.582595] [108/142] (301s left) api_intel_bb (blit-noreloc-keep-cache) [717.970502] Starting subtest: blit-noreloc-keep-cache [718.006652] Subtest blit-noreloc-keep-cache: SUCCESS (0.043s) [718.203606] [109/142] (300s left) gem_ppgtt (shrink-vs-evict-pinned) [718.608475] Starting subtest: shrink-vs-evict-pinned [726.590463] Subtest shrink-vs-evict-pinned: SUCCESS (7.980s) [726.784608] [110/142] (292s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [727.314109] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [727.321599] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [727.499361] [111/142] (291s left) kms_flip (2x-plain-flip-ts-check-interruptible) [727.929854] Starting subtest: 2x-plain-flip-ts-check-interruptible [728.098173] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.164s) [728.279758] [112/142] (290s left) kms_color (invalid-ctm-matrix-sizes) [728.638567] Starting subtest: invalid-ctm-matrix-sizes [728.641860] Starting dynamic subtest: pipe-A [728.648241] Dynamic subtest pipe-A: SUCCESS (0.013s) [728.709389] Starting dynamic subtest: pipe-B [728.712853] Dynamic subtest pipe-B: SUCCESS (0.016s) [728.774247] Starting dynamic subtest: pipe-C [728.777701] Dynamic subtest pipe-C: SUCCESS (0.021s) [728.835444] Starting dynamic subtest: pipe-D [728.838847] Dynamic subtest pipe-D: SUCCESS (0.022s) [728.841928] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.086s) [728.921136] [113/142] (290s left) gem_exec_reloc (basic-wc-active) [729.321752] Subtest basic-wc-active: SKIP (0.000s) [729.471250] [114/142] (289s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [729.854650] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [729.996223] [115/142] (289s left) gem_ctx_param (get-priority-new-ctx) [730.380862] Starting subtest: get-priority-new-ctx [730.384525] Subtest get-priority-new-ctx: SUCCESS (0.002s) [730.545747] [116/142] (289s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [731.057705] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [731.064371] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [731.244542] [117/142] (288s left) gem_render_linear_blits (basic) [731.643551] Starting subtest: basic [731.795485] Subtest basic: SUCCESS (0.152s) [731.978867] [118/142] (287s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [732.468059] Starting subtest: compare-crc-sanitycheck-xr24 [732.473248] Starting dynamic subtest: pipe-A-eDP-1 [733.670985] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.193s) [733.747630] Starting dynamic subtest: pipe-B-eDP-1 [735.491318] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.812s) [735.557178] Starting dynamic subtest: pipe-C-eDP-1 [737.563920] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.058s) [737.629170] Starting dynamic subtest: pipe-D-eDP-1 [739.884524] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.311s) [739.888123] Subtest compare-crc-sanitycheck-xr24: SUCCESS (7.419s) [740.854903] [119/142] (279s left) kms_vblank (pipe-c-accuracy-idle) [741.347112] Starting subtest: pipe-C-accuracy-idle [744.826933] Subtest pipe-C-accuracy-idle: SUCCESS (3.476s) [745.794400] [120/142] (274s left) kms_sequence (get-busy) [746.281860] Starting subtest: get-busy [746.290759] Starting dynamic subtest: eDP-1-pipe-A [748.493823] Dynamic subtest eDP-1-pipe-A: SUCCESS (2.205s) [748.562405] Starting dynamic subtest: eDP-1-pipe-B [751.383397] Dynamic subtest eDP-1-pipe-B: SUCCESS (2.878s) [751.450888] Starting dynamic subtest: eDP-1-pipe-C [754.129933] Dynamic subtest eDP-1-pipe-C: SUCCESS (2.738s) [754.197619] Starting dynamic subtest: eDP-1-pipe-D [757.590955] Dynamic subtest eDP-1-pipe-D: SUCCESS (3.449s) [757.594725] Subtest get-busy: SUCCESS (11.308s) [758.556262] [121/142] (261s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [759.125289] Starting subtest: 2x-cursor-vs-flip-atomic [759.139635] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.016s) [759.496604] [122/142] (260s left) gem_exec_schedule (u-independent) [759.944535] Starting subtest: u-independent [759.947943] Starting dynamic subtest: rcs0 [761.534657] Dynamic subtest rcs0: SUCCESS (1.591s) [761.595517] Starting dynamic subtest: bcs0 [763.518208] Dynamic subtest bcs0: SUCCESS (1.979s) [763.585870] Starting dynamic subtest: vcs0 [765.551254] Dynamic subtest vcs0: SUCCESS (2.025s) [765.616728] Starting dynamic subtest: vcs1 [767.589301] Dynamic subtest vcs1: SUCCESS (2.036s) [767.656385] Starting dynamic subtest: vecs0 [769.574688] Dynamic subtest vecs0: SUCCESS (1.980s) [769.640254] Starting dynamic subtest: ccs0 [771.456925] Dynamic subtest ccs0: SUCCESS (1.876s) [771.460934] Subtest u-independent: SUCCESS (11.516s) [771.889834] [123/142] (248s left) perf (blocking) [772.844704] Starting subtest: blocking [772.848281] Starting dynamic subtest: 0-rcs0 [782.952998] Dynamic subtest 0-rcs0: SUCCESS (10.105s) [783.016864] Starting dynamic subtest: 1-vecs0 [793.005797] Dynamic subtest 1-vecs0: SUCCESS (10.048s) [793.009437] Subtest blocking: SUCCESS (20.162s) [793.133431] [124/142] (227s left) gem_exec_gttfill (multigpu-basic) [793.689307] Starting subtest: multigpu-basic [793.696718] Subtest multigpu-basic: SKIP (0.000s) [793.888969] [125/142] (226s left) gem_userptr_blits (vma-merge) [794.403397] Starting subtest: vma-merge [814.946545] Subtest vma-merge: FAIL (20.495s) [815.098806] [126/142] (205s left) gem_exec_params (secure-non-root) [815.506844] Starting subtest: secure-non-root [815.513956] Subtest secure-non-root: SKIP (0.000s) [815.727755] [127/142] (205s left) kms_flip (2x-absolute-wf_vblank) [816.145859] Starting subtest: 2x-absolute-wf_vblank [816.309707] Subtest 2x-absolute-wf_vblank: SKIP (0.165s) [816.527171] [128/142] (204s left) gem_exec_alignment (forked) [816.935124] Starting subtest: forked [829.626987] Killing the test because the kernel is tainted. [830.800184] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 1861 [max: 8192] direct dependencies: 20756 [max: 32768] indirect dependencies: 165691 all direct dependencies: 428114 dependency chains: 32012 [max: 131072] dependency chain hlocks used: 142476 [max: 655360] dependency chain hlocks lost: 0 in-hardirq chains: 334 in-softirq chains: 636 in-process chains: 31042 stack-trace entries: 208844 [max: 1048576] number of stack traces: 10333 number of stack hash chains: 7674 combined max dependencies: 2329453689 hardirq-safe locks: 124 hardirq-unsafe locks: 1098 softirq-safe locks: 220 softirq-unsafe locks: 1010 irq-safe locks: 247 irq-unsafe locks: 1098 hardirq-read-safe locks: 3 hardirq-read-unsafe locks: 331 softirq-read-safe locks: 7 softirq-read-unsafe locks: 326 irq-read-safe locks: 7 irq-read-unsafe locks: 331 uncategorized locks: 298 unused locks: 1 max locking depth: 16 max bfs queue depth: 443 max lock class index: 1860 chain lookup misses: 37446 chain lookup hits: 434928894 cyclic checks: 37850 redundant checks: 0 redundant links: 0 find-mask forwards checks: 6570 find-mask backwards checks: 3047 hardirq on events: 252369231 hardirq off events: 252369210 redundant hardirq ons: 54 redundant hardirq offs: 30 softirq on events: 1194539 softirq off events: 1194539 redundant softirq ons: 0 redundant softirq offs: 0 debug_locks: 0 zapped classes: 196 zapped lock chains: 4951 large chain blocks: 1 [830.805622] Closing watchdogs Done.