[62.443737] Initializing watchdogs [62.443802] /dev/watchdog0 [62.464027] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [62.475260] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [62.478960] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.481358] [001/132] (960s left) syncobj_eventfd (binary-wait-before-signal) [62.566508] Starting subtest: binary-wait-before-signal [62.597508] Subtest binary-wait-before-signal: SUCCESS (0.031s) [62.762114] [002/132] (960s left) gem_mmap_gtt (fault-concurrent-x) [62.832968] Subtest fault-concurrent-X: SKIP (0.000s) [62.894378] [003/132] (960s left) gem_exec_store (cachelines) [62.979550] Starting subtest: cachelines [62.980482] Starting dynamic subtest: rcs0 [63.094507] Dynamic subtest rcs0: SUCCESS (0.115s) [63.105684] Starting dynamic subtest: bcs0 [63.150234] Dynamic subtest bcs0: SUCCESS (0.055s) [63.161139] Starting dynamic subtest: vcs0 [63.207206] Dynamic subtest vcs0: SUCCESS (0.057s) [63.232523] Starting dynamic subtest: vcs1 [63.283250] Dynamic subtest vcs1: SUCCESS (0.075s) [63.294364] Starting dynamic subtest: vecs0 [63.333857] Dynamic subtest vecs0: SUCCESS (0.050s) [63.346397] Starting dynamic subtest: vecs1 [63.387097] Dynamic subtest vecs1: SUCCESS (0.053s) [63.414993] Starting dynamic subtest: ccs0 [63.462041] Dynamic subtest ccs0: SUCCESS (0.074s) [63.463758] Subtest cachelines: SUCCESS (0.485s) [63.749733] [004/132] (959s left) drm_read (empty-block) [64.037512] Starting subtest: empty-block [65.038960] Subtest empty-block: SUCCESS (1.004s) [65.292555] [005/132] (957s left) perf (whitelisted-registers-userspace-config) [65.714110] Starting subtest: whitelisted-registers-userspace-config [65.714954] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s) [65.769600] [006/132] (957s left) syncobj_wait (wait-all-for-submit-delayed-submit) [65.842940] Starting subtest: wait-all-for-submit-delayed-submit [65.945807] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [66.087975] [007/132] (957s left) kms_ccs (random-ccs-data-y-tiled-ccs) [66.267242] Starting subtest: random-ccs-data-y-tiled-ccs [66.268135] Starting dynamic subtest: pipe-A-DP-3 [66.277191] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [66.284741] Starting dynamic subtest: pipe-B-DP-3 [66.293655] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [66.300995] Starting dynamic subtest: pipe-C-DP-3 [66.309821] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [66.317101] Starting dynamic subtest: pipe-D-DP-3 [66.327366] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [66.329347] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s) [66.729560] [008/132] (956s left) kms_content_protection (legacy) [67.096968] Starting subtest: legacy [67.336061] Starting dynamic subtest: pipe-A-DP-3 [188.343123] Dynamic subtest pipe-A-DP-3: FAIL (120.734s) [188.344006] Subtest legacy: FAIL (121.074s) [188.506593] [009/132] (834s left) kms_addfb_basic (bo-too-small-due-to-tiling) [188.684372] Starting subtest: bo-too-small-due-to-tiling [188.686145] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [188.871522] [010/132] (834s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [189.050222] Starting subtest: primary-yf-tiled-reflect-x-0 [189.144744] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.093s) [189.340018] [011/132] (834s left) syncobj_timeline (wait-all-for-submit-complex) [189.411463] Starting subtest: wait-all-for-submit-complex [189.630426] Subtest wait-all-for-submit-complex: SUCCESS (0.218s) [189.769019] [012/132] (833s left) api_intel_bb (object-reloc-keep-cache) [189.838306] Starting subtest: object-reloc-keep-cache [189.843437] Subtest object-reloc-keep-cache: SKIP (0.004s) [190.019119] [013/132] (833s left) kms_cursor_legacy (single-bo) [190.199419] Starting subtest: single-bo [190.200263] Starting dynamic subtest: pipe-A [195.581309] Dynamic subtest pipe-A: SUCCESS (5.380s) [195.589421] Starting dynamic subtest: pipe-B [200.960169] Dynamic subtest pipe-B: SUCCESS (5.378s) [200.968039] Starting dynamic subtest: pipe-C [206.339296] Dynamic subtest pipe-C: SUCCESS (5.379s) [206.347390] Starting dynamic subtest: pipe-D [211.719272] Dynamic subtest pipe-D: SUCCESS (5.379s) [211.727138] Starting dynamic subtest: all-pipes [217.098592] Dynamic subtest all-pipes: SUCCESS (5.379s) [217.099463] Subtest single-bo: SUCCESS (26.897s) [217.224514] [014/132] (806s left) kms_cursor_crc (cursor-size-hints) [217.481972] Starting subtest: cursor-size-hints [217.482919] Starting dynamic subtest: pipe-A-DP-3 [218.034296] Dynamic subtest pipe-A-DP-3: SUCCESS (0.551s) [218.043927] Starting dynamic subtest: pipe-D-DP-3 [218.521180] Dynamic subtest pipe-D-DP-3: SUCCESS (0.485s) [218.522212] Subtest cursor-size-hints: SUCCESS (1.039s) [219.084013] [015/132] (804s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [219.264440] Starting subtest: 2x-flip-vs-cursor-atomic [219.267216] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s) [219.443545] [016/132] (804s left) gem_exercise_blt (fast-copy-emit) [219.523244] Starting subtest: fast-copy-emit [219.524149] Starting dynamic subtest: linear-smem-smem-emit [219.568248] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.045s) [219.576154] Starting dynamic subtest: linear-smem-lmem0-emit [219.583499] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s) [219.591297] Starting dynamic subtest: linear-lmem0-smem-emit [219.675568] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.092s) [219.683323] Starting dynamic subtest: linear-lmem0-lmem0-emit [219.773628] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.098s) [219.781374] Starting dynamic subtest: xmajor-smem-smem-emit [219.789160] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.015s) [219.797635] Starting dynamic subtest: xmajor-smem-lmem0-emit [219.803938] Dynamic subtest xmajor-smem-lmem0-emit: SUCCESS (0.014s) [219.811759] Starting dynamic subtest: xmajor-lmem0-smem-emit [219.894634] Dynamic subtest xmajor-lmem0-smem-emit: SUCCESS (0.090s) [219.902433] Starting dynamic subtest: xmajor-lmem0-lmem0-emit [219.982886] Dynamic subtest xmajor-lmem0-lmem0-emit: SUCCESS (0.088s) [219.990669] Starting dynamic subtest: tile4-smem-smem-emit [219.999358] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s) [220.007180] Starting dynamic subtest: tile4-smem-lmem0-emit [220.013944] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.014s) [220.021800] Starting dynamic subtest: tile4-lmem0-smem-emit [220.113608] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.099s) [220.121232] Starting dynamic subtest: tile4-lmem0-lmem0-emit [220.204932] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.091s) [220.212665] Starting dynamic subtest: tile64-smem-smem-emit [220.220211] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s) [220.227975] Starting dynamic subtest: tile64-smem-lmem0-emit [220.235259] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.015s) [220.243059] Starting dynamic subtest: tile64-lmem0-smem-emit [220.331628] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.096s) [220.339436] Starting dynamic subtest: tile64-lmem0-lmem0-emit [220.437047] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.105s) [220.438039] Subtest fast-copy-emit: SUCCESS (0.914s) [220.614688] [017/132] (803s left) kms_async_flips (test-cursor-atomic) [220.791939] Starting subtest: test-cursor-atomic [221.026315] Starting dynamic subtest: pipe-A-DP-3 [221.322591] Dynamic subtest pipe-A-DP-3: SUCCESS (0.296s) [221.562143] Starting dynamic subtest: pipe-B-DP-3 [221.680568] Dynamic subtest pipe-B-DP-3: SUCCESS (0.126s) [221.891906] Starting dynamic subtest: pipe-C-DP-3 [222.003452] Dynamic subtest pipe-C-DP-3: SUCCESS (0.119s) [222.210879] Starting dynamic subtest: pipe-D-DP-3 [222.329552] Dynamic subtest pipe-D-DP-3: SUCCESS (0.126s) [222.330505] Subtest test-cursor-atomic: SUCCESS (1.539s) [222.871793] [018/132] (801s left) kms_frontbuffer_tracking (psr-2p-rte) [223.054699] Starting subtest: psr-2p-rte [223.056326] Subtest psr-2p-rte: SKIP (0.000s) [223.256222] [019/132] (800s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu) [223.441185] Starting subtest: psr-rgb101010-draw-mmap-cpu [223.442954] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [223.637371] [020/132] (800s left) drm_read (empty-nonblock) [223.876643] Starting subtest: empty-nonblock [223.877548] Subtest empty-nonblock: SUCCESS (0.000s) [224.154648] [021/132] (800s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [224.341395] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [224.343105] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [224.539387] [022/132] (799s left) gem_exec_nop (basic-series) [224.619843] Starting subtest: basic-series [228.964189] Subtest basic-series: SUCCESS (4.344s) [229.267932] [023/132] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [229.473617] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [232.395032] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.922s) [232.603476] [024/132] (791s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [232.855152] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [233.006171] [025/132] (791s left) prime_mmap (test_map_unmap) [233.075851] Starting subtest: test_map_unmap [233.076732] Starting dynamic subtest: test_map_unmap-smem [233.124145] Dynamic subtest test_map_unmap-smem: SUCCESS (0.048s) [233.132434] Starting dynamic subtest: test_map_unmap-lmem0 [233.321796] Dynamic subtest test_map_unmap-lmem0: SUCCESS (0.197s) [233.322760] Subtest test_map_unmap: SUCCESS (0.246s) [233.468203] [026/132] (791s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [233.547449] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [233.549359] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [233.827887] [027/132] (790s left) gem_exec_schedule (u-fairslice) [233.907547] Starting subtest: u-fairslice [233.908443] Starting dynamic subtest: rcs0 [235.959552] Dynamic subtest rcs0: SUCCESS (2.051s) [235.968226] Starting dynamic subtest: bcs0 [237.980910] Dynamic subtest bcs0: SUCCESS (2.021s) [237.989541] Starting dynamic subtest: vcs0 [240.000404] Dynamic subtest vcs0: SUCCESS (2.019s) [240.009238] Starting dynamic subtest: vcs1 [242.020384] Dynamic subtest vcs1: SUCCESS (2.020s) [242.029111] Starting dynamic subtest: vecs0 [244.039946] Dynamic subtest vecs0: SUCCESS (2.019s) [244.048644] Starting dynamic subtest: vecs1 [246.058862] Dynamic subtest vecs1: SUCCESS (2.018s) [246.068156] Starting dynamic subtest: ccs0 [248.079903] Dynamic subtest ccs0: SUCCESS (2.021s) [248.080812] Subtest u-fairslice: SUCCESS (14.171s) [248.509119] [028/132] (776s left) kms_psr (psr2-dpms) [248.686262] Subtest psr2-dpms: SKIP (0.000s) [248.738687] [029/132] (776s left) kms_color (ctm-max) [248.924634] Starting subtest: ctm-max [248.925526] Starting dynamic subtest: pipe-A-DP-3 [249.627454] Dynamic subtest pipe-A-DP-3: SUCCESS (0.702s) [249.641662] Starting dynamic subtest: pipe-B-DP-3 [250.239957] Dynamic subtest pipe-B-DP-3: SUCCESS (0.612s) [250.250640] Starting dynamic subtest: pipe-C-DP-3 [250.831470] Dynamic subtest pipe-C-DP-3: SUCCESS (0.592s) [250.842352] Starting dynamic subtest: pipe-D-DP-3 [251.429170] Dynamic subtest pipe-D-DP-3: SUCCESS (0.596s) [251.430243] Subtest ctm-max: SUCCESS (2.504s) [251.765602] [030/132] (773s left) gem_userptr_blits (nohangcheck) [251.853198] Starting subtest: nohangcheck [252.174222] Subtest nohangcheck: SUCCESS (0.320s) [252.362967] [031/132] (772s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [252.544738] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [252.546372] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [252.732489] [032/132] (772s left) kms_atomic_transition (plane-all-modeset-transition) [252.913980] Starting subtest: plane-all-modeset-transition [252.914846] Starting dynamic subtest: pipe-A-DP-3 [279.790884] Dynamic subtest pipe-A-DP-3: SUCCESS (26.875s) [279.895864] Starting dynamic subtest: pipe-B-DP-3 [303.241125] Dynamic subtest pipe-B-DP-3: SUCCESS (23.375s) [303.293846] Subtest plane-all-modeset-transition: SUCCESS (50.379s) [303.616128] [033/132] (721s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [303.792124] Starting subtest: flip-vs-cursor-busy-crc-legacy [304.557640] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.766s) [304.887345] [034/132] (720s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [305.074927] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [305.127674] [035/132] (720s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [305.310494] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [305.312134] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [305.522332] [036/132] (719s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [305.712410] Starting subtest: yf-tiled-16bpp-rotate-180 [305.714063] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [305.917151] [037/132] (719s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [306.096490] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [306.098172] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [306.297925] [038/132] (719s left) gem_render_copy (yf-tiled-ccs-to-linear) [306.371574] Starting subtest: yf-tiled-ccs-to-linear [306.373598] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [306.612572] [039/132] (718s left) gem_exec_params (invalid-flag) [306.689896] Starting subtest: invalid-flag [306.690852] Subtest invalid-flag: SUCCESS (0.000s) [306.864714] [040/132] (718s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [307.046561] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [307.048244] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [307.254512] [041/132] (718s left) vgem_basic (setversion) [307.354339] Starting subtest: setversion [307.356130] Subtest setversion: SUCCESS (0.000s) [307.467267] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true [307.469386] [042/132] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [307.662784] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [307.664410] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [307.853647] [043/132] (717s left) prime_mmap (test_dup) [307.933457] Starting subtest: test_dup [307.934412] Starting dynamic subtest: test_dup-smem [307.981869] Dynamic subtest test_dup-smem: SUCCESS (0.048s) [307.990505] Starting dynamic subtest: test_dup-lmem0 [308.184642] Dynamic subtest test_dup-lmem0: SUCCESS (0.202s) [308.185554] Subtest test_dup: SUCCESS (0.251s) [308.329043] [044/132] (717s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [308.531448] Starting subtest: flip-vs-cursor-busy-crc-atomic [309.314107] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.783s) [309.624706] [045/132] (716s left) kms_cursor_crc (cursor-onscreen-64x64) [309.955231] Starting subtest: cursor-onscreen-64x64 [309.959356] Starting dynamic subtest: pipe-A-DP-3 [312.793931] Dynamic subtest pipe-A-DP-3: SUCCESS (2.833s) [312.843776] Starting dynamic subtest: pipe-D-DP-3 [315.576464] Dynamic subtest pipe-D-DP-3: SUCCESS (2.741s) [315.577348] Subtest cursor-onscreen-64x64: SUCCESS (5.621s) [316.146276] [046/132] (709s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [316.339391] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [316.341123] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [316.525785] [047/132] (709s left) kms_vblank (query-forked-hang) [316.713763] Starting subtest: query-forked-hang [316.715759] Starting dynamic subtest: pipe-A-DP-3 [343.554433] Dynamic subtest pipe-A-DP-3: SUCCESS (26.838s) [343.565007] Starting dynamic subtest: pipe-D-DP-3 [368.547281] Dynamic subtest pipe-D-DP-3: SUCCESS (24.989s) [368.548246] Subtest query-forked-hang: SUCCESS (51.832s) [368.848165] [048/132] (657s left) syncobj_timeline (single-wait-all-available-submitted) [368.928162] Starting subtest: single-wait-all-available-submitted [368.929051] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [369.128415] [049/132] (657s left) i915_query (query-topology-kernel-writes) [369.209210] Starting subtest: query-topology-kernel-writes [369.210165] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [369.413883] [050/132] (656s left) gem_ctx_persistence (hang) [369.498264] Starting subtest: hang [369.500245] Subtest hang: SKIP (0.000s) [369.697826] [051/132] (656s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [369.887245] Starting subtest: cursorA-vs-flipB-atomic-transitions [369.888991] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [370.052295] [052/132] (656s left) kms_joiner (basic-ultra-joiner) [370.241265] Starting subtest: basic-ultra-joiner [370.242955] Subtest basic-ultra-joiner: SKIP (0.000s) [370.397498] [053/132] (656s left) kms_vblank (wait-forked-busy-hang) [370.585010] Starting subtest: wait-forked-busy-hang [370.587601] Starting dynamic subtest: pipe-A-DP-3 [397.576135] Dynamic subtest pipe-A-DP-3: SUCCESS (26.988s) [397.586502] Starting dynamic subtest: pipe-D-DP-3 [422.568553] Dynamic subtest pipe-D-DP-3: SUCCESS (24.989s) [422.569527] Subtest wait-forked-busy-hang: SUCCESS (51.982s) [422.830845] [054/132] (603s left) intel_hwmon (hwmon-read) [422.915200] Starting subtest: hwmon-read [422.917281] Subtest hwmon-read: SUCCESS (0.001s) [423.112576] [055/132] (603s left) gem_mmap_wc (write-read) [423.188060] Subtest write-read: SKIP (0.000s) [423.257978] [056/132] (603s left) kms_big_fb (linear-16bpp-rotate-0) [423.456270] Starting subtest: linear-16bpp-rotate-0 [425.400109] Subtest linear-16bpp-rotate-0: SUCCESS (1.943s) [425.630851] [057/132] (601s left) perf_pmu (frequency) [425.705133] Starting subtest: frequency [425.706939] Starting dynamic subtest: gt0 [428.012162] Dynamic subtest gt0: FAIL (2.224s) [428.046719] Starting dynamic subtest: idle-gt0 [428.438508] Dynamic subtest idle-gt0: SUCCESS (0.504s) [428.441719] Subtest frequency: FAIL (2.736s) [428.650715] [058/132] (598s left) kms_flip (2x-flip-vs-panning-interruptible) [428.844852] Starting subtest: 2x-flip-vs-panning-interruptible [428.860076] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.014s) [429.014970] [059/132] (598s left) kms_psr (fbc-psr-sprite-plane-onoff) [429.203313] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s) [429.258909] [060/132] (597s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc) [429.447537] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc [429.448445] Starting dynamic subtest: pipe-A-DP-3 [429.456919] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [429.466279] Starting dynamic subtest: pipe-B-DP-3 [429.475180] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [429.484294] Starting dynamic subtest: pipe-C-DP-3 [429.492571] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [429.501511] Starting dynamic subtest: pipe-D-DP-3 [429.512355] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [429.514397] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s) [429.945576] [061/132] (597s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [430.140230] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [430.142060] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [430.344996] [062/132] (596s left) kms_prop_blob (blob-prop-core) [430.424221] Starting subtest: blob-prop-core [430.425055] Subtest blob-prop-core: SUCCESS (0.000s) [430.610981] [063/132] (596s left) kms_plane_cursor (viewport) [430.797745] Starting subtest: viewport [430.799483] Starting dynamic subtest: pipe-A-DP-3-size-64 [434.012061] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.213s) [434.115282] Starting dynamic subtest: pipe-A-DP-3-size-128 [437.296312] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.215s) [437.375348] Starting dynamic subtest: pipe-A-DP-3-size-256 [440.629489] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.266s) [440.812939] Starting dynamic subtest: pipe-B-DP-3-size-64 [444.037971] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.242s) [444.112908] Starting dynamic subtest: pipe-B-DP-3-size-128 [447.371730] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.283s) [447.443637] Starting dynamic subtest: pipe-B-DP-3-size-256 [450.604520] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.183s) [450.741815] Starting dynamic subtest: pipe-C-DP-3-size-64 [454.030217] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.299s) [454.107667] Starting dynamic subtest: pipe-C-DP-3-size-128 [457.314485] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.232s) [457.375597] Starting dynamic subtest: pipe-C-DP-3-size-256 [460.613887] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.249s) [460.755246] Starting dynamic subtest: pipe-D-DP-3-size-64 [464.027301] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.284s) [464.094517] Starting dynamic subtest: pipe-D-DP-3-size-128 [467.260907] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.183s) [467.319684] Starting dynamic subtest: pipe-D-DP-3-size-256 [470.544476] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.233s) [470.673181] Subtest viewport: SUCCESS (39.873s) [471.015526] [064/132] (556s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [471.206244] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [474.326315] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.120s) [474.652513] [065/132] (552s left) gem_softpin (evict-snoop-interruptible) [474.744888] Starting subtest: evict-snoop-interruptible [474.746580] Subtest evict-snoop-interruptible: SKIP (0.000s) [474.946420] [066/132] (552s left) gen9_exec_parse (secure-batches) [475.031539] Subtest secure-batches: SKIP (0.000s) [475.112318] [067/132] (552s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [475.302492] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [475.307362] Starting dynamic subtest: A-DP3 [476.242402] Dynamic subtest A-DP3: SUCCESS (0.934s) [476.265011] Starting dynamic subtest: B-DP3 [477.015144] Dynamic subtest B-DP3: SUCCESS (0.768s) [477.036389] Starting dynamic subtest: C-DP3 [477.758468] Dynamic subtest C-DP3: SUCCESS (0.740s) [477.767936] Starting dynamic subtest: D-DP3 [478.483166] Dynamic subtest D-DP3: SUCCESS (0.724s) [478.485399] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.182s) [478.808358] [068/132] (548s left) gem_exec_balancer (bonded-chain) [478.915469] Starting subtest: bonded-chain [492.757382] Subtest bonded-chain: SUCCESS (13.841s) [493.218778] [069/132] (534s left) kms_psr (fbc-pr-no-drrs) [493.406017] Subtest fbc-pr-no-drrs: SKIP (0.000s) [493.470236] [070/132] (534s left) gem_ctx_persistence (engines-hostile-preempt) [493.560913] Starting subtest: engines-hostile-preempt [493.561895] Starting dynamic subtest: rcs0 [493.677412] Dynamic subtest rcs0: SUCCESS (0.116s) [493.691951] Starting dynamic subtest: bcs0 [493.723185] Dynamic subtest bcs0: SUCCESS (0.044s) [493.738475] Starting dynamic subtest: vcs0 [493.788484] Dynamic subtest vcs0: SUCCESS (0.063s) [493.829466] Starting dynamic subtest: vcs1 [493.864428] Dynamic subtest vcs1: SUCCESS (0.071s) [493.887910] Starting dynamic subtest: vecs0 [493.930401] Dynamic subtest vecs0: SUCCESS (0.063s) [493.970143] Starting dynamic subtest: vecs1 [493.977396] Dynamic subtest vecs1: SUCCESS (0.043s) [493.995515] Starting dynamic subtest: ccs0 [494.051897] Dynamic subtest ccs0: SUCCESS (0.072s) [494.056238] Subtest engines-hostile-preempt: SUCCESS (0.493s) [494.258914] [071/132] (533s left) i915_selftest (mock) [495.465598] Starting subtest: mock [495.466539] Starting dynamic subtest: sanitycheck [496.267090] Dynamic subtest sanitycheck: SUCCESS (0.800s) [496.299338] Starting dynamic subtest: shmem [497.120054] Dynamic subtest shmem: SUCCESS (0.848s) [497.153267] Starting dynamic subtest: fence [505.064791] Dynamic subtest fence: SUCCESS (7.940s) [505.079599] Starting dynamic subtest: scatterlist [506.934663] Dynamic subtest scatterlist: SUCCESS (1.866s) [506.950008] Starting dynamic subtest: syncmap [509.853678] Dynamic subtest syncmap: SUCCESS (2.914s) [509.869058] Starting dynamic subtest: uncore [510.665097] Dynamic subtest uncore: SUCCESS (0.807s) [510.696572] Starting dynamic subtest: ring [511.519683] Dynamic subtest ring: SUCCESS (0.850s) [511.551036] Starting dynamic subtest: engine [512.373070] Dynamic subtest engine: SUCCESS (0.848s) [512.406784] Starting dynamic subtest: timelines [517.033023] Dynamic subtest timelines: SUCCESS (4.655s) [517.045066] Starting dynamic subtest: requests [519.899917] Dynamic subtest requests: SUCCESS (2.865s) [519.909182] Starting dynamic subtest: objects [520.878013] Dynamic subtest objects: SUCCESS (0.977s) [520.887511] Starting dynamic subtest: phys [521.850997] Dynamic subtest phys: SUCCESS (0.971s) [521.860287] Starting dynamic subtest: dmabuf [522.823012] Dynamic subtest dmabuf: SUCCESS (0.971s) [522.836371] Starting dynamic subtest: vma [531.015191] Dynamic subtest vma: SUCCESS (8.190s) [531.023832] Starting dynamic subtest: evict [532.832998] Dynamic subtest evict: SUCCESS (1.816s) [532.843292] Starting dynamic subtest: gtt [536.852907] Dynamic subtest gtt: SUCCESS (4.019s) [536.864810] Starting dynamic subtest: hugepages [538.023927] Dynamic subtest hugepages: SUCCESS (1.169s) [538.033199] Starting dynamic subtest: memory_region [541.526129] Dynamic subtest memory_region: SUCCESS (3.501s) [541.527244] Subtest mock: SUCCESS (46.061s) [541.561792] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [541.562949] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [541.565065] [072/132] (486s left) gem_pread (uncached) [543.186161] Subtest uncached: SKIP (0.000s) [543.239515] [FACT gem_pread (uncached)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [543.242432] [FACT gem_pread (uncached)] new: kernel.kmod_is_loaded.i915: true [543.245482] [073/132] (484s left) kms_psr (psr-cursor-plane-move) [543.437461] Subtest psr-cursor-plane-move: SKIP (0.000s) [543.492404] [074/132] (484s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [543.680673] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [543.682282] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [543.893956] [075/132] (484s left) kms_flip (plain-flip-ts-check) [544.082351] Starting subtest: plain-flip-ts-check [544.087108] Starting dynamic subtest: A-DP3 [552.222097] Dynamic subtest A-DP3: SUCCESS (8.134s) [552.257130] Starting dynamic subtest: B-DP3 [560.287206] Dynamic subtest B-DP3: SUCCESS (8.059s) [560.301517] Starting dynamic subtest: C-DP3 [568.336777] Dynamic subtest C-DP3: SUCCESS (8.045s) [568.348555] Starting dynamic subtest: D-DP3 [576.391887] Dynamic subtest D-DP3: SUCCESS (8.054s) [576.394402] Subtest plain-flip-ts-check: SUCCESS (32.312s) [576.796424] [076/132] (451s left) kms_pm_rpm (modeset-pc8-residency-stress) [579.024344] Starting subtest: modeset-pc8-residency-stress [579.026600] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [579.448042] [077/132] (448s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf) [579.651273] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [579.698868] [078/132] (448s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [579.890326] Starting subtest: plane-downscale-factor-0-75-with-modifiers [579.891089] Starting dynamic subtest: pipe-A [580.455170] Dynamic subtest pipe-A: SUCCESS (0.566s) [580.475569] Starting dynamic subtest: pipe-B [581.103133] Dynamic subtest pipe-B: SUCCESS (0.646s) [581.115280] Starting dynamic subtest: pipe-C [581.736513] Dynamic subtest pipe-C: SUCCESS (0.632s) [581.757863] Starting dynamic subtest: pipe-D [582.382479] Dynamic subtest pipe-D: SUCCESS (0.644s) [582.383740] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (2.495s) [582.748547] [079/132] (445s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [582.950011] Starting subtest: y-tiled-addfb-size-offset-overflow [582.951801] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [583.148606] [080/132] (445s left) kms_sequence (queue-busy) [583.333968] Starting subtest: queue-busy [583.336425] Starting dynamic subtest: pipe-A-DP-3 [585.919891] Dynamic subtest pipe-A-DP-3: SUCCESS (2.584s) [585.930740] Starting dynamic subtest: pipe-B-DP-3 [588.405482] Dynamic subtest pipe-B-DP-3: SUCCESS (2.483s) [588.419749] Starting dynamic subtest: pipe-C-DP-3 [590.882416] Dynamic subtest pipe-C-DP-3: SUCCESS (2.475s) [590.895738] Starting dynamic subtest: pipe-D-DP-3 [593.365278] Dynamic subtest pipe-D-DP-3: SUCCESS (2.481s) [593.366228] Subtest queue-busy: SUCCESS (10.031s) [593.674459] [081/132] (435s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [593.869451] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [593.870422] Starting dynamic subtest: pipe-A-valid-mode [593.950253] Dynamic subtest pipe-A-valid-mode: SKIP (0.079s) [593.952170] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.081s) [594.203841] [082/132] (434s left) gem_ctx_engines (execute-oneforall) [594.298322] Starting subtest: execute-oneforall [595.046200] Subtest execute-oneforall: SUCCESS (0.748s) [595.741401] [083/132] (433s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [595.932901] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [595.948315] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.015s) [596.104063] [084/132] (432s left) prime_mmap (test_forked_cpu_write) [596.180637] Starting subtest: test_forked_cpu_write [596.181512] Starting dynamic subtest: test_forked_cpu_write-smem [596.189568] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s) [596.200504] Starting dynamic subtest: test_forked_cpu_write-lmem0 [596.201423] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.009s) [596.202305] Subtest test_forked_cpu_write: SUCCESS (0.020s) [596.405582] [085/132] (432s left) kms_dsc (dsc-fractional-bpp) [596.591455] Starting subtest: dsc-fractional-bpp [596.596496] Subtest dsc-fractional-bpp: SKIP (0.000s) [596.760251] [086/132] (432s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [596.947426] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [596.948293] Starting dynamic subtest: pipe-A-DP-3 [596.951882] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [596.961369] Starting dynamic subtest: pipe-B-DP-3 [596.964895] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [596.974163] Starting dynamic subtest: pipe-C-DP-3 [596.977560] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [596.986706] Starting dynamic subtest: pipe-D-DP-3 [596.990055] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [596.991744] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.008s) [597.432436] [087/132] (431s left) gem_userptr_blits (unsync-unmap-after-close) [597.527304] Subtest unsync-unmap-after-close: SKIP (0.000s) [597.700818] [088/132] (431s left) gem_exec_fence (basic-busy) [597.906946] Starting subtest: basic-busy [597.907872] Starting dynamic subtest: rcs0 [598.043095] Dynamic subtest rcs0: SUCCESS (0.135s) [598.061664] Starting dynamic subtest: bcs0 [598.099978] Dynamic subtest bcs0: SUCCESS (0.052s) [598.116810] Starting dynamic subtest: vcs0 [598.153846] Dynamic subtest vcs0: SUCCESS (0.052s) [598.189893] Starting dynamic subtest: vcs1 [598.212982] Dynamic subtest vcs1: SUCCESS (0.056s) [598.231897] Starting dynamic subtest: vecs0 [598.268697] Dynamic subtest vecs0: SUCCESS (0.053s) [598.298504] Starting dynamic subtest: vecs1 [598.333200] Dynamic subtest vecs1: SUCCESS (0.062s) [598.364997] Starting dynamic subtest: ccs0 [598.398717] Dynamic subtest ccs0: SUCCESS (0.063s) [598.402588] Subtest basic-busy: SUCCESS (0.493s) [599.116727] [089/132] (430s left) i915_pm_freq_api (freq-reset) [599.206811] Starting subtest: freq-reset [599.207770] Starting dynamic subtest: gt0 [599.583384] Dynamic subtest gt0: SUCCESS (0.375s) [599.584270] Subtest freq-reset: SUCCESS (0.377s) [599.759030] [090/132] (429s left) dmabuf (all-tests) [599.808429] Starting subtest: all-tests [599.809401] Starting dynamic subtest: sanitycheck [599.901652] Dynamic subtest sanitycheck: SUCCESS (0.092s) [599.928888] Starting dynamic subtest: dma_fence [600.119663] Dynamic subtest dma_fence: SUCCESS (0.213s) [600.160046] Starting dynamic subtest: dma_fence_chain [609.317659] Dynamic subtest dma_fence_chain: SUCCESS (9.193s) [609.335272] Starting dynamic subtest: dma_fence_unwrap [609.406274] Dynamic subtest dma_fence_unwrap: SUCCESS (0.085s) [609.431152] Starting dynamic subtest: dma_resv [609.523279] Dynamic subtest dma_resv: SUCCESS (0.113s) [609.528361] Subtest all-tests: SUCCESS (9.716s) [609.694503] [091/132] (419s left) gem_exec_parallel (engines) [609.785205] Starting subtest: engines [609.786159] Starting dynamic subtest: basic [611.340156] Dynamic subtest basic: SUCCESS (1.554s) [611.352658] Starting dynamic subtest: contexts [615.895692] Dynamic subtest contexts: SUCCESS (4.554s) [615.906181] Starting dynamic subtest: fds [620.691281] Dynamic subtest fds: SUCCESS (4.794s) [620.702188] Starting dynamic subtest: userptr [622.186602] Dynamic subtest userptr: SUCCESS (1.495s) [622.187545] Subtest engines: SUCCESS (12.402s) [622.530144] [092/132] (407s left) api_intel_allocator (standalone) [622.612211] Starting subtest: standalone [622.653298] Subtest standalone: SUCCESS (0.041s) [622.859972] [093/132] (406s left) sysfs_timeslice_duration (timeout) [622.944459] Starting subtest: timeout [622.945431] Starting dynamic subtest: vecs0 [624.903205] Dynamic subtest vecs0: SUCCESS (1.959s) [624.913988] Starting dynamic subtest: ccs0 [626.780232] Dynamic subtest ccs0: SUCCESS (1.876s) [626.791248] Starting dynamic subtest: vcs0 [628.489107] Dynamic subtest vcs0: SUCCESS (1.708s) [628.499840] Starting dynamic subtest: bcs0 [629.685201] Dynamic subtest bcs0: SUCCESS (1.195s) [629.696119] Starting dynamic subtest: vecs1 [631.481935] Dynamic subtest vecs1: SUCCESS (1.796s) [631.492642] Starting dynamic subtest: rcs0 [633.163410] Dynamic subtest rcs0: SUCCESS (1.680s) [633.174035] Starting dynamic subtest: vcs1 [634.874204] Dynamic subtest vcs1: SUCCESS (1.709s) [634.875199] Subtest timeout: SUCCESS (11.931s) [635.035116] [094/132] (394s left) fbdev (eof) [635.101133] Starting subtest: eof [635.102058] Subtest eof: SUCCESS (0.000s) [635.295206] [095/132] (394s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [635.483390] Starting subtest: modeset-atomic-cursor-hotspot [635.485232] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [635.652901] [096/132] (394s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [635.842434] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [635.843295] Starting dynamic subtest: pipe-A-valid-mode [637.701558] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.855s) [637.702966] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (1.859s) [638.049265] [097/132] (391s left) gem_pxp (create-regular-context-2) [640.659266] Starting subtest: create-regular-context-2 [640.661451] Subtest create-regular-context-2: SKIP (0.000s) [640.794554] [098/132] (389s left) syncobj_timeline (multi-wait-all-available-signaled) [640.872520] Starting subtest: multi-wait-all-available-signaled [640.873456] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s) [641.034818] [099/132] (389s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [641.223237] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [641.225293] Starting dynamic subtest: pipe-A-DP-3 [641.233137] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [641.243557] Starting dynamic subtest: pipe-B-DP-3 [641.253182] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [641.263587] Starting dynamic subtest: pipe-C-DP-3 [641.271785] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [641.282375] Starting dynamic subtest: pipe-D-DP-3 [641.293539] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [641.295328] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.010s) [641.726165] [100/132] (388s left) kms_lease (lease-again) [641.914427] Starting subtest: lease-again [641.915332] Starting dynamic subtest: pipe-A-DP-3 [641.918992] Dynamic subtest pipe-A-DP-3: SUCCESS (0.004s) [641.930917] Starting dynamic subtest: pipe-B-DP-3 [641.931864] Dynamic subtest pipe-B-DP-3: SUCCESS (0.003s) [641.942304] Starting dynamic subtest: pipe-C-DP-3 [641.943214] Dynamic subtest pipe-C-DP-3: SUCCESS (0.003s) [641.953480] Starting dynamic subtest: pipe-D-DP-3 [641.954374] Dynamic subtest pipe-D-DP-3: SUCCESS (0.004s) [641.955269] Subtest lease-again: SUCCESS (0.022s) [642.141580] [101/132] (388s left) gem_eio (execbuf) [642.419455] Starting subtest: execbuf [642.875803] Subtest execbuf: SUCCESS (0.457s) [643.143108] [102/132] (387s left) kms_hdr (static-toggle-suspend) [643.337864] Starting subtest: static-toggle-suspend [643.930098] Starting dynamic subtest: pipe-A-DP-3 [664.902771] Dynamic subtest pipe-A-DP-3: SUCCESS (5.031s) [664.903876] Subtest static-toggle-suspend: SUCCESS (5.624s) [665.206178] [103/132] (365s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [665.410768] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [665.411551] Starting dynamic subtest: pipe-A-DP-3 [665.419713] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [665.433357] Starting dynamic subtest: pipe-B-DP-3 [665.440690] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [665.452958] Starting dynamic subtest: pipe-C-DP-3 [665.461148] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [665.473287] Starting dynamic subtest: pipe-D-DP-3 [665.481712] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [665.483330] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.007s) [665.846934] [104/132] (364s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [665.925324] Starting subtest: invalid-multi-wait-unsubmitted-submitted [665.926153] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [666.068912] [105/132] (364s left) perf_pmu (busy-idle) [666.141492] Starting subtest: busy-idle [666.142325] Starting dynamic subtest: rcs0 [666.896211] Dynamic subtest rcs0: SUCCESS (0.754s) [666.914455] Starting dynamic subtest: bcs0 [667.560334] Dynamic subtest bcs0: SUCCESS (0.661s) [667.581086] Starting dynamic subtest: vcs0 [668.230377] Dynamic subtest vcs0: SUCCESS (0.665s) [668.251230] Starting dynamic subtest: vcs1 [668.897123] Dynamic subtest vcs1: SUCCESS (0.662s) [668.917446] Starting dynamic subtest: vecs0 [669.561245] Dynamic subtest vecs0: SUCCESS (0.659s) [669.577869] Starting dynamic subtest: vecs1 [670.223439] Dynamic subtest vecs1: SUCCESS (0.657s) [670.244196] Starting dynamic subtest: ccs0 [670.889021] Dynamic subtest ccs0: SUCCESS (0.661s) [670.894081] Subtest busy-idle: SUCCESS (4.749s) [671.111810] [106/132] (359s left) gem_exec_parallel (contexts) [671.201199] Starting subtest: contexts [671.202303] Starting dynamic subtest: rcs0 [675.396764] Dynamic subtest rcs0: SUCCESS (4.195s) [675.409851] Starting dynamic subtest: bcs0 [679.832960] Dynamic subtest bcs0: SUCCESS (4.435s) [679.845343] Starting dynamic subtest: vcs0 [683.614355] Dynamic subtest vcs0: SUCCESS (3.780s) [683.627420] Starting dynamic subtest: vcs1 [688.766777] Dynamic subtest vcs1: SUCCESS (5.151s) [688.779470] Starting dynamic subtest: vecs0 [692.770454] Dynamic subtest vecs0: SUCCESS (4.002s) [692.786024] Starting dynamic subtest: vecs1 [696.884235] Dynamic subtest vecs1: SUCCESS (4.113s) [696.897112] Starting dynamic subtest: ccs0 [700.762497] Dynamic subtest ccs0: SUCCESS (3.878s) [700.763410] Subtest contexts: SUCCESS (29.563s) [701.103473] [107/132] (329s left) i915_drm_fdinfo (busy-idle-check-all) [701.175360] Starting subtest: busy-idle-check-all [701.176316] Starting dynamic subtest: rcs0 [701.204157] Dynamic subtest rcs0: SKIP (0.027s) [701.217340] Starting dynamic subtest: bcs0 [701.219259] Dynamic subtest bcs0: SKIP (0.001s) [701.232085] Starting dynamic subtest: vcs0 [701.234571] Dynamic subtest vcs0: SKIP (0.000s) [701.247147] Starting dynamic subtest: vcs1 [701.249385] Dynamic subtest vcs1: SKIP (0.001s) [701.261856] Starting dynamic subtest: vecs0 [701.264067] Dynamic subtest vecs0: SKIP (0.001s) [701.276311] Starting dynamic subtest: vecs1 [701.278454] Dynamic subtest vecs1: SKIP (0.000s) [701.291891] Starting dynamic subtest: ccs0 [701.294164] Dynamic subtest ccs0: SKIP (0.000s) [701.295902] Subtest busy-idle-check-all: SKIP (0.038s) [701.343289] [108/132] (329s left) gem_exec_schedule (noreorder) [701.575132] Starting subtest: noreorder [701.576094] Starting dynamic subtest: rcs0 [701.666374] Dynamic subtest rcs0: SUCCESS (0.091s) [701.683374] Starting dynamic subtest: bcs0 [701.726360] Dynamic subtest bcs0: SUCCESS (0.059s) [701.754731] Starting dynamic subtest: vcs0 [701.807216] Dynamic subtest vcs0: SUCCESS (0.078s) [701.850558] Starting dynamic subtest: vcs1 [701.915353] Dynamic subtest vcs1: SUCCESS (0.104s) [701.959664] Starting dynamic subtest: vecs0 [702.003369] Dynamic subtest vecs0: SUCCESS (0.084s) [702.030800] Starting dynamic subtest: vecs1 [702.080392] Dynamic subtest vecs1: SUCCESS (0.075s) [702.097131] Starting dynamic subtest: ccs0 [702.155337] Dynamic subtest ccs0: SUCCESS (0.071s) [702.159707] Subtest noreorder: SUCCESS (0.581s) [702.486601] [109/132] (328s left) gem_mmap (bad-size) [702.567159] Subtest bad-size: SKIP (0.000s) [702.643875] [110/132] (328s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [702.841194] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [702.842905] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [703.040804] [111/132] (327s left) gem_spin_batch (resubmit-new-all) [703.128318] Starting subtest: resubmit-new-all [703.129184] Starting dynamic subtest: rcs0 [703.165517] Dynamic subtest rcs0: SUCCESS (0.038s) [703.179880] Starting dynamic subtest: bcs0 [703.180829] Dynamic subtest bcs0: SUCCESS (0.010s) [703.193907] Starting dynamic subtest: vcs0 [703.194791] Dynamic subtest vcs0: SUCCESS (0.009s) [703.207797] Starting dynamic subtest: vcs1 [703.208702] Dynamic subtest vcs1: SUCCESS (0.008s) [703.221555] Starting dynamic subtest: vecs0 [703.222424] Dynamic subtest vecs0: SUCCESS (0.010s) [703.235388] Starting dynamic subtest: vecs1 [703.236447] Dynamic subtest vecs1: SUCCESS (0.008s) [703.249042] Starting dynamic subtest: ccs0 [703.250105] Dynamic subtest ccs0: SUCCESS (0.009s) [703.251059] Subtest resubmit-new-all: SUCCESS (0.100s) [703.607260] [112/132] (327s left) kms_big_fb (x-tiled-32bpp-rotate-90) [703.803053] Starting subtest: x-tiled-32bpp-rotate-90 [703.858304] Subtest x-tiled-32bpp-rotate-90: SKIP (0.054s) [704.093963] [113/132] (327s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [704.291268] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [704.292958] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [704.493630] [114/132] (326s left) prime_busy (after) [704.581551] Starting subtest: after [704.586432] Starting dynamic subtest: rcs0 [704.648802] Dynamic subtest rcs0: SUCCESS (0.062s) [704.663484] Starting dynamic subtest: bcs0 [704.725100] Dynamic subtest bcs0: SUCCESS (0.075s) [704.769436] Starting dynamic subtest: vcs0 [704.770587] Dynamic subtest vcs0: SUCCESS (0.039s) [704.788624] Starting dynamic subtest: vcs1 [704.806151] Dynamic subtest vcs1: SUCCESS (0.037s) [704.820579] Starting dynamic subtest: vecs0 [704.845858] Dynamic subtest vecs0: SUCCESS (0.039s) [704.860583] Starting dynamic subtest: vecs1 [704.884291] Dynamic subtest vecs1: SUCCESS (0.037s) [704.899583] Starting dynamic subtest: ccs0 [704.924384] Dynamic subtest ccs0: SUCCESS (0.039s) [705.038409] Subtest after: SUCCESS (0.456s) [705.260354] [115/132] (326s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [705.341255] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [705.445325] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s) [705.630023] [116/132] (325s left) gem_fence_thrash (bo-write-verify-none) [705.678166] Starting subtest: bo-write-verify-none [705.707342] Subtest bo-write-verify-none: SKIP (0.028s) [705.788492] [117/132] (325s left) kms_psr (fbc-psr2-suspend) [705.973336] Subtest fbc-psr2-suspend: SKIP (0.000s) [706.038484] [118/132] (325s left) kms_chamelium_edid (dp-mode-timings) [706.320666] Subtest dp-mode-timings: SKIP (0.000s) [706.480507] [119/132] (325s left) i915_pm_rpm (reg-read-ioctl) [707.996232] Starting subtest: reg-read-ioctl [708.807033] Subtest reg-read-ioctl: SUCCESS (0.814s) [709.284336] [120/132] (322s left) gem_exec_params (invalid-bsd1-flag-on-blt) [709.369229] Starting subtest: invalid-bsd1-flag-on-blt [709.370156] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [709.584165] [121/132] (322s left) gem_ctx_bad_destroy (invalid-ctx) [709.662776] Starting subtest: invalid-ctx [709.663711] Subtest invalid-ctx: SUCCESS (0.000s) [709.846822] [122/132] (321s left) kms_pm_dc (dc6-dpms) [711.038158] Starting subtest: dc6-dpms [711.039902] Subtest dc6-dpms: SKIP (0.000s) [711.204942] [123/132] (320s left) kms_busy (extended-modeset-hang-oldfb) [711.410200] Starting subtest: extended-modeset-hang-oldfb [711.411158] Starting dynamic subtest: pipe-A [719.481545] Dynamic subtest pipe-A: SUCCESS (8.070s) [719.504838] Starting dynamic subtest: pipe-D [727.573679] Dynamic subtest pipe-D: SUCCESS (8.086s) [727.577820] Subtest extended-modeset-hang-oldfb: SUCCESS (16.167s) [727.907573] [124/132] (304s left) gem_ctx_shared (exec-single-timeline) [727.998330] Starting subtest: exec-single-timeline [727.999269] Starting dynamic subtest: rcs0 [729.054184] Dynamic subtest rcs0: SUCCESS (1.054s) [729.072269] Starting dynamic subtest: bcs0 [730.077829] Dynamic subtest bcs0: SUCCESS (1.019s) [730.098476] Starting dynamic subtest: vcs0 [731.165852] Dynamic subtest vcs0: SUCCESS (1.083s) [731.183696] Starting dynamic subtest: vcs1 [732.190002] Dynamic subtest vcs1: SUCCESS (1.019s) [732.208420] Starting dynamic subtest: vecs0 [733.213821] Dynamic subtest vecs0: SUCCESS (1.019s) [733.231578] Starting dynamic subtest: vecs1 [734.237790] Dynamic subtest vecs1: SUCCESS (1.019s) [734.255469] Starting dynamic subtest: ccs0 [735.261818] Dynamic subtest ccs0: SUCCESS (1.019s) [735.266458] Subtest exec-single-timeline: SUCCESS (7.265s) [735.603906] [125/132] (296s left) kms_plane (plane-position-covered) [735.789252] Starting subtest: plane-position-covered [736.221364] Starting dynamic subtest: pipe-A-plane-1 [736.695841] Dynamic subtest pipe-A-plane-1: SUCCESS (0.474s) [736.712423] Starting dynamic subtest: pipe-A-plane-2 [737.138699] Dynamic subtest pipe-A-plane-2: SUCCESS (0.441s) [737.155210] Starting dynamic subtest: pipe-A-plane-3 [737.579343] Dynamic subtest pipe-A-plane-3: SUCCESS (0.440s) [737.595354] Starting dynamic subtest: pipe-A-plane-4 [738.023138] Dynamic subtest pipe-A-plane-4: SUCCESS (0.442s) [738.042968] Starting dynamic subtest: pipe-A-plane-5 [738.052096] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s) [738.419230] Starting dynamic subtest: pipe-B-plane-1 [738.847104] Dynamic subtest pipe-B-plane-1: SUCCESS (0.443s) [738.860573] Starting dynamic subtest: pipe-B-plane-2 [739.289012] Dynamic subtest pipe-B-plane-2: SUCCESS (0.440s) [739.303299] Starting dynamic subtest: pipe-B-plane-3 [739.727842] Dynamic subtest pipe-B-plane-3: SUCCESS (0.438s) [739.741477] Starting dynamic subtest: pipe-B-plane-4 [740.166071] Dynamic subtest pipe-B-plane-4: SUCCESS (0.438s) [740.179561] Starting dynamic subtest: pipe-B-plane-5 [740.187969] Dynamic subtest pipe-B-plane-5: SUCCESS (0.021s) [740.188889] Subtest plane-position-covered: SUCCESS (4.399s) [740.492598] [126/132] (291s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [740.681334] Starting subtest: flip-vs-cursor-crc-atomic [741.273146] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.590s) [741.625810] [127/132] (290s left) kms_cursor_legacy (cursor-vs-flip-toggle) [741.814300] Starting subtest: cursor-vs-flip-toggle [775.214419] Subtest cursor-vs-flip-toggle: SUCCESS (33.399s) [775.533442] [128/132] (256s left) gem_exec_fence (syncobj-invalid-flags) [776.081380] Starting subtest: syncobj-invalid-flags [776.082318] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [776.535256] [129/132] (255s left) gem_eio (wait-wedge-10ms) [776.802981] Starting subtest: wait-wedge-10ms [777.799256] Subtest wait-wedge-10ms: SUCCESS (0.997s) [778.093257] [130/132] (254s left) perf (non-system-wide-paranoid) [778.513112] Starting subtest: non-system-wide-paranoid [778.547300] Subtest non-system-wide-paranoid: SUCCESS (0.035s) [778.606209] [131/132] (253s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [778.799144] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [778.800875] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [778.991876] [132/132] (253s left) kms_big_fb (4-tiled-16bpp-rotate-90) [779.190049] Starting subtest: 4-tiled-16bpp-rotate-90 [779.255425] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.065s) [779.486430] Closing watchdogs results: parsing output: 0/ for test: syncobj_eventfd results: parsing output: 1/ for test: gem_mmap_gtt results: parsing output: 2/ for test: gem_exec_store results: parsing output: 3/ for test: drm_read results: parsing output: 4/ for test: perf results: parsing output: 5/ for test: syncobj_wait results: parsing output: 6/ for test: kms_ccs results: parsing output: 7/ for test: kms_content_protection results: parsing output: 8/ for test: kms_addfb_basic results: parsing output: 9/ for test: kms_rotation_crc results: parsing output: 10/ for test: syncobj_timeline results: parsing output: 11/ for test: api_intel_bb results: parsing output: 12/ for test: kms_cursor_legacy results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: kms_cursor_legacy results: parsing output: 15/ for test: gem_exercise_blt results: parsing output: 16/ for test: kms_async_flips results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: drm_read results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: gem_exec_nop results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_chamelium_hpd results: parsing output: 24/ for test: prime_mmap results: parsing output: 25/ for test: gem_render_copy results: parsing output: 26/ for test: gem_exec_schedule results: parsing output: 27/ for test: kms_psr results: parsing output: 28/ for test: kms_color results: parsing output: 29/ for test: gem_userptr_blits results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_atomic_transition results: parsing output: 32/ for test: kms_cursor_legacy results: parsing output: 33/ for test: kms_psr2_sf results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_render_copy results: parsing output: 38/ for test: gem_exec_params results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: vgem_basic results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: prime_mmap results: parsing output: 43/ for test: kms_cursor_legacy results: parsing output: 44/ for test: kms_cursor_crc results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_vblank results: parsing output: 47/ for test: syncobj_timeline results: parsing output: 48/ for test: i915_query results: parsing output: 49/ for test: gem_ctx_persistence results: parsing output: 50/ for test: kms_cursor_legacy results: parsing output: 51/ for test: kms_joiner results: parsing output: 52/ for test: kms_vblank results: parsing output: 53/ for test: intel_hwmon results: parsing output: 54/ for test: gem_mmap_wc results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: perf_pmu results: parsing output: 57/ for test: kms_flip results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: kms_ccs results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_prop_blob results: parsing output: 62/ for test: kms_plane_cursor results: parsing output: 63/ for test: kms_cursor_legacy results: parsing output: 64/ for test: gem_softpin results: parsing output: 65/ for test: gen9_exec_parse results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: gem_exec_balancer results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: gem_ctx_persistence results: parsing output: 70/ for test: i915_selftest results: parsing output: 71/ for test: gem_pread results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: kms_pm_rpm results: parsing output: 76/ for test: kms_psr2_sf results: parsing output: 77/ for test: kms_plane_scaling results: parsing output: 78/ for test: kms_big_fb results: parsing output: 79/ for test: kms_sequence results: parsing output: 80/ for test: kms_flip_scaled_crc results: parsing output: 81/ for test: gem_ctx_engines results: parsing output: 82/ for test: kms_flip results: parsing output: 83/ for test: prime_mmap results: parsing output: 84/ for test: kms_dsc results: parsing output: 85/ for test: kms_ccs results: parsing output: 86/ for test: gem_userptr_blits results: parsing output: 87/ for test: gem_exec_fence results: parsing output: 88/ for test: i915_pm_freq_api results: parsing output: 89/ for test: dmabuf results: parsing output: 90/ for test: gem_exec_parallel results: parsing output: 91/ for test: api_intel_allocator results: parsing output: 92/ for test: sysfs_timeslice_duration results: parsing output: 93/ for test: fbdev results: parsing output: 94/ for test: kms_cursor_legacy results: parsing output: 95/ for test: kms_flip_scaled_crc results: parsing output: 96/ for test: gem_pxp results: parsing output: 97/ for test: syncobj_timeline results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: kms_lease results: parsing output: 100/ for test: gem_eio results: parsing output: 101/ for test: kms_hdr results: parsing output: 102/ for test: kms_ccs results: parsing output: 103/ for test: syncobj_timeline results: parsing output: 104/ for test: perf_pmu results: parsing output: 105/ for test: gem_exec_parallel results: parsing output: 106/ for test: i915_drm_fdinfo results: parsing output: 107/ for test: gem_exec_schedule results: parsing output: 108/ for test: gem_mmap results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: gem_spin_batch results: parsing output: 111/ for test: kms_big_fb results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: prime_busy results: parsing output: 114/ for test: syncobj_timeline results: parsing output: 115/ for test: gem_fence_thrash results: parsing output: 116/ for test: kms_psr results: parsing output: 117/ for test: kms_chamelium_edid results: parsing output: 118/ for test: i915_pm_rpm results: parsing output: 119/ for test: gem_exec_params results: parsing output: 120/ for test: gem_ctx_bad_destroy results: parsing output: 121/ for test: kms_pm_dc results: parsing output: 122/ for test: kms_busy results: parsing output: 123/ for test: gem_ctx_shared results: parsing output: 124/ for test: kms_plane results: parsing output: 125/ for test: kms_cursor_legacy results: parsing output: 126/ for test: kms_cursor_legacy results: parsing output: 127/ for test: gem_exec_fence results: parsing output: 128/ for test: gem_eio results: parsing output: 129/ for test: perf results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_big_fb Done.