[58.991741] Initializing watchdogs [58.991790] /dev/watchdog0 [59.007341] [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.012325] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.014904] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.016921] [001/133] (960s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [59.117095] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [59.118732] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [60.238335] [002/133] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [60.321923] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [60.323883] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [60.405011] [003/133] (959s left) kms_cursor_crc (cursor-tearing-position-change) [60.512757] Starting subtest: cursor-tearing-position-change [60.513883] Starting dynamic subtest: pipe-A-eDP-1 [61.102919] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s) [61.108758] Starting dynamic subtest: pipe-D-eDP-1 [62.387861] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.279s) [62.388869] Subtest cursor-tearing-position-change: SUCCESS (1.868s) [63.214340] [004/133] (956s left) kms_async_flips (crc) [63.304557] Starting subtest: crc [63.684201] Starting dynamic subtest: pipe-A-eDP-1 [66.563917] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.873s) [66.951107] Starting dynamic subtest: pipe-B-eDP-1 [69.897764] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.950s) [70.292115] Starting dynamic subtest: pipe-C-eDP-1 [73.218473] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.929s) [73.584549] Starting dynamic subtest: pipe-D-eDP-1 [76.438354] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.858s) [76.439415] Subtest crc: SUCCESS (13.117s) [77.606923] [005/133] (942s left) kms_content_protection (content-type-change) [77.746985] Starting subtest: content-type-change [77.748792] Subtest content-type-change: SKIP (0.000s) [77.850716] [006/133] (941s left) kms_chamelium_hpd (common-hpd-after-suspend) [78.264796] Subtest common-hpd-after-suspend: SKIP (0.000s) [79.033820] [007/133] (940s left) fbdev (eof) [79.070856] Starting subtest: eof [79.071735] Subtest eof: SUCCESS (0.000s) [79.131831] [008/133] (940s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [79.181303] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [79.300904] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.108s) [79.369835] [009/133] (940s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [79.489777] Starting subtest: cursorA-vs-flipA-atomic [90.619455] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.124s) [91.496340] [010/133] (928s left) kms_color_pipeline (plane-ctm3x4-lut1d) [91.594860] Starting subtest: plane-ctm3x4-lut1d [91.742826] Starting dynamic subtest: pipe-A-plane-0 [91.931512] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s) [91.938865] Starting dynamic subtest: pipe-A-plane-1 [92.087075] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s) [92.094150] Starting dynamic subtest: pipe-A-plane-2 [92.254056] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [93.414636] Starting dynamic subtest: pipe-B-plane-0 [93.585474] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [93.592989] Starting dynamic subtest: pipe-B-plane-1 [93.729926] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s) [93.736943] Starting dynamic subtest: pipe-B-plane-2 [93.896681] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [95.034850] Starting dynamic subtest: pipe-C-plane-0 [95.183718] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [95.192536] Starting dynamic subtest: pipe-C-plane-1 [95.339104] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [95.347192] Starting dynamic subtest: pipe-C-plane-2 [95.495287] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [96.686866] Starting dynamic subtest: pipe-D-plane-0 [96.846789] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s) [96.854035] Starting dynamic subtest: pipe-D-plane-1 [96.991119] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s) [96.997777] Starting dynamic subtest: pipe-D-plane-2 [97.146751] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [97.430942] Subtest plane-ctm3x4-lut1d: SUCCESS (5.835s) [98.244196] [011/133] (921s left) gem_lmem_swapping (heavy-verify-multi) [98.283593] Subtest heavy-verify-multi: SKIP (0.000s) [98.314958] [012/133] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [98.395554] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [98.397069] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [98.487464] [013/133] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [98.572939] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [98.574831] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [98.665047] [014/133] (921s left) gen3_render_linear_blits [98.761968] [015/133] (921s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [98.852808] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [98.853674] Starting dynamic subtest: pipe-A-eDP-1 [98.876904] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [98.887358] Starting dynamic subtest: pipe-B-eDP-1 [98.909424] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [98.915991] Starting dynamic subtest: pipe-C-eDP-1 [98.936803] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [98.942895] Starting dynamic subtest: pipe-D-eDP-1 [98.963657] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [98.965238] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s) [101.094571] [016/133] (918s left) kms_cursor_crc (cursor-rapid-movement-128x42) [101.327743] Starting subtest: cursor-rapid-movement-128x42 [101.373467] Subtest cursor-rapid-movement-128x42: SKIP (0.044s) [101.597682] [017/133] (918s left) gem_exec_schedule (fifo) [101.665266] Starting subtest: fifo [101.666178] Starting dynamic subtest: rcs0 [101.759977] Dynamic subtest rcs0: SUCCESS (0.094s) [101.769126] Starting dynamic subtest: vcs0 [101.850735] Dynamic subtest vcs0: SUCCESS (0.091s) [101.860458] Starting dynamic subtest: vcs1 [101.944850] Dynamic subtest vcs1: SUCCESS (0.093s) [101.954398] Starting dynamic subtest: vecs0 [102.023422] Dynamic subtest vecs0: SUCCESS (0.078s) [102.034026] Starting dynamic subtest: ccs0 [102.109793] Dynamic subtest ccs0: SUCCESS (0.086s) [102.111414] Subtest fifo: SUCCESS (0.445s) [103.013694] [018/133] (917s left) gem_softpin (noreloc) [103.078069] Starting subtest: noreloc [108.543486] Subtest noreloc: SUCCESS (5.419s) [108.622419] [019/133] (911s left) i915_drm_fdinfo (virtual-busy-hang) [108.655971] Starting subtest: virtual-busy-hang [108.657828] Subtest virtual-busy-hang: SKIP (0.000s) [108.720939] [020/133] (911s left) kms_lease (master-vs-lease) [108.813814] Starting subtest: master-vs-lease [108.816442] Subtest master-vs-lease: SUCCESS (0.001s) [108.919099] [021/133] (911s left) prime_vgem (basic-gtt) [109.050148] Starting subtest: basic-gtt [109.051864] Subtest basic-gtt: SKIP (0.000s) [109.136712] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true [109.138405] [022/133] (911s left) gem_exec_schedule (u-semaphore-resolve) [109.205970] Starting subtest: u-semaphore-resolve [109.243478] Subtest u-semaphore-resolve: SUCCESS (0.037s) [109.582043] [023/133] (910s left) kms_joiner (invalid-modeset-force-big-joiner) [109.675302] Starting subtest: invalid-modeset-force-big-joiner [109.677043] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [109.737694] [024/133] (910s left) gem_shrink (reclaim) [109.790998] Starting subtest: reclaim [112.263169] Subtest reclaim: SUCCESS (2.464s) [112.404056] [025/133] (907s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [112.520701] Starting subtest: 2x-cursor-vs-flip-atomic [112.523327] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s) [112.663932] [026/133] (907s left) kms_chamelium_frames (hdmi-crc-single) [113.065480] Subtest hdmi-crc-single: SKIP (0.000s) [113.909941] [027/133] (906s left) gem_exec_params (rel-constants-invalid-rel-gen5) [113.964408] Starting subtest: rel-constants-invalid-rel-gen5 [113.965487] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [114.060444] [028/133] (906s left) vgem_basic (dmabuf-mmap) [114.105306] Starting subtest: dmabuf-mmap [114.112801] Subtest dmabuf-mmap: SUCCESS (0.008s) [114.160191] [029/133] (906s left) gem_userptr_blits (readonly-unsync) [114.224998] Subtest readonly-unsync: SKIP (0.000s) [114.341159] [030/133] (906s left) gem_softpin (evict-active) [114.396018] Starting subtest: evict-active [114.402989] Subtest evict-active: SUCCESS (0.007s) [114.533250] [031/133] (905s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [114.626202] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [114.627855] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [114.692203] [032/133] (905s left) kms_pm_backlight (fade) [114.785123] Starting subtest: fade [114.836046] Starting dynamic subtest: eDP-1 [117.326778] Dynamic subtest eDP-1: SUCCESS (2.490s) [117.327782] Subtest fade: SUCCESS (2.542s) [118.164567] [033/133] (902s left) kms_big_fb (y-tiled-16bpp-rotate-270) [118.263270] Starting subtest: y-tiled-16bpp-rotate-270 [118.264994] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [118.356135] [034/133] (902s left) gem_ctx_persistence (smoketest) [118.420309] Starting subtest: smoketest [158.844695] Subtest smoketest: SUCCESS (40.414s) [158.910537] [035/133] (861s left) gem_exec_balancer (sequential) [158.971776] Starting subtest: sequential [162.150344] Subtest sequential: SUCCESS (3.178s) [162.497615] [036/133] (858s left) gem_wait (write-wait) [162.555058] Starting subtest: write-wait [162.556009] Starting dynamic subtest: all-engines [163.667937] Dynamic subtest all-engines: SUCCESS (1.112s) [163.686834] Starting dynamic subtest: rcs0 [164.728665] Dynamic subtest rcs0: SUCCESS (1.059s) [164.743746] Starting dynamic subtest: bcs0 [165.787370] Dynamic subtest bcs0: SUCCESS (1.057s) [165.803904] Starting dynamic subtest: vcs0 [166.841850] Dynamic subtest vcs0: SUCCESS (1.053s) [166.858849] Starting dynamic subtest: vcs1 [167.899051] Dynamic subtest vcs1: SUCCESS (1.056s) [167.913783] Starting dynamic subtest: vecs0 [168.955154] Dynamic subtest vecs0: SUCCESS (1.055s) [168.971094] Starting dynamic subtest: ccs0 [170.012896] Dynamic subtest ccs0: SUCCESS (1.056s) [170.013999] Subtest write-wait: SUCCESS (7.458s) [170.208031] [037/133] (850s left) kms_psr (fbc-psr2-suspend) [170.304178] Starting subtest: fbc-psr2-suspend [170.305196] Starting dynamic subtest: eDP-1 [170.307191] Dynamic subtest eDP-1: SKIP (0.000s) [170.309066] Subtest fbc-psr2-suspend: SKIP (0.001s) [170.389156] [038/133] (850s left) gen9_exec_parse (batch-without-end) [170.447363] Subtest batch-without-end: SKIP (0.000s) [170.514565] [039/133] (850s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [170.623496] Starting subtest: cursor-vs-flip-varying-size [202.117336] Subtest cursor-vs-flip-varying-size: SUCCESS (31.492s) [202.920191] [040/133] (817s left) dmabuf_sync_file (import-multiple-read-only) [202.965796] Starting subtest: import-multiple-read-only [202.969090] Subtest import-multiple-read-only: SUCCESS (0.004s) [203.023222] [041/133] (817s left) prime_mmap (test_map_unmap) [203.073158] Starting subtest: test_map_unmap [203.074035] Starting dynamic subtest: test_map_unmap-smem [203.108089] Dynamic subtest test_map_unmap-smem: SUCCESS (0.035s) [203.109255] Subtest test_map_unmap: SUCCESS (0.036s) [203.224728] [042/133] (817s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [203.320029] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [203.321138] Starting dynamic subtest: pipe-A-default-mode [204.484400] Dynamic subtest pipe-A-default-mode: SKIP (1.164s) [204.486212] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.165s) [204.616320] [043/133] (816s left) kms_plane (pixel-format-linear-modifier-source-clamping) [204.705043] Starting subtest: pixel-format-linear-modifier-source-clamping [204.732286] Starting dynamic subtest: pipe-A-plane-0 [208.243655] Dynamic subtest pipe-A-plane-0: SUCCESS (3.511s) [208.251308] Starting dynamic subtest: pipe-A-plane-3 [209.865993] Dynamic subtest pipe-A-plane-3: SUCCESS (1.622s) [210.941291] Starting dynamic subtest: pipe-B-plane-0 [214.423267] Dynamic subtest pipe-B-plane-0: SUCCESS (3.489s) [214.431192] Starting dynamic subtest: pipe-B-plane-3 [216.090100] Dynamic subtest pipe-B-plane-3: SUCCESS (1.665s) [216.398901] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (11.694s) [217.225634] [044/133] (803s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [217.334150] Starting subtest: psr-2p-scndscrn-cur-indfb-move [217.335867] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [217.421384] [045/133] (803s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [217.472549] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [217.577717] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [217.661547] [046/133] (803s left) gem_ctx_shared (q-in-order) [217.723142] Starting subtest: Q-in-order [217.724108] Starting dynamic subtest: rcs0 [217.831637] Dynamic subtest rcs0: SUCCESS (0.108s) [217.839491] Starting dynamic subtest: vcs0 [217.920603] Dynamic subtest vcs0: SUCCESS (0.088s) [217.935583] Starting dynamic subtest: vcs1 [218.002510] Dynamic subtest vcs1: SUCCESS (0.081s) [218.019463] Starting dynamic subtest: vecs0 [218.082643] Dynamic subtest vecs0: SUCCESS (0.080s) [218.098535] Starting dynamic subtest: ccs0 [218.163912] Dynamic subtest ccs0: SUCCESS (0.081s) [218.165131] Subtest Q-in-order: SUCCESS (0.442s) [220.001948] [047/133] (801s left) kms_getfb (getfb-repeated-different-handles) [220.103211] Starting subtest: getfb-repeated-different-handles [220.104154] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [220.200784] [048/133] (800s left) gem_mmap_wc (close) [220.257769] Subtest close: SKIP (0.000s) [220.307167] [049/133] (800s left) drm_read (invalid-buffer) [220.449640] Starting subtest: invalid-buffer [220.450645] Subtest invalid-buffer: SUCCESS (0.000s) [220.561398] [050/133] (800s left) kms_flip (plain-flip-interruptible) [220.643925] Starting subtest: plain-flip-interruptible [220.645391] Starting dynamic subtest: A-eDP1 [222.312325] Dynamic subtest A-eDP1: SUCCESS (1.667s) [222.320562] Starting dynamic subtest: B-eDP1 [223.946251] Dynamic subtest B-eDP1: SUCCESS (1.631s) [223.954868] Starting dynamic subtest: C-eDP1 [225.567164] Dynamic subtest C-eDP1: SUCCESS (1.619s) [225.578818] Starting dynamic subtest: D-eDP1 [227.203341] Dynamic subtest D-eDP1: SUCCESS (1.632s) [227.204409] Subtest plain-flip-interruptible: SUCCESS (6.560s) [228.378953] [051/133] (792s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [228.434407] Starting subtest: yf-tiled-to-vebox-x-tiled [228.436204] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [228.608781] [052/133] (792s left) kms_big_fb (4-tiled-64bpp-rotate-0) [228.702590] Starting subtest: 4-tiled-64bpp-rotate-0 [230.403865] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.702s) [230.563585] [053/133] (790s left) gem_create (create-ext-placement-all) [230.731264] Starting subtest: create-ext-placement-all [230.732412] Subtest create-ext-placement-all: SUCCESS (0.000s) [230.871517] [054/133] (790s left) gem_mmap_offset (partial-unmap) [230.934908] Starting subtest: partial-unmap [230.935850] Starting dynamic subtest: smem0 [231.453759] Dynamic subtest smem0: SUCCESS (0.509s) [231.455195] Subtest partial-unmap: SUCCESS (0.510s) [231.560891] [055/133] (789s left) gem_ctx_isolation (dirty-create) [231.618428] Starting subtest: dirty-create [231.619252] Starting dynamic subtest: rcs0 [231.800176] Dynamic subtest rcs0: SUCCESS (0.183s) [231.809632] Starting dynamic subtest: bcs0 [231.999631] Dynamic subtest bcs0: SUCCESS (0.198s) [232.009104] Starting dynamic subtest: vcs0 [232.167499] Dynamic subtest vcs0: SUCCESS (0.167s) [232.176865] Starting dynamic subtest: vcs1 [234.152679] Dynamic subtest vcs1: SUCCESS (1.984s) [234.161578] Starting dynamic subtest: vecs0 [236.128934] Dynamic subtest vecs0: SUCCESS (1.975s) [236.137840] Starting dynamic subtest: ccs0 [238.129844] Dynamic subtest ccs0: SUCCESS (2.000s) [238.130858] Subtest dirty-create: SUCCESS (6.513s) [238.351170] [056/133] (783s left) api_intel_bb (blit-reloc-purge-cache) [238.401388] Starting subtest: blit-reloc-purge-cache [238.403080] Subtest blit-reloc-purge-cache: SKIP (0.001s) [238.502908] [057/133] (782s left) vgem_basic (bad-fence) [238.543623] Starting subtest: bad-fence [238.544641] Subtest bad-fence: SUCCESS (0.000s) [238.601857] [058/133] (782s left) kms_flip (2x-blocking-absolute-wf_vblank) [238.694948] Starting subtest: 2x-blocking-absolute-wf_vblank [238.706024] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s) [238.792754] [059/133] (782s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [238.878532] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [238.879459] Starting dynamic subtest: pipe-A [238.900117] Dynamic subtest pipe-A: SKIP (0.019s) [238.907356] Starting dynamic subtest: pipe-B [238.933940] Dynamic subtest pipe-B: SKIP (0.033s) [238.940760] Starting dynamic subtest: pipe-C [238.967397] Dynamic subtest pipe-C: SKIP (0.034s) [238.974304] Starting dynamic subtest: pipe-D [239.001922] Dynamic subtest pipe-D: SKIP (0.033s) [239.003794] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.122s) [239.089342] [060/133] (782s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [239.178607] Starting subtest: primary-x-tiled-reflect-x-180 [246.125037] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.947s) [247.326011] [061/133] (774s left) syncobj_timeline (invalid-transfer-illegal-handle) [247.388737] Starting subtest: invalid-transfer-illegal-handle [247.389683] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [247.504418] [062/133] (774s left) kms_psr (fbc-pr-sprite-mmap-gtt) [247.581261] Starting subtest: fbc-pr-sprite-mmap-gtt [247.583063] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [247.663635] [063/133] (773s left) kms_psr (fbc-pr-primary-mmap-cpu) [247.764508] Starting subtest: fbc-pr-primary-mmap-cpu [247.766262] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [247.870188] [064/133] (773s left) gem_exec_nop (basic-parallel) [247.949304] Starting subtest: basic-parallel [262.943451] Subtest basic-parallel: SUCCESS (14.986s) [263.151530] [065/133] (758s left) syncobj_timeline (reset-multiple-signaled) [263.214796] Starting subtest: reset-multiple-signaled [263.215919] Subtest reset-multiple-signaled: SUCCESS (0.000s) [263.313443] [066/133] (758s left) gem_mmap_wc (read-write-distinct) [263.380751] Subtest read-write-distinct: SKIP (0.000s) [263.434144] [067/133] (758s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [263.522927] Starting subtest: plane-downscale-factor-0-75-with-rotation [263.523965] Starting dynamic subtest: pipe-A [263.753768] Dynamic subtest pipe-A: SUCCESS (0.230s) [263.760770] Starting dynamic subtest: pipe-B [265.011905] Dynamic subtest pipe-B: SUCCESS (1.257s) [265.018997] Starting dynamic subtest: pipe-C [266.343702] Dynamic subtest pipe-C: SUCCESS (1.331s) [266.351089] Starting dynamic subtest: pipe-D [267.672663] Dynamic subtest pipe-D: SUCCESS (1.328s) [267.673595] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.150s) [268.857586] [068/133] (752s left) gem_mmap_gtt (cpuset-big-copy-xy) [268.914958] Subtest cpuset-big-copy-XY: SKIP (0.000s) [268.971615] [069/133] (752s left) kms_universal_plane (universal-plane-sanity) [269.063545] Starting subtest: universal-plane-sanity [269.064504] Starting dynamic subtest: pipe-A-eDP-1 [269.667486] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s) [269.675846] Starting dynamic subtest: pipe-B-eDP-1 [270.887498] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.218s) [270.894824] Starting dynamic subtest: pipe-C-eDP-1 [272.096260] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s) [272.103072] Starting dynamic subtest: pipe-D-eDP-1 [273.321193] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s) [273.322052] Subtest universal-plane-sanity: SUCCESS (4.260s) [274.181770] [070/133] (747s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [274.286196] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [274.287903] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [274.380065] [071/133] (747s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [274.480634] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [278.580642] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.101s) [279.776241] [072/133] (742s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [279.873120] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [283.817069] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.944s) [284.973161] [073/133] (737s left) kms_scaling_modes (scaling-mode-full-aspect) [285.069223] Starting subtest: scaling-mode-full-aspect [285.070082] Starting dynamic subtest: pipe-A-eDP-1 [285.165227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s) [285.179643] Starting dynamic subtest: pipe-B-eDP-1 [286.296420] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s) [286.304577] Starting dynamic subtest: pipe-C-eDP-1 [287.423336] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s) [287.433191] Starting dynamic subtest: pipe-D-eDP-1 [288.536089] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.109s) [288.536977] Subtest scaling-mode-full-aspect: SUCCESS (3.468s) [289.688753] [074/133] (732s left) kms_psr (psr2-sprite-render) [289.780924] Starting subtest: psr2-sprite-render [289.781729] Starting dynamic subtest: eDP-1 [291.519422] Dynamic subtest eDP-1: SUCCESS (1.737s) [291.520366] Subtest psr2-sprite-render: SUCCESS (1.738s) [292.369544] [075/133] (729s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs) [292.463605] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs [292.464538] Starting dynamic subtest: pipe-A-eDP-1 [292.476335] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [292.483906] Starting dynamic subtest: pipe-B-eDP-1 [292.492404] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [292.499379] Starting dynamic subtest: pipe-C-eDP-1 [292.507336] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [292.513907] Starting dynamic subtest: pipe-D-eDP-1 [292.522401] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [292.523903] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s) [294.754089] [076/133] (727s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [294.841484] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [294.843238] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [294.924773] [077/133] (727s left) kms_addfb_basic (bad-pitch-0) [294.976342] Starting subtest: bad-pitch-0 [294.977296] Subtest bad-pitch-0: SUCCESS (0.000s) [295.108914] [078/133] (727s left) gem_workarounds (basic-read) [295.171472] Starting subtest: basic-read [295.182854] Subtest basic-read: SUCCESS (0.011s) [295.304768] [079/133] (726s left) gem_exec_whisper (basic-fds-priority-all) [295.364398] Starting subtest: basic-fds-priority-all [317.114026] Subtest basic-fds-priority-all: SUCCESS (21.737s) [317.289921] [080/133] (704s left) kms_draw_crc (draw-method-mmap-wc) [317.381228] Starting subtest: draw-method-mmap-wc [317.382023] Starting dynamic subtest: xrgb8888-untiled [317.620376] Dynamic subtest xrgb8888-untiled: SUCCESS (0.237s) [317.636429] Starting dynamic subtest: rgb565-untiled [317.873570] Dynamic subtest rgb565-untiled: SUCCESS (0.253s) [317.881622] Starting dynamic subtest: xrgb2101010-untiled [318.096125] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [318.104617] Starting dynamic subtest: xbgr16161616f-untiled [318.318078] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [318.327351] Starting dynamic subtest: xrgb8888-xtiled [318.451706] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [318.460937] Starting dynamic subtest: rgb565-xtiled [318.595985] Dynamic subtest rgb565-xtiled: SUCCESS (0.144s) [318.604882] Starting dynamic subtest: xrgb2101010-xtiled [318.729341] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s) [318.739276] Starting dynamic subtest: xbgr16161616f-xtiled [318.862674] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [318.875343] Starting dynamic subtest: xrgb8888-4tiled [319.029232] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.165s) [319.037797] Starting dynamic subtest: rgb565-4tiled [319.162607] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s) [319.170281] Starting dynamic subtest: xrgb2101010-4tiled [319.318075] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s) [319.328276] Starting dynamic subtest: xbgr16161616f-4tiled [319.496242] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s) [319.497276] Subtest draw-method-mmap-wc: SUCCESS (2.115s) [319.588030] [081/133] (702s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [319.677103] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [326.732397] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.056s) [326.852240] [082/133] (695s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [326.939356] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [326.941481] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [327.030431] [083/133] (695s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [327.124757] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [327.983716] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.859s) [328.152270] [084/133] (694s left) core_getstats (basic) [328.208583] Starting subtest: basic [328.209623] Subtest basic: SUCCESS (0.000s) [328.321661] [085/133] (694s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [328.424197] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [335.032250] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.608s) [335.140175] [086/133] (687s left) kms_atomic (atomic-plane-damage) [335.226268] Starting subtest: atomic-plane-damage [335.280920] Starting dynamic subtest: pipe-A-eDP-1 [335.825644] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s) [335.826680] Subtest atomic-plane-damage: SUCCESS (0.600s) [336.695767] [087/133] (685s left) kms_chamelium_color (ctm-max) [336.784351] Subtest ctm-max: SKIP (0.000s) [336.824547] [088/133] (685s left) gem_spin_batch (spin-all-new) [336.883123] Starting subtest: spin-all-new [336.895620] Subtest spin-all-new: SUCCESS (0.014s) [338.935984] [089/133] (683s left) kms_pipe_stress (stress-xrgb8888-ytiled) [339.031467] Starting subtest: stress-xrgb8888-ytiled [339.033202] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [339.094191] [090/133] (683s left) kms_plane_multiple (2x-tiling-x) [339.183259] Starting subtest: 2x-tiling-x [339.185277] Subtest 2x-tiling-x: SKIP (0.000s) [339.254377] [091/133] (683s left) perf (oa-formats) [339.376456] Starting subtest: oa-formats [339.377337] Starting dynamic subtest: 0-rcs0 [339.393538] Dynamic subtest 0-rcs0: SUCCESS (0.018s) [339.401118] Starting dynamic subtest: 1-vecs0 [339.415800] Dynamic subtest 1-vecs0: SUCCESS (0.022s) [339.416675] Subtest oa-formats: SUCCESS (0.041s) [339.461761] [092/133] (683s left) syncobj_timeline (wait-any-complex) [339.521432] Starting subtest: wait-any-complex [339.584867] Subtest wait-any-complex: SUCCESS (0.062s) [339.672657] [093/133] (683s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [339.764567] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [339.842969] [094/133] (682s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [339.935391] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [339.936527] Starting dynamic subtest: pipe-A-eDP-1 [339.945768] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [339.953561] Starting dynamic subtest: pipe-B-eDP-1 [339.962107] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [339.969582] Starting dynamic subtest: pipe-C-eDP-1 [339.977839] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [339.985359] Starting dynamic subtest: pipe-D-eDP-1 [339.993657] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [339.995444] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s) [342.256622] [095/133] (680s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt) [342.351158] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt [342.353465] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [342.441052] [096/133] (680s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [342.525655] Starting subtest: pr-overlay-plane-update-sf-dmg-area [342.527584] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [342.593570] [097/133] (680s left) gem_exec_fence (syncobj-timeline-invalid-wait) [343.227871] Starting subtest: syncobj-timeline-invalid-wait [343.229189] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s) [345.023217] [098/133] (677s left) gem_mmap_offset (ptrace) [345.078360] Starting subtest: ptrace [345.084049] Starting dynamic subtest: smem0-wb [345.100589] Dynamic subtest smem0-wb: SUCCESS (0.017s) [345.108664] Starting dynamic subtest: smem0-wc [345.115901] Dynamic subtest smem0-wc: SUCCESS (0.015s) [345.123308] Starting dynamic subtest: smem0-uc [345.134419] Dynamic subtest smem0-uc: SUCCESS (0.016s) [345.135369] Subtest ptrace: SUCCESS (0.056s) [345.247617] [099/133] (677s left) kms_vblank (wait-busy-hang) [345.348246] Starting subtest: wait-busy-hang [345.349074] Starting dynamic subtest: pipe-A-eDP-1 [371.690133] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.339s) [371.699296] Starting dynamic subtest: pipe-D-eDP-1 [386.660158] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.967s) [386.661030] Subtest wait-busy-hang: SUCCESS (41.311s) [387.530833] [100/133] (635s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [387.623842] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [394.465497] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.842s) [394.595702] [101/133] (628s left) kms_big_fb (x-tiled-32bpp-rotate-270) [394.694406] Starting subtest: x-tiled-32bpp-rotate-270 [394.714676] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s) [394.833410] [102/133] (628s left) gem_render_copy (linear-to-vebox-yf-tiled) [394.886328] Starting subtest: linear-to-vebox-yf-tiled [394.888212] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [395.081689] [103/133] (628s left) i915_hangman (gt-engine-hang) [395.141110] Starting subtest: gt-engine-hang [395.141884] Starting dynamic subtest: rcs0 [396.861150] Dynamic subtest rcs0: SUCCESS (1.710s) [396.870201] Starting dynamic subtest: bcs0 [398.910913] Dynamic subtest bcs0: SUCCESS (2.047s) [398.923567] Starting dynamic subtest: vcs0 [400.828655] Dynamic subtest vcs0: SUCCESS (1.915s) [400.840775] Starting dynamic subtest: vcs1 [402.813107] Dynamic subtest vcs1: SUCCESS (1.981s) [402.827259] Starting dynamic subtest: vecs0 [404.860904] Dynamic subtest vecs0: SUCCESS (2.045s) [404.871521] Starting dynamic subtest: ccs0 [406.910234] Dynamic subtest ccs0: SUCCESS (2.046s) [406.911667] Subtest gt-engine-hang: SUCCESS (11.760s) [407.033193] [104/133] (616s left) kms_addfb_basic (bad-pitch-32) [407.104860] Starting subtest: bad-pitch-32 [407.105836] Subtest bad-pitch-32: SUCCESS (0.000s) [407.222932] [105/133] (615s left) perf_pmu (semaphore-busy) [407.260182] Starting subtest: semaphore-busy [407.260992] Starting dynamic subtest: rcs0 [408.877093] Dynamic subtest rcs0: SUCCESS (1.606s) [408.886075] Starting dynamic subtest: bcs0 [410.508975] Dynamic subtest bcs0: SUCCESS (1.629s) [410.517415] Starting dynamic subtest: vcs0 [414.425062] Dynamic subtest vcs0: SUCCESS (3.913s) [414.434546] Starting dynamic subtest: vcs1 [420.440899] Dynamic subtest vcs1: SUCCESS (6.012s) [420.450583] Starting dynamic subtest: vecs0 [426.391950] Dynamic subtest vecs0: SUCCESS (5.948s) [426.401473] Starting dynamic subtest: ccs0 [429.530907] Dynamic subtest ccs0: SUCCESS (3.136s) [429.531960] Subtest semaphore-busy: SUCCESS (22.260s) [429.633440] [106/133] (593s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [429.736938] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [429.738877] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [429.827152] [107/133] (593s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [429.924206] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [429.925971] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [430.020263] [108/133] (593s left) syncobj_timeline (host-signal-ordered) [430.084990] Starting subtest: host-signal-ordered [430.086025] Subtest host-signal-ordered: SUCCESS (0.000s) [430.190382] [109/133] (593s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [430.299599] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [430.301341] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [430.373887] [110/133] (592s left) syncobj_wait (wait-for-submit-complex) [430.420758] Starting subtest: wait-for-submit-complex [430.483038] Subtest wait-for-submit-complex: SUCCESS (0.062s) [430.581677] [111/133] (592s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [430.672340] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [431.786053] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.113s) [431.916770] [112/133] (591s left) gem_readwrite (write-bad-handle) [431.971834] Subtest write-bad-handle: SKIP (0.000s) [432.028458] [113/133] (591s left) i915_pm_rpm (system-suspend-devices) [434.058747] Starting subtest: system-suspend-devices [441.924849] Subtest system-suspend-devices: SUCCESS (7.858s) [449.362797] [114/133] (581s left) kms_psr (fbc-psr-sprite-render) [449.496106] Starting subtest: fbc-psr-sprite-render [449.496970] Starting dynamic subtest: eDP-1 [449.498825] Dynamic subtest eDP-1: SKIP (0.000s) [449.500485] Subtest fbc-psr-sprite-render: SKIP (0.001s) [449.581560] [115/133] (581s left) kms_pm_rpm (modeset-non-lpsp-stress) [451.104540] Starting subtest: modeset-non-lpsp-stress [452.255872] Subtest modeset-non-lpsp-stress: SKIP (1.152s) [452.650416] [116/133] (577s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [452.739221] Starting subtest: 2x-wf_vblank-ts-check-interruptible [452.750972] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [452.839308] [117/133] (577s left) gem_ctx_bad_destroy (invalid-ctx) [452.891478] Starting subtest: invalid-ctx [452.892498] Subtest invalid-ctx: SUCCESS (0.000s) [452.965940] [118/133] (577s left) gem_render_copy_redux (flink-interruptible) [453.022883] Starting subtest: flink-interruptible [453.788365] Subtest flink-interruptible: SUCCESS (0.766s) [453.907785] [119/133] (576s left) gem_exec_reloc (basic-gtt-cpu-active) [453.959142] Subtest basic-gtt-cpu-active: SKIP (0.000s) [454.026418] [120/133] (576s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [454.118654] Starting subtest: fbcpsr-rgb101010-draw-blt [460.867817] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.749s) [460.976395] [121/133] (569s left) i915_selftest (perf) [464.306041] Starting subtest: perf [464.307457] Starting dynamic subtest: engine_cs [467.034450] Dynamic subtest engine_cs: SUCCESS (2.728s) [467.043506] Starting dynamic subtest: request [472.273344] Dynamic subtest request: SUCCESS (5.237s) [472.281994] Starting dynamic subtest: migrate [476.564028] Dynamic subtest migrate: SUCCESS (4.290s) [476.573509] Starting dynamic subtest: region [482.155403] Dynamic subtest region: SUCCESS (5.589s) [482.156481] Subtest perf: SUCCESS (17.851s) [482.177825] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [482.178560] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [482.180399] [122/133] (548s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [483.779143] Starting subtest: short-flip-before-cursor-toggle [484.714550] Subtest short-flip-before-cursor-toggle: SUCCESS (0.940s) [485.524312] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [485.525586] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true [485.527809] [123/133] (545s left) gem_fence_thrash (bo-write-verify-x) [485.565741] Starting subtest: bo-write-verify-x [485.586523] Subtest bo-write-verify-x: SKIP (0.020s) [485.651017] [124/133] (545s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [485.750358] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [485.752098] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [485.852101] [125/133] (545s left) kms_cursor_crc (cursor-offscreen-64x21) [486.026396] Starting subtest: cursor-offscreen-64x21 [486.075358] Subtest cursor-offscreen-64x21: SKIP (0.047s) [486.303148] [126/133] (544s left) perf_pmu (busy-accuracy-2) [486.348221] Starting subtest: busy-accuracy-2 [486.349273] Starting dynamic subtest: rcs0 [489.399958] Dynamic subtest rcs0: SUCCESS (3.045s) [489.410044] Starting dynamic subtest: bcs0 [492.459858] Dynamic subtest bcs0: SUCCESS (3.057s) [492.469784] Starting dynamic subtest: vcs0 [495.507848] Dynamic subtest vcs0: SUCCESS (3.044s) [495.517668] Starting dynamic subtest: vcs1 [498.558352] Dynamic subtest vcs1: SUCCESS (3.048s) [498.568552] Starting dynamic subtest: vecs0 [501.606267] Dynamic subtest vecs0: SUCCESS (3.045s) [501.616225] Starting dynamic subtest: ccs0 [504.665046] Dynamic subtest ccs0: SUCCESS (3.056s) [504.666129] Subtest busy-accuracy-2: SUCCESS (18.312s) [504.777672] [127/133] (526s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [504.873775] Starting subtest: fbc-indfb-scaledprimary [507.936062] Subtest fbc-indfb-scaledprimary: SUCCESS (3.063s) [509.102328] [128/133] (521s left) gem_exec_balancer (hang) [509.375818] Starting subtest: hang [511.094447] Subtest hang: SUCCESS (1.728s) [511.211673] [129/133] (519s left) perf_pmu (busy-idle-no-semaphores) [511.258911] Starting subtest: busy-idle-no-semaphores [511.259914] Starting dynamic subtest: rcs0 [511.941332] Dynamic subtest rcs0: SUCCESS (0.672s) [511.949522] Starting dynamic subtest: bcs0 [512.597052] Dynamic subtest bcs0: SUCCESS (0.653s) [512.606355] Starting dynamic subtest: vcs0 [513.250318] Dynamic subtest vcs0: SUCCESS (0.651s) [513.260835] Starting dynamic subtest: vcs1 [514.565751] Dynamic subtest vcs1: SUCCESS (1.313s) [514.576532] Starting dynamic subtest: vecs0 [516.551721] Dynamic subtest vecs0: SUCCESS (1.983s) [516.562312] Starting dynamic subtest: ccs0 [518.533186] Dynamic subtest ccs0: SUCCESS (1.979s) [518.534262] Subtest busy-idle-no-semaphores: SUCCESS (7.267s) [518.639664] [130/133] (512s left) gem_exec_params (invalid-ring2) [518.706214] Starting subtest: invalid-ring2 [518.707124] Subtest invalid-ring2: SUCCESS (0.000s) [518.803635] [131/133] (512s left) gem_exec_schedule (pi-ringfull) [518.985199] Starting subtest: pi-ringfull [518.986371] Starting dynamic subtest: rcs0 [519.010445] Dynamic subtest rcs0: SUCCESS (0.033s) [519.019186] Starting dynamic subtest: bcs0 [519.043031] Dynamic subtest bcs0: SUCCESS (0.032s) [519.050958] Starting dynamic subtest: vcs0 [519.075896] Dynamic subtest vcs0: SUCCESS (0.032s) [519.083809] Starting dynamic subtest: vcs1 [519.107368] Dynamic subtest vcs1: SUCCESS (0.031s) [519.115513] Starting dynamic subtest: vecs0 [519.138848] Dynamic subtest vecs0: SUCCESS (0.030s) [519.146740] Starting dynamic subtest: ccs0 [519.171279] Dynamic subtest ccs0: SUCCESS (0.032s) [519.172380] Subtest pi-ringfull: SUCCESS (0.195s) [519.400660] [132/133] (511s left) kms_dp_link_training (non-uhbr-sst) [519.501955] Starting subtest: non-uhbr-sst [519.506041] Subtest non-uhbr-sst: SKIP (0.000s) [519.571173] [133/133] (511s left) gem_exec_flush (basic-wb-set-default) [519.632216] Starting subtest: basic-wb-set-default [525.086296] Subtest basic-wb-set-default: SUCCESS (5.455s) [525.269476] 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.