[38.876057] Initializing watchdogs [38.876116] /dev/watchdog0 [38.882543] [001/131] (960s left) gem_exec_schedule (pi-distinct-iova) [39.062144] Starting subtest: pi-distinct-iova [39.064496] Starting dynamic subtest: rcs0 [39.129383] Dynamic subtest rcs0: SUCCESS (0.072s) [39.135547] Starting dynamic subtest: vcs0 [39.174923] Dynamic subtest vcs0: SUCCESS (0.046s) [39.180032] Starting dynamic subtest: vcs1 [39.214554] Dynamic subtest vcs1: SUCCESS (0.038s) [39.222133] Starting dynamic subtest: vecs0 [39.252390] Dynamic subtest vecs0: SUCCESS (0.038s) [39.259999] Starting dynamic subtest: ccs0 [39.290782] Dynamic subtest ccs0: SUCCESS (0.039s) [39.293044] Subtest pi-distinct-iova: SUCCESS (0.234s) [40.450274] [002/131] (958s left) kms_vblank (query-busy) [40.535811] Starting subtest: query-busy [40.538121] Starting dynamic subtest: pipe-A-eDP-1 [42.423750] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s) [42.436674] Starting dynamic subtest: pipe-D-eDP-1 [45.089414] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.663s) [45.091739] Subtest query-busy: SUCCESS (4.552s) [45.966631] [003/131] (953s left) gem_exec_params (rel-constants-invalid) [46.019127] Starting subtest: rel-constants-invalid [46.021579] Subtest rel-constants-invalid: SUCCESS (0.000s) [46.081907] [004/131] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [46.173079] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [46.177424] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [46.251641] [005/131] (953s left) gem_exec_fence (keep-in-fence) [46.416362] Starting subtest: keep-in-fence [46.419122] Starting dynamic subtest: rcs0 [46.480966] Dynamic subtest rcs0: SUCCESS (0.068s) [46.488936] Starting dynamic subtest: bcs0 [46.533716] Dynamic subtest bcs0: SUCCESS (0.055s) [46.541407] Starting dynamic subtest: vcs0 [48.360793] Dynamic subtest vcs0: SUCCESS (1.890s) [48.369201] Starting dynamic subtest: vcs1 [50.409117] Dynamic subtest vcs1: SUCCESS (2.103s) [50.414627] Starting dynamic subtest: vecs0 [52.393253] Dynamic subtest vecs0: SUCCESS (2.024s) [52.401493] Starting dynamic subtest: ccs0 [52.583628] Dynamic subtest ccs0: SUCCESS (0.194s) [52.586053] Subtest keep-in-fence: SUCCESS (6.336s) [54.444923] [006/131] (944s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [59.562716] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [59.565081] Starting dynamic subtest: pipe-A-eDP-1 [60.396543] Dynamic subtest pipe-A-eDP-1: SKIP (0.836s) [60.403429] Starting dynamic subtest: pipe-B-eDP-1 [61.613706] Dynamic subtest pipe-B-eDP-1: SKIP (1.223s) [61.618089] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (2.061s) [62.861209] [007/131] (936s left) kms_legacy_colorkey (invalid-plane) [62.951852] Starting subtest: invalid-plane [62.954276] Starting dynamic subtest: zero-id [62.956616] Dynamic subtest zero-id: SUCCESS (0.000s) [62.961722] Starting dynamic subtest: outrange-id [62.964079] Dynamic subtest outrange-id: SUCCESS (0.000s) [62.966435] Subtest invalid-plane: SUCCESS (0.000s) [62.997155] [008/131] (936s left) kms_psr (fbc-psr2-sprite-plane-onoff) [63.085704] Starting subtest: fbc-psr2-sprite-plane-onoff [63.087901] Starting dynamic subtest: eDP-1 [63.091902] Dynamic subtest eDP-1: SKIP (0.000s) [63.095863] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s) [63.131428] [009/131] (936s left) gem_close (many-handles-one-vma) [63.189627] Starting subtest: many-handles-one-vma [63.216160] Subtest many-handles-one-vma: SUCCESS (0.026s) [63.298235] [010/131] (935s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [63.382777] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [63.385207] Starting dynamic subtest: pipe-A [63.451041] Dynamic subtest pipe-A: SUCCESS (0.068s) [63.458858] Starting dynamic subtest: pipe-B [64.671538] Dynamic subtest pipe-B: SUCCESS (1.224s) [64.677865] Starting dynamic subtest: pipe-C [65.862678] Dynamic subtest pipe-C: SUCCESS (1.195s) [65.869988] Starting dynamic subtest: pipe-D [67.078643] Dynamic subtest pipe-D: SUCCESS (1.219s) [67.081474] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.707s) [68.293732] [011/131] (930s left) kms_selftest (drm_plane_helper) [68.337323] Starting subtest: drm_plane_helper [68.344392] Starting dynamic subtest: drm_test_check_plane_state [68.432184] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.088s) [68.437151] Starting dynamic subtest: drm_test_check_invalid_plane_state [68.538946] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.106s) [68.540872] Subtest drm_plane_helper: SUCCESS (0.201s) [68.682268] [012/131] (930s left) kms_draw_crc (draw-method-mmap-gtt) [68.773894] Starting subtest: draw-method-mmap-gtt [68.778099] Subtest draw-method-mmap-gtt: SKIP (0.000s) [68.838758] [013/131] (930s left) gem_ctx_param (set-priority-range) [68.881880] Starting subtest: set-priority-range [68.891556] Subtest set-priority-range: SUCCESS (0.010s) [68.977687] [014/131] (930s left) kms_psr (psr2-cursor-mmap-gtt) [69.059859] Starting subtest: psr2-cursor-mmap-gtt [69.062314] Starting dynamic subtest: eDP-1 [70.819201] Dynamic subtest eDP-1: SUCCESS (1.761s) [70.821643] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.761s) [71.695849] [015/131] (927s left) kms_cursor_legacy (flip-vs-cursor-legacy) [71.806857] Starting subtest: flip-vs-cursor-legacy [78.238061] Subtest flip-vs-cursor-legacy: SUCCESS (6.436s) [79.113663] [016/131] (920s left) syncobj_wait (multi-wait-all-submitted) [79.170648] Starting subtest: multi-wait-all-submitted [79.277307] Subtest multi-wait-all-submitted: SUCCESS (0.106s) [79.329805] [017/131] (919s left) gem_ctx_engines (invalid-engines) [79.386043] Starting subtest: invalid-engines [79.445036] Subtest invalid-engines: FAIL (0.020s) [79.566229] [018/131] (919s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs) [79.650816] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs [79.653240] Starting dynamic subtest: pipe-A-eDP-1 [79.676206] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [79.683484] Starting dynamic subtest: pipe-B-eDP-1 [79.706033] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [79.712061] Starting dynamic subtest: pipe-C-eDP-1 [79.734227] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [79.740322] Starting dynamic subtest: pipe-D-eDP-1 [79.762800] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [79.766903] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.002s) [81.995135] [019/131] (917s left) kms_chamelium_frames (hdmi-crc-multiple) [82.373240] Subtest hdmi-crc-multiple: SKIP (0.000s) [83.255732] [020/131] (916s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite) [83.361063] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite [89.189846] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (5.830s) [89.276424] [021/131] (910s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [89.375242] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [89.379380] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [89.441907] [022/131] (909s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [89.528187] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [89.530885] Starting dynamic subtest: pipe-A-eDP-1 [89.555832] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [89.561141] Starting dynamic subtest: pipe-B-eDP-1 [89.582069] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [89.587048] Starting dynamic subtest: pipe-C-eDP-1 [89.607863] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [89.612523] Starting dynamic subtest: pipe-D-eDP-1 [89.633818] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [89.638089] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.002s) [91.849111] [023/131] (907s left) kms_pm_rpm (basic-rte) [91.873541] Starting subtest: basic-rte [94.906410] Subtest basic-rte: SUCCESS (3.032s) [96.677986] [024/131] (902s left) fbdev (nullptr) [96.719133] Starting subtest: nullptr [96.721758] Subtest nullptr: SUCCESS (0.000s) [96.751109] [025/131] (902s left) gem_ctx_shared (detached-shared-gtt) [96.798361] Starting subtest: detached-shared-gtt [98.950740] Subtest detached-shared-gtt: SUCCESS (2.151s) [99.369137] [026/131] (900s left) kms_prime (d3hot) [100.091435] Subtest D3hot: SKIP (0.000s) [100.146521] [027/131] (899s left) kms_plane_multiple (tiling-4) [100.236076] Starting subtest: tiling-4 [100.238763] Starting dynamic subtest: pipe-A-eDP-1 [104.218941] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.980s) [104.225392] Starting dynamic subtest: pipe-B-eDP-1 [108.955623] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.735s) [108.963984] Starting dynamic subtest: pipe-C-eDP-1 [113.682285] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.727s) [113.690615] Starting dynamic subtest: pipe-D-eDP-1 [118.405338] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.723s) [118.407558] Subtest tiling-4: SUCCESS (18.168s) [119.307562] [028/131] (880s left) gem_render_copy_redux (normal) [119.350076] Starting subtest: normal [119.631779] Subtest normal: SUCCESS (0.281s) [119.735827] [029/131] (879s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [119.829112] Starting subtest: fbc-rgb101010-draw-render [123.462970] Subtest fbc-rgb101010-draw-render: SUCCESS (3.638s) [123.577156] [030/131] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [123.673437] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [127.991049] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.322s) [128.102354] [031/131] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [128.197549] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [128.201816] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [128.258884] [032/131] (871s left) syncobj_timeline (multi-wait-all-signaled) [128.304733] Starting subtest: multi-wait-all-signaled [128.307350] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [128.357888] [033/131] (871s left) vgem_basic (sysfs) [128.393953] Starting subtest: sysfs [128.396425] Subtest sysfs: SUCCESS (0.000s) [128.426109] [034/131] (871s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [128.532587] Starting subtest: cursorA-vs-flipB-atomic-transitions [128.537289] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s) [128.617207] [035/131] (870s left) gem_exec_gttfill (multigpu-basic) [128.780522] Starting subtest: multigpu-basic [143.513575] Subtest multigpu-basic: SUCCESS (14.733s) [143.542010] [036/131] (856s left) perf_pmu (gt-awake) [143.599711] Starting subtest: gt-awake [152.361902] Subtest gt-awake: SUCCESS (8.762s) [152.433642] [037/131] (847s left) kms_psr (pr-cursor-plane-onoff) [152.532164] Starting subtest: pr-cursor-plane-onoff [152.536599] Subtest pr-cursor-plane-onoff: SKIP (0.000s) [152.581116] [038/131] (847s left) vgem_basic (unload) [152.609623] Starting subtest: unload [181.682485] Subtest unload: SUCCESS (29.074s) [181.754088] [039/131] (817s left) gen9_exec_parse (bb-start-out) [181.811619] Subtest bb-start-out: SKIP (0.000s) [181.854721] [040/131] (817s left) kms_joiner (invalid-modeset-force-ultra-joiner) [181.948045] Starting subtest: invalid-modeset-force-ultra-joiner [181.952121] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [181.988243] [041/131] (817s left) gem_exec_schedule (semaphore-power) [182.153469] Subtest semaphore-power: SKIP (0.000s) [182.303756] [042/131] (817s left) vgem_basic (setversion) [182.336242] Starting subtest: setversion [182.340335] Subtest setversion: SUCCESS (0.000s) [182.367334] [043/131] (817s left) gem_lmem_swapping (random-engines) [182.399076] Subtest random-engines: SKIP (0.000s) [182.421646] [044/131] (817s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [182.512562] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [182.516998] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [182.583951] [045/131] (817s left) syncobj_timeline (host-signal-ordered) [182.635512] Starting subtest: host-signal-ordered [182.637690] Subtest host-signal-ordered: SUCCESS (0.000s) [182.701607] [046/131] (816s left) gem_tiled_fence_blits (normal) [182.759492] Subtest normal: SKIP (0.000s) [182.801869] [047/131] (816s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [182.914687] Starting subtest: cursorB-vs-flipB-varying-size [182.919453] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [182.998563] [048/131] (816s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf) [188.118846] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf [188.121750] Starting dynamic subtest: pipe-A-eDP-1 [205.382637] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.260s) [205.390701] Starting dynamic subtest: pipe-B-eDP-1 [222.647684] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.266s) [222.650144] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.529s) [223.563793] [049/131] (776s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [223.658142] Starting subtest: yf-tiled-16bpp-rotate-270 [223.662497] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [223.720666] [050/131] (776s left) sysfs_timeslice_duration (duration) [223.769710] Starting subtest: duration [223.772291] Starting dynamic subtest: vecs0 [238.278373] Dynamic subtest vecs0: SUCCESS (14.506s) [238.288281] Starting dynamic subtest: ccs0 [251.428848] Dynamic subtest ccs0: SUCCESS (13.151s) [251.437774] Starting dynamic subtest: vcs0 [265.350708] Dynamic subtest vcs0: SUCCESS (13.919s) [265.360043] Starting dynamic subtest: bcs0 [278.502851] Dynamic subtest bcs0: SUCCESS (13.152s) [278.511715] Starting dynamic subtest: rcs0 [291.660280] Dynamic subtest rcs0: SUCCESS (13.156s) [291.668070] Starting dynamic subtest: vcs1 [305.287622] Dynamic subtest vcs1: SUCCESS (13.625s) [305.290293] Subtest duration: SUCCESS (81.514s) [305.341953] [051/131] (694s left) gem_mmap_offset (bad-flags) [305.404704] Starting subtest: bad-flags [305.407527] Subtest bad-flags: SUCCESS (0.000s) [305.482163] [052/131] (694s left) i915_pm_rpm (gem-execbuf-stress) [307.507332] Starting subtest: gem-execbuf-stress [307.510692] Starting dynamic subtest: smem0 [320.425522] Dynamic subtest smem0: SUCCESS (12.918s) [320.434071] Starting dynamic subtest: extra-wait-smem0 [382.087788] Dynamic subtest extra-wait-smem0: SUCCESS (61.658s) [382.091937] Subtest gem-execbuf-stress: SUCCESS (74.579s) [382.422092] [053/131] (617s left) gem_pread (snoop) [382.467055] Subtest snoop: SKIP (0.000s) [382.496981] [054/131] (617s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [382.880623] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [383.734687] [055/131] (616s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [383.839141] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [383.843198] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [383.903562] [056/131] (615s left) gem_pxp (protected-encrypted-src-copy-not-readible) [386.478303] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s) [386.522039] [057/131] (613s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [386.618743] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [386.623047] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [386.687510] [058/131] (613s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [386.776913] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [386.779345] Starting dynamic subtest: pipe-A-default-mode [389.564828] Dynamic subtest pipe-A-default-mode: SUCCESS (2.786s) [389.567563] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.787s) [390.474307] [059/131] (609s left) kms_vblank (crtc-id) [390.567786] Starting subtest: crtc-id [390.570114] Starting dynamic subtest: pipe-A-eDP-1 [390.990751] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s) [391.004637] Starting dynamic subtest: pipe-D-eDP-1 [392.196435] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.203s) [392.198707] Subtest crtc-id: SUCCESS (1.626s) [393.101800] [060/131] (606s left) api_intel_bb (intel-bb-blit-y) [393.149035] Starting subtest: intel-bb-blit-y [396.502881] Subtest intel-bb-blit-y: SUCCESS (3.352s) [396.607119] [061/131] (603s left) gem_mmap_gtt (basic-write-read) [396.660752] Subtest basic-write-read: SKIP (0.000s) [396.695102] [062/131] (603s left) syncobj_wait (invalid-reset-bad-pad) [396.742360] Starting subtest: invalid-reset-bad-pad [396.744797] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [396.796867] [063/131] (603s left) perf_pmu (init-sema) [396.827939] Starting subtest: init-sema [396.830350] Starting dynamic subtest: rcs0 [396.832730] Dynamic subtest rcs0: SUCCESS (0.002s) [396.840561] Starting dynamic subtest: bcs0 [396.842422] Dynamic subtest bcs0: SUCCESS (0.000s) [396.848031] Starting dynamic subtest: vcs0 [396.849936] Dynamic subtest vcs0: SUCCESS (0.001s) [396.855344] Starting dynamic subtest: vcs1 [396.857209] Dynamic subtest vcs1: SUCCESS (0.001s) [396.862533] Starting dynamic subtest: vecs0 [396.864424] Dynamic subtest vecs0: SUCCESS (0.001s) [396.869821] Starting dynamic subtest: ccs0 [396.871781] Dynamic subtest ccs0: SUCCESS (0.000s) [396.874132] Subtest init-sema: SUCCESS (0.006s) [396.922107] [064/131] (603s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [397.017351] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [401.754881] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.740s) [401.841755] [065/131] (598s left) gen3_mixed_blits [401.919789] [066/131] (598s left) kms_color (legacy-gamma-reset) [402.013512] Starting subtest: legacy-gamma-reset [402.016180] Starting dynamic subtest: pipe-A-eDP-1 [402.372878] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s) [402.379394] Starting dynamic subtest: pipe-B-eDP-1 [402.382203] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s) [402.388136] Starting dynamic subtest: pipe-C-eDP-1 [402.390374] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s) [402.396225] Starting dynamic subtest: pipe-D-eDP-1 [402.398859] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s) [402.401567] Subtest legacy-gamma-reset: SUCCESS (0.385s) [403.275200] [067/131] (596s left) i915_query (query-regions-sanity-check) [403.326869] Starting subtest: query-regions-sanity-check [403.331939] Subtest query-regions-sanity-check: SUCCESS (0.008s) [403.399825] [068/131] (596s left) gem_busy (extended) [403.568363] Starting subtest: extended [403.570853] Starting dynamic subtest: rcs0 [403.663188] Dynamic subtest rcs0: SUCCESS (0.094s) [403.672232] Starting dynamic subtest: bcs0 [403.704455] Dynamic subtest bcs0: SUCCESS (0.041s) [403.715792] Starting dynamic subtest: vcs0 [405.352913] Dynamic subtest vcs0: SUCCESS (1.646s) [405.362229] Starting dynamic subtest: vcs1 [407.400540] Dynamic subtest vcs1: SUCCESS (2.046s) [407.410056] Starting dynamic subtest: vecs0 [409.384784] Dynamic subtest vecs0: SUCCESS (1.983s) [409.394627] Starting dynamic subtest: ccs0 [409.429917] Dynamic subtest ccs0: SUCCESS (0.045s) [409.432644] Subtest extended: SUCCESS (5.862s) [409.645823] [069/131] (590s left) gem_exec_balancer (hog) [409.704254] Starting subtest: hog [409.708794] Subtest hog: SKIP (0.000s) [409.934837] [070/131] (590s left) gem_mmap_offset (partial-remap) [409.974083] Starting subtest: partial-remap [409.976793] Starting dynamic subtest: smem0 [409.985197] Dynamic subtest smem0: SUCCESS (0.003s) [409.987034] Subtest partial-remap: SUCCESS (0.004s) [410.067932] [071/131] (589s left) syncobj_wait (signal) [410.114637] Starting subtest: signal [410.116742] Subtest signal: SUCCESS (0.000s) [410.177819] [072/131] (589s left) gem_eio (create-ext) [410.362219] Starting subtest: create-ext [410.651473] Subtest create-ext: SUCCESS (0.287s) [410.768589] [073/131] (589s left) kms_force_connector_basic (prune-stale-modes) [410.842999] Starting subtest: prune-stale-modes [411.082643] Subtest prune-stale-modes: SKIP (0.238s) [411.211721] [074/131] (588s left) kms_async_flips (alternate-sync-async-flip) [411.300639] Starting subtest: alternate-sync-async-flip [411.663405] Starting dynamic subtest: pipe-A-eDP-1 [414.498300] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.838s) [414.851085] Starting dynamic subtest: pipe-B-eDP-1 [417.740181] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.895s) [418.104287] Starting dynamic subtest: pipe-C-eDP-1 [420.942513] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.845s) [421.293054] Starting dynamic subtest: pipe-D-eDP-1 [424.141711] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.855s) [424.143932] Subtest alternate-sync-async-flip: SUCCESS (12.841s) [425.358474] [075/131] (574s left) core_auth (basic-auth) [425.410851] Starting subtest: basic-auth [425.413224] Subtest basic-auth: SUCCESS (0.002s) [425.502312] [076/131] (574s left) sw_sync (sync_busy_fork) [425.532493] Starting subtest: sync_busy_fork [426.542641] Subtest sync_busy_fork: SUCCESS (1.010s) [426.580657] [077/131] (573s left) gem_fence_thrash (bo-write-verify-threaded-y) [426.608863] Starting subtest: bo-write-verify-threaded-y [426.634575] Subtest bo-write-verify-threaded-y: SKIP (0.025s) [426.673577] [078/131] (573s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [426.758519] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [426.762822] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [426.825556] [079/131] (573s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [426.875825] Starting subtest: etime-single-wait-all-for-submit-submitted [426.982192] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s) [427.035030] [080/131] (573s left) kms_big_fb (linear-64bpp-rotate-90) [427.132669] Starting subtest: linear-64bpp-rotate-90 [427.149582] Subtest linear-64bpp-rotate-90: SKIP (0.018s) [427.253183] [081/131] (572s left) i915_pciid [427.388518] [082/131] (572s left) gem_wait (invalid-flags) [427.437105] Starting subtest: invalid-flags [427.439378] Subtest invalid-flags: SUCCESS (0.000s) [427.627214] [083/131] (572s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [427.713973] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [427.716398] Starting dynamic subtest: pipe-A [428.807604] Dynamic subtest pipe-A: SUCCESS (1.094s) [428.815134] Starting dynamic subtest: pipe-B [431.066522] Dynamic subtest pipe-B: SUCCESS (2.258s) [431.074059] Starting dynamic subtest: pipe-C [432.333288] Dynamic subtest pipe-C: SUCCESS (1.266s) [432.341310] Starting dynamic subtest: pipe-D [433.611561] Dynamic subtest pipe-D: SUCCESS (1.277s) [433.614312] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.898s) [434.830611] [084/131] (565s left) kms_cursor_edge_walk (128x128-top-bottom) [434.934938] Starting subtest: 128x128-top-bottom [434.937370] Starting dynamic subtest: pipe-A-eDP-1 [438.467514] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.530s) [438.475369] Starting dynamic subtest: pipe-D-eDP-1 [441.698470] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.230s) [441.700932] Subtest 128x128-top-bottom: SUCCESS (6.762s) [442.572813] [085/131] (557s left) gem_ctx_param (invalid-get-ringsize) [442.618911] Starting subtest: invalid-get-ringsize [442.621682] Subtest invalid-get-ringsize: SUCCESS (0.001s) [442.686492] [086/131] (557s left) prime_vgem (shrink) [442.761286] Starting subtest: shrink [442.771879] Subtest shrink: SUCCESS (0.013s) [442.857238] [087/131] (557s left) kms_big_fb (4-tiled-64bpp-rotate-0) [442.957978] Starting subtest: 4-tiled-64bpp-rotate-0 [444.324175] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.367s) [444.481973] [088/131] (555s left) kms_big_fb (x-tiled-64bpp-rotate-270) [444.572148] Starting subtest: x-tiled-64bpp-rotate-270 [444.593875] Subtest x-tiled-64bpp-rotate-270: SKIP (0.018s) [444.678235] [089/131] (555s left) sysfs_heartbeat_interval (invalid) [444.729298] Starting subtest: invalid [444.731464] Starting dynamic subtest: vecs0 [444.733507] Dynamic subtest vecs0: SUCCESS (0.000s) [444.739241] Starting dynamic subtest: ccs0 [444.741146] Dynamic subtest ccs0: SUCCESS (0.000s) [444.746921] Starting dynamic subtest: vcs0 [444.748812] Dynamic subtest vcs0: SUCCESS (0.000s) [444.754322] Starting dynamic subtest: bcs0 [444.756102] Dynamic subtest bcs0: SUCCESS (0.000s) [444.762210] Starting dynamic subtest: rcs0 [444.764332] Dynamic subtest rcs0: SUCCESS (0.000s) [444.770150] Starting dynamic subtest: vcs1 [444.772277] Dynamic subtest vcs1: SUCCESS (0.000s) [444.774169] Subtest invalid: SUCCESS (0.002s) [444.819567] [090/131] (555s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [444.915529] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [444.919244] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [444.982145] [091/131] (555s left) kms_flip (absolute-wf_vblank) [445.063449] Starting subtest: absolute-wf_vblank [445.065520] Starting dynamic subtest: A-eDP1 [453.900275] Dynamic subtest A-eDP1: SUCCESS (8.835s) [453.906728] Starting dynamic subtest: B-eDP1 [462.731011] Dynamic subtest B-eDP1: SUCCESS (8.829s) [462.739701] Starting dynamic subtest: C-eDP1 [471.554472] Dynamic subtest C-eDP1: SUCCESS (8.822s) [471.562056] Starting dynamic subtest: D-eDP1 [480.319938] Dynamic subtest D-eDP1: SUCCESS (8.765s) [480.325539] Subtest absolute-wf_vblank: SUCCESS (35.260s) [481.550368] [092/131] (518s left) gem_mmap_gtt (basic-write) [481.598488] Subtest basic-write: SKIP (0.000s) [481.637253] [093/131] (518s left) kms_psr (fbc-psr2-cursor-plane-move) [481.722028] Starting subtest: fbc-psr2-cursor-plane-move [481.724454] Starting dynamic subtest: eDP-1 [481.728709] Dynamic subtest eDP-1: SKIP (0.000s) [481.732964] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s) [481.769980] [094/131] (518s left) perf (short-reads) [481.874738] Starting subtest: short-reads [481.887050] Subtest short-reads: SUCCESS (0.013s) [481.902876] [095/131] (518s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [481.957657] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [481.961924] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s) [482.114643] [096/131] (518s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [482.197957] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [482.200420] Starting dynamic subtest: pipe-A-eDP-1 [482.223511] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [482.231350] Starting dynamic subtest: pipe-B-eDP-1 [482.253171] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [482.260099] Starting dynamic subtest: pipe-C-eDP-1 [482.281644] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [482.288238] Starting dynamic subtest: pipe-D-eDP-1 [482.310783] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [482.314973] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.004s) [484.553766] [097/131] (515s left) api_intel_allocator (gem-pool) [484.598626] Starting subtest: gem-pool [484.604649] Subtest gem-pool: SUCCESS (0.006s) [484.712206] [098/131] (515s left) gem_exec_reloc (basic-wc-gtt) [484.768272] Subtest basic-wc-gtt: SKIP (0.000s) [484.835159] [099/131] (515s left) gem_exec_whisper (basic-sync) [484.895308] Starting subtest: basic-sync [492.573334] Subtest basic-sync: SUCCESS (7.679s) [492.738212] [100/131] (507s left) kms_cursor_crc (cursor-onscreen-64x64) [492.888347] Starting subtest: cursor-onscreen-64x64 [492.893205] Starting dynamic subtest: pipe-A-eDP-1 [494.967893] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.074s) [494.987652] Starting dynamic subtest: pipe-D-eDP-1 [497.832828] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.848s) [497.835198] Subtest cursor-onscreen-64x64: SUCCESS (4.942s) [498.690114] [101/131] (501s left) gem_exec_fair (basic-none-share) [498.760747] Subtest basic-none-share: SKIP (0.000s) [498.810332] [102/131] (501s left) gem_softpin (evict-prime-sanity-check) [498.850907] Starting subtest: evict-prime-sanity-check [498.853200] Starting dynamic subtest: rcs0 [500.009252] Dynamic subtest rcs0: SUCCESS (1.157s) [500.016800] Starting dynamic subtest: bcs0 [501.140187] Dynamic subtest bcs0: SUCCESS (1.130s) [501.147463] Starting dynamic subtest: vcs0 [502.331808] Dynamic subtest vcs0: SUCCESS (1.189s) [502.341768] Starting dynamic subtest: vcs1 [504.343553] Dynamic subtest vcs1: SUCCESS (2.011s) [504.351303] Starting dynamic subtest: vecs0 [506.326718] Dynamic subtest vecs0: SUCCESS (1.982s) [506.334274] Starting dynamic subtest: ccs0 [507.493243] Dynamic subtest ccs0: SUCCESS (1.167s) [507.502406] Starting dynamic subtest: all [508.624358] Dynamic subtest all: SUCCESS (1.130s) [508.627382] Subtest evict-prime-sanity-check: SUCCESS (9.773s) [508.683336] [103/131] (491s left) gem_mmap_gtt (basic) [508.730494] Subtest basic: SKIP (0.000s) [508.771770] [104/131] (491s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [508.872459] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [512.045805] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (3.177s) [512.158290] [105/131] (488s left) kms_cursor_crc (cursor-rapid-movement-256x256) [512.365078] Starting subtest: cursor-rapid-movement-256x256 [512.369547] Starting dynamic subtest: pipe-A-eDP-1 [512.874788] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.505s) [512.896893] Starting dynamic subtest: pipe-D-eDP-1 [514.118316] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s) [514.121405] Subtest cursor-rapid-movement-256x256: SUCCESS (1.751s) [514.981114] [106/131] (485s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [515.082257] Starting subtest: primary-y-tiled-reflect-x-270 [515.086885] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [515.138277] [107/131] (485s left) kms_getfb (getfb2-handle-not-fb) [515.196501] Starting subtest: getfb2-handle-not-fb [515.236662] Subtest getfb2-handle-not-fb: SUCCESS (0.042s) [515.305910] [108/131] (485s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc) [515.408676] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc [515.413180] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [515.490183] [109/131] (485s left) kms_setmode (invalid-clone-single-crtc) [515.545313] Starting subtest: invalid-clone-single-crtc [515.552045] Subtest invalid-clone-single-crtc: SKIP (0.001s) [515.615700] [110/131] (485s left) device_reset (unbind-cold-reset-rebind) [515.651412] Starting subtest: unbind-cold-reset-rebind [515.655779] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [515.691106] [111/131] (484s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [515.782371] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [518.658058] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.879s) [518.757874] [112/131] (481s left) gem_exec_schedule (u-semaphore-resolve) [518.817638] Starting subtest: u-semaphore-resolve [518.840279] Subtest u-semaphore-resolve: SUCCESS (0.031s) [519.159583] [113/131] (481s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [519.207961] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [519.210364] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s) [519.272229] [114/131] (481s left) gem_mmap_gtt (basic-copy) [519.323253] Subtest basic-copy: SKIP (0.000s) [519.363040] [115/131] (481s left) gem_spin_batch (spin-all) [519.416419] Starting subtest: spin-all [519.428044] Subtest spin-all: SUCCESS (0.011s) [521.401242] [116/131] (479s left) kms_flip (flip-vs-blocking-wf-vblank) [521.485058] Starting subtest: flip-vs-blocking-wf-vblank [521.487454] Starting dynamic subtest: A-eDP1 [530.505516] Dynamic subtest A-eDP1: SUCCESS (9.019s) [530.515016] Starting dynamic subtest: B-eDP1 [539.527752] Dynamic subtest B-eDP1: SUCCESS (9.020s) [539.536482] Starting dynamic subtest: C-eDP1 [548.542524] Dynamic subtest C-eDP1: SUCCESS (9.013s) [548.553371] Starting dynamic subtest: D-eDP1 [557.500537] Dynamic subtest D-eDP1: SUCCESS (8.956s) [557.506447] Subtest flip-vs-blocking-wf-vblank: SUCCESS (36.019s) [558.732718] [117/131] (442s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [558.828371] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [558.832952] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [558.897161] [118/131] (441s left) kms_atomic (plane-primary-legacy) [558.976807] Starting subtest: plane-primary-legacy [558.979208] Starting dynamic subtest: pipe-A-eDP-1 [559.406751] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.427s) [559.409388] Subtest plane-primary-legacy: SUCCESS (0.428s) [560.267295] [119/131] (440s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs) [560.353959] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs [560.356241] Starting dynamic subtest: pipe-A-eDP-1 [561.563220] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.208s) [561.571465] Starting dynamic subtest: pipe-B-eDP-1 [563.877244] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.313s) [563.885611] Starting dynamic subtest: pipe-C-eDP-1 [566.255346] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.378s) [566.262824] Starting dynamic subtest: pipe-D-eDP-1 [568.612921] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.356s) [568.615618] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.258s) [569.804541] [120/131] (431s left) kms_feature_discovery (display-2x) [569.894116] Starting subtest: display-2x [569.898212] Subtest display-2x: SKIP (0.000s) [569.941393] [121/131] (430s left) syncobj_wait (invalid-signal-one-illegal-handle) [569.980045] Starting subtest: invalid-signal-one-illegal-handle [569.981975] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [570.030983] [122/131] (430s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [570.127358] Starting subtest: psr-2p-scndscrn-spr-indfb-move [570.132218] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [570.198192] [123/131] (430s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [570.563237] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [571.448870] [124/131] (429s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [571.539776] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [571.541950] Starting dynamic subtest: pipe-A-eDP-1 [571.563518] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [571.570554] Starting dynamic subtest: pipe-B-eDP-1 [571.591619] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [571.598212] Starting dynamic subtest: pipe-C-eDP-1 [571.618979] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [571.625261] Starting dynamic subtest: pipe-D-eDP-1 [571.647470] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [571.651926] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.004s) [573.898922] [125/131] (426s left) kms_writeback (writeback-fb-id-xrgb2101010) [573.982085] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s) [574.005020] [126/131] (426s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [574.105210] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [578.387628] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.284s) [578.476181] [127/131] (422s left) kms_plane_scaling (invalid-parameters) [578.558993] Starting subtest: invalid-parameters [578.561345] Starting dynamic subtest: less-than-1-height-src [578.566635] Dynamic subtest less-than-1-height-src: SUCCESS (0.008s) [578.574040] Starting dynamic subtest: less-than-1-width-src [578.576400] Dynamic subtest less-than-1-width-src: SUCCESS (0.008s) [578.578658] Subtest invalid-parameters: SUCCESS (0.017s) [578.637865] [128/131] (422s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [578.736560] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [578.740960] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [578.793830] [129/131] (422s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [578.882291] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [578.886464] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [578.963294] [130/131] (422s left) gem_basic (create-close) [579.002732] Starting subtest: create-close [579.007515] Subtest create-close: SUCCESS (0.000s) [579.059224] [131/131] (421s left) kms_psr (psr-dpms) [579.142792] Starting subtest: psr-dpms [579.144919] Starting dynamic subtest: eDP-1 [582.200201] Dynamic subtest eDP-1: SUCCESS (3.054s) [582.202228] Subtest psr-dpms: SUCCESS (3.055s) [583.113287] Closing watchdogs Done.