[63.332373] Initializing watchdogs [63.332510] /dev/watchdog0 [63.348509] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [63.353163] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [63.355668] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [63.359163] [001/133] (960s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [63.488409] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [63.492934] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [64.606656] [002/133] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [64.710661] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [64.714994] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [64.816970] [003/133] (959s left) kms_cursor_crc (cursor-tearing-position-change) [64.939535] Starting subtest: cursor-tearing-position-change [64.941965] Starting dynamic subtest: pipe-A-eDP-1 [65.556883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s) [65.566980] Starting dynamic subtest: pipe-D-eDP-1 [66.819915] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.264s) [66.822372] Subtest cursor-tearing-position-change: SUCCESS (1.883s) [68.018869] [004/133] (955s left) kms_async_flips (crc) [68.117672] Starting subtest: crc [68.492911] Starting dynamic subtest: pipe-A-eDP-1 [71.469915] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.957s) [71.831062] Starting dynamic subtest: pipe-B-eDP-1 [74.780457] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.940s) [75.133055] Starting dynamic subtest: pipe-C-eDP-1 [78.092924] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.937s) [78.436766] Starting dynamic subtest: pipe-D-eDP-1 [81.321365] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.863s) [81.323371] Subtest crc: SUCCESS (13.182s) [82.456822] [005/133] (941s left) kms_content_protection (content-type-change) [82.595064] Starting subtest: content-type-change [82.599767] Subtest content-type-change: SKIP (0.000s) [82.723311] [006/133] (941s left) kms_chamelium_hpd (common-hpd-after-suspend) [83.124331] Subtest common-hpd-after-suspend: SKIP (0.000s) [83.960735] [007/133] (940s left) fbdev (eof) [83.999953] Starting subtest: eof [84.002160] Subtest eof: SUCCESS (0.000s) [84.068190] [008/133] (940s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [84.124687] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [84.226464] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.102s) [84.302327] [009/133] (939s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [84.434153] Starting subtest: cursorA-vs-flipA-atomic [95.562886] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.127s) [96.422105] [010/133] (927s left) kms_color_pipeline (plane-ctm3x4-lut1d) [96.513702] Starting subtest: plane-ctm3x4-lut1d [96.659637] Starting dynamic subtest: pipe-A-plane-0 [96.871439] Dynamic subtest pipe-A-plane-0: SUCCESS (0.211s) [96.881315] Starting dynamic subtest: pipe-A-plane-1 [97.082277] Dynamic subtest pipe-A-plane-1: SUCCESS (0.210s) [97.092395] Starting dynamic subtest: pipe-A-plane-2 [97.273763] Dynamic subtest pipe-A-plane-2: SUCCESS (0.189s) [98.458781] Starting dynamic subtest: pipe-B-plane-0 [98.618961] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s) [98.627187] Starting dynamic subtest: pipe-B-plane-1 [98.752255] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s) [98.759927] Starting dynamic subtest: pipe-B-plane-2 [98.885245] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [100.051512] Starting dynamic subtest: pipe-C-plane-0 [100.200735] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [100.209270] Starting dynamic subtest: pipe-C-plane-1 [100.356763] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [100.364839] Starting dynamic subtest: pipe-C-plane-2 [100.489704] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s) [101.689696] Starting dynamic subtest: pipe-D-plane-0 [101.828644] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [101.836339] Starting dynamic subtest: pipe-D-plane-1 [101.983416] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [101.991926] Starting dynamic subtest: pipe-D-plane-2 [102.138972] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [102.424724] Subtest plane-ctm3x4-lut1d: SUCCESS (5.912s) [103.256259] [011/133] (921s left) gem_lmem_swapping (heavy-verify-multi) [103.298995] Subtest heavy-verify-multi: SKIP (0.000s) [103.352543] [012/133] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [103.459081] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [103.463524] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [103.575053] [013/133] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [103.672686] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [103.676929] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [103.777091] [014/133] (920s left) gen3_render_linear_blits [103.919454] [015/133] (920s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [104.005824] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [104.008083] Starting dynamic subtest: pipe-A-eDP-1 [104.066102] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [104.073626] Starting dynamic subtest: pipe-B-eDP-1 [104.129078] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [104.136738] Starting dynamic subtest: pipe-C-eDP-1 [104.191106] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [104.198468] Starting dynamic subtest: pipe-D-eDP-1 [104.242807] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [104.246216] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s) [106.333919] [016/133] (918s left) kms_cursor_crc (cursor-rapid-movement-128x42) [106.557021] Starting subtest: cursor-rapid-movement-128x42 [106.604737] Subtest cursor-rapid-movement-128x42: SKIP (0.043s) [106.790735] [017/133] (917s left) gem_exec_schedule (fifo) [106.856053] Starting subtest: fifo [106.858347] Starting dynamic subtest: rcs0 [106.945716] Dynamic subtest rcs0: SUCCESS (0.096s) [106.956382] Starting dynamic subtest: vcs0 [107.024031] Dynamic subtest vcs0: SUCCESS (0.078s) [107.034537] Starting dynamic subtest: vcs1 [107.105623] Dynamic subtest vcs1: SUCCESS (0.081s) [107.116531] Starting dynamic subtest: vecs0 [107.180802] Dynamic subtest vecs0: SUCCESS (0.075s) [107.190952] Starting dynamic subtest: ccs0 [107.260475] Dynamic subtest ccs0: SUCCESS (0.079s) [107.263793] Subtest fifo: SUCCESS (0.412s) [108.979820] [018/133] (915s left) gem_softpin (noreloc) [109.034180] Starting subtest: noreloc [114.520679] Subtest noreloc: SUCCESS (5.431s) [114.590761] [019/133] (910s left) i915_drm_fdinfo (virtual-busy-hang) [114.631962] Starting subtest: virtual-busy-hang [114.636575] Subtest virtual-busy-hang: SKIP (0.000s) [114.707090] [020/133] (909s left) kms_lease (master-vs-lease) [114.796652] Starting subtest: master-vs-lease [114.798963] Subtest master-vs-lease: SUCCESS (0.002s) [114.896743] [021/133] (909s left) prime_vgem (basic-gtt) [115.069857] Starting subtest: basic-gtt [115.074189] Subtest basic-gtt: SKIP (0.000s) [115.178214] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true [115.181273] [022/133] (909s left) gem_exec_schedule (u-semaphore-resolve) [115.247295] Starting subtest: u-semaphore-resolve [115.283633] Subtest u-semaphore-resolve: SUCCESS (0.043s) [115.626285] [023/133] (909s left) kms_joiner (invalid-modeset-force-big-joiner) [115.721841] Starting subtest: invalid-modeset-force-big-joiner [115.726442] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [115.789795] [024/133] (909s left) gem_shrink (reclaim) [115.849103] Starting subtest: reclaim [118.271873] Subtest reclaim: SUCCESS (2.423s) [118.432505] [025/133] (906s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [118.550167] Starting subtest: 2x-cursor-vs-flip-atomic [118.554731] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s) [118.690701] [026/133] (906s left) kms_chamelium_frames (hdmi-crc-single) [119.074254] Subtest hdmi-crc-single: SKIP (0.000s) [119.931429] [027/133] (905s left) gem_exec_params (rel-constants-invalid-rel-gen5) [119.986952] Starting subtest: rel-constants-invalid-rel-gen5 [119.989311] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [120.077791] [028/133] (904s left) vgem_basic (dmabuf-mmap) [120.122882] Starting subtest: dmabuf-mmap [120.127631] Subtest dmabuf-mmap: SUCCESS (0.008s) [120.177391] [029/133] (904s left) gem_userptr_blits (readonly-unsync) [120.250974] Subtest readonly-unsync: SKIP (0.000s) [120.375769] [030/133] (904s left) gem_softpin (evict-active) [120.437955] Starting subtest: evict-active [120.444237] Subtest evict-active: SUCCESS (0.006s) [120.576008] [031/133] (904s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [120.674956] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [120.679044] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [120.744239] [032/133] (904s left) kms_pm_backlight (fade) [120.825087] Starting subtest: fade [120.875260] Starting dynamic subtest: eDP-1 [123.354277] Dynamic subtest eDP-1: SUCCESS (2.478s) [123.356644] Subtest fade: SUCCESS (2.529s) [124.182979] [033/133] (901s left) kms_big_fb (y-tiled-16bpp-rotate-270) [124.291785] Starting subtest: y-tiled-16bpp-rotate-270 [124.296021] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [124.398293] [034/133] (900s left) gem_ctx_persistence (smoketest) [124.459211] Starting subtest: smoketest [164.853072] Subtest smoketest: SUCCESS (40.393s) [164.941570] [035/133] (860s left) gem_exec_balancer (sequential) [165.011797] Starting subtest: sequential [168.104871] Subtest sequential: SUCCESS (3.093s) [168.439240] [036/133] (856s left) gem_wait (write-wait) [168.511886] Starting subtest: write-wait [168.513841] Starting dynamic subtest: all-engines [169.626667] Dynamic subtest all-engines: SUCCESS (1.117s) [169.641854] Starting dynamic subtest: rcs0 [170.687410] Dynamic subtest rcs0: SUCCESS (1.059s) [170.704275] Starting dynamic subtest: bcs0 [171.744269] Dynamic subtest bcs0: SUCCESS (1.055s) [171.760786] Starting dynamic subtest: vcs0 [172.797057] Dynamic subtest vcs0: SUCCESS (1.052s) [172.812808] Starting dynamic subtest: vcs1 [173.850671] Dynamic subtest vcs1: SUCCESS (1.052s) [173.865875] Starting dynamic subtest: vecs0 [174.903355] Dynamic subtest vecs0: SUCCESS (1.052s) [174.918104] Starting dynamic subtest: ccs0 [175.960632] Dynamic subtest ccs0: SUCCESS (1.055s) [175.963575] Subtest write-wait: SUCCESS (7.451s) [176.157688] [037/133] (849s left) kms_psr (fbc-psr2-suspend) [176.248964] Starting subtest: fbc-psr2-suspend [176.251352] Starting dynamic subtest: eDP-1 [176.255714] Dynamic subtest eDP-1: SKIP (0.000s) [176.260223] Subtest fbc-psr2-suspend: SKIP (0.001s) [176.318316] [038/133] (849s left) gen9_exec_parse (batch-without-end) [176.389979] Subtest batch-without-end: SKIP (0.000s) [176.463426] [039/133] (848s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [176.580423] Starting subtest: cursor-vs-flip-varying-size [207.926680] Subtest cursor-vs-flip-varying-size: SUCCESS (31.345s) [208.808754] [040/133] (816s left) dmabuf_sync_file (import-multiple-read-only) [208.857334] Starting subtest: import-multiple-read-only [208.859779] Subtest import-multiple-read-only: SUCCESS (0.003s) [208.918136] [041/133] (816s left) prime_mmap (test_map_unmap) [208.978363] Starting subtest: test_map_unmap [208.980368] Starting dynamic subtest: test_map_unmap-smem [209.018560] Dynamic subtest test_map_unmap-smem: SUCCESS (0.041s) [209.020926] Subtest test_map_unmap: SUCCESS (0.042s) [209.115258] [042/133] (816s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [209.205963] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [209.208283] Starting dynamic subtest: pipe-A-default-mode [210.361949] Dynamic subtest pipe-A-default-mode: SKIP (1.155s) [210.366458] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.156s) [210.513844] [043/133] (815s left) kms_plane (pixel-format-linear-modifier-source-clamping) [210.615173] Starting subtest: pixel-format-linear-modifier-source-clamping [210.640658] Starting dynamic subtest: pipe-A-plane-0 [214.152070] Dynamic subtest pipe-A-plane-0: SUCCESS (3.511s) [214.161481] Starting dynamic subtest: pipe-A-plane-3 [215.818509] Dynamic subtest pipe-A-plane-3: SUCCESS (1.666s) [216.916261] Starting dynamic subtest: pipe-B-plane-0 [220.416960] Dynamic subtest pipe-B-plane-0: SUCCESS (3.511s) [220.425644] Starting dynamic subtest: pipe-B-plane-3 [222.094661] Dynamic subtest pipe-B-plane-3: SUCCESS (1.676s) [222.404009] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (11.789s) [223.303266] [044/133] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [223.406757] Starting subtest: psr-2p-scndscrn-cur-indfb-move [223.411654] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [223.545464] [045/133] (802s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [223.618753] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [223.722869] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [223.835936] [046/133] (801s left) gem_ctx_shared (q-in-order) [223.907740] Starting subtest: Q-in-order [223.910227] Starting dynamic subtest: rcs0 [224.010310] Dynamic subtest rcs0: SUCCESS (0.105s) [224.021691] Starting dynamic subtest: vcs0 [224.096794] Dynamic subtest vcs0: SUCCESS (0.086s) [224.112680] Starting dynamic subtest: vcs1 [224.175637] Dynamic subtest vcs1: SUCCESS (0.078s) [224.191096] Starting dynamic subtest: vecs0 [224.253125] Dynamic subtest vecs0: SUCCESS (0.077s) [224.267689] Starting dynamic subtest: ccs0 [224.342651] Dynamic subtest ccs0: SUCCESS (0.088s) [224.345229] Subtest Q-in-order: SUCCESS (0.438s) [226.053834] [047/133] (799s left) kms_getfb (getfb-repeated-different-handles) [226.150853] Starting subtest: getfb-repeated-different-handles [226.153101] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [226.262119] [048/133] (799s left) gem_mmap_wc (close) [226.320177] Subtest close: SKIP (0.000s) [226.386422] [049/133] (799s left) drm_read (invalid-buffer) [226.526084] Starting subtest: invalid-buffer [226.528366] Subtest invalid-buffer: SUCCESS (0.000s) [226.665573] [050/133] (799s left) kms_flip (plain-flip-interruptible) [226.758902] Starting subtest: plain-flip-interruptible [226.761259] Starting dynamic subtest: A-eDP1 [228.381521] Dynamic subtest A-eDP1: SUCCESS (1.621s) [228.390213] Starting dynamic subtest: B-eDP1 [230.006099] Dynamic subtest B-eDP1: SUCCESS (1.623s) [230.014499] Starting dynamic subtest: C-eDP1 [231.616507] Dynamic subtest C-eDP1: SUCCESS (1.609s) [231.624867] Starting dynamic subtest: D-eDP1 [233.243545] Dynamic subtest D-eDP1: SUCCESS (1.625s) [233.249202] Subtest plain-flip-interruptible: SUCCESS (6.490s) [234.415787] [051/133] (791s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [234.477282] Starting subtest: yf-tiled-to-vebox-x-tiled [234.482218] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [234.661560] [052/133] (791s left) kms_big_fb (4-tiled-64bpp-rotate-0) [234.767603] Starting subtest: 4-tiled-64bpp-rotate-0 [236.402687] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.634s) [236.596275] [053/133] (789s left) gem_create (create-ext-placement-all) [236.770295] Starting subtest: create-ext-placement-all [236.772414] Subtest create-ext-placement-all: SUCCESS (0.000s) [236.890560] [054/133] (789s left) gem_mmap_offset (partial-unmap) [236.955475] Starting subtest: partial-unmap [236.958229] Starting dynamic subtest: smem0 [237.456364] Dynamic subtest smem0: SUCCESS (0.500s) [237.459082] Subtest partial-unmap: SUCCESS (0.501s) [237.561774] [055/133] (788s left) gem_ctx_isolation (dirty-create) [237.622840] Starting subtest: dirty-create [237.625231] Starting dynamic subtest: rcs0 [237.822014] Dynamic subtest rcs0: SUCCESS (0.199s) [237.830228] Starting dynamic subtest: bcs0 [237.997022] Dynamic subtest bcs0: SUCCESS (0.174s) [238.005286] Starting dynamic subtest: vcs0 [238.199135] Dynamic subtest vcs0: SUCCESS (0.201s) [238.209044] Starting dynamic subtest: vcs1 [240.089981] Dynamic subtest vcs1: SUCCESS (1.890s) [240.100021] Starting dynamic subtest: vecs0 [242.149521] Dynamic subtest vecs0: SUCCESS (2.058s) [242.161550] Starting dynamic subtest: ccs0 [244.151051] Dynamic subtest ccs0: SUCCESS (2.000s) [244.153544] Subtest dirty-create: SUCCESS (6.529s) [244.391294] [056/133] (781s left) api_intel_bb (blit-reloc-purge-cache) [244.441681] Starting subtest: blit-reloc-purge-cache [244.446032] Subtest blit-reloc-purge-cache: SKIP (0.001s) [244.541513] [057/133] (781s left) vgem_basic (bad-fence) [244.585100] Starting subtest: bad-fence [244.587327] Subtest bad-fence: SUCCESS (0.000s) [244.639963] [058/133] (781s left) kms_flip (2x-blocking-absolute-wf_vblank) [244.733255] Starting subtest: 2x-blocking-absolute-wf_vblank [244.744989] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s) [244.857325] [059/133] (781s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [244.974068] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [244.976375] Starting dynamic subtest: pipe-A [244.998677] Dynamic subtest pipe-A: SKIP (0.019s) [245.008046] Starting dynamic subtest: pipe-B [245.035365] Dynamic subtest pipe-B: SKIP (0.035s) [245.043622] Starting dynamic subtest: pipe-C [245.067752] Dynamic subtest pipe-C: SKIP (0.033s) [245.075823] Starting dynamic subtest: pipe-D [245.102986] Dynamic subtest pipe-D: SKIP (0.034s) [245.107110] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.124s) [245.198042] [060/133] (781s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [245.292970] Starting subtest: primary-x-tiled-reflect-x-180 [252.201182] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.908s) [253.363390] [061/133] (773s left) syncobj_timeline (invalid-transfer-illegal-handle) [253.424221] Starting subtest: invalid-transfer-illegal-handle [253.426510] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [253.533594] [062/133] (772s left) kms_psr (fbc-pr-sprite-mmap-gtt) [253.622137] Starting subtest: fbc-pr-sprite-mmap-gtt [253.626592] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [253.694760] [063/133] (772s left) kms_psr (fbc-pr-primary-mmap-cpu) [253.780212] Starting subtest: fbc-pr-primary-mmap-cpu [253.784190] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [253.852942] [064/133] (772s left) gem_exec_nop (basic-parallel) [253.931260] Starting subtest: basic-parallel [268.888495] Subtest basic-parallel: SUCCESS (14.966s) [269.123140] [065/133] (757s left) syncobj_timeline (reset-multiple-signaled) [269.180496] Starting subtest: reset-multiple-signaled [269.182953] Subtest reset-multiple-signaled: SUCCESS (0.001s) [269.290291] [066/133] (757s left) gem_mmap_wc (read-write-distinct) [269.355675] Subtest read-write-distinct: SKIP (0.000s) [269.414654] [067/133] (757s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [269.501832] Starting subtest: plane-downscale-factor-0-75-with-rotation [269.504028] Starting dynamic subtest: pipe-A [269.753265] Dynamic subtest pipe-A: SUCCESS (0.253s) [269.762753] Starting dynamic subtest: pipe-B [271.038105] Dynamic subtest pipe-B: SUCCESS (1.283s) [271.046300] Starting dynamic subtest: pipe-C [272.397555] Dynamic subtest pipe-C: SUCCESS (1.357s) [272.406345] Starting dynamic subtest: pipe-D [273.702160] Dynamic subtest pipe-D: SUCCESS (1.303s) [273.704648] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.203s) [274.874880] [068/133] (751s left) gem_mmap_gtt (cpuset-big-copy-xy) [274.926712] Subtest cpuset-big-copy-XY: SKIP (0.000s) [274.982092] [069/133] (751s left) kms_universal_plane (universal-plane-sanity) [275.085338] Starting subtest: universal-plane-sanity [275.087591] Starting dynamic subtest: pipe-A-eDP-1 [275.694197] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s) [275.703220] Starting dynamic subtest: pipe-B-eDP-1 [276.897661] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.200s) [276.906983] Starting dynamic subtest: pipe-C-eDP-1 [278.104210] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s) [278.113281] Starting dynamic subtest: pipe-D-eDP-1 [279.325838] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s) [279.328179] Subtest universal-plane-sanity: SUCCESS (4.242s) [280.202767] [070/133] (746s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [280.302098] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [280.306663] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [280.399844] [071/133] (746s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [280.498299] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [284.486098] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.990s) [285.675389] [072/133] (741s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [285.782906] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [289.680419] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.901s) [290.849401] [073/133] (736s left) kms_scaling_modes (scaling-mode-full-aspect) [290.968494] Starting subtest: scaling-mode-full-aspect [290.970819] Starting dynamic subtest: pipe-A-eDP-1 [291.070916] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.102s) [291.079891] Starting dynamic subtest: pipe-B-eDP-1 [292.214579] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s) [292.223035] Starting dynamic subtest: pipe-C-eDP-1 [293.339343] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s) [293.350669] Starting dynamic subtest: pipe-D-eDP-1 [294.458274] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.116s) [294.460665] Subtest scaling-mode-full-aspect: SUCCESS (3.492s) [295.637229] [074/133] (731s left) kms_psr (psr2-sprite-render) [295.732046] Starting subtest: psr2-sprite-render [295.734336] Starting dynamic subtest: eDP-1 [297.444535] Dynamic subtest eDP-1: SUCCESS (1.712s) [297.446901] Subtest psr2-sprite-render: SUCCESS (1.713s) [298.314289] [075/133] (728s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs) [298.411249] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs [298.413553] Starting dynamic subtest: pipe-A-eDP-1 [298.437189] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [298.447663] Starting dynamic subtest: pipe-B-eDP-1 [298.469665] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [298.478274] Starting dynamic subtest: pipe-C-eDP-1 [298.500832] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [298.510757] Starting dynamic subtest: pipe-D-eDP-1 [298.532825] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [298.537060] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s) [300.667621] [076/133] (726s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [300.760856] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [300.765232] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [300.861403] [077/133] (726s left) kms_addfb_basic (bad-pitch-0) [300.918089] Starting subtest: bad-pitch-0 [300.920265] Subtest bad-pitch-0: SUCCESS (0.000s) [301.049727] [078/133] (726s left) gem_workarounds (basic-read) [301.123707] Starting subtest: basic-read [301.133575] Subtest basic-read: SUCCESS (0.010s) [301.222918] [079/133] (726s left) gem_exec_whisper (basic-fds-priority-all) [301.282338] Starting subtest: basic-fds-priority-all [323.204769] Subtest basic-fds-priority-all: SUCCESS (21.919s) [323.388925] [080/133] (703s left) kms_draw_crc (draw-method-mmap-wc) [323.486833] Starting subtest: draw-method-mmap-wc [323.489110] Starting dynamic subtest: xrgb8888-untiled [323.731718] Dynamic subtest xrgb8888-untiled: SUCCESS (0.247s) [323.739846] Starting dynamic subtest: rgb565-untiled [323.987404] Dynamic subtest rgb565-untiled: SUCCESS (0.255s) [323.997080] Starting dynamic subtest: xrgb2101010-untiled [324.198621] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s) [324.209312] Starting dynamic subtest: xbgr16161616f-untiled [324.420383] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [324.430343] Starting dynamic subtest: xrgb8888-xtiled [324.565078] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s) [324.574230] Starting dynamic subtest: rgb565-xtiled [324.709159] Dynamic subtest rgb565-xtiled: SUCCESS (0.143s) [324.717158] Starting dynamic subtest: xrgb2101010-xtiled [324.842562] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s) [324.854455] Starting dynamic subtest: xbgr16161616f-xtiled [324.975822] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [324.984050] Starting dynamic subtest: xrgb8888-4tiled [325.131246] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s) [325.139453] Starting dynamic subtest: rgb565-4tiled [325.290472] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s) [325.299128] Starting dynamic subtest: xrgb2101010-4tiled [325.442496] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.153s) [325.451311] Starting dynamic subtest: xbgr16161616f-4tiled [325.620324] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s) [325.624486] Subtest draw-method-mmap-wc: SUCCESS (2.138s) [325.724730] [081/133] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [325.818584] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [332.913518] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.095s) [333.059690] [082/133] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [333.170567] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [333.174806] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [333.267101] [083/133] (694s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [333.360477] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [334.184705] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s) [334.369298] [084/133] (693s left) core_getstats (basic) [334.421294] Starting subtest: basic [334.423554] Subtest basic: SUCCESS (0.000s) [334.521521] [085/133] (693s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [334.622787] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [341.173364] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.553s) [341.273169] [086/133] (686s left) kms_atomic (atomic-plane-damage) [341.386465] Starting subtest: atomic-plane-damage [341.449031] Starting dynamic subtest: pipe-A-eDP-1 [342.008077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s) [342.010044] Subtest atomic-plane-damage: SUCCESS (0.622s) [342.864262] [087/133] (684s left) kms_chamelium_color (ctm-max) [342.958261] Subtest ctm-max: SKIP (0.000s) [343.007682] [088/133] (684s left) gem_spin_batch (spin-all-new) [343.077081] Starting subtest: spin-all-new [343.092943] Subtest spin-all-new: SUCCESS (0.017s) [344.961421] [089/133] (682s left) kms_pipe_stress (stress-xrgb8888-ytiled) [345.050447] Starting subtest: stress-xrgb8888-ytiled [345.054862] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [345.132678] [090/133] (682s left) kms_plane_multiple (2x-tiling-x) [345.222843] Starting subtest: 2x-tiling-x [345.227191] Subtest 2x-tiling-x: SKIP (0.000s) [345.294884] [091/133] (682s left) perf (oa-formats) [345.429531] Starting subtest: oa-formats [345.431766] Starting dynamic subtest: 0-rcs0 [345.446083] Dynamic subtest 0-rcs0: SUCCESS (0.018s) [345.456643] Starting dynamic subtest: 1-vcs1 [345.471351] Dynamic subtest 1-vcs1: SUCCESS (0.024s) [345.473561] Subtest oa-formats: SUCCESS (0.044s) [345.523598] [092/133] (682s left) syncobj_timeline (wait-any-complex) [345.577199] Starting subtest: wait-any-complex [345.638421] Subtest wait-any-complex: SUCCESS (0.062s) [345.720864] [093/133] (682s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [345.816235] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [345.908331] [094/133] (682s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [346.003619] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [346.005541] Starting dynamic subtest: pipe-A-eDP-1 [346.024458] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [346.034065] Starting dynamic subtest: pipe-B-eDP-1 [346.051930] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [346.060191] Starting dynamic subtest: pipe-C-eDP-1 [346.077393] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [346.084719] Starting dynamic subtest: pipe-D-eDP-1 [346.102217] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [346.105673] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s) [348.234868] [095/133] (679s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt) [348.333020] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt [348.337608] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [348.423374] [096/133] (679s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [348.519905] Starting subtest: pr-overlay-plane-update-sf-dmg-area [348.523975] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [348.584656] [097/133] (679s left) gem_exec_fence (syncobj-timeline-invalid-wait) [349.227588] Starting subtest: syncobj-timeline-invalid-wait [349.230609] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s) [351.014023] [098/133] (677s left) gem_mmap_offset (ptrace) [351.079309] Starting subtest: ptrace [351.084290] Starting dynamic subtest: smem0-wb [351.100591] Dynamic subtest smem0-wb: SUCCESS (0.018s) [351.112250] Starting dynamic subtest: smem0-wc [351.123269] Dynamic subtest smem0-wc: SUCCESS (0.022s) [351.131740] Starting dynamic subtest: smem0-uc [351.142447] Dynamic subtest smem0-uc: SUCCESS (0.018s) [351.144613] Subtest ptrace: SUCCESS (0.066s) [351.271661] [099/133] (676s left) kms_vblank (wait-busy-hang) [351.376758] Starting subtest: wait-busy-hang [351.378600] Starting dynamic subtest: pipe-A-eDP-1 [365.716971] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.340s) [365.732087] Starting dynamic subtest: pipe-D-eDP-1 [390.689071] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.968s) [390.691473] Subtest wait-busy-hang: SUCCESS (39.314s) [391.490886] [100/133] (636s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [391.594407] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [398.428989] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.837s) [398.535891] [101/133] (629s left) kms_big_fb (x-tiled-32bpp-rotate-270) [398.632696] Starting subtest: x-tiled-32bpp-rotate-270 [398.652564] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s) [398.782159] [102/133] (629s left) gem_render_copy (linear-to-vebox-yf-tiled) [398.835841] Starting subtest: linear-to-vebox-yf-tiled [398.841113] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [399.022608] [103/133] (629s left) i915_hangman (gt-engine-hang) [399.090063] Starting subtest: gt-engine-hang [399.092337] Starting dynamic subtest: rcs0 [400.884281] Dynamic subtest rcs0: SUCCESS (1.794s) [400.895947] Starting dynamic subtest: bcs0 [402.868059] Dynamic subtest bcs0: SUCCESS (1.981s) [402.879733] Starting dynamic subtest: vcs0 [404.852197] Dynamic subtest vcs0: SUCCESS (1.980s) [404.863559] Starting dynamic subtest: vcs1 [406.900633] Dynamic subtest vcs1: SUCCESS (2.046s) [406.912540] Starting dynamic subtest: vecs0 [408.884367] Dynamic subtest vecs0: SUCCESS (1.981s) [408.896569] Starting dynamic subtest: ccs0 [410.868711] Dynamic subtest ccs0: SUCCESS (1.981s) [410.871572] Subtest gt-engine-hang: SUCCESS (11.780s) [410.949755] [104/133] (617s left) kms_addfb_basic (bad-pitch-32) [411.001014] Starting subtest: bad-pitch-32 [411.003190] Subtest bad-pitch-32: SUCCESS (0.000s) [411.143811] [105/133] (617s left) perf_pmu (semaphore-busy) [411.180548] Starting subtest: semaphore-busy [411.183214] Starting dynamic subtest: rcs0 [412.811881] Dynamic subtest rcs0: SUCCESS (1.627s) [412.821712] Starting dynamic subtest: bcs0 [414.443342] Dynamic subtest bcs0: SUCCESS (1.628s) [414.453209] Starting dynamic subtest: vcs0 [418.510052] Dynamic subtest vcs0: SUCCESS (4.003s) [418.522145] Starting dynamic subtest: vcs1 [424.401914] Dynamic subtest vcs1: SUCCESS (5.949s) [424.413630] Starting dynamic subtest: vecs0 [430.419044] Dynamic subtest vecs0: SUCCESS (6.013s) [430.430591] Starting dynamic subtest: ccs0 [433.490798] Dynamic subtest ccs0: SUCCESS (3.069s) [433.493174] Subtest semaphore-busy: SUCCESS (22.308s) [433.613772] [106/133] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [433.725774] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [433.730341] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [433.832843] [107/133] (594s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [433.936720] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [433.941270] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [434.075572] [108/133] (594s left) syncobj_timeline (host-signal-ordered) [434.138565] Starting subtest: host-signal-ordered [434.140898] Subtest host-signal-ordered: SUCCESS (0.000s) [434.266294] [109/133] (594s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [434.360663] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [434.364942] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [434.459577] [110/133] (594s left) syncobj_wait (wait-for-submit-complex) [434.525296] Starting subtest: wait-for-submit-complex [434.585381] Subtest wait-for-submit-complex: SUCCESS (0.062s) [434.712413] [111/133] (594s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [434.811801] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [435.916947] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.106s) [436.039305] [112/133] (592s left) gem_readwrite (write-bad-handle) [436.099366] Subtest write-bad-handle: SKIP (0.000s) [436.164497] [113/133] (592s left) i915_pm_rpm (system-suspend-devices) [438.091357] Starting subtest: system-suspend-devices [445.893642] Subtest system-suspend-devices: SUCCESS (7.806s) [446.291902] [114/133] (582s left) kms_psr (fbc-psr-sprite-render) [446.394396] Starting subtest: fbc-psr-sprite-render [446.396699] Starting dynamic subtest: eDP-1 [446.401247] Dynamic subtest eDP-1: SKIP (0.000s) [446.405898] Subtest fbc-psr-sprite-render: SKIP (0.001s) [446.480453] [115/133] (582s left) kms_pm_rpm (modeset-non-lpsp-stress) [448.010288] Starting subtest: modeset-non-lpsp-stress [449.168029] Subtest modeset-non-lpsp-stress: SKIP (1.153s) [449.571423] [116/133] (579s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [449.673433] Starting subtest: 2x-wf_vblank-ts-check-interruptible [449.686095] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [449.792052] [117/133] (579s left) gem_ctx_bad_destroy (invalid-ctx) [449.846068] Starting subtest: invalid-ctx [449.848380] Subtest invalid-ctx: SUCCESS (0.000s) [449.943167] [118/133] (579s left) gem_render_copy_redux (flink-interruptible) [450.002566] Starting subtest: flink-interruptible [450.790393] Subtest flink-interruptible: SUCCESS (0.788s) [450.909016] [119/133] (578s left) gem_exec_reloc (basic-gtt-cpu-active) [450.962978] Subtest basic-gtt-cpu-active: SKIP (0.000s) [451.024799] [120/133] (578s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [451.126139] Starting subtest: fbcpsr-rgb101010-draw-blt [457.897159] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.773s) [458.043584] [121/133] (571s left) i915_selftest (perf) [459.834760] Starting subtest: perf [459.836840] Starting dynamic subtest: engine_cs [464.136718] Dynamic subtest engine_cs: SUCCESS (4.304s) [464.147047] Starting dynamic subtest: request [471.400616] Dynamic subtest request: SUCCESS (7.262s) [471.410227] Starting dynamic subtest: migrate [475.723390] Dynamic subtest migrate: SUCCESS (4.321s) [475.733074] Starting dynamic subtest: region [481.363654] Dynamic subtest region: SUCCESS (5.638s) [481.366241] Subtest perf: SUCCESS (21.532s) [481.392655] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [481.393737] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [481.397157] [122/133] (547s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [482.988475] Starting subtest: short-flip-before-cursor-toggle [483.941369] Subtest short-flip-before-cursor-toggle: SUCCESS (0.953s) [484.884026] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [484.885233] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true [484.889112] [123/133] (544s left) gem_fence_thrash (bo-write-verify-x) [484.927132] Starting subtest: bo-write-verify-x [484.950479] Subtest bo-write-verify-x: SKIP (0.019s) [485.018502] [124/133] (544s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [485.130930] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [485.135289] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [485.231192] [125/133] (544s left) kms_cursor_crc (cursor-offscreen-64x21) [485.430021] Starting subtest: cursor-offscreen-64x21 [485.483243] Subtest cursor-offscreen-64x21: SKIP (0.048s) [485.714134] [126/133] (543s left) perf_pmu (busy-accuracy-2) [485.752937] Starting subtest: busy-accuracy-2 [485.755318] Starting dynamic subtest: rcs0 [488.802430] Dynamic subtest rcs0: SUCCESS (3.048s) [488.813814] Starting dynamic subtest: bcs0 [491.911461] Dynamic subtest bcs0: SUCCESS (3.055s) [491.921586] Starting dynamic subtest: vcs0 [494.955288] Dynamic subtest vcs0: SUCCESS (3.043s) [494.963949] Starting dynamic subtest: vcs1 [498.004988] Dynamic subtest vcs1: SUCCESS (3.047s) [498.014472] Starting dynamic subtest: vecs0 [501.051063] Dynamic subtest vecs0: SUCCESS (3.043s) [501.062229] Starting dynamic subtest: ccs0 [504.107687] Dynamic subtest ccs0: SUCCESS (3.054s) [504.109905] Subtest busy-accuracy-2: SUCCESS (18.305s) [504.176415] [127/133] (525s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [504.291715] Starting subtest: fbc-indfb-scaledprimary [507.289304] Subtest fbc-indfb-scaledprimary: SUCCESS (3.000s) [508.434468] [128/133] (521s left) gem_exec_balancer (hang) [508.704471] Starting subtest: hang [510.353597] Subtest hang: SUCCESS (1.653s) [510.491919] [129/133] (519s left) perf_pmu (busy-idle-no-semaphores) [510.533281] Starting subtest: busy-idle-no-semaphores [510.535698] Starting dynamic subtest: rcs0 [511.197095] Dynamic subtest rcs0: SUCCESS (0.664s) [511.209026] Starting dynamic subtest: bcs0 [511.853558] Dynamic subtest bcs0: SUCCESS (0.653s) [511.864682] Starting dynamic subtest: vcs0 [512.507901] Dynamic subtest vcs0: SUCCESS (0.652s) [512.519537] Starting dynamic subtest: vcs1 [514.560060] Dynamic subtest vcs1: SUCCESS (2.049s) [514.571813] Starting dynamic subtest: vecs0 [516.542528] Dynamic subtest vecs0: SUCCESS (1.980s) [516.554673] Starting dynamic subtest: ccs0 [518.526392] Dynamic subtest ccs0: SUCCESS (1.981s) [518.529276] Subtest busy-idle-no-semaphores: SUCCESS (7.995s) [518.657455] [130/133] (510s left) gem_exec_params (invalid-ring2) [518.716757] Starting subtest: invalid-ring2 [518.719067] Subtest invalid-ring2: SUCCESS (0.000s) [518.819964] [131/133] (510s left) gem_exec_schedule (pi-ringfull) [519.013532] Starting subtest: pi-ringfull [519.015984] Starting dynamic subtest: rcs0 [519.047075] Dynamic subtest rcs0: SUCCESS (0.038s) [519.060276] Starting dynamic subtest: bcs0 [519.078688] Dynamic subtest bcs0: SUCCESS (0.031s) [519.087882] Starting dynamic subtest: vcs0 [519.111231] Dynamic subtest vcs0: SUCCESS (0.032s) [519.120327] Starting dynamic subtest: vcs1 [519.141985] Dynamic subtest vcs1: SUCCESS (0.030s) [519.154937] Starting dynamic subtest: vecs0 [519.173442] Dynamic subtest vecs0: SUCCESS (0.031s) [519.182690] Starting dynamic subtest: ccs0 [519.205251] Dynamic subtest ccs0: SUCCESS (0.031s) [519.207457] Subtest pi-ringfull: SUCCESS (0.197s) [519.439373] [132/133] (510s left) kms_dp_link_training (non-uhbr-sst) [519.547040] Starting subtest: non-uhbr-sst [519.555510] Subtest non-uhbr-sst: SKIP (0.000s) [519.623487] [133/133] (510s left) gem_exec_flush (basic-wb-set-default) [519.696533] Starting subtest: basic-wb-set-default [525.180658] Subtest basic-wb-set-default: SUCCESS (5.456s) [525.383666] 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.