[59.387937] Initializing watchdogs [59.387998] /dev/watchdog0 [59.404660] [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] [59.409107] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.411396] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.414771] [001/133] (960s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [59.531581] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [59.535957] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [60.693993] [002/133] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [60.793970] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [60.798435] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [60.877172] [003/133] (959s left) kms_cursor_crc (cursor-tearing-position-change) [60.989962] Starting subtest: cursor-tearing-position-change [60.992319] Starting dynamic subtest: pipe-A-eDP-1 [61.570895] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.581s) [61.579259] Starting dynamic subtest: pipe-D-eDP-1 [62.824018] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.254s) [62.826461] Subtest cursor-tearing-position-change: SUCCESS (1.837s) [63.668573] [004/133] (956s left) kms_async_flips (crc) [63.763163] Starting subtest: crc [64.142781] Starting dynamic subtest: pipe-A-eDP-1 [67.112277] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.950s) [67.494900] Starting dynamic subtest: pipe-B-eDP-1 [70.447435] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.944s) [70.806412] Starting dynamic subtest: pipe-C-eDP-1 [73.775221] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.948s) [74.107705] Starting dynamic subtest: pipe-D-eDP-1 [76.993462] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.865s) [76.995686] Subtest crc: SUCCESS (13.208s) [78.121987] [005/133] (941s left) kms_content_protection (content-type-change) [78.273693] Starting subtest: content-type-change [78.277715] Subtest content-type-change: SKIP (0.000s) [78.394800] [006/133] (941s left) kms_chamelium_hpd (common-hpd-after-suspend) [78.782784] Subtest common-hpd-after-suspend: SKIP (0.000s) [79.630792] [007/133] (940s left) fbdev (eof) [79.668094] Starting subtest: eof [79.670530] Subtest eof: SUCCESS (0.000s) [79.736962] [008/133] (940s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [79.798979] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [79.909801] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.108s) [79.991742] [009/133] (940s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [80.121823] Starting subtest: cursorA-vs-flipA-atomic [91.248050] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.125s) [92.080705] [010/133] (928s left) kms_color_pipeline (plane-ctm3x4-lut1d) [92.179577] Starting subtest: plane-ctm3x4-lut1d [92.344179] Starting dynamic subtest: pipe-A-plane-0 [92.532454] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s) [92.540916] Starting dynamic subtest: pipe-A-plane-1 [92.676400] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s) [92.685421] Starting dynamic subtest: pipe-A-plane-2 [92.843214] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [94.074296] Starting dynamic subtest: pipe-B-plane-0 [94.212682] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [94.221820] Starting dynamic subtest: pipe-B-plane-1 [94.345808] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s) [94.354699] Starting dynamic subtest: pipe-B-plane-2 [94.479424] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [95.701583] Starting dynamic subtest: pipe-C-plane-0 [95.828986] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [95.837099] Starting dynamic subtest: pipe-C-plane-1 [95.973389] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [95.982155] Starting dynamic subtest: pipe-C-plane-2 [96.141640] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [97.401902] Starting dynamic subtest: pipe-D-plane-0 [97.536296] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [97.544647] Starting dynamic subtest: pipe-D-plane-1 [97.669977] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s) [97.678822] Starting dynamic subtest: pipe-D-plane-2 [97.803322] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s) [98.089170] Subtest plane-ctm3x4-lut1d: SUCCESS (5.915s) [98.915831] [011/133] (921s left) gem_lmem_swapping (heavy-verify-multi) [98.962701] Subtest heavy-verify-multi: SKIP (0.000s) [99.003748] [012/133] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [99.094247] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [99.098800] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [99.193695] [013/133] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [99.288989] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [99.293209] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [99.397811] [014/133] (921s left) gen3_render_linear_blits [99.527292] [015/133] (920s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [99.616831] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [99.619318] Starting dynamic subtest: pipe-A-eDP-1 [99.680098] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [99.689149] Starting dynamic subtest: pipe-B-eDP-1 [99.749258] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [99.758384] Starting dynamic subtest: pipe-C-eDP-1 [99.816122] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [99.823988] Starting dynamic subtest: pipe-D-eDP-1 [99.875458] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [99.879082] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s) [101.874210] [016/133] (918s left) kms_cursor_crc (cursor-rapid-movement-128x42) [102.122485] Starting subtest: cursor-rapid-movement-128x42 [102.176479] Subtest cursor-rapid-movement-128x42: SKIP (0.048s) [102.365775] [017/133] (918s left) gem_exec_schedule (fifo) [102.445700] Starting subtest: fifo [102.447674] Starting dynamic subtest: rcs0 [102.542053] Dynamic subtest rcs0: SUCCESS (0.099s) [102.552821] Starting dynamic subtest: vcs0 [102.624025] Dynamic subtest vcs0: SUCCESS (0.082s) [102.634389] Starting dynamic subtest: vcs1 [102.705029] Dynamic subtest vcs1: SUCCESS (0.080s) [102.716578] Starting dynamic subtest: vecs0 [102.781530] Dynamic subtest vecs0: SUCCESS (0.076s) [102.790193] Starting dynamic subtest: ccs0 [102.884891] Dynamic subtest ccs0: SUCCESS (0.102s) [102.887351] Subtest fifo: SUCCESS (0.442s) [103.981960] [018/133] (916s left) gem_softpin (noreloc) [104.036224] Starting subtest: noreloc [109.418085] Subtest noreloc: SUCCESS (5.380s) [109.547424] [019/133] (911s left) i915_drm_fdinfo (virtual-busy-hang) [109.592580] Starting subtest: virtual-busy-hang [109.597234] Subtest virtual-busy-hang: SKIP (0.000s) [109.661241] [020/133] (910s left) kms_lease (master-vs-lease) [109.758758] Starting subtest: master-vs-lease [109.761102] Subtest master-vs-lease: SUCCESS (0.001s) [109.873898] [021/133] (910s left) prime_vgem (basic-gtt) [110.022574] Starting subtest: basic-gtt [110.027429] Subtest basic-gtt: SKIP (0.000s) [110.127845] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true [110.130968] [022/133] (910s left) gem_exec_schedule (u-semaphore-resolve) [110.204116] Starting subtest: u-semaphore-resolve [110.231970] Subtest u-semaphore-resolve: SUCCESS (0.037s) [110.566712] [023/133] (910s left) kms_joiner (invalid-modeset-force-big-joiner) [110.655791] Starting subtest: invalid-modeset-force-big-joiner [110.660382] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [110.739768] [024/133] (910s left) gem_shrink (reclaim) [110.803994] Starting subtest: reclaim [113.225086] Subtest reclaim: SUCCESS (2.417s) [113.398959] [025/133] (907s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [113.533065] Starting subtest: 2x-cursor-vs-flip-atomic [113.537787] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s) [113.675088] [026/133] (907s left) kms_chamelium_frames (hdmi-crc-single) [114.075847] Subtest hdmi-crc-single: SKIP (0.000s) [114.887949] [027/133] (906s left) gem_exec_params (rel-constants-invalid-rel-gen5) [114.962679] Starting subtest: rel-constants-invalid-rel-gen5 [114.965223] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [115.050795] [028/133] (905s left) vgem_basic (dmabuf-mmap) [115.104212] Starting subtest: dmabuf-mmap [115.116051] Subtest dmabuf-mmap: SUCCESS (0.014s) [115.172056] [029/133] (905s left) gem_userptr_blits (readonly-unsync) [115.241312] Subtest readonly-unsync: SKIP (0.000s) [115.368900] [030/133] (905s left) gem_softpin (evict-active) [115.420580] Starting subtest: evict-active [115.427080] Subtest evict-active: SUCCESS (0.006s) [115.567502] [031/133] (905s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [115.668895] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [115.672943] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [115.750663] [032/133] (905s left) kms_pm_backlight (fade) [115.847454] Starting subtest: fade [115.895938] Starting dynamic subtest: eDP-1 [118.381625] Dynamic subtest eDP-1: SUCCESS (2.483s) [118.383938] Subtest fade: SUCCESS (2.534s) [119.253377] [033/133] (901s left) kms_big_fb (y-tiled-16bpp-rotate-270) [119.364179] Starting subtest: y-tiled-16bpp-rotate-270 [119.368352] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [119.449634] [034/133] (901s left) gem_ctx_persistence (smoketest) [119.514985] Starting subtest: smoketest [159.797209] Subtest smoketest: SUCCESS (40.280s) [159.872890] [035/133] (861s left) gem_exec_balancer (sequential) [159.938961] Starting subtest: sequential [162.999091] Subtest sequential: SUCCESS (3.062s) [163.319494] [036/133] (857s left) gem_wait (write-wait) [163.390698] Starting subtest: write-wait [163.393269] Starting dynamic subtest: all-engines [164.510479] Dynamic subtest all-engines: SUCCESS (1.120s) [164.527277] Starting dynamic subtest: rcs0 [165.573719] Dynamic subtest rcs0: SUCCESS (1.062s) [165.589419] Starting dynamic subtest: bcs0 [166.631267] Dynamic subtest bcs0: SUCCESS (1.057s) [166.646890] Starting dynamic subtest: vcs0 [167.685297] Dynamic subtest vcs0: SUCCESS (1.053s) [167.700875] Starting dynamic subtest: vcs1 [168.738939] Dynamic subtest vcs1: SUCCESS (1.052s) [168.754373] Starting dynamic subtest: vecs0 [169.792131] Dynamic subtest vecs0: SUCCESS (1.052s) [169.806257] Starting dynamic subtest: ccs0 [170.849518] Dynamic subtest ccs0: SUCCESS (1.056s) [170.852235] Subtest write-wait: SUCCESS (7.459s) [171.046015] [037/133] (850s left) kms_psr (fbc-psr2-suspend) [171.165116] Starting subtest: fbc-psr2-suspend [171.167471] Starting dynamic subtest: eDP-1 [171.171775] Dynamic subtest eDP-1: SKIP (0.000s) [171.176208] Subtest fbc-psr2-suspend: SKIP (0.001s) [171.241451] [038/133] (850s left) gen9_exec_parse (batch-without-end) [171.314260] Subtest batch-without-end: SKIP (0.000s) [171.381262] [039/133] (850s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [171.507392] Starting subtest: cursor-vs-flip-varying-size [202.770793] Subtest cursor-vs-flip-varying-size: SUCCESS (31.263s) [203.644049] [040/133] (817s left) dmabuf_sync_file (import-multiple-read-only) [203.696922] Starting subtest: import-multiple-read-only [203.699373] Subtest import-multiple-read-only: SUCCESS (0.004s) [203.752483] [041/133] (817s left) prime_mmap (test_map_unmap) [203.816231] Starting subtest: test_map_unmap [203.818190] Starting dynamic subtest: test_map_unmap-smem [203.846027] Dynamic subtest test_map_unmap-smem: SUCCESS (0.032s) [203.848394] Subtest test_map_unmap: SUCCESS (0.032s) [203.943302] [042/133] (817s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [204.051590] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [204.053794] Starting dynamic subtest: pipe-A-default-mode [205.214609] Dynamic subtest pipe-A-default-mode: SKIP (1.159s) [205.219096] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.160s) [205.357374] [043/133] (816s left) kms_plane (pixel-format-linear-modifier-source-clamping) [205.443194] Starting subtest: pixel-format-linear-modifier-source-clamping [205.470635] Starting dynamic subtest: pipe-A-plane-0 [209.047906] Dynamic subtest pipe-A-plane-0: SUCCESS (3.578s) [209.056395] Starting dynamic subtest: pipe-A-plane-3 [210.736791] Dynamic subtest pipe-A-plane-3: SUCCESS (1.688s) [211.860836] Starting dynamic subtest: pipe-B-plane-0 [215.516148] Dynamic subtest pipe-B-plane-0: SUCCESS (3.667s) [215.523910] Starting dynamic subtest: pipe-B-plane-3 [217.127081] Dynamic subtest pipe-B-plane-3: SUCCESS (1.609s) [217.437614] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (11.996s) [218.239748] [044/133] (803s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [218.335401] Starting subtest: psr-2p-scndscrn-cur-indfb-move [218.339361] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [218.433260] [045/133] (803s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [218.488554] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [218.595451] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [218.674313] [046/133] (802s left) gem_ctx_shared (q-in-order) [218.733490] Starting subtest: Q-in-order [218.735918] Starting dynamic subtest: rcs0 [218.841878] Dynamic subtest rcs0: SUCCESS (0.106s) [218.858221] Starting dynamic subtest: vcs0 [218.938430] Dynamic subtest vcs0: SUCCESS (0.097s) [218.954568] Starting dynamic subtest: vcs1 [219.018663] Dynamic subtest vcs1: SUCCESS (0.079s) [219.034653] Starting dynamic subtest: vecs0 [219.091844] Dynamic subtest vecs0: SUCCESS (0.073s) [219.107276] Starting dynamic subtest: ccs0 [219.173818] Dynamic subtest ccs0: SUCCESS (0.082s) [219.176309] Subtest Q-in-order: SUCCESS (0.441s) [220.985974] [047/133] (800s left) kms_getfb (getfb-repeated-different-handles) [221.082907] Starting subtest: getfb-repeated-different-handles [221.085193] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [221.177352] [048/133] (800s left) gem_mmap_wc (close) [221.228036] Subtest close: SKIP (0.000s) [221.288646] [049/133] (800s left) drm_read (invalid-buffer) [221.420304] Starting subtest: invalid-buffer [221.422646] Subtest invalid-buffer: SUCCESS (0.000s) [221.554368] [050/133] (800s left) kms_flip (plain-flip-interruptible) [221.649547] Starting subtest: plain-flip-interruptible [221.651837] Starting dynamic subtest: A-eDP1 [223.344255] Dynamic subtest A-eDP1: SUCCESS (1.694s) [223.354481] Starting dynamic subtest: B-eDP1 [224.958664] Dynamic subtest B-eDP1: SUCCESS (1.612s) [224.968611] Starting dynamic subtest: C-eDP1 [226.590098] Dynamic subtest C-eDP1: SUCCESS (1.630s) [226.601412] Starting dynamic subtest: D-eDP1 [228.233731] Dynamic subtest D-eDP1: SUCCESS (1.642s) [228.238931] Subtest plain-flip-interruptible: SUCCESS (6.590s) [229.397362] [051/133] (792s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [229.465694] Starting subtest: yf-tiled-to-vebox-x-tiled [229.470247] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [229.650097] [052/133] (792s left) kms_big_fb (4-tiled-64bpp-rotate-0) [229.749073] Starting subtest: 4-tiled-64bpp-rotate-0 [231.349812] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.602s) [231.506360] [053/133] (790s left) gem_create (create-ext-placement-all) [231.668880] Starting subtest: create-ext-placement-all [231.671807] Subtest create-ext-placement-all: SUCCESS (0.000s) [231.762529] [054/133] (790s left) gem_mmap_offset (partial-unmap) [231.828440] Starting subtest: partial-unmap [231.830692] Starting dynamic subtest: smem0 [232.304618] Dynamic subtest smem0: SUCCESS (0.476s) [232.307429] Subtest partial-unmap: SUCCESS (0.477s) [232.416768] [055/133] (789s left) gem_ctx_isolation (dirty-create) [232.467107] Starting subtest: dirty-create [232.469367] Starting dynamic subtest: rcs0 [232.648422] Dynamic subtest rcs0: SUCCESS (0.181s) [232.656656] Starting dynamic subtest: bcs0 [232.836257] Dynamic subtest bcs0: SUCCESS (0.187s) [232.847500] Starting dynamic subtest: vcs0 [233.032716] Dynamic subtest vcs0: SUCCESS (0.196s) [233.042266] Starting dynamic subtest: vcs1 [235.100519] Dynamic subtest vcs1: SUCCESS (2.067s) [235.110591] Starting dynamic subtest: vecs0 [237.089965] Dynamic subtest vecs0: SUCCESS (1.988s) [237.100291] Starting dynamic subtest: ccs0 [239.159028] Dynamic subtest ccs0: SUCCESS (2.067s) [239.161497] Subtest dirty-create: SUCCESS (6.692s) [239.383360] [056/133] (782s left) api_intel_bb (blit-reloc-purge-cache) [239.436894] Starting subtest: blit-reloc-purge-cache [239.441210] Subtest blit-reloc-purge-cache: SKIP (0.000s) [239.532971] [057/133] (782s left) vgem_basic (bad-fence) [239.576705] Starting subtest: bad-fence [239.578967] Subtest bad-fence: SUCCESS (0.000s) [239.631797] [058/133] (782s left) kms_flip (2x-blocking-absolute-wf_vblank) [239.730049] Starting subtest: 2x-blocking-absolute-wf_vblank [239.738722] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s) [239.815226] [059/133] (782s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [239.911468] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [239.913767] Starting dynamic subtest: pipe-A [239.932272] Dynamic subtest pipe-A: SKIP (0.018s) [239.941345] Starting dynamic subtest: pipe-B [239.964115] Dynamic subtest pipe-B: SKIP (0.030s) [239.972278] Starting dynamic subtest: pipe-C [239.994084] Dynamic subtest pipe-C: SKIP (0.031s) [240.001981] Starting dynamic subtest: pipe-D [240.024053] Dynamic subtest pipe-D: SKIP (0.030s) [240.027691] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.111s) [240.131687] [060/133] (782s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [240.222262] Starting subtest: primary-x-tiled-reflect-x-180 [247.189564] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.969s) [248.365930] [061/133] (773s left) syncobj_timeline (invalid-transfer-illegal-handle) [248.417966] Starting subtest: invalid-transfer-illegal-handle [248.420144] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [248.510044] [062/133] (773s left) kms_psr (fbc-pr-sprite-mmap-gtt) [248.620562] Starting subtest: fbc-pr-sprite-mmap-gtt [248.625042] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [248.695493] [063/133] (773s left) kms_psr (fbc-pr-primary-mmap-cpu) [248.796455] Starting subtest: fbc-pr-primary-mmap-cpu [248.800857] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [248.869812] [064/133] (773s left) gem_exec_nop (basic-parallel) [248.936666] Starting subtest: basic-parallel [264.856114] Subtest basic-parallel: SUCCESS (15.928s) [265.114569] [065/133] (757s left) syncobj_timeline (reset-multiple-signaled) [265.171141] Starting subtest: reset-multiple-signaled [265.173509] Subtest reset-multiple-signaled: SUCCESS (0.001s) [265.275563] [066/133] (757s left) gem_mmap_wc (read-write-distinct) [265.338141] Subtest read-write-distinct: SKIP (0.000s) [265.404202] [067/133] (757s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [265.515748] Starting subtest: plane-downscale-factor-0-75-with-rotation [265.518408] Starting dynamic subtest: pipe-A [265.758918] Dynamic subtest pipe-A: SUCCESS (0.244s) [265.769443] Starting dynamic subtest: pipe-B [267.035904] Dynamic subtest pipe-B: SUCCESS (1.276s) [267.050886] Starting dynamic subtest: pipe-C [268.367517] Dynamic subtest pipe-C: SUCCESS (1.330s) [268.375290] Starting dynamic subtest: pipe-D [269.715293] Dynamic subtest pipe-D: SUCCESS (1.347s) [269.717607] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.201s) [270.893532] [068/133] (751s left) gem_mmap_gtt (cpuset-big-copy-xy) [270.956641] Subtest cpuset-big-copy-XY: SKIP (0.000s) [271.034200] [069/133] (751s left) kms_universal_plane (universal-plane-sanity) [271.129146] Starting subtest: universal-plane-sanity [271.131422] Starting dynamic subtest: pipe-A-eDP-1 [271.739919] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s) [271.748974] Starting dynamic subtest: pipe-B-eDP-1 [273.001508] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s) [273.013782] Starting dynamic subtest: pipe-C-eDP-1 [274.205434] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s) [274.214733] Starting dynamic subtest: pipe-D-eDP-1 [275.439402] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s) [275.441829] Subtest universal-plane-sanity: SUCCESS (4.311s) [276.291052] [070/133] (746s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [276.395341] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [276.399491] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [276.501998] [071/133] (746s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [276.607413] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [280.640427] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.036s) [281.790679] [072/133] (740s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [281.888426] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [285.788999] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.905s) [286.993594] [073/133] (735s left) kms_scaling_modes (scaling-mode-full-aspect) [287.098321] Starting subtest: scaling-mode-full-aspect [287.100661] Starting dynamic subtest: pipe-A-eDP-1 [287.190773] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s) [287.204263] Starting dynamic subtest: pipe-B-eDP-1 [288.334900] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.143s) [288.345476] Starting dynamic subtest: pipe-C-eDP-1 [289.449889] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s) [289.458403] Starting dynamic subtest: pipe-D-eDP-1 [290.577582] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s) [290.579912] Subtest scaling-mode-full-aspect: SUCCESS (3.482s) [291.737869] [074/133] (731s left) kms_psr (psr2-sprite-render) [291.830094] Starting subtest: psr2-sprite-render [291.832370] Starting dynamic subtest: eDP-1 [293.528409] Dynamic subtest eDP-1: SUCCESS (1.697s) [293.530383] Subtest psr2-sprite-render: SUCCESS (1.698s) [294.399127] [075/133] (728s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs) [294.503727] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs [294.506125] Starting dynamic subtest: pipe-A-eDP-1 [294.529737] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [294.540057] Starting dynamic subtest: pipe-B-eDP-1 [294.561676] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [294.569140] Starting dynamic subtest: pipe-C-eDP-1 [294.590263] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [294.597828] Starting dynamic subtest: pipe-D-eDP-1 [294.619652] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [294.623880] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s) [296.759967] [076/133] (726s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [296.859212] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [296.863167] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [296.955545] [077/133] (725s left) kms_addfb_basic (bad-pitch-0) [297.009244] Starting subtest: bad-pitch-0 [297.011190] Subtest bad-pitch-0: SUCCESS (0.000s) [297.130885] [078/133] (725s left) gem_workarounds (basic-read) [297.191876] Starting subtest: basic-read [297.203847] Subtest basic-read: SUCCESS (0.010s) [297.321740] [079/133] (725s left) gem_exec_whisper (basic-fds-priority-all) [297.377917] Starting subtest: basic-fds-priority-all [320.150956] Subtest basic-fds-priority-all: SUCCESS (22.770s) [320.337315] [080/133] (702s left) kms_draw_crc (draw-method-mmap-wc) [320.435790] Starting subtest: draw-method-mmap-wc [320.437661] Starting dynamic subtest: xrgb8888-untiled [320.659207] Dynamic subtest xrgb8888-untiled: SUCCESS (0.225s) [320.668466] Starting dynamic subtest: rgb565-untiled [320.892525] Dynamic subtest rgb565-untiled: SUCCESS (0.233s) [320.900647] Starting dynamic subtest: xrgb2101010-untiled [321.092906] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s) [321.102312] Starting dynamic subtest: xbgr16161616f-untiled [321.314549] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [321.324675] Starting dynamic subtest: xrgb8888-xtiled [321.459128] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s) [321.467121] Starting dynamic subtest: rgb565-xtiled [321.592470] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [321.603010] Starting dynamic subtest: xrgb2101010-xtiled [321.714828] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [321.722602] Starting dynamic subtest: xbgr16161616f-xtiled [321.847868] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [321.856761] Starting dynamic subtest: xrgb8888-4tiled [322.003819] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s) [322.014704] Starting dynamic subtest: rgb565-4tiled [322.148118] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [322.156683] Starting dynamic subtest: xrgb2101010-4tiled [322.292795] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.143s) [322.303247] Starting dynamic subtest: xbgr16161616f-4tiled [322.470393] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s) [322.472432] Subtest draw-method-mmap-wc: SUCCESS (2.037s) [322.589859] [081/133] (700s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [322.677433] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [329.505276] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.830s) [329.625758] [082/133] (693s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [329.716415] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [329.720568] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [329.807368] [083/133] (693s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [329.913110] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [330.748531] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.837s) [331.009824] [084/133] (692s left) core_getstats (basic) [331.062203] Starting subtest: basic [331.064165] Subtest basic: SUCCESS (0.000s) [331.173319] [085/133] (692s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [331.269329] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [337.853054] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.586s) [337.954526] [086/133] (685s left) kms_atomic (atomic-plane-damage) [338.049119] Starting subtest: atomic-plane-damage [338.097469] Starting dynamic subtest: pipe-A-eDP-1 [338.639120] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s) [338.641662] Subtest atomic-plane-damage: SUCCESS (0.591s) [339.477314] [087/133] (683s left) kms_chamelium_color (ctm-max) [339.572453] Subtest ctm-max: SKIP (0.000s) [339.615607] [088/133] (683s left) gem_spin_batch (spin-all-new) [339.673683] Starting subtest: spin-all-new [339.688685] Subtest spin-all-new: SUCCESS (0.017s) [340.925652] [089/133] (682s left) kms_pipe_stress (stress-xrgb8888-ytiled) [341.029776] Starting subtest: stress-xrgb8888-ytiled [341.034124] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [341.100094] [090/133] (682s left) kms_plane_multiple (2x-tiling-x) [341.190167] Starting subtest: 2x-tiling-x [341.194460] Subtest 2x-tiling-x: SKIP (0.000s) [341.262365] [091/133] (682s left) perf (oa-formats) [341.390329] Starting subtest: oa-formats [341.392214] Starting dynamic subtest: 0-rcs0 [341.406784] Dynamic subtest 0-rcs0: SUCCESS (0.018s) [341.415623] Starting dynamic subtest: 1-vcs1 [341.428714] Dynamic subtest 1-vcs1: SUCCESS (0.021s) [341.431231] Subtest oa-formats: SUCCESS (0.040s) [341.479966] [092/133] (682s left) syncobj_timeline (wait-any-complex) [341.528738] Starting subtest: wait-any-complex [341.591352] Subtest wait-any-complex: SUCCESS (0.062s) [341.682382] [093/133] (681s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [341.768096] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [341.861278] [094/133] (681s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [341.944563] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [341.946557] Starting dynamic subtest: pipe-A-eDP-1 [341.966169] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [341.975040] Starting dynamic subtest: pipe-B-eDP-1 [341.992636] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [342.000151] Starting dynamic subtest: pipe-C-eDP-1 [342.017138] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [342.025151] Starting dynamic subtest: pipe-D-eDP-1 [342.042404] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s) [342.045862] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.009s) [344.128097] [095/133] (679s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt) [344.225864] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt [344.230114] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [344.352055] [096/133] (679s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [344.443976] Starting subtest: pr-overlay-plane-update-sf-dmg-area [344.448190] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [344.514166] [097/133] (679s left) gem_exec_fence (syncobj-timeline-invalid-wait) [345.110794] Starting subtest: syncobj-timeline-invalid-wait [345.113183] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s) [346.996430] [098/133] (676s left) gem_mmap_offset (ptrace) [347.059387] Starting subtest: ptrace [347.065055] Starting dynamic subtest: smem0-wb [347.078180] Dynamic subtest smem0-wb: SUCCESS (0.014s) [347.088815] Starting dynamic subtest: smem0-wc [347.101613] Dynamic subtest smem0-wc: SUCCESS (0.023s) [347.110156] Starting dynamic subtest: smem0-uc [347.122700] Dynamic subtest smem0-uc: SUCCESS (0.020s) [347.125082] Subtest ptrace: SUCCESS (0.066s) [347.221176] [099/133] (676s left) kms_vblank (wait-busy-hang) [347.316158] Starting subtest: wait-busy-hang [347.318424] Starting dynamic subtest: pipe-A-eDP-1 [373.662134] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.346s) [373.677241] Starting dynamic subtest: pipe-D-eDP-1 [388.683722] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.018s) [388.686169] Subtest wait-busy-hang: SUCCESS (41.369s) [389.498907] [100/133] (634s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [389.599427] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [396.384548] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.787s) [396.519108] [101/133] (627s left) kms_big_fb (x-tiled-32bpp-rotate-270) [396.615181] Starting subtest: x-tiled-32bpp-rotate-270 [396.634571] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s) [396.760467] [102/133] (627s left) gem_render_copy (linear-to-vebox-yf-tiled) [396.821285] Starting subtest: linear-to-vebox-yf-tiled [396.825571] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [397.010778] [103/133] (627s left) i915_hangman (gt-engine-hang) [397.073491] Starting subtest: gt-engine-hang [397.075480] Starting dynamic subtest: rcs0 [398.902457] Dynamic subtest rcs0: SUCCESS (1.828s) [398.914393] Starting dynamic subtest: bcs0 [400.884508] Dynamic subtest bcs0: SUCCESS (1.979s) [400.894886] Starting dynamic subtest: vcs0 [402.868624] Dynamic subtest vcs0: SUCCESS (1.982s) [402.879649] Starting dynamic subtest: vcs1 [404.852896] Dynamic subtest vcs1: SUCCESS (1.981s) [404.864437] Starting dynamic subtest: vecs0 [406.900064] Dynamic subtest vecs0: SUCCESS (2.045s) [406.909982] Starting dynamic subtest: ccs0 [408.885471] Dynamic subtest ccs0: SUCCESS (1.983s) [408.888062] Subtest gt-engine-hang: SUCCESS (11.814s) [408.965693] [104/133] (615s left) kms_addfb_basic (bad-pitch-32) [409.025941] Starting subtest: bad-pitch-32 [409.027871] Subtest bad-pitch-32: SUCCESS (0.000s) [409.172093] [105/133] (614s left) perf_pmu (semaphore-busy) [409.215495] Starting subtest: semaphore-busy [409.217607] Starting dynamic subtest: rcs0 [410.858847] Dynamic subtest rcs0: SUCCESS (1.641s) [410.869667] Starting dynamic subtest: bcs0 [412.488311] Dynamic subtest bcs0: SUCCESS (1.627s) [412.499336] Starting dynamic subtest: vcs0 [416.457660] Dynamic subtest vcs0: SUCCESS (3.912s) [416.468498] Starting dynamic subtest: vcs1 [422.417028] Dynamic subtest vcs1: SUCCESS (6.010s) [422.428592] Starting dynamic subtest: vecs0 [428.484782] Dynamic subtest vecs0: SUCCESS (6.014s) [428.495869] Starting dynamic subtest: ccs0 [431.509077] Dynamic subtest ccs0: SUCCESS (3.073s) [431.511918] Subtest semaphore-busy: SUCCESS (22.293s) [431.622194] [106/133] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [431.729274] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [431.733241] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [431.842589] [107/133] (592s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [431.948093] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [431.952526] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [432.044116] [108/133] (592s left) syncobj_timeline (host-signal-ordered) [432.099712] Starting subtest: host-signal-ordered [432.101991] Subtest host-signal-ordered: SUCCESS (0.000s) [432.196687] [109/133] (592s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [432.287170] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [432.291514] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [432.357043] [110/133] (591s left) syncobj_wait (wait-for-submit-complex) [432.417823] Starting subtest: wait-for-submit-complex [432.478435] Subtest wait-for-submit-complex: SUCCESS (0.062s) [432.558153] [111/133] (591s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [432.659282] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [433.594870] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.934s) [433.719240] [112/133] (590s left) gem_readwrite (write-bad-handle) [433.777320] Subtest write-bad-handle: SKIP (0.000s) [433.835800] [113/133] (590s left) i915_pm_rpm (system-suspend-devices) [436.009257] Starting subtest: system-suspend-devices [443.778207] Subtest system-suspend-devices: SUCCESS (7.772s) [444.164231] [114/133] (580s left) kms_psr (fbc-psr-sprite-render) [444.285336] Starting subtest: fbc-psr-sprite-render [444.287729] Starting dynamic subtest: eDP-1 [444.292156] Dynamic subtest eDP-1: SKIP (0.000s) [444.296518] Subtest fbc-psr-sprite-render: SKIP (0.001s) [444.358317] [115/133] (580s left) kms_pm_rpm (modeset-non-lpsp-stress) [446.080889] Starting subtest: modeset-non-lpsp-stress [447.248195] Subtest modeset-non-lpsp-stress: SKIP (1.167s) [447.614174] [116/133] (576s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [447.719368] Starting subtest: 2x-wf_vblank-ts-check-interruptible [447.730087] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [447.806783] [117/133] (576s left) gem_ctx_bad_destroy (invalid-ctx) [447.858633] Starting subtest: invalid-ctx [447.860740] Subtest invalid-ctx: SUCCESS (0.000s) [447.969254] [118/133] (576s left) gem_render_copy_redux (flink-interruptible) [448.031164] Starting subtest: flink-interruptible [448.801562] Subtest flink-interruptible: SUCCESS (0.771s) [448.927684] [119/133] (575s left) gem_exec_reloc (basic-gtt-cpu-active) [448.975725] Subtest basic-gtt-cpu-active: SKIP (0.000s) [449.042661] [120/133] (575s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [449.139160] Starting subtest: fbcpsr-rgb101010-draw-blt [455.848083] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.710s) [455.984952] [121/133] (568s left) i915_selftest (perf) [457.769806] Starting subtest: perf [457.772449] Starting dynamic subtest: engine_cs [460.441369] Dynamic subtest engine_cs: SUCCESS (2.671s) [460.451736] Starting dynamic subtest: request [465.686973] Dynamic subtest request: SUCCESS (5.244s) [465.697171] Starting dynamic subtest: migrate [470.014386] Dynamic subtest migrate: SUCCESS (4.326s) [470.030324] Starting dynamic subtest: region [475.970952] Dynamic subtest region: SUCCESS (5.955s) [475.973602] Subtest perf: SUCCESS (18.202s) [476.003902] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [476.004622] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [476.007773] [122/133] (548s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [477.599739] Starting subtest: short-flip-before-cursor-toggle [478.546247] Subtest short-flip-before-cursor-toggle: SUCCESS (0.944s) [479.463329] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [479.466235] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true [479.470931] [123/133] (545s left) gem_fence_thrash (bo-write-verify-x) [479.510456] Starting subtest: bo-write-verify-x [479.533244] Subtest bo-write-verify-x: SKIP (0.021s) [479.607186] [124/133] (545s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [479.699543] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [479.703722] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [479.800558] [125/133] (545s left) kms_cursor_crc (cursor-offscreen-64x21) [480.001841] Starting subtest: cursor-offscreen-64x21 [480.056579] Subtest cursor-offscreen-64x21: SKIP (0.052s) [480.279915] [126/133] (544s left) perf_pmu (busy-accuracy-2) [480.319322] Starting subtest: busy-accuracy-2 [480.321260] Starting dynamic subtest: rcs0 [483.360197] Dynamic subtest rcs0: SUCCESS (3.040s) [483.371724] Starting dynamic subtest: bcs0 [486.474674] Dynamic subtest bcs0: SUCCESS (3.061s) [486.488137] Starting dynamic subtest: vcs0 [489.518937] Dynamic subtest vcs0: SUCCESS (3.044s) [489.529655] Starting dynamic subtest: vcs1 [492.566906] Dynamic subtest vcs1: SUCCESS (3.045s) [492.576484] Starting dynamic subtest: vecs0 [495.615578] Dynamic subtest vecs0: SUCCESS (3.045s) [495.627909] Starting dynamic subtest: ccs0 [498.677258] Dynamic subtest ccs0: SUCCESS (3.059s) [498.679620] Subtest busy-accuracy-2: SUCCESS (18.309s) [498.741651] [127/133] (526s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [498.846750] Starting subtest: fbc-indfb-scaledprimary [501.799642] Subtest fbc-indfb-scaledprimary: SUCCESS (2.956s) [502.913344] [128/133] (522s left) gem_exec_balancer (hang) [503.188869] Starting subtest: hang [504.929786] Subtest hang: SUCCESS (1.743s) [505.053307] [129/133] (520s left) perf_pmu (busy-idle-no-semaphores) [505.097343] Starting subtest: busy-idle-no-semaphores [505.099287] Starting dynamic subtest: rcs0 [505.766599] Dynamic subtest rcs0: SUCCESS (0.668s) [505.779977] Starting dynamic subtest: bcs0 [506.423572] Dynamic subtest bcs0: SUCCESS (0.654s) [506.435574] Starting dynamic subtest: vcs0 [507.080570] Dynamic subtest vcs0: SUCCESS (0.653s) [507.091439] Starting dynamic subtest: vcs1 [508.480404] Dynamic subtest vcs1: SUCCESS (1.398s) [508.492255] Starting dynamic subtest: vecs0 [510.527457] Dynamic subtest vecs0: SUCCESS (2.044s) [510.539192] Starting dynamic subtest: ccs0 [512.514252] Dynamic subtest ccs0: SUCCESS (1.984s) [512.517050] Subtest busy-idle-no-semaphores: SUCCESS (7.417s) [512.629566] [130/133] (512s left) gem_exec_params (invalid-ring2) [512.695271] Starting subtest: invalid-ring2 [512.697686] Subtest invalid-ring2: SUCCESS (0.000s) [512.804077] [131/133] (512s left) gem_exec_schedule (pi-ringfull) [512.988931] Starting subtest: pi-ringfull [512.991341] Starting dynamic subtest: rcs0 [513.018750] Dynamic subtest rcs0: SUCCESS (0.033s) [513.027937] Starting dynamic subtest: bcs0 [513.051945] Dynamic subtest bcs0: SUCCESS (0.032s) [513.060585] Starting dynamic subtest: vcs0 [513.084088] Dynamic subtest vcs0: SUCCESS (0.032s) [513.092688] Starting dynamic subtest: vcs1 [513.113665] Dynamic subtest vcs1: SUCCESS (0.029s) [513.122397] Starting dynamic subtest: vecs0 [513.148033] Dynamic subtest vecs0: SUCCESS (0.033s) [513.156859] Starting dynamic subtest: ccs0 [513.178927] Dynamic subtest ccs0: SUCCESS (0.030s) [513.181190] Subtest pi-ringfull: SUCCESS (0.194s) [513.416601] [132/133] (511s left) kms_dp_link_training (non-uhbr-sst) [513.513275] Starting subtest: non-uhbr-sst [513.522188] Subtest non-uhbr-sst: SKIP (0.000s) [513.589709] [133/133] (511s left) gem_exec_flush (basic-wb-set-default) [513.660494] Starting subtest: basic-wb-set-default [519.146096] Subtest basic-wb-set-default: SUCCESS (5.456s) [519.302906] Closing watchdogs results: parsing output: 0/ for test: kms_ccs results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_cursor_crc results: parsing output: 3/ for test: kms_async_flips results: parsing output: 4/ for test: kms_content_protection results: parsing output: 5/ for test: kms_chamelium_hpd results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: syncobj_timeline results: parsing output: 8/ for test: kms_cursor_legacy results: parsing output: 9/ for test: kms_color_pipeline results: parsing output: 10/ for test: gem_lmem_swapping results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: gen3_render_linear_blits results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: kms_cursor_crc results: parsing output: 16/ for test: gem_exec_schedule results: parsing output: 17/ for test: gem_softpin results: parsing output: 18/ for test: i915_drm_fdinfo results: parsing output: 19/ for test: kms_lease results: parsing output: 20/ for test: prime_vgem results: parsing output: 21/ for test: gem_exec_schedule results: parsing output: 22/ for test: kms_joiner results: parsing output: 23/ for test: gem_shrink results: parsing output: 24/ for test: kms_cursor_legacy results: parsing output: 25/ for test: kms_chamelium_frames results: parsing output: 26/ for test: gem_exec_params results: parsing output: 27/ for test: vgem_basic results: parsing output: 28/ for test: gem_userptr_blits results: parsing output: 29/ for test: gem_softpin results: parsing output: 30/ for test: kms_flip_scaled_crc results: parsing output: 31/ for test: kms_pm_backlight results: parsing output: 32/ for test: kms_big_fb results: parsing output: 33/ for test: gem_ctx_persistence results: parsing output: 34/ for test: gem_exec_balancer results: parsing output: 35/ for test: gem_wait results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: gen9_exec_parse results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: dmabuf_sync_file results: parsing output: 40/ for test: prime_mmap results: parsing output: 41/ for test: kms_flip_scaled_crc results: parsing output: 42/ for test: kms_plane results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: syncobj_wait results: parsing output: 45/ for test: gem_ctx_shared results: parsing output: 46/ for test: kms_getfb results: parsing output: 47/ for test: gem_mmap_wc results: parsing output: 48/ for test: drm_read results: parsing output: 49/ for test: kms_flip results: parsing output: 50/ for test: gem_render_copy results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: gem_create results: parsing output: 53/ for test: gem_mmap_offset results: parsing output: 54/ for test: gem_ctx_isolation results: parsing output: 55/ for test: api_intel_bb results: parsing output: 56/ for test: vgem_basic results: parsing output: 57/ for test: kms_flip results: parsing output: 58/ for test: kms_plane_scaling results: parsing output: 59/ for test: kms_rotation_crc results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_psr results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: gem_exec_nop results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: gem_mmap_wc results: parsing output: 66/ for test: kms_plane_scaling results: parsing output: 67/ for test: gem_mmap_gtt results: parsing output: 68/ for test: kms_universal_plane results: parsing output: 69/ for test: kms_big_fb results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_scaling_modes results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: kms_ccs results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: gem_workarounds results: parsing output: 78/ for test: gem_exec_whisper results: parsing output: 79/ for test: kms_draw_crc results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: core_getstats results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_atomic results: parsing output: 86/ for test: kms_chamelium_color results: parsing output: 87/ for test: gem_spin_batch results: parsing output: 88/ for test: kms_pipe_stress results: parsing output: 89/ for test: kms_plane_multiple results: parsing output: 90/ for test: perf results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: kms_addfb_basic results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_psr2_sf results: parsing output: 96/ for test: gem_exec_fence results: parsing output: 97/ for test: gem_mmap_offset results: parsing output: 98/ for test: kms_vblank results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_big_fb results: parsing output: 101/ for test: gem_render_copy results: parsing output: 102/ for test: i915_hangman results: parsing output: 103/ for test: kms_addfb_basic results: parsing output: 104/ for test: perf_pmu results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: syncobj_timeline results: parsing output: 108/ for test: kms_psr2_sf results: parsing output: 109/ for test: syncobj_wait results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: gem_readwrite results: parsing output: 112/ for test: i915_pm_rpm results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: kms_pm_rpm results: parsing output: 115/ for test: kms_flip results: parsing output: 116/ for test: gem_ctx_bad_destroy results: parsing output: 117/ for test: gem_render_copy_redux results: parsing output: 118/ for test: gem_exec_reloc results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: i915_selftest results: parsing output: 121/ for test: kms_cursor_legacy results: parsing output: 122/ for test: gem_fence_thrash results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: perf_pmu results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: gem_exec_balancer results: parsing output: 128/ for test: perf_pmu results: parsing output: 129/ for test: gem_exec_params results: parsing output: 130/ for test: gem_exec_schedule results: parsing output: 131/ for test: kms_dp_link_training results: parsing output: 132/ for test: gem_exec_flush Done.