[63.638047] Initializing watchdogs [63.638100] /dev/watchdog0 [63.654885] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [63.660405] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [63.662647] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [63.665870] [001/133] (960s left) kms_psr (psr-basic) [63.781922] Starting subtest: psr-basic [63.784303] Starting dynamic subtest: eDP-1 [65.439624] Dynamic subtest eDP-1: SUCCESS (1.647s) [65.441952] Subtest psr-basic: SUCCESS (1.648s) [66.319706] [002/133] (957s left) kms_psr (fbc-psr-sprite-mmap-cpu) [66.412586] Starting subtest: fbc-psr-sprite-mmap-cpu [66.414539] Starting dynamic subtest: eDP-1 [66.418652] Dynamic subtest eDP-1: SKIP (0.000s) [66.422772] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s) [66.493596] [003/133] (957s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [66.579504] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [66.581931] Starting dynamic subtest: pipe-A [66.690546] Dynamic subtest pipe-A: SKIP (0.108s) [66.699381] Starting dynamic subtest: pipe-B [67.898801] Dynamic subtest pipe-B: SKIP (1.203s) [67.906830] Starting dynamic subtest: pipe-C [69.054219] Dynamic subtest pipe-C: SUCCESS (1.157s) [69.061618] Starting dynamic subtest: pipe-D [70.290505] Dynamic subtest pipe-D: SUCCESS (1.232s) [70.292971] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.702s) [71.502552] [004/133] (952s left) gem_exec_whisper (basic-forked) [71.570291] Starting subtest: basic-forked [78.907348] Subtest basic-forked: SUCCESS (7.324s) [79.106612] [005/133] (945s left) gem_exec_reloc (basic-wc-read-noreloc) [79.167620] Subtest basic-wc-read-noreloc: SKIP (0.000s) [79.231740] [006/133] (945s left) gem_reg_read (bad-register) [79.283644] Starting subtest: bad-register [79.285833] Subtest bad-register: SUCCESS (0.000s) [79.378488] [007/133] (945s left) gem_fence_thrash (bo-write-verify-y) [79.411173] Starting subtest: bo-write-verify-y [79.441442] Subtest bo-write-verify-y: SKIP (0.027s) [79.504296] [008/133] (944s left) gem_mmap_offset (bad-extensions) [79.561776] Starting subtest: bad-extensions [79.563656] Subtest bad-extensions: SUCCESS (0.000s) [79.651624] [009/133] (944s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [79.751777] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [79.754395] Starting dynamic subtest: pipe-A [79.772815] Dynamic subtest pipe-A: SKIP (0.019s) [79.782301] Starting dynamic subtest: pipe-B [79.804189] Dynamic subtest pipe-B: SKIP (0.033s) [79.812739] Starting dynamic subtest: pipe-C [79.836922] Dynamic subtest pipe-C: SKIP (0.032s) [79.845141] Starting dynamic subtest: pipe-D [79.868755] Dynamic subtest pipe-D: SKIP (0.032s) [79.872748] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.117s) [79.983181] [010/133] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render) [80.084158] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render [87.061360] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.975s) [87.208726] [011/133] (937s left) gem_tiled_blits (interruptible) [87.276234] Subtest interruptible: SKIP (0.000s) [87.337801] [012/133] (937s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu) [87.435156] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu [91.568833] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.136s) [92.765871] [013/133] (931s left) gem_exercise_blt (fast-copy-emit) [92.830258] Starting subtest: fast-copy-emit [92.832215] Starting dynamic subtest: linear-smem-smem-emit [92.850453] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s) [92.862625] Starting dynamic subtest: xmajor-smem-smem-emit [92.868126] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s) [92.877473] Starting dynamic subtest: tile4-smem-smem-emit [92.885657] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s) [92.894228] Starting dynamic subtest: tile64-smem-smem-emit [92.902508] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s) [92.905303] Subtest fast-copy-emit: SUCCESS (0.074s) [93.014785] [014/133] (931s left) gem_exec_schedule (noreorder) [93.203736] Starting subtest: noreorder [93.205757] Starting dynamic subtest: rcs0 [93.262408] Dynamic subtest rcs0: SUCCESS (0.060s) [93.274499] Starting dynamic subtest: vcs0 [95.326285] Dynamic subtest vcs0: SUCCESS (2.063s) [95.342241] Starting dynamic subtest: vcs1 [97.312504] Dynamic subtest vcs1: SUCCESS (1.983s) [97.322601] Starting dynamic subtest: vecs0 [99.325564] Dynamic subtest vecs0: SUCCESS (1.986s) [99.337554] Starting dynamic subtest: ccs0 [99.367618] Dynamic subtest ccs0: SUCCESS (0.068s) [99.369986] Subtest noreorder: SUCCESS (6.166s) [99.574170] [015/133] (925s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [99.701777] Starting subtest: yf-tiled-64bpp-rotate-270 [99.705733] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [99.796974] [016/133] (924s left) gem_mmap_gtt (basic-read-write) [99.844035] Subtest basic-read-write: SKIP (0.000s) [99.907212] [017/133] (924s left) kms_psr (pr-no-drrs) [100.006812] Starting subtest: pr-no-drrs [100.010908] Subtest pr-no-drrs: SKIP (0.000s) [100.078138] [018/133] (924s left) kms_dsc (dsc-with-bpc) [100.173711] Starting subtest: dsc-with-bpc [100.204141] Subtest dsc-with-bpc: SKIP (0.001s) [100.244985] [019/133] (924s left) kms_async_flips (alternate-sync-async-flip-atomic) [100.336069] Starting subtest: alternate-sync-async-flip-atomic [100.711261] Starting dynamic subtest: pipe-A-eDP-1 [103.454941] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.743s) [103.837594] Starting dynamic subtest: pipe-B-eDP-1 [106.589955] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s) [106.966829] Starting dynamic subtest: pipe-C-eDP-1 [109.725899] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s) [110.108196] Starting dynamic subtest: pipe-D-eDP-1 [112.867345] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s) [112.869546] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.533s) [114.034479] [020/133] (910s left) gem_ctx_persistence (legacy-engines-mixed) [114.097088] Starting subtest: legacy-engines-mixed [114.099446] Starting dynamic subtest: render [114.184685] Dynamic subtest render: SUCCESS (0.087s) [114.195389] Starting dynamic subtest: bsd1 [114.247660] Dynamic subtest bsd1: SUCCESS (0.061s) [114.262447] Starting dynamic subtest: bsd2 [114.298725] Dynamic subtest bsd2: SUCCESS (0.050s) [114.309553] Starting dynamic subtest: blt [114.348896] Dynamic subtest blt: SUCCESS (0.048s) [114.361485] Starting dynamic subtest: vebox [114.396626] Dynamic subtest vebox: SUCCESS (0.047s) [114.399065] Subtest legacy-engines-mixed: SUCCESS (0.300s) [114.488970] [021/133] (910s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [114.540044] Starting subtest: invalid-multi-wait-unsubmitted [114.542410] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [114.621318] [022/133] (910s left) gem_exec_params (invalid-bsd-ring) [114.669231] Starting subtest: invalid-bsd-ring [114.671625] Subtest invalid-bsd-ring: SUCCESS (0.000s) [114.779444] [023/133] (910s left) kms_big_fb (x-tiled-8bpp-rotate-270) [114.887784] Starting subtest: x-tiled-8bpp-rotate-270 [114.911824] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s) [115.009318] [024/133] (910s left) gem_mmap_gtt (medium-copy-odd) [115.067592] Subtest medium-copy-odd: SKIP (0.000s) [115.128811] [025/133] (909s left) gem_flink_basic (bad-open) [115.189783] Starting subtest: bad-open [115.191747] Subtest bad-open: SUCCESS (0.000s) [115.300513] [026/133] (909s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [115.391238] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [115.393104] Starting dynamic subtest: pipe-A-eDP-1 [115.441948] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [115.450539] Starting dynamic subtest: pipe-B-eDP-1 [115.498788] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [115.508543] Starting dynamic subtest: pipe-C-eDP-1 [115.556070] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [115.565279] Starting dynamic subtest: pipe-D-eDP-1 [115.613217] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [115.616902] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s) [117.721122] [027/133] (907s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [117.814574] Starting subtest: psr-rgb565-draw-mmap-cpu [124.725430] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.913s) [124.838144] [028/133] (900s left) gem_pread (bench) [124.899260] Subtest bench: SKIP (0.000s) [124.964130] [029/133] (900s left) kms_cursor_crc (cursor-onscreen-256x256) [125.208067] Starting subtest: cursor-onscreen-256x256 [125.213285] Starting dynamic subtest: pipe-A-eDP-1 [127.337046] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.124s) [127.367279] Starting dynamic subtest: pipe-D-eDP-1 [130.133621] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s) [130.136408] Subtest cursor-onscreen-256x256: SUCCESS (4.923s) [130.990128] [030/133] (894s left) gem_sync (basic-store-each) [131.062089] Starting subtest: basic-store-each [133.387570] Subtest basic-store-each: SUCCESS (2.335s) [133.601961] [031/133] (891s left) gem_ctx_param (invalid-get-ringsize) [133.651793] Starting subtest: invalid-get-ringsize [133.654186] Subtest invalid-get-ringsize: SUCCESS (0.001s) [133.798221] [032/133] (891s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [133.894660] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [140.715674] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.823s) [140.836622] [033/133] (884s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [140.928313] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [140.930610] Starting dynamic subtest: pipe-A-eDP-1 [140.939837] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [140.949878] Starting dynamic subtest: pipe-B-eDP-1 [140.959135] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [140.968127] Starting dynamic subtest: pipe-C-eDP-1 [140.976901] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [140.985845] Starting dynamic subtest: pipe-D-eDP-1 [140.994150] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [140.998255] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [143.107635] [034/133] (882s left) gem_partial_pwrite_pread (write-uncached) [143.176962] Subtest write-uncached: SKIP (0.000s) [143.242697] [035/133] (882s left) kms_fence_pin_leak [143.407367] [036/133] (882s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [143.457258] Starting subtest: multi-wait-available-unsubmitted-signaled [143.459612] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [143.558924] [037/133] (882s left) kms_flip (2x-absolute-wf_vblank-interruptible) [143.655430] Starting subtest: 2x-absolute-wf_vblank-interruptible [143.668078] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s) [143.756430] [038/133] (881s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs) [143.852850] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs [143.857370] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s) [144.933954] [039/133] (880s left) kms_panel_fitting (atomic-fastset) [145.034120] Starting subtest: atomic-fastset [145.036417] Starting dynamic subtest: pipe-A-eDP-1 [145.171252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s) [145.183088] Starting dynamic subtest: pipe-B-eDP-1 [146.398832] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.227s) [146.408426] Starting dynamic subtest: pipe-C-eDP-1 [147.590779] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.191s) [147.603523] Starting dynamic subtest: pipe-D-eDP-1 [148.729760] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s) [148.732055] Subtest atomic-fastset: SUCCESS (3.698s) [149.965888] [040/133] (875s left) syncobj_timeline (wait-zero-handles) [150.020367] Starting subtest: wait-zero-handles [150.022307] Subtest wait-zero-handles: SUCCESS (0.000s) [150.119586] [041/133] (875s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [150.214778] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [150.217079] Starting dynamic subtest: A-eDP1 [153.797489] Dynamic subtest A-eDP1: SUCCESS (3.579s) [153.807701] Starting dynamic subtest: B-eDP1 [157.034150] Dynamic subtest B-eDP1: SUCCESS (3.236s) [157.043351] Starting dynamic subtest: C-eDP1 [160.210855] Dynamic subtest C-eDP1: SUCCESS (3.173s) [160.221055] Starting dynamic subtest: D-eDP1 [163.408920] Dynamic subtest D-eDP1: SUCCESS (3.197s) [163.411153] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.194s) [164.205095] [042/133] (861s left) kms_color (ctm-green-to-red) [164.296127] Starting subtest: ctm-green-to-red [164.297978] Starting dynamic subtest: pipe-A-eDP-1 [165.019336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.724s) [165.029411] Starting dynamic subtest: pipe-B-eDP-1 [166.421819] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s) [166.431799] Starting dynamic subtest: pipe-C-eDP-1 [167.795962] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s) [167.805331] Starting dynamic subtest: pipe-D-eDP-1 [169.133724] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s) [169.136024] Subtest ctm-green-to-red: SUCCESS (4.839s) [169.925406] [043/133] (855s left) gem_exec_parallel (engines) [169.979509] Starting subtest: engines [169.981981] Starting dynamic subtest: basic [173.348585] Dynamic subtest basic: SUCCESS (3.367s) [173.358978] Starting dynamic subtest: contexts [177.644532] Dynamic subtest contexts: SUCCESS (4.292s) [177.656652] Starting dynamic subtest: fds [181.481799] Dynamic subtest fds: SUCCESS (3.836s) [181.494484] Starting dynamic subtest: userptr [183.331732] Dynamic subtest userptr: SUCCESS (1.848s) [183.334070] Subtest engines: SUCCESS (13.352s) [183.525069] [044/133] (842s left) kms_flip (2x-flip-vs-rmfb) [183.622196] Starting subtest: 2x-flip-vs-rmfb [183.633782] Subtest 2x-flip-vs-rmfb: SKIP (0.011s) [183.713131] [045/133] (842s left) gem_userptr_blits (userfault) [183.779056] Starting subtest: userfault [183.781458] Subtest userfault: SUCCESS (0.007s) [183.910634] [046/133] (842s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [184.041527] Starting subtest: short-flip-before-cursor-atomic-transitions [184.999824] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.957s) [185.857619] [047/133] (840s left) kms_tiled_display (basic-test-pattern-with-chamelium) [185.974988] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s) [186.037353] [048/133] (840s left) gem_exec_balancer (individual) [186.103853] Starting subtest: individual [188.325089] Subtest individual: SUCCESS (2.220s) [188.671594] [049/133] (837s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [188.779834] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [196.118256] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.342s) [196.246598] [050/133] (829s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [196.344597] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [196.348795] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [196.441907] [051/133] (829s left) gem_exec_params (invalid-ring) [196.500745] Starting subtest: invalid-ring [196.502970] Subtest invalid-ring: SUCCESS (0.000s) [196.593547] [052/133] (829s left) i915_suspend (basic-s3-without-i915) [196.627905] Starting subtest: basic-s3-without-i915 [199.981617] Subtest basic-s3-without-i915: SKIP (3.351s) [201.532460] [053/133] (824s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [201.635196] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [201.639734] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [201.740892] [054/133] (824s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [201.798317] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [201.854116] [055/133] (824s left) kms_chamelium_frames (hdmi-aspect-ratio) [202.255441] Subtest hdmi-aspect-ratio: SKIP (0.000s) [203.049696] [056/133] (823s left) perf (whitelisted-registers-userspace-config) [203.162783] Starting subtest: whitelisted-registers-userspace-config [203.164696] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s) [203.202490] [057/133] (823s left) gem_render_linear_blits (basic) [203.257874] Starting subtest: basic [203.288018] Subtest basic: SUCCESS (0.032s) [203.370661] [058/133] (823s left) i915_pm_rpm (gem-pread) [205.506355] Starting subtest: gem-pread [207.263097] Subtest gem-pread: SUCCESS (1.755s) [207.386408] [059/133] (819s left) kms_pm_rpm (drm-resources-equal) [209.516472] Starting subtest: drm-resources-equal [214.549461] Subtest drm-resources-equal: SUCCESS (5.035s) [214.651452] [060/133] (811s left) perf_pmu (invalid-open) [214.697061] Starting subtest: invalid-open [214.699392] Subtest invalid-open: SUCCESS (0.000s) [214.798546] [061/133] (811s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [214.845317] Starting subtest: etime-single-wait-for-submit-submitted [214.952653] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s) [215.027356] [062/133] (811s left) api_intel_allocator (alloc-simple) [215.076064] Starting subtest: alloc-simple [215.080761] Subtest alloc-simple: SUCCESS (0.004s) [215.194459] [063/133] (811s left) kms_prime (basic-modeset-hybrid) [215.270125] Subtest basic-modeset-hybrid: SKIP (0.000s) [215.395380] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true [215.399578] [064/133] (811s left) i915_drm_fdinfo (virtual-busy-all) [215.441185] Starting subtest: virtual-busy-all [215.445923] Subtest virtual-busy-all: SKIP (0.000s) [215.505245] [065/133] (811s left) kms_chamelium_color (ctm-green-to-red) [215.590630] Subtest ctm-green-to-red: SKIP (0.000s) [215.634292] [066/133] (811s left) gem_create (create-ext-cpu-access-sanity-check) [215.806090] Starting subtest: create-ext-cpu-access-sanity-check [215.811133] Subtest create-ext-cpu-access-sanity-check: SKIP (0.000s) [215.887145] [067/133] (811s left) kms_addfb_basic (tile-pitch-mismatch) [215.936977] Starting subtest: tile-pitch-mismatch [215.941289] Subtest tile-pitch-mismatch: SKIP (0.000s) [216.073010] [068/133] (810s left) kms_psr (psr-dpms) [216.160300] Starting subtest: psr-dpms [216.162569] Starting dynamic subtest: eDP-1 [219.107911] Dynamic subtest eDP-1: SUCCESS (2.948s) [219.110271] Subtest psr-dpms: SUCCESS (2.949s) [219.969834] [069/133] (807s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping) [220.061879] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping [220.087573] Starting dynamic subtest: pipe-A-plane-0 [220.375657] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s) [220.384878] Starting dynamic subtest: pipe-A-plane-3 [220.621973] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s) [221.747909] Starting dynamic subtest: pipe-B-plane-0 [222.041375] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [222.051268] Starting dynamic subtest: pipe-B-plane-3 [222.275188] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s) [222.585630] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.523s) [223.422967] [070/133] (803s left) gen9_exec_parse (bb-chained) [223.483438] Subtest bb-chained: SKIP (0.000s) [223.550376] [071/133] (803s left) gem_exec_schedule (semaphore-power) [223.729609] Subtest semaphore-power: SKIP (0.000s) [223.907720] [072/133] (803s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [223.955417] Starting subtest: invalid-single-wait-all-unsubmitted [223.957615] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [224.052907] [073/133] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [224.151729] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [224.156146] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [224.249883] [074/133] (802s left) gem_exec_reloc (basic-cpu-read) [224.303910] Subtest basic-cpu-read: SKIP (0.000s) [224.375663] [075/133] (802s left) kms_big_fb (y-tiled-addfb-size-overflow) [224.473297] Starting subtest: y-tiled-addfb-size-overflow [224.477557] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [224.574615] [076/133] (802s left) syncobj_wait (invalid-multi-wait-unsubmitted) [224.625078] Starting subtest: invalid-multi-wait-unsubmitted [224.627359] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [224.735335] [077/133] (802s left) kms_flip (flip-vs-dpms-on-nop) [224.828478] Starting subtest: flip-vs-dpms-on-nop [224.830426] Starting dynamic subtest: A-eDP1 [226.725745] Dynamic subtest A-eDP1: SUCCESS (1.899s) [226.740502] Starting dynamic subtest: B-eDP1 [228.539028] Dynamic subtest B-eDP1: SUCCESS (1.810s) [228.550821] Starting dynamic subtest: C-eDP1 [230.363071] Dynamic subtest C-eDP1: SUCCESS (1.822s) [230.374487] Starting dynamic subtest: D-eDP1 [232.193733] Dynamic subtest D-eDP1: SUCCESS (1.830s) [232.199296] Subtest flip-vs-dpms-on-nop: SUCCESS (7.374s) [233.378488] [078/133] (794s left) kms_big_fb (linear-16bpp-rotate-0) [233.483144] Starting subtest: linear-16bpp-rotate-0 [234.839855] Subtest linear-16bpp-rotate-0: SUCCESS (1.357s) [234.963069] [079/133] (792s left) kms_flip (flip-vs-absolute-wf_vblank) [235.050485] Starting subtest: flip-vs-absolute-wf_vblank [235.052336] Starting dynamic subtest: A-eDP1 [244.024904] Dynamic subtest A-eDP1: SUCCESS (8.972s) [244.034500] Starting dynamic subtest: B-eDP1 [252.952217] Dynamic subtest B-eDP1: SUCCESS (8.926s) [252.962543] Starting dynamic subtest: C-eDP1 [261.877381] Dynamic subtest C-eDP1: SUCCESS (8.922s) [261.890102] Starting dynamic subtest: D-eDP1 [270.818908] Dynamic subtest D-eDP1: SUCCESS (8.936s) [270.821280] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.767s) [272.047536] [080/133] (755s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [272.137035] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [272.140999] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [272.226759] [081/133] (755s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [272.326031] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [272.328162] Starting dynamic subtest: pipe-A-eDP-1 [272.350802] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [272.364326] Starting dynamic subtest: pipe-B-eDP-1 [272.385984] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [272.395105] Starting dynamic subtest: pipe-C-eDP-1 [272.416743] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [272.425781] Starting dynamic subtest: pipe-D-eDP-1 [272.447450] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [272.451519] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [274.621428] [082/133] (752s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [274.715608] Starting subtest: fbc-1p-primscrn-spr-indfb-move [278.850983] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.138s) [280.037205] [083/133] (747s left) kms_addfb_basic (bad-pitch-128) [280.095711] Starting subtest: bad-pitch-128 [280.097959] Subtest bad-pitch-128: SUCCESS (0.000s) [280.230293] [084/133] (747s left) gem_softpin (allocator-basic) [280.285715] Starting subtest: allocator-basic [280.358241] Subtest allocator-basic: SUCCESS (0.072s) [280.470487] [085/133] (747s left) kms_plane_cursor (overlay) [280.568996] Starting subtest: overlay [280.573660] Starting dynamic subtest: pipe-A-eDP-1-size-64 [283.164831] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.595s) [283.225650] Starting dynamic subtest: pipe-A-eDP-1-size-128 [285.832160] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.616s) [285.893029] Starting dynamic subtest: pipe-A-eDP-1-size-256 [288.466765] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.584s) [288.814520] Starting dynamic subtest: pipe-B-eDP-1-size-64 [292.119404] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.316s) [292.179431] Starting dynamic subtest: pipe-B-eDP-1-size-128 [294.776095] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.605s) [294.834414] Starting dynamic subtest: pipe-B-eDP-1-size-256 [297.432088] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.604s) [297.781056] Starting dynamic subtest: pipe-C-eDP-1-size-64 [300.685654] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.914s) [300.723880] Starting dynamic subtest: pipe-C-eDP-1-size-128 [302.919518] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s) [302.956572] Starting dynamic subtest: pipe-C-eDP-1-size-256 [305.208649] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.259s) [305.537631] Starting dynamic subtest: pipe-D-eDP-1-size-64 [308.526500] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.999s) [308.564924] Starting dynamic subtest: pipe-D-eDP-1-size-128 [310.770740] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s) [310.808957] Starting dynamic subtest: pipe-D-eDP-1-size-256 [313.048494] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.248s) [313.374958] Subtest overlay: SUCCESS (32.804s) [314.244388] [086/133] (713s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [314.635284] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [315.451164] [087/133] (712s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [315.549968] Starting subtest: fbcpsr-rgb565-draw-render [322.716967] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.170s) [322.869183] [088/133] (704s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [322.976745] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [322.980890] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [323.087611] [089/133] (704s left) gem_exec_balancer (parallel-out-fence) [323.338999] Starting subtest: parallel-out-fence [324.561412] Subtest parallel-out-fence: SUCCESS (1.222s) [324.659488] [090/133] (703s left) kms_flip (bo-too-big-interruptible) [324.760197] Starting subtest: bo-too-big-interruptible [324.762689] Starting dynamic subtest: A-eDP1 [326.048255] Dynamic subtest A-eDP1: SUCCESS (1.287s) [326.059219] Starting dynamic subtest: B-eDP1 [327.294274] Dynamic subtest B-eDP1: SUCCESS (1.245s) [327.304026] Starting dynamic subtest: C-eDP1 [328.628841] Dynamic subtest C-eDP1: SUCCESS (1.332s) [328.644179] Starting dynamic subtest: D-eDP1 [329.875558] Dynamic subtest D-eDP1: SUCCESS (1.244s) [329.878030] Subtest bo-too-big-interruptible: SUCCESS (5.119s) [331.084418] [091/133] (696s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [331.181500] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [338.300119] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.122s) [338.472186] [092/133] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [338.569267] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [338.573464] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [338.660982] [093/133] (689s left) perf (per-context-mode-unprivileged) [338.751475] Starting subtest: per-context-mode-unprivileged [338.756063] Subtest per-context-mode-unprivileged: SKIP (0.000s) [338.797922] [094/133] (689s left) kms_getfb (getfb2-handle-closed) [338.886695] Starting subtest: getfb2-handle-closed [338.889043] Subtest getfb2-handle-closed: SUCCESS (0.000s) [338.996395] [095/133] (689s left) gem_userptr_blits (unsync-unmap-after-close) [339.067083] Subtest unsync-unmap-after-close: SKIP (0.000s) [339.201619] [096/133] (688s left) i915_pm_freq_mult (media-freq) [339.258380] Starting subtest: media-freq [339.260227] Starting dynamic subtest: gt0 [339.263939] Dynamic subtest gt0: SKIP (0.000s) [339.273225] Starting dynamic subtest: gt1 [339.276808] Dynamic subtest gt1: SKIP (0.000s) [339.280342] Subtest media-freq: SKIP (0.002s) [339.368980] [097/133] (688s left) kms_cursor_crc (cursor-size-hints) [339.497187] Starting subtest: cursor-size-hints [339.498978] Starting dynamic subtest: pipe-A-eDP-1 [340.116295] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s) [340.130412] Starting dynamic subtest: pipe-D-eDP-1 [341.383229] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.262s) [341.385537] Subtest cursor-size-hints: SUCCESS (1.887s) [342.183983] [098/133] (686s left) gem_spin_batch (engines) [342.248170] Starting subtest: engines [342.250489] Starting dynamic subtest: rcs0 [345.487930] Dynamic subtest rcs0: SUCCESS (3.235s) [345.500075] Starting dynamic subtest: bcs0 [348.725813] Dynamic subtest bcs0: SUCCESS (3.234s) [348.739533] Starting dynamic subtest: vcs0 [351.964160] Dynamic subtest vcs0: SUCCESS (3.235s) [351.976074] Starting dynamic subtest: vcs1 [355.201059] Dynamic subtest vcs1: SUCCESS (3.234s) [355.212883] Starting dynamic subtest: vecs0 [358.439253] Dynamic subtest vecs0: SUCCESS (3.236s) [358.451825] Starting dynamic subtest: ccs0 [361.677615] Dynamic subtest ccs0: SUCCESS (3.235s) [361.679741] Subtest engines: SUCCESS (19.425s) [361.913634] [099/133] (666s left) kms_properties (get_properties-sanity-atomic) [362.024769] Starting subtest: get_properties-sanity-atomic [362.027094] Subtest get_properties-sanity-atomic: SUCCESS (0.003s) [362.103123] [100/133] (666s left) kms_vblank (wait-forked-hang) [362.202337] Starting subtest: wait-forked-hang [362.204608] Starting dynamic subtest: pipe-A-eDP-1 [389.094374] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.886s) [389.109704] Starting dynamic subtest: pipe-D-eDP-1 [404.136046] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.038s) [404.138368] Subtest wait-forked-hang: SUCCESS (41.928s) [404.938212] [101/133] (623s left) kms_display_modes (extended-mode-basic) [405.040911] Starting subtest: extended-mode-basic [405.045116] Subtest extended-mode-basic: SKIP (0.000s) [405.087376] [102/133] (623s left) kms_invalid_mode (zero-clock) [405.184395] Starting subtest: zero-clock [405.186703] Starting dynamic subtest: pipe-A-eDP-1 [405.470613] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [405.482454] Starting dynamic subtest: pipe-B-eDP-1 [405.484367] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [405.493916] Starting dynamic subtest: pipe-C-eDP-1 [405.496166] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [405.505594] Starting dynamic subtest: pipe-D-eDP-1 [405.507898] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [405.510204] Subtest zero-clock: SUCCESS (0.294s) [406.266161] [103/133] (622s left) kms_prop_blob (invalid-get-prop) [406.325618] Starting subtest: invalid-get-prop [406.327818] Subtest invalid-get-prop: SUCCESS (0.000s) [406.413205] [104/133] (622s left) kms_busy (extended-modeset-hang-newfb) [406.515080] Starting subtest: extended-modeset-hang-newfb [406.517250] Starting dynamic subtest: pipe-A [441.162218] Dynamic subtest pipe-A: SUCCESS (34.646s) [441.172398] Starting dynamic subtest: pipe-D [464.299939] Dynamic subtest pipe-D: SUCCESS (23.131s) [464.302673] Subtest extended-modeset-hang-newfb: SUCCESS (57.782s) [465.094557] [105/133] (563s left) api_intel_bb (object-noreloc-keep-cache-simple) [465.152338] Starting subtest: object-noreloc-keep-cache-simple [465.157200] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s) [465.284887] [106/133] (563s left) gem_exec_fence (submit67) [465.458958] Starting subtest: submit67 [465.462969] Subtest submit67: SKIP (0.000s) [467.389991] [107/133] (561s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [467.487463] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [468.133617] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s) [468.311593] [108/133] (560s left) gem_render_copy (yf-tiled-ccs-to-x-tiled) [468.368838] Starting subtest: yf-tiled-ccs-to-x-tiled [468.373423] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s) [468.572560] [109/133] (560s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [468.674722] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [468.679200] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [468.771046] [110/133] (559s left) gem_mmap_gtt (cpuset-medium-copy-xy) [468.823107] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [468.883401] [111/133] (559s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [468.978394] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [468.980735] Starting dynamic subtest: A-eDP1 [472.532478] Dynamic subtest A-eDP1: SUCCESS (3.549s) [472.543772] Starting dynamic subtest: B-eDP1 [475.740728] Dynamic subtest B-eDP1: SUCCESS (3.207s) [475.751746] Starting dynamic subtest: C-eDP1 [478.924356] Dynamic subtest C-eDP1: SUCCESS (3.184s) [478.936553] Starting dynamic subtest: D-eDP1 [482.053187] Dynamic subtest D-eDP1: SUCCESS (3.125s) [482.055428] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.074s) [482.873614] [112/133] (545s left) kms_psr (fbc-psr2-cursor-render) [482.977883] Starting subtest: fbc-psr2-cursor-render [482.980154] Starting dynamic subtest: eDP-1 [482.984341] Dynamic subtest eDP-1: SKIP (0.000s) [482.988512] Subtest fbc-psr2-cursor-render: SKIP (0.001s) [483.052601] [113/133] (545s left) gem_busy (busy) [483.111312] Starting subtest: busy [483.113474] Starting dynamic subtest: all-engines [483.141814] Dynamic subtest all-engines: SUCCESS (0.033s) [483.155229] Starting dynamic subtest: rcs0 [484.330944] Dynamic subtest rcs0: SUCCESS (1.188s) [484.342580] Starting dynamic subtest: bcs0 [484.383218] Dynamic subtest bcs0: SUCCESS (0.050s) [484.395355] Starting dynamic subtest: vcs0 [484.421987] Dynamic subtest vcs0: SUCCESS (0.038s) [484.431974] Starting dynamic subtest: vcs1 [486.315604] Dynamic subtest vcs1: SUCCESS (1.889s) [486.326278] Starting dynamic subtest: vecs0 [488.362507] Dynamic subtest vecs0: SUCCESS (2.045s) [488.373747] Starting dynamic subtest: ccs0 [490.348033] Dynamic subtest ccs0: SUCCESS (1.986s) [490.350739] Subtest busy: SUCCESS (7.239s) [490.709396] [114/133] (538s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [490.802954] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [490.807077] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s) [490.889394] [115/133] (538s left) kms_properties (connector-properties-legacy) [490.983996] Starting subtest: connector-properties-legacy [490.986299] Starting dynamic subtest: pipe-A-eDP-1 [498.883075] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.899s) [498.895685] Starting dynamic subtest: pipe-None-DP-1 [498.900493] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [498.909873] Starting dynamic subtest: pipe-None-HDMI-A-1 [498.914364] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [498.923966] Starting dynamic subtest: pipe-None-DP-2 [498.928208] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [498.937597] Starting dynamic subtest: pipe-None-HDMI-A-2 [498.942101] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [498.951752] Starting dynamic subtest: pipe-None-DP-3 [498.956232] Dynamic subtest pipe-None-DP-3: SUCCESS (0.002s) [498.966165] Starting dynamic subtest: pipe-None-DP-4 [498.970639] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [498.972523] Subtest connector-properties-legacy: SUCCESS (7.912s) [499.752039] [116/133] (529s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [499.854841] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [500.944745] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.090s) [501.068107] [117/133] (527s left) dumb_buffer (invalid-bpp) [501.114100] Starting subtest: invalid-bpp [501.115681] Subtest invalid-bpp: SUCCESS (0.000s) [501.206689] [118/133] (527s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [501.308202] Starting subtest: fbc-rgb101010-draw-render [505.877846] Subtest fbc-rgb101010-draw-render: SUCCESS (4.571s) [507.091846] [119/133] (522s left) kms_async_flips (test-cursor) [507.182884] Starting subtest: test-cursor [507.566524] Starting dynamic subtest: pipe-A-eDP-1 [508.364891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.799s) [508.755961] Starting dynamic subtest: pipe-B-eDP-1 [509.507432] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s) [509.899242] Starting dynamic subtest: pipe-C-eDP-1 [510.647082] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.757s) [511.025893] Starting dynamic subtest: pipe-D-eDP-1 [511.787263] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s) [511.789553] Subtest test-cursor: SUCCESS (4.606s) [512.956384] [120/133] (516s left) gem_eio (kms) [513.221365] Starting subtest: kms [530.992772] Subtest kms: SUCCESS (17.772s) [531.115059] [121/133] (498s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [531.215082] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [531.219116] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [531.320350] [122/133] (497s left) kms_cursor_edge_walk (64x64-right-edge) [531.416394] Starting subtest: 64x64-right-edge [531.418717] Starting dynamic subtest: pipe-A-eDP-1 [534.887167] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s) [534.902939] Starting dynamic subtest: pipe-D-eDP-1 [538.015222] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s) [538.017155] Subtest 64x64-right-edge: SUCCESS (6.598s) [538.826477] [123/133] (490s left) perf_pmu (semaphore-wait) [538.867610] Starting subtest: semaphore-wait [538.869930] Starting dynamic subtest: rcs0 [539.384367] Dynamic subtest rcs0: SUCCESS (0.515s) [539.397921] Starting dynamic subtest: bcs0 [539.898316] Dynamic subtest bcs0: SUCCESS (0.511s) [539.910626] Starting dynamic subtest: vcs0 [540.414322] Dynamic subtest vcs0: SUCCESS (0.512s) [540.427977] Starting dynamic subtest: vcs1 [540.927948] Dynamic subtest vcs1: SUCCESS (0.511s) [540.941234] Starting dynamic subtest: vecs0 [541.442654] Dynamic subtest vecs0: SUCCESS (0.511s) [541.455305] Starting dynamic subtest: ccs0 [541.960300] Dynamic subtest ccs0: SUCCESS (0.514s) [541.963253] Subtest semaphore-wait: SUCCESS (3.094s) [542.390444] [124/133] (486s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [542.449100] Starting subtest: wait-all-for-submit-delayed-submit [542.553069] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [542.635555] [125/133] (486s left) kms_lease (lease-invalid-plane) [542.740734] Starting subtest: lease-invalid-plane [542.742992] Starting dynamic subtest: pipe-A-eDP-1 [542.745133] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [542.754988] Starting dynamic subtest: pipe-B-eDP-1 [542.757235] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [542.768789] Starting dynamic subtest: pipe-C-eDP-1 [542.770639] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [542.780748] Starting dynamic subtest: pipe-D-eDP-1 [542.782628] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [542.784502] Subtest lease-invalid-plane: SUCCESS (0.004s) [542.822480] [126/133] (486s left) kms_psr (fbc-pr-primary-mmap-gtt) [542.916230] Starting subtest: fbc-pr-primary-mmap-gtt [542.920481] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [543.000446] [127/133] (486s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [543.097919] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [543.102073] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [543.195997] [128/133] (486s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [543.283015] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [543.285310] Starting dynamic subtest: pipe-A-eDP-1 [543.403868] Dynamic subtest pipe-A-eDP-1: SKIP (0.123s) [543.416112] Starting dynamic subtest: pipe-B-eDP-1 [544.597453] Dynamic subtest pipe-B-eDP-1: SKIP (1.191s) [544.602226] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.316s) [545.785423] [129/133] (483s left) kms_content_protection (suspend-resume) [545.933608] Starting subtest: suspend-resume [545.938312] Subtest suspend-resume: SKIP (0.000s) [546.062405] [130/133] (483s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [546.159155] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [546.161416] Starting dynamic subtest: pipe-A-default-mode [547.345666] Dynamic subtest pipe-A-default-mode: SKIP (1.184s) [547.350063] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.186s) [547.482465] [131/133] (482s left) kms_flip (2x-modeset-vs-vblank-race) [547.593916] Starting subtest: 2x-modeset-vs-vblank-race [547.603645] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s) [547.723738] [132/133] (481s left) perf_pmu (busy-accuracy-50) [547.761252] Starting subtest: busy-accuracy-50 [547.764822] Starting dynamic subtest: rcs0 [549.307277] Dynamic subtest rcs0: SUCCESS (1.530s) [549.317717] Starting dynamic subtest: bcs0 [550.835453] Dynamic subtest bcs0: SUCCESS (1.543s) [550.846046] Starting dynamic subtest: vcs0 [552.379679] Dynamic subtest vcs0: SUCCESS (1.541s) [552.391574] Starting dynamic subtest: vcs1 [553.925371] Dynamic subtest vcs1: SUCCESS (1.543s) [553.937968] Starting dynamic subtest: vecs0 [555.464091] Dynamic subtest vecs0: SUCCESS (1.536s) [555.476875] Starting dynamic subtest: ccs0 [557.011786] Dynamic subtest ccs0: SUCCESS (1.545s) [557.014231] Subtest busy-accuracy-50: SUCCESS (9.253s) [557.168292] [133/133] (472s left) syncobj_timeline (device-signal-unordered) [557.230700] Starting subtest: device-signal-unordered [557.232818] Subtest device-signal-unordered: SUCCESS (0.000s) [557.339419] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: kms_psr results: parsing output: 2/ for test: kms_plane_scaling results: parsing output: 3/ for test: gem_exec_whisper results: parsing output: 4/ for test: gem_exec_reloc results: parsing output: 5/ for test: gem_reg_read results: parsing output: 6/ for test: gem_fence_thrash results: parsing output: 7/ for test: gem_mmap_offset results: parsing output: 8/ for test: kms_plane_scaling results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_tiled_blits results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: gem_exercise_blt results: parsing output: 13/ for test: gem_exec_schedule results: parsing output: 14/ for test: kms_big_fb results: parsing output: 15/ for test: gem_mmap_gtt results: parsing output: 16/ for test: kms_psr results: parsing output: 17/ for test: kms_dsc results: parsing output: 18/ for test: kms_async_flips results: parsing output: 19/ for test: gem_ctx_persistence results: parsing output: 20/ for test: syncobj_timeline results: parsing output: 21/ for test: gem_exec_params results: parsing output: 22/ for test: kms_big_fb results: parsing output: 23/ for test: gem_mmap_gtt results: parsing output: 24/ for test: gem_flink_basic results: parsing output: 25/ for test: kms_ccs results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_pread results: parsing output: 28/ for test: kms_cursor_crc results: parsing output: 29/ for test: gem_sync results: parsing output: 30/ for test: gem_ctx_param results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_ccs results: parsing output: 33/ for test: gem_partial_pwrite_pread results: parsing output: 34/ for test: kms_fence_pin_leak results: parsing output: 35/ for test: syncobj_timeline results: parsing output: 36/ for test: kms_flip results: parsing output: 37/ for test: kms_ccs results: parsing output: 38/ for test: kms_panel_fitting results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: kms_flip results: parsing output: 41/ for test: kms_color results: parsing output: 42/ for test: gem_exec_parallel results: parsing output: 43/ for test: kms_flip results: parsing output: 44/ for test: gem_userptr_blits results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_tiled_display results: parsing output: 47/ for test: gem_exec_balancer results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_exec_params results: parsing output: 51/ for test: i915_suspend results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: gem_mmap_gtt results: parsing output: 54/ for test: kms_chamelium_frames results: parsing output: 55/ for test: perf results: parsing output: 56/ for test: gem_render_linear_blits results: parsing output: 57/ for test: i915_pm_rpm results: parsing output: 58/ for test: kms_pm_rpm results: parsing output: 59/ for test: perf_pmu results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: api_intel_allocator results: parsing output: 62/ for test: kms_prime results: parsing output: 63/ for test: i915_drm_fdinfo results: parsing output: 64/ for test: kms_chamelium_color results: parsing output: 65/ for test: gem_create results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_psr results: parsing output: 68/ for test: kms_plane results: parsing output: 69/ for test: gen9_exec_parse results: parsing output: 70/ for test: gem_exec_schedule results: parsing output: 71/ for test: syncobj_wait results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: gem_exec_reloc results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: syncobj_wait results: parsing output: 76/ for test: kms_flip results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: kms_flip results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_ccs results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: gem_softpin results: parsing output: 84/ for test: kms_plane_cursor results: parsing output: 85/ for test: kms_chamelium_hpd results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: gem_exec_balancer results: parsing output: 89/ for test: kms_flip results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: perf results: parsing output: 93/ for test: kms_getfb results: parsing output: 94/ for test: gem_userptr_blits results: parsing output: 95/ for test: i915_pm_freq_mult results: parsing output: 96/ for test: kms_cursor_crc results: parsing output: 97/ for test: gem_spin_batch results: parsing output: 98/ for test: kms_properties results: parsing output: 99/ for test: kms_vblank results: parsing output: 100/ for test: kms_display_modes results: parsing output: 101/ for test: kms_invalid_mode results: parsing output: 102/ for test: kms_prop_blob results: parsing output: 103/ for test: kms_busy results: parsing output: 104/ for test: api_intel_bb results: parsing output: 105/ for test: gem_exec_fence results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_render_copy results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_mmap_gtt results: parsing output: 110/ for test: kms_flip results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: gem_busy results: parsing output: 113/ for test: kms_plane results: parsing output: 114/ for test: kms_properties results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: dumb_buffer results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_async_flips results: parsing output: 119/ for test: gem_eio results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_cursor_edge_walk results: parsing output: 122/ for test: perf_pmu results: parsing output: 123/ for test: syncobj_timeline results: parsing output: 124/ for test: kms_lease results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_psr2_sf results: parsing output: 128/ for test: kms_content_protection results: parsing output: 129/ for test: kms_flip_scaled_crc results: parsing output: 130/ for test: kms_flip results: parsing output: 131/ for test: perf_pmu results: parsing output: 132/ for test: syncobj_timeline Done.