[65.525450] Initializing watchdogs [65.525515] /dev/watchdog0 [65.544807] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [65.555672] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [65.559311] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [65.561747] [001/132] (960s left) gem_mmap_gtt (pf-nonblock) [65.637053] Subtest pf-nonblock: SKIP (0.000s) [65.715507] [002/132] (960s left) gen9_exec_parse (bb-start-far) [65.792667] Subtest bb-start-far: SKIP (0.000s) [65.878995] [003/132] (960s left) kms_big_fb (x-tiled-8bpp-rotate-180) [66.067537] Starting subtest: x-tiled-8bpp-rotate-180 [67.632848] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.565s) [67.931637] [004/132] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [68.121568] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [68.123288] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [68.287634] [005/132] (958s left) gem_eio (create-ext) [68.579992] Starting subtest: create-ext [69.097642] Subtest create-ext: SUCCESS (0.518s) [69.368276] [006/132] (957s left) gem_exec_schedule (pi-shared-iova) [69.566027] Starting subtest: pi-shared-iova [69.566974] Starting dynamic subtest: rcs0 [69.835895] Dynamic subtest rcs0: SUCCESS (0.270s) [69.844186] Starting dynamic subtest: bcs0 [70.014229] Dynamic subtest bcs0: SUCCESS (0.178s) [70.022444] Starting dynamic subtest: vcs0 [70.200656] Dynamic subtest vcs0: SUCCESS (0.186s) [70.208902] Starting dynamic subtest: vcs1 [70.393296] Dynamic subtest vcs1: SUCCESS (0.192s) [70.401496] Starting dynamic subtest: vecs0 [70.582177] Dynamic subtest vecs0: SUCCESS (0.189s) [70.590335] Starting dynamic subtest: vecs1 [70.767918] Dynamic subtest vecs1: SUCCESS (0.186s) [70.776188] Starting dynamic subtest: ccs0 [71.017908] Dynamic subtest ccs0: SUCCESS (0.250s) [71.018842] Subtest pi-shared-iova: SUCCESS (1.452s) [71.337517] [007/132] (955s left) i915_query (query-topology-kernel-writes) [71.406138] Starting subtest: query-topology-kernel-writes [71.407125] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [71.574172] [008/132] (954s left) gem_exec_balancer (invalid-bonds) [71.651980] Starting subtest: invalid-bonds [71.653856] Subtest invalid-bonds: SKIP (0.000s) [72.082022] [009/132] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [72.274298] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [72.276009] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [72.477968] [010/132] (954s left) perf_pmu (module-unload) [72.582735] Starting subtest: module-unload [79.187019] Subtest module-unload: FAIL (6.579s) [79.211878] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true [79.213397] [011/132] (947s left) kms_busy (basic-hang) [80.897467] Starting subtest: basic-hang [80.899301] Starting dynamic subtest: flip-pipe-A [81.535269] Dynamic subtest flip-pipe-A: SUCCESS (0.636s) [81.556814] Starting dynamic subtest: modeset-pipe-A [82.484887] Dynamic subtest modeset-pipe-A: SUCCESS (0.948s) [82.505823] Starting dynamic subtest: flip-pipe-D [82.981292] Dynamic subtest flip-pipe-D: SUCCESS (0.492s) [82.992283] Starting dynamic subtest: modeset-pipe-D [83.862281] Dynamic subtest modeset-pipe-D: SUCCESS (0.880s) [83.863222] Subtest basic-hang: SUCCESS (2.965s) [84.194985] [FACT kms_busy (basic-hang)] new: kernel.kmod_is_loaded.i915: true [84.197780] [012/132] (942s left) kms_cursor_legacy (cursor-vs-flip-atomic) [84.381931] Starting subtest: cursor-vs-flip-atomic [114.814243] Subtest cursor-vs-flip-atomic: SUCCESS (30.431s) [115.122464] [013/132] (911s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [115.301936] Starting subtest: primary-y-tiled-reflect-x-270 [115.303858] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [115.444313] [014/132] (911s left) kms_atomic_transition (plane-all-transition-fencing) [115.621136] Starting subtest: plane-all-transition-fencing [115.622123] Starting dynamic subtest: pipe-A-DP-3 [119.348629] Dynamic subtest pipe-A-DP-3: SUCCESS (3.727s) [119.468717] Starting dynamic subtest: pipe-B-DP-3 [123.474047] Dynamic subtest pipe-B-DP-3: SUCCESS (4.016s) [123.579818] Subtest plane-all-transition-fencing: SUCCESS (7.959s) [123.853414] [015/132] (903s left) gem_exec_params (no-bsd) [123.932116] Starting subtest: no-bsd [123.935835] Subtest no-bsd: SUCCESS (0.004s) [124.183919] [016/132] (902s left) perf_pmu (busy) [124.246345] Starting subtest: busy [124.247276] Starting dynamic subtest: rcs0 [124.877167] Dynamic subtest rcs0: SUCCESS (0.630s) [124.888574] Starting dynamic subtest: bcs0 [125.433270] Dynamic subtest bcs0: SUCCESS (0.555s) [125.444643] Starting dynamic subtest: vcs0 [125.991121] Dynamic subtest vcs0: SUCCESS (0.557s) [126.002573] Starting dynamic subtest: vcs1 [126.552368] Dynamic subtest vcs1: SUCCESS (0.560s) [126.563609] Starting dynamic subtest: vecs0 [127.110256] Dynamic subtest vecs0: SUCCESS (0.557s) [127.121545] Starting dynamic subtest: vecs1 [127.669855] Dynamic subtest vecs1: SUCCESS (0.558s) [127.682148] Starting dynamic subtest: ccs0 [128.233607] Dynamic subtest ccs0: SUCCESS (0.561s) [128.235490] Subtest busy: SUCCESS (3.988s) [128.404047] [017/132] (898s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [131.006251] Starting subtest: verify-pxp-key-change-after-suspend-resume [131.008571] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s) [131.151817] [018/132] (896s left) gem_exec_balancer (parallel-ordering) [131.525653] Starting subtest: parallel-ordering [133.177483] Subtest parallel-ordering: SUCCESS (1.652s) [133.357951] [019/132] (893s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [133.541570] Starting subtest: yf-tiled-8bpp-rotate-270 [133.543275] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [133.707645] [020/132] (893s left) kms_prime (d3hot) [133.886137] Subtest D3hot: SKIP (0.000s) [134.135969] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true [134.137824] [021/132] (893s left) dmabuf_sync_file (import-multiple-read-only) [134.206928] Starting subtest: import-multiple-read-only [134.210909] Subtest import-multiple-read-only: SUCCESS (0.005s) [134.309979] [022/132] (893s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [134.506829] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [134.565310] [023/132] (892s left) gem_ctx_engines (none) [134.664067] Starting subtest: none [134.665193] Subtest none: SUCCESS (0.002s) [134.921746] [024/132] (892s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling) [135.106752] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling [135.107591] Starting dynamic subtest: pipe-A-valid-mode [135.183397] Dynamic subtest pipe-A-valid-mode: SKIP (0.074s) [135.185226] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.076s) [135.432621] [025/132] (892s left) kms_flip (busy-flip) [135.621396] Starting subtest: busy-flip [135.625548] Starting dynamic subtest: A-DP3 [136.463343] Dynamic subtest A-DP3: SUCCESS (0.837s) [136.490866] Starting dynamic subtest: B-DP3 [137.244777] Dynamic subtest B-DP3: SUCCESS (0.778s) [137.255156] Starting dynamic subtest: C-DP3 [138.012196] Dynamic subtest C-DP3: SUCCESS (0.767s) [138.022817] Starting dynamic subtest: D-DP3 [138.785177] Dynamic subtest D-DP3: SUCCESS (0.772s) [138.787343] Subtest busy-flip: SUCCESS (3.166s) [139.166717] [026/132] (888s left) kms_pm_backlight (fade) [139.351331] Subtest fade: SKIP (0.000s) [139.407357] [027/132] (888s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [139.484301] Starting subtest: multi-wait-available-unsubmitted-signaled [139.485223] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [139.653858] [028/132] (888s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [139.837275] Starting subtest: cursorB-vs-flipB-varying-size [139.839121] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [140.006337] [029/132] (887s left) kms_rmfb (close-fd) [140.190568] Starting subtest: close-fd [140.192767] Starting dynamic subtest: pipe-A-DP-3 [140.352888] Dynamic subtest pipe-A-DP-3: SUCCESS (0.161s) [140.366440] Starting dynamic subtest: pipe-B-DP-3 [140.644126] Dynamic subtest pipe-B-DP-3: SUCCESS (0.289s) [140.654984] Starting dynamic subtest: pipe-C-DP-3 [140.927784] Dynamic subtest pipe-C-DP-3: SUCCESS (0.282s) [140.939287] Starting dynamic subtest: pipe-D-DP-3 [141.210589] Dynamic subtest pipe-D-DP-3: SUCCESS (0.281s) [141.211526] Subtest close-fd: SUCCESS (1.021s) [141.552423] [030/132] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [141.742762] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [141.744412] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [141.897335] [031/132] (886s left) kms_big_fb (linear-8bpp-rotate-180) [142.095610] Starting subtest: linear-8bpp-rotate-180 [143.668113] Subtest linear-8bpp-rotate-180: SUCCESS (1.571s) [143.848221] [032/132] (884s left) kms_psr (psr2-cursor-plane-move) [144.037266] Subtest psr2-cursor-plane-move: SKIP (0.000s) [144.119161] [033/132] (884s left) kms_psr (pr-cursor-mmap-cpu) [144.305160] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [144.366600] [034/132] (883s left) gem_ctx_persistence (legacy-engines-hostile) [144.453595] Starting subtest: legacy-engines-hostile [144.454492] Starting dynamic subtest: render [144.597073] Dynamic subtest render: SUCCESS (0.142s) [144.638269] Starting dynamic subtest: bsd1 [144.639471] Dynamic subtest bsd1: SUCCESS (0.036s) [144.655055] Starting dynamic subtest: bsd2 [144.756435] Dynamic subtest bsd2: SUCCESS (0.118s) [144.777022] Starting dynamic subtest: blt [144.809126] Dynamic subtest blt: SUCCESS (0.050s) [144.849183] Starting dynamic subtest: vebox [144.874402] Dynamic subtest vebox: SUCCESS (0.062s) [144.875437] Subtest legacy-engines-hostile: SUCCESS (0.421s) [145.095137] [035/132] (883s left) kms_lease (lease-again) [145.284483] Starting subtest: lease-again [145.286494] Starting dynamic subtest: pipe-A-DP-3 [145.289578] Dynamic subtest pipe-A-DP-3: SUCCESS (0.004s) [145.300517] Starting dynamic subtest: pipe-B-DP-3 [145.301423] Dynamic subtest pipe-B-DP-3: SUCCESS (0.003s) [145.311078] Starting dynamic subtest: pipe-C-DP-3 [145.311961] Dynamic subtest pipe-C-DP-3: SUCCESS (0.003s) [145.321427] Starting dynamic subtest: pipe-D-DP-3 [145.322332] Dynamic subtest pipe-D-DP-3: SUCCESS (0.003s) [145.323232] Subtest lease-again: SUCCESS (0.020s) [145.458134] [036/132] (883s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [145.647937] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [145.649594] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [145.835760] [037/132] (882s left) kms_flip (nonexisting-fb-interruptible) [146.024254] Starting subtest: nonexisting-fb-interruptible [146.028957] Starting dynamic subtest: A-DP3 [146.340585] Dynamic subtest A-DP3: SUCCESS (0.311s) [146.379370] Starting dynamic subtest: B-DP3 [146.623030] Dynamic subtest B-DP3: SUCCESS (0.279s) [146.659140] Starting dynamic subtest: C-DP3 [146.905495] Dynamic subtest C-DP3: SUCCESS (0.280s) [146.930416] Starting dynamic subtest: D-DP3 [147.166523] Dynamic subtest D-DP3: SUCCESS (0.259s) [147.170075] Subtest nonexisting-fb-interruptible: SUCCESS (1.145s) [147.559851] [038/132] (881s left) gem_exec_fence (basic-wait-all) [147.648594] Starting subtest: basic-wait-all [147.776872] Subtest basic-wait-all: SUCCESS (0.128s) [148.661505] [039/132] (880s left) gem_ctx_exec (basic) [148.739251] Starting subtest: basic [148.746069] Subtest basic: SUCCESS (0.007s) [148.881419] [040/132] (879s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [149.071922] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [149.073634] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [149.251248] [041/132] (879s left) kms_sequence (get-idle) [149.434903] Starting subtest: get-idle [149.435812] Starting dynamic subtest: pipe-A-DP-3 [151.837197] Dynamic subtest pipe-A-DP-3: SUCCESS (2.401s) [151.849737] Starting dynamic subtest: pipe-B-DP-3 [154.156998] Dynamic subtest pipe-B-DP-3: SUCCESS (2.318s) [154.169935] Starting dynamic subtest: pipe-C-DP-3 [156.460432] Dynamic subtest pipe-C-DP-3: SUCCESS (2.301s) [156.470313] Starting dynamic subtest: pipe-D-DP-3 [158.771321] Dynamic subtest pipe-D-DP-3: SUCCESS (2.309s) [158.772277] Subtest get-idle: SUCCESS (9.336s) [159.072282] [042/132] (869s left) kms_hdr (invalid-metadata-sizes) [159.261950] Starting subtest: invalid-metadata-sizes [159.849714] Starting dynamic subtest: pipe-A-DP-3 [159.854626] Dynamic subtest pipe-A-DP-3: SUCCESS (0.003s) [159.856323] Subtest invalid-metadata-sizes: SUCCESS (0.592s) [160.174066] [043/132] (868s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [160.253598] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [160.357373] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s) [160.537084] [044/132] (868s left) gem_exec_reloc (basic-write-gtt-active) [160.620623] Subtest basic-write-gtt-active: SKIP (0.000s) [160.698960] [045/132] (868s left) perf_pmu (rc6) [160.770185] Starting subtest: rc6 [160.771247] Starting dynamic subtest: gt0 [167.147960] Dynamic subtest gt0: SUCCESS (6.377s) [167.160475] Starting dynamic subtest: runtime-pm-gt0 [174.933843] Dynamic subtest runtime-pm-gt0: SUCCESS (7.782s) [174.944260] Starting dynamic subtest: runtime-pm-long-gt0 [187.552533] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.616s) [187.564258] Starting dynamic subtest: other-idle-gt0 [187.566044] Dynamic subtest other-idle-gt0: SKIP (0.000s) [187.566963] Subtest rc6: SUCCESS (26.785s) [188.258882] [046/132] (841s left) gem_mmap_gtt (coherency) [188.335055] Subtest coherency: SKIP (0.000s) [188.401426] [047/132] (840s left) gem_ccs (block-copy-uncompressed) [188.490327] Starting subtest: block-copy-uncompressed [188.491260] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [188.536456] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.045s) [188.546790] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0 [188.553055] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.016s) [188.563255] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem [188.653561] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.100s) [188.663737] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0 [188.753894] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.099s) [188.765472] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem [188.770354] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s) [188.780498] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-lmem0 [188.785781] Dynamic subtest xmajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s) [188.795967] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-smem [188.894484] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.108s) [188.904961] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-lmem0 [188.993389] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.098s) [189.004911] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem [189.009830] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s) [189.020031] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-lmem0 [189.025181] Dynamic subtest tile4-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s) [189.035342] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-smem [189.130323] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.104s) [189.140650] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-lmem0 [189.233124] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.102s) [189.244548] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem [189.249410] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s) [189.259518] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-lmem0 [189.264874] Dynamic subtest tile64-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s) [189.275059] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-smem [189.367130] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.101s) [189.377451] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-lmem0 [189.475097] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.107s) [189.476022] Subtest block-copy-uncompressed: SUCCESS (0.985s) [189.580249] [048/132] (839s left) kms_universal_plane (universal-plane-sanity) [189.767391] Starting subtest: universal-plane-sanity [189.768276] Starting dynamic subtest: pipe-A-DP-3 [190.399249] Dynamic subtest pipe-A-DP-3: SUCCESS (0.631s) [190.409475] Starting dynamic subtest: pipe-B-DP-3 [190.891940] Dynamic subtest pipe-B-DP-3: SUCCESS (0.492s) [190.906115] Starting dynamic subtest: pipe-C-DP-3 [191.372462] Dynamic subtest pipe-C-DP-3: SUCCESS (0.478s) [191.385674] Starting dynamic subtest: pipe-D-DP-3 [191.861433] Dynamic subtest pipe-D-DP-3: SUCCESS (0.485s) [191.862416] Subtest universal-plane-sanity: SUCCESS (2.095s) [192.062885] [049/132] (837s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [192.256480] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [193.375076] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.118s) [193.546920] [050/132] (835s left) i915_pm_rps (min-max-config-loaded) [193.635288] Starting subtest: min-max-config-loaded [193.637300] Subtest min-max-config-loaded: SKIP (0.000s) [193.687860] [051/132] (835s left) kms_psr (fbc-pr-cursor-render) [193.879421] Subtest fbc-pr-cursor-render: SKIP (0.000s) [193.957487] [052/132] (835s left) gem_exec_reloc (basic-concurrent16) [194.044575] Subtest basic-concurrent16: SKIP (0.000s) [194.124203] [053/132] (835s left) kms_addfb_basic (legacy-format) [194.202435] Starting subtest: legacy-format [194.239622] Subtest legacy-format: SUCCESS (0.037s) [194.439692] [054/132] (835s left) kms_big_fb (4-tiled-16bpp-rotate-0) [194.634986] Starting subtest: 4-tiled-16bpp-rotate-0 [196.376109] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.741s) [196.489142] [055/132] (833s left) kms_big_fb (y-tiled-32bpp-rotate-0) [196.687064] Starting subtest: y-tiled-32bpp-rotate-0 [196.688845] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [196.781034] [056/132] (833s left) api_intel_bb (simple-bb) [196.858489] Starting subtest: simple-bb [196.888222] Subtest simple-bb: SUCCESS (0.030s) [197.041329] [057/132] (832s left) gem_mmap_offset (perf) [197.118286] Starting subtest: perf [197.119224] Starting dynamic subtest: lmem0 [197.384197] Dynamic subtest lmem0: SUCCESS (0.265s) [197.394472] Starting dynamic subtest: smem0 [197.398939] Dynamic subtest smem0: SUCCESS (0.003s) [197.399869] Subtest perf: SUCCESS (0.270s) [197.499298] [058/132] (832s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [197.581575] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [197.583580] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [197.745067] [059/132] (832s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [197.937924] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [197.939546] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [198.031785] [060/132] (832s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [198.223168] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [198.224876] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [198.309789] [061/132] (831s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [198.500962] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [198.502606] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [198.597677] [062/132] (831s left) kms_addfb_basic (too-wide) [198.784237] Starting subtest: too-wide [198.785109] Subtest too-wide: SUCCESS (0.000s) [198.878423] [063/132] (831s left) gem_mmap_gtt (close-race) [198.956241] Subtest close-race: SKIP (0.000s) [199.018975] [064/132] (831s left) gem_exec_flush (basic-wb-set-default) [199.103384] Subtest basic-wb-set-default: SKIP (0.000s) [199.192164] [065/132] (831s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [199.375471] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [199.377922] Starting dynamic subtest: pipe-A-DP-3 [199.386143] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [199.396302] Starting dynamic subtest: pipe-B-DP-3 [199.404552] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [199.414528] Starting dynamic subtest: pipe-C-DP-3 [199.422838] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [199.432976] Starting dynamic subtest: pipe-D-DP-3 [199.443824] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [199.446068] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.009s) [199.768368] [066/132] (830s left) api_intel_allocator (reopen-fork) [199.845482] Starting subtest: reopen-fork [203.196525] Subtest reopen-fork: SUCCESS (3.351s) [203.304738] [067/132] (827s left) kms_pipe_crc_basic (nonblocking-crc) [203.486887] Starting subtest: nonblocking-crc [203.489339] Starting dynamic subtest: pipe-A-DP-3 [204.243459] Dynamic subtest pipe-A-DP-3: SUCCESS (0.754s) [204.255295] Starting dynamic subtest: pipe-B-DP-3 [204.884509] Dynamic subtest pipe-B-DP-3: SUCCESS (0.639s) [204.903639] Starting dynamic subtest: pipe-C-DP-3 [205.518205] Dynamic subtest pipe-C-DP-3: SUCCESS (0.631s) [205.532546] Starting dynamic subtest: pipe-D-DP-3 [206.152290] Dynamic subtest pipe-D-DP-3: SUCCESS (0.630s) [206.153195] Subtest nonblocking-crc: SUCCESS (2.665s) [206.335701] [068/132] (824s left) syncobj_eventfd (binary-wait-before-signal) [206.415492] Starting subtest: binary-wait-before-signal [206.446339] Subtest binary-wait-before-signal: SUCCESS (0.031s) [206.538754] [069/132] (824s left) gem_exec_reloc (basic-write-gtt-noreloc) [206.621447] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [206.693349] [070/132] (823s left) gem_render_linear_blits (basic) [206.783033] Starting subtest: basic [206.861196] Subtest basic: SUCCESS (0.078s) [206.968758] [071/132] (823s left) gem_spin_batch (user-each) [207.059439] Starting subtest: user-each [210.392219] Subtest user-each: SUCCESS (3.332s) [210.683893] [072/132] (820s left) kms_cursor_crc (cursor-sliding-max-size) [211.177285] Starting subtest: cursor-sliding-max-size [211.179983] Subtest cursor-sliding-max-size: SKIP (0.000s) [211.316038] [073/132] (819s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [211.507286] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [211.508087] Starting dynamic subtest: pipe-A [213.515996] Dynamic subtest pipe-A: SUCCESS (2.009s) [213.541700] Starting dynamic subtest: pipe-B [215.595055] Dynamic subtest pipe-B: SUCCESS (2.077s) [215.614740] Starting dynamic subtest: pipe-C [215.908132] Dynamic subtest pipe-C: SUCCESS (0.311s) [215.930565] Starting dynamic subtest: pipe-D [216.221044] Dynamic subtest pipe-D: SUCCESS (0.311s) [216.222212] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.715s) [216.484931] [074/132] (814s left) kms_addfb_basic (bo-too-small-due-to-tiling) [216.671280] Starting subtest: bo-too-small-due-to-tiling [216.673011] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [216.747251] [075/132] (814s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [216.936121] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [216.937851] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [217.042931] [076/132] (813s left) gem_exec_whisper (basic-queues-all) [217.133929] Starting subtest: basic-queues-all [238.949116] Subtest basic-queues-all: SUCCESS (21.813s) [239.127590] [077/132] (791s left) syncobj_timeline (wait-any-complex) [239.203437] Starting subtest: wait-any-complex [239.266448] Subtest wait-any-complex: SUCCESS (0.063s) [239.342552] [078/132] (791s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [239.541052] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [242.368251] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.828s) [242.538017] [079/132] (788s left) kms_psr (psr-sprite-mmap-cpu) [242.726457] Subtest psr-sprite-mmap-cpu: SKIP (0.000s) [242.778486] [080/132] (788s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [242.973184] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [245.268617] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (2.296s) [245.408543] [081/132] (785s left) gem_exec_store (dword) [245.496234] Starting subtest: dword [245.497198] Starting dynamic subtest: rcs0 [245.599824] Dynamic subtest rcs0: SUCCESS (0.103s) [245.627594] Starting dynamic subtest: bcs0 [245.647225] Dynamic subtest bcs0: SUCCESS (0.045s) [245.674123] Starting dynamic subtest: vcs0 [245.692775] Dynamic subtest vcs0: SUCCESS (0.043s) [245.712062] Starting dynamic subtest: vcs1 [245.735762] Dynamic subtest vcs1: SUCCESS (0.041s) [245.752795] Starting dynamic subtest: vecs0 [245.777902] Dynamic subtest vecs0: SUCCESS (0.040s) [245.798919] Starting dynamic subtest: vecs1 [245.822808] Dynamic subtest vecs1: SUCCESS (0.043s) [245.844049] Starting dynamic subtest: ccs0 [245.867824] Dynamic subtest ccs0: SUCCESS (0.043s) [245.868948] Subtest dword: SUCCESS (0.372s) [246.108017] [082/132] (785s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite) [246.307265] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite [246.308975] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [246.408188] [083/132] (785s left) kms_vblank (wait-forked) [246.594754] Starting subtest: wait-forked [246.597258] Starting dynamic subtest: pipe-A-DP-3 [248.985229] Dynamic subtest pipe-A-DP-3: SUCCESS (2.386s) [249.013285] Starting dynamic subtest: pipe-D-DP-3 [251.316576] Dynamic subtest pipe-D-DP-3: SUCCESS (2.322s) [251.317626] Subtest wait-forked: SUCCESS (4.721s) [251.472993] [084/132] (780s left) gem_softpin (evict-prime) [251.556471] Starting subtest: evict-prime [251.557703] Starting dynamic subtest: rcs0 [252.788591] Dynamic subtest rcs0: SUCCESS (1.233s) [252.803671] Starting dynamic subtest: bcs0 [253.993400] Dynamic subtest bcs0: SUCCESS (1.204s) [254.010039] Starting dynamic subtest: vcs0 [255.169404] Dynamic subtest vcs0: SUCCESS (1.175s) [255.181999] Starting dynamic subtest: vcs1 [256.305372] Dynamic subtest vcs1: SUCCESS (1.135s) [256.317931] Starting dynamic subtest: vecs0 [257.515572] Dynamic subtest vecs0: SUCCESS (1.209s) [257.533829] Starting dynamic subtest: vecs1 [258.703545] Dynamic subtest vecs1: SUCCESS (1.187s) [258.716331] Starting dynamic subtest: ccs0 [259.893567] Dynamic subtest ccs0: SUCCESS (1.189s) [259.906340] Starting dynamic subtest: all [261.139511] Dynamic subtest all: SUCCESS (1.245s) [261.140522] Subtest evict-prime: SUCCESS (9.585s) [261.223556] [085/132] (770s left) kms_cursor_crc (cursor-onscreen-64x64) [261.543393] Starting subtest: cursor-onscreen-64x64 [261.548877] Starting dynamic subtest: pipe-A-DP-3 [264.245519] Dynamic subtest pipe-A-DP-3: SUCCESS (2.696s) [264.292800] Starting dynamic subtest: pipe-D-DP-3 [267.005259] Dynamic subtest pipe-D-DP-3: SUCCESS (2.722s) [267.006291] Subtest cursor-onscreen-64x64: SUCCESS (5.462s) [267.425841] [086/132] (764s left) kms_addfb_basic (bad-pitch-1024) [267.503704] Starting subtest: bad-pitch-1024 [267.504581] Subtest bad-pitch-1024: SUCCESS (0.000s) [267.686246] [087/132] (764s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [267.765428] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [267.766531] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [267.869476] [088/132] (763s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [268.057416] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [268.058275] Starting dynamic subtest: pipe-A-valid-mode [270.561810] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.500s) [270.563306] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (2.504s) [270.753745] [089/132] (761s left) gem_exec_fence (basic-busy-all) [270.841587] Starting subtest: basic-busy-all [270.959667] Subtest basic-busy-all: SUCCESS (0.118s) [271.847698] [090/132] (760s left) kms_big_fb (4-tiled-8bpp-rotate-180) [272.048447] Starting subtest: 4-tiled-8bpp-rotate-180 [273.586316] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.537s) [273.687500] [091/132] (758s left) kms_chamelium_color (ctm-max) [273.870161] Subtest ctm-max: SKIP (0.000s) [273.929534] [092/132] (758s left) gem_mmap_gtt (basic-small-copy-xy) [274.005175] Subtest basic-small-copy-XY: SKIP (0.000s) [274.083237] [093/132] (757s left) i915_query (query-regions-unallocated) [274.162603] Starting subtest: query-regions-unallocated [275.274857] Subtest query-regions-unallocated: SUCCESS (1.113s) [275.333140] [094/132] (756s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [275.520273] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [275.521177] Starting dynamic subtest: pipe-A-DP-3 [275.529824] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [275.540526] Starting dynamic subtest: pipe-B-DP-3 [275.549122] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [275.559509] Starting dynamic subtest: pipe-C-DP-3 [275.567772] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [275.578330] Starting dynamic subtest: pipe-D-DP-3 [275.589131] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [275.591336] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.007s) [275.920924] [095/132] (756s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [276.109373] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [276.125057] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.015s) [276.176994] [096/132] (756s left) kms_rotation_crc (bad-tiling) [276.365409] Starting subtest: bad-tiling [276.367156] Subtest bad-tiling: SKIP (0.001s) [276.427924] [097/132] (755s left) kms_chamelium_edid (vga-edid-read) [276.708457] Subtest vga-edid-read: SKIP (0.000s) [276.865807] [098/132] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [277.058924] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [277.060539] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [277.132337] [099/132] (755s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [277.321268] Starting subtest: cursorA-vs-flipB-legacy [277.323026] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [277.382753] [100/132] (755s left) syncobj_wait (wait-all-complex) [277.458431] Starting subtest: wait-all-complex [277.675312] Subtest wait-all-complex: SUCCESS (0.216s) [277.796062] [101/132] (754s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [277.981944] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [277.984190] Starting dynamic subtest: pipe-A-DP-3 [277.992531] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [278.003055] Starting dynamic subtest: pipe-B-DP-3 [278.011427] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [278.021878] Starting dynamic subtest: pipe-C-DP-3 [278.030102] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [278.040627] Starting dynamic subtest: pipe-D-DP-3 [278.050964] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [278.053186] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.007s) [278.380848] [102/132] (754s left) gem_exec_fence (syncobj-timeline-export) [279.036969] Starting subtest: syncobj-timeline-export [279.089060] Subtest syncobj-timeline-export: SUCCESS (0.053s) [279.353611] [103/132] (753s left) kms_cursor_crc (cursor-rapid-movement-512x170) [279.857214] Starting subtest: cursor-rapid-movement-512x170 [279.859023] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [280.037227] [104/132] (752s left) gem_ctx_param (basic-default) [280.115789] Starting subtest: basic-default [280.116675] Subtest basic-default: SUCCESS (0.000s) [280.178351] [105/132] (752s left) kms_psr (fbc-psr2-sprite-plane-move) [280.368464] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s) [280.426386] [106/132] (752s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [280.619161] Starting subtest: fbcpsr-indfb-scaledprimary [280.620867] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s) [280.694782] [107/132] (752s left) i915_drm_fdinfo (virtual-busy) [280.766508] Starting subtest: virtual-busy [280.768310] Subtest virtual-busy: SKIP (0.000s) [280.827531] [108/132] (752s left) kms_color_pipeline (plane-lut1d-ctm3x4) [281.024782] Starting subtest: plane-lut1d-ctm3x4 [281.049448] Starting dynamic subtest: pipe-A-DP-3 [281.447829] Dynamic subtest pipe-A-DP-3: SUCCESS (0.399s) [281.647662] Starting dynamic subtest: pipe-B-DP-3 [281.984808] Dynamic subtest pipe-B-DP-3: SUCCESS (0.348s) [282.174210] Starting dynamic subtest: pipe-C-DP-3 [282.511859] Dynamic subtest pipe-C-DP-3: SUCCESS (0.348s) [282.694037] Starting dynamic subtest: pipe-D-DP-3 [283.031837] Dynamic subtest pipe-D-DP-3: SUCCESS (0.348s) [283.091060] Subtest plane-lut1d-ctm3x4: SUCCESS (2.065s) [283.293145] [109/132] (749s left) i915_hangman (engine-engine-error) [283.391730] Starting subtest: engine-engine-error [283.392555] Starting dynamic subtest: rcs0 [284.262074] Dynamic subtest rcs0: SUCCESS (0.870s) [284.278993] Starting dynamic subtest: bcs0 [285.077541] Dynamic subtest bcs0: SUCCESS (0.813s) [285.090271] Starting dynamic subtest: vcs0 [285.881375] Dynamic subtest vcs0: SUCCESS (0.803s) [285.893788] Starting dynamic subtest: vcs1 [286.690502] Dynamic subtest vcs1: SUCCESS (0.808s) [286.702965] Starting dynamic subtest: vecs0 [287.491373] Dynamic subtest vecs0: SUCCESS (0.800s) [287.503769] Starting dynamic subtest: vecs1 [288.301369] Dynamic subtest vecs1: SUCCESS (0.809s) [288.313545] Starting dynamic subtest: ccs0 [289.143724] Dynamic subtest ccs0: SUCCESS (0.841s) [289.144787] Subtest engine-engine-error: SUCCESS (5.754s) [289.273121] [110/132] (743s left) gem_exec_schedule (u-independent) [289.366950] Starting subtest: u-independent [289.367874] Starting dynamic subtest: rcs0 [289.828929] Dynamic subtest rcs0: SUCCESS (0.461s) [289.866516] Starting dynamic subtest: bcs0 [290.256571] Dynamic subtest bcs0: SUCCESS (0.425s) [290.279659] Starting dynamic subtest: vcs0 [290.673538] Dynamic subtest vcs0: SUCCESS (0.415s) [290.691549] Starting dynamic subtest: vcs1 [291.066553] Dynamic subtest vcs1: SUCCESS (0.392s) [291.080331] Starting dynamic subtest: vecs0 [291.465441] Dynamic subtest vecs0: SUCCESS (0.398s) [291.485857] Starting dynamic subtest: vecs1 [291.865395] Dynamic subtest vecs1: SUCCESS (0.398s) [291.878559] Starting dynamic subtest: ccs0 [292.201320] Dynamic subtest ccs0: SUCCESS (0.335s) [292.202310] Subtest u-independent: SUCCESS (2.835s) [292.529553] [111/132] (740s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [292.610341] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [292.611250] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [292.697998] [112/132] (740s left) kms_dp_link_training (uhbr-mst) [292.885294] Starting subtest: uhbr-mst [292.887055] Subtest uhbr-mst: SKIP (0.000s) [292.942616] [113/132] (740s left) vgem_basic (setversion) [292.994575] Starting subtest: setversion [292.996275] Subtest setversion: SUCCESS (0.000s) [293.043607] [114/132] (740s left) syncobj_timeline (invalid-signal-illegal-point) [293.122373] Starting subtest: invalid-signal-illegal-point [293.123295] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [293.225922] [115/132] (740s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [293.420287] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [293.473486] [116/132] (739s left) kms_pm_rpm (basic-pci-d3-state) [295.083897] Starting subtest: basic-pci-d3-state [295.686150] Subtest basic-pci-d3-state: SUCCESS (0.603s) [295.848674] [117/132] (737s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [296.069072] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [296.070795] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [296.147500] [118/132] (737s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs) [296.343588] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs [296.346123] Starting dynamic subtest: pipe-A-DP-3 [296.354736] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [296.365460] Starting dynamic subtest: pipe-B-DP-3 [296.373878] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [296.384498] Starting dynamic subtest: pipe-C-DP-3 [296.392720] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [296.403218] Starting dynamic subtest: pipe-D-DP-3 [296.414525] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [296.416265] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.007s) [296.711362] [119/132] (736s left) kms_content_protection (dp-mst-lic-type-1) [296.969764] Starting subtest: dp-mst-lic-type-1 [296.971595] Subtest dp-mst-lic-type-1: SKIP (0.000s) [297.091085] [120/132] (736s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [297.283185] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [297.284917] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [297.357827] [121/132] (736s left) kms_chamelium_hpd (dp-hpd) [297.620802] Subtest dp-hpd: SKIP (0.000s) [297.766562] [122/132] (735s left) kms_flip (2x-flip-vs-modeset) [297.953161] Starting subtest: 2x-flip-vs-modeset [297.968295] Subtest 2x-flip-vs-modeset: SKIP (0.014s) [298.038367] [123/132] (735s left) gem_ctx_isolation (clean) [298.125238] Starting subtest: clean [298.126192] Starting dynamic subtest: rcs0 [298.225063] Dynamic subtest rcs0: SUCCESS (0.099s) [298.237439] Starting dynamic subtest: bcs0 [298.342466] Dynamic subtest bcs0: SUCCESS (0.116s) [298.353402] Starting dynamic subtest: vcs0 [298.461183] Dynamic subtest vcs0: SUCCESS (0.118s) [298.473493] Starting dynamic subtest: vcs1 [298.569372] Dynamic subtest vcs1: SUCCESS (0.107s) [298.581512] Starting dynamic subtest: vecs0 [298.676252] Dynamic subtest vecs0: SUCCESS (0.106s) [298.688391] Starting dynamic subtest: vecs1 [298.784857] Dynamic subtest vecs1: SUCCESS (0.107s) [298.795733] Starting dynamic subtest: ccs0 [298.919609] Dynamic subtest ccs0: SUCCESS (0.134s) [298.920494] Subtest clean: SUCCESS (0.795s) [299.142936] [124/132] (734s left) kms_flip (flip-vs-panning) [299.329424] Starting subtest: flip-vs-panning [299.334262] Starting dynamic subtest: A-DP3 [307.181643] Dynamic subtest A-DP3: SUCCESS (7.846s) [307.223870] Starting dynamic subtest: B-DP3 [314.999590] Dynamic subtest B-DP3: SUCCESS (7.813s) [315.012442] Starting dynamic subtest: C-DP3 [322.782878] Dynamic subtest C-DP3: SUCCESS (7.781s) [322.821064] Starting dynamic subtest: D-DP3 [330.578856] Dynamic subtest D-DP3: SUCCESS (7.790s) [330.587341] Subtest flip-vs-panning: SUCCESS (31.256s) [330.898964] [125/132] (702s left) kms_feature_discovery (display-1x) [331.087500] Starting subtest: display-1x [331.088392] Subtest display-1x: SUCCESS (0.000s) [331.147818] [126/132] (702s left) kms_plane (pixel-format) [331.333607] Starting subtest: pixel-format [331.356570] Starting dynamic subtest: pipe-A-plane-0 [339.073860] Dynamic subtest pipe-A-plane-0: SUCCESS (7.717s) [339.109616] Starting dynamic subtest: pipe-A-plane-3 [343.207818] Dynamic subtest pipe-A-plane-3: SUCCESS (4.131s) [343.248182] Starting dynamic subtest: pipe-A-plane-5 [343.457261] Dynamic subtest pipe-A-plane-5: SUCCESS (0.246s) [343.720678] Starting dynamic subtest: pipe-B-plane-0 [351.067947] Dynamic subtest pipe-B-plane-0: SUCCESS (7.366s) [351.098074] Starting dynamic subtest: pipe-B-plane-3 [355.168229] Dynamic subtest pipe-B-plane-3: SUCCESS (4.098s) [355.207574] Starting dynamic subtest: pipe-B-plane-5 [355.418126] Dynamic subtest pipe-B-plane-5: SUCCESS (0.247s) [355.507879] Subtest pixel-format: SUCCESS (24.173s) [355.762701] [127/132] (678s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [355.956128] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [355.957835] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [356.045447] [128/132] (677s left) prime_mmap (test_aperture_limit) [356.123779] Starting subtest: test_aperture_limit [356.124646] Starting dynamic subtest: test_aperture_limit-smem [356.135425] Dynamic subtest test_aperture_limit-smem: SKIP (0.010s) [356.137209] Subtest test_aperture_limit: SKIP (0.011s) [356.187790] [129/132] (677s left) kms_invalid_mode (overflow-vrefresh) [356.372584] Starting subtest: overflow-vrefresh [356.373430] Starting dynamic subtest: pipe-A-DP-3 [356.449797] Dynamic subtest pipe-A-DP-3: SUCCESS (0.075s) [356.462606] Starting dynamic subtest: pipe-B-DP-3 [356.463816] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s) [356.475997] Starting dynamic subtest: pipe-C-DP-3 [356.476946] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s) [356.489042] Starting dynamic subtest: pipe-D-DP-3 [356.489958] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s) [356.490853] Subtest overflow-vrefresh: SUCCESS (0.085s) [356.619466] [130/132] (677s left) gem_exec_reloc (basic-write-wc-active) [356.704306] Subtest basic-write-wc-active: SKIP (0.000s) [356.803132] [131/132] (677s left) gem_ctx_param (non-root-set) [356.882673] Starting subtest: non-root-set [356.899510] Subtest non-root-set: SUCCESS (0.017s) [356.988151] [132/132] (677s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [357.178050] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [357.179776] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [357.255728] Closing watchdogs results: parsing output: 0/ for test: gem_mmap_gtt results: parsing output: 1/ for test: gen9_exec_parse results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_eio results: parsing output: 5/ for test: gem_exec_schedule results: parsing output: 6/ for test: i915_query results: parsing output: 7/ for test: gem_exec_balancer results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: perf_pmu results: parsing output: 10/ for test: kms_busy results: parsing output: 11/ for test: kms_cursor_legacy results: parsing output: 12/ for test: kms_rotation_crc results: parsing output: 13/ for test: kms_atomic_transition results: parsing output: 14/ for test: gem_exec_params results: parsing output: 15/ for test: perf_pmu results: parsing output: 16/ for test: gem_pxp results: parsing output: 17/ for test: gem_exec_balancer results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: kms_prime results: parsing output: 20/ for test: dmabuf_sync_file results: parsing output: 21/ for test: kms_psr2_sf results: parsing output: 22/ for test: gem_ctx_engines results: parsing output: 23/ for test: kms_flip_scaled_crc results: parsing output: 24/ for test: kms_flip results: parsing output: 25/ for test: kms_pm_backlight results: parsing output: 26/ for test: syncobj_timeline results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: kms_rmfb results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_big_fb results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: kms_psr results: parsing output: 33/ for test: gem_ctx_persistence results: parsing output: 34/ for test: kms_lease results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_flip results: parsing output: 37/ for test: gem_exec_fence results: parsing output: 38/ for test: gem_ctx_exec results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_sequence results: parsing output: 41/ for test: kms_hdr results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: perf_pmu results: parsing output: 45/ for test: gem_mmap_gtt results: parsing output: 46/ for test: gem_ccs results: parsing output: 47/ for test: kms_universal_plane results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: i915_pm_rps results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: gem_exec_reloc results: parsing output: 52/ for test: kms_addfb_basic results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: kms_big_fb results: parsing output: 55/ for test: api_intel_bb results: parsing output: 56/ for test: gem_mmap_offset results: parsing output: 57/ for test: gem_render_copy results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_addfb_basic results: parsing output: 62/ for test: gem_mmap_gtt results: parsing output: 63/ for test: gem_exec_flush results: parsing output: 64/ for test: kms_ccs results: parsing output: 65/ for test: api_intel_allocator results: parsing output: 66/ for test: kms_pipe_crc_basic results: parsing output: 67/ for test: syncobj_eventfd results: parsing output: 68/ for test: gem_exec_reloc results: parsing output: 69/ for test: gem_render_linear_blits results: parsing output: 70/ for test: gem_spin_batch results: parsing output: 71/ for test: kms_cursor_crc results: parsing output: 72/ for test: kms_plane_scaling results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: gem_exec_whisper results: parsing output: 76/ for test: syncobj_timeline results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_exec_store results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_vblank results: parsing output: 83/ for test: gem_softpin results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: syncobj_wait results: parsing output: 87/ for test: kms_flip_scaled_crc results: parsing output: 88/ for test: gem_exec_fence results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: kms_chamelium_color results: parsing output: 91/ for test: gem_mmap_gtt results: parsing output: 92/ for test: i915_query results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: kms_flip results: parsing output: 95/ for test: kms_rotation_crc results: parsing output: 96/ for test: kms_chamelium_edid results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: syncobj_wait results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: gem_exec_fence results: parsing output: 102/ for test: kms_cursor_crc results: parsing output: 103/ for test: gem_ctx_param results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: i915_drm_fdinfo results: parsing output: 107/ for test: kms_color_pipeline results: parsing output: 108/ for test: i915_hangman results: parsing output: 109/ for test: gem_exec_schedule results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: kms_dp_link_training results: parsing output: 112/ for test: vgem_basic results: parsing output: 113/ for test: syncobj_timeline results: parsing output: 114/ for test: kms_psr2_sf results: parsing output: 115/ for test: kms_pm_rpm results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_ccs results: parsing output: 118/ for test: kms_content_protection results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_chamelium_hpd results: parsing output: 121/ for test: kms_flip results: parsing output: 122/ for test: gem_ctx_isolation results: parsing output: 123/ for test: kms_flip results: parsing output: 124/ for test: kms_feature_discovery results: parsing output: 125/ for test: kms_plane results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: prime_mmap results: parsing output: 128/ for test: kms_invalid_mode results: parsing output: 129/ for test: gem_exec_reloc results: parsing output: 130/ for test: gem_ctx_param results: parsing output: 131/ for test: kms_frontbuffer_tracking Done.