[57.284039] Initializing watchdogs [57.284089] /dev/watchdog0 [57.297807] [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] [57.301977] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.304131] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.308343] [001/132] (960s left) gem_exec_suspend (basic-s0) [57.392072] Starting subtest: basic-S0 [57.394366] Starting dynamic subtest: smem [77.199463] Dynamic subtest smem: SUCCESS (6.413s) [77.202829] Subtest basic-S0: SUCCESS (6.414s) [77.392536] [002/132] (940s left) kms_flip (2x-flip-vs-expired-vblank) [77.489801] Starting subtest: 2x-flip-vs-expired-vblank [77.500785] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s) [77.585203] [003/132] (940s left) kms_big_fb (4-tiled-16bpp-rotate-0) [77.688611] Starting subtest: 4-tiled-16bpp-rotate-0 [79.013748] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.289s) [79.136472] [004/132] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [79.239700] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [79.244460] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [79.338988] [005/132] (938s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [79.422440] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [79.427234] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s) [79.492226] [006/132] (938s left) kms_chamelium_edid (dp-edid-read) [79.881420] Subtest dp-edid-read: SKIP (0.000s) [80.772277] [007/132] (937s left) kms_prop_blob (blob-prop-lifetime) [80.941958] Starting subtest: blob-prop-lifetime [80.944899] Subtest blob-prop-lifetime: SUCCESS (0.002s) [81.102261] [008/132] (937s left) kms_flip (flip-vs-wf_vblank-interruptible) [81.220960] Starting subtest: flip-vs-wf_vblank-interruptible [81.223444] Starting dynamic subtest: A-eDP1 [83.171357] Dynamic subtest A-eDP1: SUCCESS (1.915s) [83.181697] Starting dynamic subtest: B-eDP1 [85.121603] Dynamic subtest B-eDP1: SUCCESS (1.923s) [85.129667] Starting dynamic subtest: C-eDP1 [87.055957] Dynamic subtest C-eDP1: SUCCESS (1.913s) [87.064221] Starting dynamic subtest: D-eDP1 [88.901971] Dynamic subtest D-eDP1: SUCCESS (1.828s) [88.904954] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.588s) [90.136725] [009/132] (928s left) kms_psr (pr-suspend) [90.238933] Starting subtest: pr-suspend [90.243949] Subtest pr-suspend: SKIP (0.000s) [90.315613] [010/132] (927s left) kms_vblank (ts-continuation-modeset) [90.418442] Starting subtest: ts-continuation-modeset [90.420746] Starting dynamic subtest: pipe-A-eDP-1 [91.911894] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.482s) [91.926406] Starting dynamic subtest: pipe-D-eDP-1 [94.095663] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.173s) [94.098090] Subtest ts-continuation-modeset: SUCCESS (3.658s) [94.891190] [011/132] (923s left) syncobj_wait (multi-wait-submitted-signaled) [94.949724] Starting subtest: multi-wait-submitted-signaled [94.952674] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [95.050413] [012/132] (923s left) kms_flip (2x-nonexisting-fb) [95.158333] Starting subtest: 2x-nonexisting-fb [95.169281] Subtest 2x-nonexisting-fb: SKIP (0.010s) [95.247087] [013/132] (923s left) kms_chamelium_hpd (common-hpd-after-suspend) [95.641719] Subtest common-hpd-after-suspend: SKIP (0.000s) [96.421903] [014/132] (921s left) kms_plane_alpha_blend (alpha-basic) [96.529901] Starting subtest: alpha-basic [96.819610] Starting dynamic subtest: pipe-A-eDP-1 [98.750966] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s) [98.772434] Starting dynamic subtest: pipe-D-eDP-1 [101.438205] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.663s) [101.440833] Subtest alpha-basic: SUCCESS (4.894s) [102.317506] [015/132] (916s left) kms_content_protection (atomic-dpms-hdcp14) [102.461702] Starting subtest: atomic-dpms-hdcp14 [102.466802] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [102.584573] [016/132] (915s left) kms_cursor_crc (cursor-offscreen-256x256) [102.833752] Starting subtest: cursor-offscreen-256x256 [102.839046] Starting dynamic subtest: pipe-A-eDP-1 [104.773264] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s) [104.799741] Starting dynamic subtest: pipe-D-eDP-1 [107.441417] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.648s) [107.443659] Subtest cursor-offscreen-256x256: SUCCESS (4.602s) [108.285306] [017/132] (910s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [108.374536] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [108.379404] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [108.449616] [018/132] (910s left) gem_ctx_isolation (dirty-create) [108.504061] Starting subtest: dirty-create [108.506726] Starting dynamic subtest: rcs0 [108.710654] Dynamic subtest rcs0: SUCCESS (0.206s) [108.718728] Starting dynamic subtest: bcs0 [108.915116] Dynamic subtest bcs0: SUCCESS (0.204s) [108.923208] Starting dynamic subtest: vcs0 [109.129664] Dynamic subtest vcs0: SUCCESS (0.214s) [109.137840] Starting dynamic subtest: vcs1 [110.405459] Dynamic subtest vcs1: SUCCESS (1.274s) [110.415951] Starting dynamic subtest: vecs0 [112.414944] Dynamic subtest vecs0: SUCCESS (2.008s) [112.425546] Starting dynamic subtest: ccs0 [114.419783] Dynamic subtest ccs0: SUCCESS (2.005s) [114.422176] Subtest dirty-create: SUCCESS (5.915s) [114.643512] [019/132] (903s left) syncobj_wait (wait-any-interrupted) [114.700945] Starting subtest: wait-any-interrupted [114.801338] Subtest wait-any-interrupted: SUCCESS (0.102s) [114.878395] [020/132] (903s left) api_intel_allocator (fork-simple-stress-signal) [114.932374] Starting subtest: fork-simple-stress-signal [120.335951] Subtest fork-simple-stress-signal: SUCCESS (5.402s) [120.458338] [021/132] (898s left) kms_psr (fbc-psr-primary-page-flip) [120.566533] Starting subtest: fbc-psr-primary-page-flip [120.569557] Starting dynamic subtest: eDP-1 [120.575301] Dynamic subtest eDP-1: SKIP (0.000s) [120.580780] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [120.645500] [022/132] (898s left) kms_psr (fbc-psr2-primary-render) [120.750370] Starting subtest: fbc-psr2-primary-render [120.752832] Starting dynamic subtest: eDP-1 [120.758053] Dynamic subtest eDP-1: SKIP (0.000s) [120.762957] Subtest fbc-psr2-primary-render: SKIP (0.001s) [120.821746] [023/132] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [120.934333] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [128.418929] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.488s) [128.542738] [024/132] (890s left) kms_plane_multiple (tiling-yf) [128.632695] Starting subtest: tiling-yf [128.637943] Subtest tiling-yf: SKIP (0.000s) [128.707848] [025/132] (890s left) kms_addfb_basic (addfb25-y-tiled-legacy) [128.796995] Starting subtest: addfb25-y-tiled-legacy [128.799486] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [128.879793] [026/132] (889s left) i915_pm_rc6_residency (rc6-accuracy) [128.939828] Starting subtest: rc6-accuracy [128.942390] Starting dynamic subtest: gt0 [132.111122] Dynamic subtest gt0: SUCCESS (3.168s) [132.122246] Starting dynamic subtest: gt1 [135.282488] Dynamic subtest gt1: SUCCESS (3.168s) [135.285566] Subtest rc6-accuracy: SUCCESS (6.339s) [135.359715] [027/132] (883s left) syncobj_eventfd (binary-wait-before-signal) [135.414794] Starting subtest: binary-wait-before-signal [135.443434] Subtest binary-wait-before-signal: SUCCESS (0.030s) [135.515933] [028/132] (883s left) syncobj_basic (bad-handle-to-fd) [135.567654] Starting subtest: bad-handle-to-fd [135.570388] Subtest bad-handle-to-fd: SUCCESS (0.000s) [135.662694] [029/132] (883s left) gem_exec_balancer (invalid-bonds) [135.728334] Starting subtest: invalid-bonds [135.733780] Subtest invalid-bonds: SKIP (0.000s) [136.038984] [030/132] (882s left) gem_userptr_blits (mmap-offset-banned) [136.116952] Starting subtest: mmap-offset-banned [136.119928] Starting dynamic subtest: wb [136.122948] Dynamic subtest wb: SUCCESS (0.000s) [136.132946] Starting dynamic subtest: wc [136.135274] Dynamic subtest wc: SUCCESS (0.000s) [136.142743] Starting dynamic subtest: uc [136.145286] Dynamic subtest uc: SUCCESS (0.000s) [136.147415] Subtest mmap-offset-banned: SUCCESS (0.001s) [136.236019] [031/132] (882s left) gem_exec_reloc (basic-write-cpu) [136.296559] Subtest basic-write-cpu: SKIP (0.000s) [136.363289] [032/132] (882s left) kms_addfb_basic (too-high) [136.456933] Starting subtest: too-high [136.459686] Subtest too-high: SUCCESS (0.000s) [136.581747] [033/132] (882s left) perf (non-system-wide-paranoid) [136.716025] Starting subtest: non-system-wide-paranoid [136.751943] Subtest non-system-wide-paranoid: SUCCESS (0.036s) [136.800475] [034/132] (882s left) kms_chamelium_color (ctm-0-50) [136.890630] Subtest ctm-0-50: SKIP (0.000s) [136.935627] [035/132] (882s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [137.023603] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [137.027894] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [137.116122] [036/132] (882s left) tools_test (tools_test) [137.166955] Starting subtest: tools_test [137.212832] Subtest tools_test: SUCCESS (0.061s) [137.278409] [037/132] (882s left) gem_ctx_exec (basic-close-race) [137.337746] Starting subtest: basic-close-race [143.236855] Subtest basic-close-race: SUCCESS (5.895s) [143.370344] [038/132] (875s left) perf (invalid-oa-format-id) [143.464684] Starting subtest: invalid-oa-format-id [143.475046] Subtest invalid-oa-format-id: SUCCESS (0.008s) [143.517325] [039/132] (875s left) kms_pm_rpm (basic-pci-d3-state) [145.352857] Starting subtest: basic-pci-d3-state [146.832671] Subtest basic-pci-d3-state: SUCCESS (1.479s) [146.934786] [040/132] (872s left) kms_psr (psr-primary-mmap-gtt) [147.057786] Starting subtest: psr-primary-mmap-gtt [147.060476] Starting dynamic subtest: eDP-1 [148.590857] Dynamic subtest eDP-1: SKIP (1.527s) [148.596842] Subtest psr-primary-mmap-gtt: SKIP (1.529s) [148.722455] [041/132] (870s left) gem_mmap_gtt (cpuset-big-copy) [148.777376] Subtest cpuset-big-copy: SKIP (0.000s) [148.830024] [042/132] (870s left) gem_mmap_gtt (zero-extend) [148.893693] Subtest zero-extend: SKIP (0.000s) [148.942977] [043/132] (870s left) kms_frontbuffer_tracking (psr-suspend) [149.054637] Starting subtest: psr-suspend [186.882798] Subtest psr-suspend: SUCCESS (7.917s) [186.979771] [044/132] (832s left) kms_debugfs (display-off-read-all) [187.078212] Starting subtest: display-off-read-all [187.362196] Subtest display-off-read-all: SUCCESS (0.286s) [188.203892] [045/132] (831s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [188.319364] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [188.323933] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [188.414014] [046/132] (831s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [188.514045] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [195.467846] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.956s) [195.568478] [047/132] (824s left) gem_exec_fence (long-history) [196.038594] Starting subtest: long-history [202.921748] Subtest long-history: SUCCESS (6.880s) [203.542027] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true [203.545132] [048/132] (816s left) gem_ringfill (engines-basic) [209.128807] Starting subtest: engines-basic [209.131150] Starting dynamic subtest: rcs0 [209.194442] Dynamic subtest rcs0: SUCCESS (0.066s) [209.204968] Starting dynamic subtest: bcs0 [209.238879] Dynamic subtest bcs0: SUCCESS (0.043s) [209.248547] Starting dynamic subtest: vcs0 [209.280800] Dynamic subtest vcs0: SUCCESS (0.041s) [209.290474] Starting dynamic subtest: vcs1 [209.324281] Dynamic subtest vcs1: SUCCESS (0.042s) [209.333662] Starting dynamic subtest: vecs0 [209.364619] Dynamic subtest vecs0: SUCCESS (0.040s) [209.376890] Starting dynamic subtest: ccs0 [209.416135] Dynamic subtest ccs0: SUCCESS (0.048s) [209.418611] Subtest engines-basic: SUCCESS (0.290s) [209.500891] [049/132] (810s left) gem_exec_schedule (pi-common) [209.687268] Starting subtest: pi-common [209.689704] Starting dynamic subtest: rcs0 [209.716038] Dynamic subtest rcs0: SUCCESS (0.033s) [209.724945] Starting dynamic subtest: bcs0 [209.747875] Dynamic subtest bcs0: SUCCESS (0.031s) [209.756812] Starting dynamic subtest: vcs0 [209.779037] Dynamic subtest vcs0: SUCCESS (0.031s) [209.787714] Starting dynamic subtest: vcs1 [209.809382] Dynamic subtest vcs1: SUCCESS (0.029s) [209.817608] Starting dynamic subtest: vecs0 [209.840349] Dynamic subtest vecs0: SUCCESS (0.030s) [209.852567] Starting dynamic subtest: ccs0 [209.868907] Dynamic subtest ccs0: SUCCESS (0.029s) [209.871153] Subtest pi-common: SUCCESS (0.186s) [210.104198] [050/132] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [210.199094] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [210.203483] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [210.294232] [051/132] (809s left) kms_vrr (negative-basic) [210.378673] Starting subtest: negative-basic [210.385235] Starting dynamic subtest: pipe-A-eDP-1 [216.292945] Dynamic subtest pipe-A-eDP-1: FAIL (5.433s) [216.294651] Subtest negative-basic: FAIL (5.739s) [216.974997] [052/132] (802s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [217.081278] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [217.083481] Starting dynamic subtest: pipe-A-eDP-1 [217.164252] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s) [217.172992] Starting dynamic subtest: pipe-B-eDP-1 [218.365882] Dynamic subtest pipe-B-eDP-1: SKIP (1.178s) [218.370311] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.270s) [219.593246] [053/132] (800s left) dmabuf_sync_file (import-multiple-read-only) [219.634959] Starting subtest: import-multiple-read-only [219.637355] Subtest import-multiple-read-only: SUCCESS (0.003s) [219.695383] [054/132] (800s left) i915_pm_freq_api (freq-reset-multiple) [219.749255] Starting subtest: freq-reset-multiple [219.751605] Starting dynamic subtest: gt0 [229.486990] Dynamic subtest gt0: SUCCESS (9.572s) [229.500856] Starting dynamic subtest: gt1 [237.783676] Dynamic subtest gt1: SUCCESS (8.250s) [237.786462] Subtest freq-reset-multiple: SUCCESS (17.824s) [237.859885] [055/132] (782s left) prime_busy (before-wait) [237.910084] Starting subtest: before-wait [237.915084] Starting dynamic subtest: rcs0 [237.943452] Dynamic subtest rcs0: SUCCESS (0.030s) [237.957316] Starting dynamic subtest: bcs0 [237.995917] Dynamic subtest bcs0: SUCCESS (0.052s) [238.005571] Starting dynamic subtest: vcs0 [238.040018] Dynamic subtest vcs0: SUCCESS (0.043s) [238.049450] Starting dynamic subtest: vcs1 [238.082757] Dynamic subtest vcs1: SUCCESS (0.042s) [238.092236] Starting dynamic subtest: vecs0 [238.125662] Dynamic subtest vecs0: SUCCESS (0.042s) [238.135095] Starting dynamic subtest: ccs0 [238.169316] Dynamic subtest ccs0: SUCCESS (0.043s) [238.278058] Subtest before-wait: SUCCESS (0.365s) [238.360879] [056/132] (781s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [238.471573] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [238.475904] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [238.556593] [057/132] (781s left) api_intel_bb (object-reloc-purge-cache) [238.615603] Starting subtest: object-reloc-purge-cache [238.620045] Subtest object-reloc-purge-cache: SKIP (0.003s) [238.730208] [058/132] (781s left) gem_partial_pwrite_pread (write) [238.784194] Subtest write: SKIP (0.000s) [238.851580] [059/132] (781s left) kms_big_fb (y-tiled-16bpp-rotate-90) [238.949078] Starting subtest: y-tiled-16bpp-rotate-90 [238.953375] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [239.039287] [060/132] (781s left) gem_mmap_wc (write-prefaulted) [239.098911] Subtest write-prefaulted: SKIP (0.000s) [239.153669] [061/132] (781s left) gem_exec_balancer (waits) [239.218764] Starting subtest: waits [245.681585] Subtest waits: SUCCESS (6.451s) [245.963367] [062/132] (774s left) gem_ctx_persistence (heartbeat-hostile) [246.031118] Starting subtest: heartbeat-hostile [246.035971] Subtest heartbeat-hostile: SKIP (0.000s) [246.142656] [063/132] (774s left) kms_setmode (invalid-clone-single-crtc) [246.194103] Starting subtest: invalid-clone-single-crtc [246.200564] Subtest invalid-clone-single-crtc: SKIP (0.000s) [246.284555] [064/132] (774s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [246.383033] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [246.387450] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [246.484545] [065/132] (773s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [246.539457] Starting subtest: x-tiled-to-vebox-y-tiled [246.543986] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [246.725886] [066/132] (773s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [246.820291] Starting subtest: fbc-1p-pri-indfb-multidraw [259.642068] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.819s) [261.049828] [067/132] (759s left) kms_cursor_crc (cursor-rapid-movement-max-size) [261.357571] Starting subtest: cursor-rapid-movement-max-size [261.364614] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [261.489978] [068/132] (759s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [261.589408] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [268.321989] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.733s) [268.455808] [069/132] (752s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [268.576003] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [269.565166] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.989s) [269.676788] [070/132] (750s left) perf (short-reads) [269.771924] Starting subtest: short-reads [269.785912] Subtest short-reads: SUCCESS (0.015s) [269.830426] [071/132] (750s left) gem_exec_schedule (thriceslice) [269.897903] Starting subtest: thriceslice [269.899696] Starting dynamic subtest: rcs0 [269.918771] Dynamic subtest rcs0: SUCCESS (0.029s) [269.928283] Starting dynamic subtest: bcs0 [269.946852] Dynamic subtest bcs0: SUCCESS (0.028s) [269.955029] Starting dynamic subtest: vcs0 [269.997999] Dynamic subtest vcs0: SUCCESS (0.050s) [270.008835] Starting dynamic subtest: vcs1 [270.027759] Dynamic subtest vcs1: SUCCESS (0.029s) [270.036032] Starting dynamic subtest: vecs0 [270.057457] Dynamic subtest vecs0: SUCCESS (0.029s) [270.065624] Starting dynamic subtest: ccs0 [270.087706] Dynamic subtest ccs0: SUCCESS (0.029s) [270.089736] Subtest thriceslice: SUCCESS (0.199s) [270.401155] [072/132] (750s left) i915_pm_rps (thresholds-park) [270.451741] Starting subtest: thresholds-park [270.456464] Subtest thresholds-park: SKIP (0.000s) [270.554318] [073/132] (750s left) syncobj_timeline (single-wait-for-submit-available-submitted) [270.618747] Starting subtest: single-wait-for-submit-available-submitted [270.621101] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [270.716404] [074/132] (750s left) gem_mmap_wc (write-read) [270.769420] Subtest write-read: SKIP (0.000s) [270.841847] [075/132] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [270.937196] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [270.941372] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [271.030840] [076/132] (749s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [271.125806] Starting subtest: plane-upscale-20x20-with-pixel-format [271.128111] Starting dynamic subtest: pipe-A [272.176202] Dynamic subtest pipe-A: SUCCESS (1.050s) [272.185197] Starting dynamic subtest: pipe-B [274.270511] Dynamic subtest pipe-B: SUCCESS (2.095s) [274.278994] Starting dynamic subtest: pipe-C [275.473261] Dynamic subtest pipe-C: SUCCESS (1.201s) [275.483450] Starting dynamic subtest: pipe-D [276.704764] Dynamic subtest pipe-D: SUCCESS (1.231s) [276.707056] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.580s) [277.893030] [077/132] (743s left) gem_userptr_blits (map-fixed-invalidate-busy) [277.960450] Starting subtest: map-fixed-invalidate-busy [277.964947] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [278.080046] [078/132] (742s left) gem_mmap_gtt (basic-small-bo-tiledx) [278.150165] Subtest basic-small-bo-tiledX: SKIP (0.000s) [278.229382] [079/132] (742s left) gem_exec_flush (basic-wb-ro-before-default) [278.289093] Starting subtest: basic-wb-ro-before-default [283.766293] Subtest basic-wb-ro-before-default: SUCCESS (5.475s) [283.954749] [080/132] (737s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [284.058482] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [284.062975] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [284.127785] [081/132] (736s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [284.245505] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [284.249933] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [284.353885] [082/132] (736s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [284.441652] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [288.520531] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.080s) [289.706531] [083/132] (731s left) kms_flip (wf_vblank-ts-check-interruptible) [289.795823] Starting subtest: wf_vblank-ts-check-interruptible [289.798179] Starting dynamic subtest: A-eDP1 [298.667356] Dynamic subtest A-eDP1: SUCCESS (8.866s) [298.679299] Starting dynamic subtest: B-eDP1 [307.605842] Dynamic subtest B-eDP1: SUCCESS (8.933s) [307.614761] Starting dynamic subtest: C-eDP1 [316.528608] Dynamic subtest C-eDP1: SUCCESS (8.919s) [316.540033] Starting dynamic subtest: D-eDP1 [325.461339] Dynamic subtest D-eDP1: SUCCESS (8.933s) [325.463535] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.662s) [326.682694] [084/132] (694s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [326.782042] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [326.784368] Starting dynamic subtest: pipe-A-eDP-1 [326.841788] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [326.852988] Starting dynamic subtest: pipe-B-eDP-1 [326.908641] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [326.919050] Starting dynamic subtest: pipe-C-eDP-1 [326.975174] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [326.984933] Starting dynamic subtest: pipe-D-eDP-1 [327.041470] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s) [327.045674] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.010s) [329.069890] [085/132] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [329.165367] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [329.169740] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [329.256227] [086/132] (692s left) kms_flip (absolute-wf_vblank-interruptible) [329.342810] Starting subtest: absolute-wf_vblank-interruptible [329.344955] Starting dynamic subtest: A-eDP1 [338.017841] Dynamic subtest A-eDP1: SUCCESS (8.675s) [338.031669] Starting dynamic subtest: B-eDP1 [346.757764] Dynamic subtest B-eDP1: SUCCESS (8.737s) [346.770028] Starting dynamic subtest: C-eDP1 [355.470044] Dynamic subtest C-eDP1: SUCCESS (8.709s) [355.482131] Starting dynamic subtest: D-eDP1 [364.195204] Dynamic subtest D-eDP1: SUCCESS (8.722s) [364.200172] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.855s) [365.417230] [087/132] (655s left) gem_lmem_swapping (heavy-verify-random) [365.463589] Subtest heavy-verify-random: SKIP (0.000s) [365.510540] [088/132] (655s left) perf_pmu (interrupts) [365.551444] Starting subtest: interrupts [366.628919] Subtest interrupts: SUCCESS (1.078s) [366.752543] [089/132] (654s left) kms_psr (psr2-cursor-render) [366.843677] Starting subtest: psr2-cursor-render [366.845970] Starting dynamic subtest: eDP-1 [368.607970] Dynamic subtest eDP-1: SUCCESS (1.764s) [368.610249] Subtest psr2-cursor-render: SUCCESS (1.765s) [369.490376] [090/132] (651s left) syncobj_wait (multi-wait-all-signaled) [369.553341] Starting subtest: multi-wait-all-signaled [369.555639] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [369.653092] [091/132] (651s left) gem_render_copy (y-tiled) [369.711534] Starting subtest: y-tiled [369.716105] Subtest y-tiled: SKIP (0.000s) [369.896611] [092/132] (651s left) kms_big_fb (x-tiled-32bpp-rotate-270) [369.995927] Starting subtest: x-tiled-32bpp-rotate-270 [370.015905] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s) [370.127396] [093/132] (651s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [370.222828] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [370.226783] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [370.323795] [094/132] (651s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [370.426537] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [370.428807] Starting dynamic subtest: pipe-A-eDP-1 [370.450479] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [370.460793] Starting dynamic subtest: pipe-B-eDP-1 [370.480757] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [370.488901] Starting dynamic subtest: pipe-C-eDP-1 [370.509348] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [370.517471] Starting dynamic subtest: pipe-D-eDP-1 [370.538876] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [370.543219] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s) [372.748213] [095/132] (648s left) sysfs_defaults (readonly) [372.800300] Starting subtest: readonly [372.802543] Starting dynamic subtest: vecs0 [372.804835] Dynamic subtest vecs0: SUCCESS (0.000s) [372.815216] Starting dynamic subtest: ccs0 [372.817082] Dynamic subtest ccs0: SUCCESS (0.000s) [372.825819] Starting dynamic subtest: vcs0 [372.827668] Dynamic subtest vcs0: SUCCESS (0.000s) [372.836017] Starting dynamic subtest: bcs0 [372.837934] Dynamic subtest bcs0: SUCCESS (0.000s) [372.846416] Starting dynamic subtest: rcs0 [372.848506] Dynamic subtest rcs0: SUCCESS (0.000s) [372.857263] Starting dynamic subtest: vcs1 [372.859408] Dynamic subtest vcs1: SUCCESS (0.000s) [372.861209] Subtest readonly: SUCCESS (0.006s) [372.905124] [096/132] (648s left) kms_plane (plane-position-hole) [372.993006] Starting subtest: plane-position-hole [373.493467] Starting dynamic subtest: pipe-A-plane-1 [374.848674] Dynamic subtest pipe-A-plane-1: SUCCESS (1.355s) [374.858219] Starting dynamic subtest: pipe-A-plane-2 [376.167129] Dynamic subtest pipe-A-plane-2: SUCCESS (1.317s) [376.176277] Starting dynamic subtest: pipe-A-plane-3 [377.513828] Dynamic subtest pipe-A-plane-3: SUCCESS (1.345s) [377.526277] Starting dynamic subtest: pipe-A-plane-4 [378.819986] Dynamic subtest pipe-A-plane-4: SUCCESS (1.304s) [378.830188] Starting dynamic subtest: pipe-A-plane-5 [378.842202] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [379.976126] Starting dynamic subtest: pipe-B-plane-1 [381.258552] Dynamic subtest pipe-B-plane-1: SUCCESS (1.289s) [381.269297] Starting dynamic subtest: pipe-B-plane-2 [382.528438] Dynamic subtest pipe-B-plane-2: SUCCESS (1.271s) [382.537499] Starting dynamic subtest: pipe-B-plane-3 [383.802943] Dynamic subtest pipe-B-plane-3: SUCCESS (1.273s) [383.814934] Starting dynamic subtest: pipe-B-plane-4 [385.098919] Dynamic subtest pipe-B-plane-4: SUCCESS (1.295s) [385.107993] Starting dynamic subtest: pipe-B-plane-5 [385.127530] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s) [385.129912] Subtest plane-position-hole: SUCCESS (12.132s) [385.893420] [097/132] (635s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [386.006024] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [386.010350] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [386.102829] [098/132] (635s left) sw_sync (sync_merge_invalid) [386.142846] Starting subtest: sync_merge_invalid [386.155206] Subtest sync_merge_invalid: SUCCESS (0.015s) [386.234234] [099/132] (635s left) gem_gtt_cpu_tlb [386.346947] [100/132] (635s left) gem_softpin (allocator-evict) [386.405339] Starting subtest: allocator-evict [386.407452] Starting dynamic subtest: rcs0 [410.134267] Dynamic subtest rcs0: SUCCESS (23.721s) [410.143485] Starting dynamic subtest: bcs0 [434.291578] Dynamic subtest bcs0: SUCCESS (24.148s) [434.303759] Starting dynamic subtest: vcs0 [457.823103] Dynamic subtest vcs0: SUCCESS (23.532s) [457.835949] Starting dynamic subtest: vcs1 [481.462009] Dynamic subtest vcs1: SUCCESS (23.638s) [481.475236] Starting dynamic subtest: vecs0 [505.158886] Dynamic subtest vecs0: SUCCESS (23.698s) [505.169000] Starting dynamic subtest: ccs0 [529.399631] Dynamic subtest ccs0: SUCCESS (24.238s) [529.402204] Subtest allocator-evict: SUCCESS (142.984s) [529.486225] [101/132] (492s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [529.628903] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [529.631239] Starting dynamic subtest: pipe-A-eDP-1 [529.651891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [529.661541] Starting dynamic subtest: pipe-B-eDP-1 [529.681211] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [529.689895] Starting dynamic subtest: pipe-C-eDP-1 [529.709022] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [529.717726] Starting dynamic subtest: pipe-D-eDP-1 [529.736876] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [529.739059] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [531.967428] [102/132] (489s left) gem_eio (in-flight-immediate) [532.198706] Starting subtest: in-flight-immediate [540.972321] Subtest in-flight-immediate: SUCCESS (8.771s) [541.089046] [103/132] (480s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [541.153389] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [541.155858] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [541.237335] [104/132] (480s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [541.326031] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [541.328380] Starting dynamic subtest: pipe-A-default-mode [544.073423] Dynamic subtest pipe-A-default-mode: SUCCESS (2.746s) [544.075938] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.748s) [544.947046] [105/132] (477s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [545.054965] Starting subtest: psr2-plane-move-sf-dmg-area [545.057373] Starting dynamic subtest: pipe-A-eDP-1 [549.593088] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.540s) [549.603586] Starting dynamic subtest: pipe-B-eDP-1 [554.922383] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.329s) [554.924770] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.872s) [555.782262] [106/132] (466s left) kms_big_fb (linear-64bpp-rotate-270) [555.894311] Starting subtest: linear-64bpp-rotate-270 [555.914003] Subtest linear-64bpp-rotate-270: SKIP (0.019s) [556.027640] [107/132] (466s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [556.118430] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [556.120564] Starting dynamic subtest: pipe-A-eDP-1 [557.009393] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.885s) [557.019145] Starting dynamic subtest: pipe-B-eDP-1 [558.536930] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.524s) [558.547606] Starting dynamic subtest: pipe-C-eDP-1 [560.000864] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.460s) [560.011548] Starting dynamic subtest: pipe-D-eDP-1 [561.497444] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.497s) [561.499390] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.371s) [562.639796] [108/132] (459s left) sw_sync (alloc_merge_fence) [562.685355] Starting subtest: alloc_merge_fence [562.687532] Subtest alloc_merge_fence: SUCCESS (0.000s) [562.741536] [109/132] (459s left) i915_drm_fdinfo (most-busy-idle-check-all) [562.789940] Starting subtest: most-busy-idle-check-all [562.792380] Starting dynamic subtest: rcs0 [562.797094] Dynamic subtest rcs0: SKIP (0.004s) [562.811264] Starting dynamic subtest: bcs0 [562.815358] Dynamic subtest bcs0: SKIP (0.000s) [562.824851] Starting dynamic subtest: vcs0 [562.828867] Dynamic subtest vcs0: SKIP (0.000s) [562.837528] Starting dynamic subtest: vcs1 [562.841392] Dynamic subtest vcs1: SKIP (0.000s) [562.849983] Starting dynamic subtest: vecs0 [562.853832] Dynamic subtest vecs0: SKIP (0.000s) [562.862531] Starting dynamic subtest: ccs0 [562.866693] Dynamic subtest ccs0: SKIP (0.000s) [562.870830] Subtest most-busy-idle-check-all: SKIP (0.009s) [562.908178] [110/132] (459s left) kms_invalid_mode (zero-vdisplay) [563.037244] Starting subtest: zero-vdisplay [563.039567] Starting dynamic subtest: pipe-A-eDP-1 [563.324821] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [563.334963] Starting dynamic subtest: pipe-B-eDP-1 [563.336910] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [563.346431] Starting dynamic subtest: pipe-C-eDP-1 [563.348810] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [563.359598] Starting dynamic subtest: pipe-D-eDP-1 [563.361999] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [563.364357] Subtest zero-vdisplay: SUCCESS (0.295s) [564.176131] [111/132] (458s left) kms_frontbuffer_tracking (fbc-tiling-y) [564.265497] Starting subtest: fbc-tiling-y [564.270004] Subtest fbc-tiling-y: SKIP (0.000s) [564.356887] [112/132] (458s left) kms_pm_rpm (fences-dpms) [566.314991] Starting subtest: fences-dpms [566.319959] Subtest fences-dpms: SKIP (0.000s) [566.688561] [113/132] (455s left) kms_cursor_edge_walk (64x64-top-edge) [566.783100] Starting subtest: 64x64-top-edge [566.785515] Starting dynamic subtest: pipe-A-eDP-1 [570.239751] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.456s) [570.254964] Starting dynamic subtest: pipe-D-eDP-1 [573.371456] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s) [573.373381] Subtest 64x64-top-edge: SUCCESS (6.588s) [574.159472] [114/132] (448s left) gem_exec_params (rs-invalid) [574.223082] Starting subtest: rs-invalid [574.228401] Subtest rs-invalid: SUCCESS (0.003s) [574.340509] [115/132] (448s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [574.440479] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [578.824585] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.388s) [579.960974] [116/132] (442s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled) [580.016949] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [580.019335] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [580.109470] [117/132] (442s left) kms_lease (empty-lease) [580.204018] Starting subtest: empty-lease [580.206410] Starting dynamic subtest: pipe-A-eDP-1 [580.209125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [580.219802] Starting dynamic subtest: pipe-B-eDP-1 [580.222231] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [580.232218] Starting dynamic subtest: pipe-C-eDP-1 [580.234387] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [580.243355] Starting dynamic subtest: pipe-D-eDP-1 [580.245607] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [580.247878] Subtest empty-lease: SUCCESS (0.009s) [580.345939] [118/132] (442s left) vgem_slow (nohang) [580.392833] Starting subtest: nohang [590.659796] Subtest nohang: SUCCESS (10.264s) [590.726172] [119/132] (431s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [590.784512] Starting subtest: etime-single-wait-available-unsubmitted [590.890353] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.103s) [590.971638] [120/132] (431s left) gen9_exec_parse (allowed-all) [591.041286] Subtest allowed-all: SKIP (0.000s) [591.117545] [121/132] (431s left) perf_pmu (init-wait) [591.158620] Starting subtest: init-wait [591.161113] Starting dynamic subtest: rcs0 [591.163412] Dynamic subtest rcs0: SUCCESS (0.002s) [591.176427] Starting dynamic subtest: bcs0 [591.178782] Dynamic subtest bcs0: SUCCESS (0.000s) [591.187855] Starting dynamic subtest: vcs0 [591.190067] Dynamic subtest vcs0: SUCCESS (0.001s) [591.200351] Starting dynamic subtest: vcs1 [591.202298] Dynamic subtest vcs1: SUCCESS (0.001s) [591.212060] Starting dynamic subtest: vecs0 [591.214342] Dynamic subtest vecs0: SUCCESS (0.001s) [591.223755] Starting dynamic subtest: ccs0 [591.225554] Dynamic subtest ccs0: SUCCESS (0.000s) [591.227444] Subtest init-wait: SUCCESS (0.008s) [591.273796] [122/132] (431s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [591.330694] Starting subtest: y-tiled-ccs-to-y-tiled [591.335436] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [591.533984] [123/132] (431s left) gem_ccs (block-multicopy-inplace) [591.593541] Starting subtest: block-multicopy-inplace [591.598200] Subtest block-multicopy-inplace: SKIP (0.000s) [591.700776] [124/132] (431s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [591.798777] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [592.623152] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s) [592.771162] [125/132] (430s left) kms_sequence (get-forked-busy) [592.867659] Starting subtest: get-forked-busy [592.870021] Starting dynamic subtest: pipe-A-eDP-1 [594.809226] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s) [594.823198] Starting dynamic subtest: pipe-B-eDP-1 [597.466193] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.653s) [597.477326] Starting dynamic subtest: pipe-C-eDP-1 [600.069479] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.603s) [600.080757] Starting dynamic subtest: pipe-D-eDP-1 [602.708888] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.637s) [602.711206] Subtest get-forked-busy: SUCCESS (9.841s) [603.513791] [126/132] (419s left) gem_exec_create (basic) [603.578026] Starting subtest: basic [603.580464] Starting dynamic subtest: smem [607.077518] Dynamic subtest smem: SUCCESS (3.496s) [607.080684] Subtest basic: SUCCESS (3.498s) [607.263500] [127/132] (415s left) kms_feature_discovery (chamelium) [607.357313] Starting subtest: chamelium [607.362108] Subtest chamelium: SKIP (0.000s) [607.442084] [128/132] (415s left) kms_frontbuffer_tracking (fbc-suspend) [607.532755] Starting subtest: fbc-suspend [644.917314] Subtest fbc-suspend: SUCCESS (7.434s) [646.130174] [129/132] (376s left) kms_addfb_basic (basic) [646.187555] Starting subtest: basic [646.189736] Subtest basic: SUCCESS (0.000s) [646.360457] [130/132] (376s left) gem_exec_params (no-blt) [646.424590] Starting subtest: no-blt [646.427342] Subtest no-blt: SUCCESS (0.003s) [646.553805] [131/132] (376s left) kms_color (invalid-gamma-lut-sizes) [646.637220] Starting subtest: invalid-gamma-lut-sizes [646.639581] Starting dynamic subtest: pipe-A [646.936389] Dynamic subtest pipe-A: SUCCESS (0.291s) [646.952546] Starting dynamic subtest: pipe-B [646.955594] Dynamic subtest pipe-B: SUCCESS (0.000s) [646.967591] Starting dynamic subtest: pipe-C [646.970600] Dynamic subtest pipe-C: SUCCESS (0.000s) [646.980587] Starting dynamic subtest: pipe-D [646.983594] Dynamic subtest pipe-D: SUCCESS (0.000s) [646.986406] Subtest invalid-gamma-lut-sizes: SUCCESS (0.295s) [647.809346] [132/132] (375s left) gem_ctx_shared (exec-single-timeline) [647.865585] Starting subtest: exec-single-timeline [647.868444] Starting dynamic subtest: rcs0 [648.909087] Dynamic subtest rcs0: SUCCESS (1.023s) [648.920728] Starting dynamic subtest: bcs0 [649.995933] Dynamic subtest bcs0: SUCCESS (1.066s) [650.008261] Starting dynamic subtest: vcs0 [651.084282] Dynamic subtest vcs0: SUCCESS (1.070s) [651.103565] Starting dynamic subtest: vcs1 [652.172984] Dynamic subtest vcs1: SUCCESS (1.072s) [652.187246] Starting dynamic subtest: vecs0 [653.260764] Dynamic subtest vecs0: SUCCESS (1.073s) [653.278002] Starting dynamic subtest: ccs0 [654.347902] Dynamic subtest ccs0: SUCCESS (1.074s) [654.351414] Subtest exec-single-timeline: SUCCESS (6.397s) [655.028694] Closing watchdogs results: parsing output: 0/ for test: gem_exec_suspend results: parsing output: 1/ for test: kms_flip results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_flip_scaled_crc results: parsing output: 5/ for test: kms_chamelium_edid results: parsing output: 6/ for test: kms_prop_blob results: parsing output: 7/ for test: kms_flip results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: kms_vblank results: parsing output: 10/ for test: syncobj_wait results: parsing output: 11/ for test: kms_flip results: parsing output: 12/ for test: kms_chamelium_hpd results: parsing output: 13/ for test: kms_plane_alpha_blend results: parsing output: 14/ for test: kms_content_protection results: parsing output: 15/ for test: kms_cursor_crc results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: gem_ctx_isolation results: parsing output: 18/ for test: syncobj_wait results: parsing output: 19/ for test: api_intel_allocator results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: kms_psr results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_plane_multiple results: parsing output: 24/ for test: kms_addfb_basic results: parsing output: 25/ for test: i915_pm_rc6_residency results: parsing output: 26/ for test: syncobj_eventfd results: parsing output: 27/ for test: syncobj_basic results: parsing output: 28/ for test: gem_exec_balancer results: parsing output: 29/ for test: gem_userptr_blits results: parsing output: 30/ for test: gem_exec_reloc results: parsing output: 31/ for test: kms_addfb_basic results: parsing output: 32/ for test: perf results: parsing output: 33/ for test: kms_chamelium_color results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: tools_test results: parsing output: 36/ for test: gem_ctx_exec results: parsing output: 37/ for test: perf results: parsing output: 38/ for test: kms_pm_rpm results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: gem_mmap_gtt results: parsing output: 41/ for test: gem_mmap_gtt results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_debugfs results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_exec_fence results: parsing output: 47/ for test: gem_ringfill results: parsing output: 48/ for test: gem_exec_schedule results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_vrr results: parsing output: 51/ for test: kms_psr2_sf results: parsing output: 52/ for test: dmabuf_sync_file results: parsing output: 53/ for test: i915_pm_freq_api results: parsing output: 54/ for test: prime_busy results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: api_intel_bb results: parsing output: 57/ for test: gem_partial_pwrite_pread results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: gem_mmap_wc results: parsing output: 60/ for test: gem_exec_balancer results: parsing output: 61/ for test: gem_ctx_persistence results: parsing output: 62/ for test: kms_setmode results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_render_copy results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_cursor_crc results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_big_fb results: parsing output: 69/ for test: perf results: parsing output: 70/ for test: gem_exec_schedule results: parsing output: 71/ for test: i915_pm_rps results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: gem_mmap_wc results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_plane_scaling results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: gem_mmap_gtt results: parsing output: 78/ for test: gem_exec_flush results: parsing output: 79/ for test: kms_plane results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_flip results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_flip results: parsing output: 86/ for test: gem_lmem_swapping results: parsing output: 87/ for test: perf_pmu results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: syncobj_wait results: parsing output: 90/ for test: gem_render_copy results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: sysfs_defaults results: parsing output: 95/ for test: kms_plane results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: sw_sync results: parsing output: 98/ for test: gem_gtt_cpu_tlb results: parsing output: 99/ for test: gem_softpin results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: gem_eio results: parsing output: 102/ for test: syncobj_timeline results: parsing output: 103/ for test: kms_flip_scaled_crc results: parsing output: 104/ for test: kms_psr2_sf results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_ccs results: parsing output: 107/ for test: sw_sync results: parsing output: 108/ for test: i915_drm_fdinfo results: parsing output: 109/ for test: kms_invalid_mode results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_pm_rpm results: parsing output: 112/ for test: kms_cursor_edge_walk results: parsing output: 113/ for test: gem_exec_params results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: syncobj_timeline results: parsing output: 116/ for test: kms_lease results: parsing output: 117/ for test: vgem_slow results: parsing output: 118/ for test: syncobj_timeline results: parsing output: 119/ for test: gen9_exec_parse results: parsing output: 120/ for test: perf_pmu results: parsing output: 121/ for test: gem_render_copy results: parsing output: 122/ for test: gem_ccs results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: kms_sequence results: parsing output: 125/ for test: gem_exec_create results: parsing output: 126/ for test: kms_feature_discovery results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_addfb_basic results: parsing output: 129/ for test: gem_exec_params results: parsing output: 130/ for test: kms_color results: parsing output: 131/ for test: gem_ctx_shared Done.