[63.475222] Initializing watchdogs [63.475272] /dev/watchdog0 [63.489690] [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.493771] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [63.496098] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [63.499412] [001/130] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [63.688685] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [63.692865] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [63.798799] [002/130] (960s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip) [63.905348] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip [63.909516] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [63.991255] [003/130] (960s left) kms_vblank (ts-continuation-modeset-rpm) [64.088875] Starting subtest: ts-continuation-modeset-rpm [64.091209] Starting dynamic subtest: pipe-A-eDP-1 [66.625887] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.535s) [66.637192] Starting dynamic subtest: pipe-D-eDP-1 [68.870771] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.241s) [68.872832] Subtest ts-continuation-modeset-rpm: SUCCESS (4.779s) [69.647672] [004/130] (954s left) api_intel_bb (purge-bb) [69.712392] Starting subtest: purge-bb [69.717402] Subtest purge-bb: SUCCESS (0.005s) [69.847487] [005/130] (954s left) gem_exec_fence (parallel) [70.031539] Starting subtest: parallel [70.034068] Starting dynamic subtest: rcs0 [72.184106] Dynamic subtest rcs0: SUCCESS (2.153s) [72.193422] Starting dynamic subtest: bcs0 [74.332618] Dynamic subtest bcs0: SUCCESS (2.149s) [74.340434] Starting dynamic subtest: vcs0 [76.481436] Dynamic subtest vcs0: SUCCESS (2.148s) [76.489959] Starting dynamic subtest: vcs1 [78.635180] Dynamic subtest vcs1: SUCCESS (2.154s) [78.642099] Starting dynamic subtest: vecs0 [80.786231] Dynamic subtest vecs0: SUCCESS (2.151s) [80.793514] Starting dynamic subtest: ccs0 [82.938429] Dynamic subtest ccs0: SUCCESS (2.152s) [82.940588] Subtest parallel: SUCCESS (12.908s) [84.044017] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true [84.047354] [006/130] (940s left) gem_userptr_blits (coherency-unsync) [84.121769] Subtest coherency-unsync: SKIP (0.000s) [84.259982] [007/130] (939s left) kms_async_flips (test-cursor) [84.361300] Starting subtest: test-cursor [84.366047] Subtest test-cursor: SKIP (0.000s) [85.578501] [008/130] (938s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [85.690530] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [85.695294] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [85.799493] [009/130] (938s left) kms_addfb_basic (unused-modifier) [85.868893] Starting subtest: unused-modifier [85.871206] Subtest unused-modifier: SUCCESS (0.000s) [86.014232] [010/130] (938s left) gen7_exec_parse (basic-offset) [86.083299] Subtest basic-offset: SKIP (0.000s) [86.177706] [011/130] (938s left) gen9_exec_parse (bb-start-param) [86.243833] Subtest bb-start-param: SKIP (0.000s) [86.333965] [012/130] (938s left) kms_feature_discovery (chamelium) [86.436705] Starting subtest: chamelium [86.441257] Subtest chamelium: SKIP (0.000s) [86.502233] [013/130] (937s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [86.601746] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [87.481485] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.881s) [87.696636] [014/130] (936s left) i915_pm_freq_api (freq-reset-multiple) [87.767486] Starting subtest: freq-reset-multiple [87.769928] Starting dynamic subtest: gt0 [97.658523] Dynamic subtest gt0: SUCCESS (9.889s) [97.667472] Starting dynamic subtest: gt1 [106.260082] Dynamic subtest gt1: SUCCESS (8.601s) [106.262775] Subtest freq-reset-multiple: SUCCESS (18.490s) [106.332183] [015/130] (918s left) perf (whitelisted-registers-userspace-config) [106.439463] Starting subtest: whitelisted-registers-userspace-config [106.441641] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s) [106.474020] [016/130] (918s left) gem_exec_create (basic) [106.547362] Starting subtest: basic [106.549766] Starting dynamic subtest: smem [109.930461] Dynamic subtest smem: SUCCESS (3.381s) [109.933213] Subtest basic: SUCCESS (3.381s) [110.109424] [017/130] (914s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [110.219292] Starting subtest: 2x-flip-vs-absolute-wf_vblank [110.230368] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s) [110.312653] [018/130] (914s left) sysfs_preempt_timeout (invalid) [110.378689] Starting subtest: invalid [110.381174] Starting dynamic subtest: vecs0 [110.383553] Dynamic subtest vecs0: SUCCESS (0.000s) [110.392306] Starting dynamic subtest: ccs0 [110.394591] Dynamic subtest ccs0: SUCCESS (0.000s) [110.402605] Starting dynamic subtest: vcs0 [110.405397] Dynamic subtest vcs0: SUCCESS (0.000s) [110.413775] Starting dynamic subtest: bcs0 [110.415996] Dynamic subtest bcs0: SUCCESS (0.000s) [110.423376] Starting dynamic subtest: rcs0 [110.425750] Dynamic subtest rcs0: SUCCESS (0.000s) [110.435141] Starting dynamic subtest: vcs1 [110.437083] Dynamic subtest vcs1: SUCCESS (0.000s) [110.439028] Subtest invalid: SUCCESS (0.002s) [110.481697] [019/130] (914s left) gem_exec_params (rs-invalid) [110.551478] Starting subtest: rs-invalid [110.556498] Subtest rs-invalid: SUCCESS (0.003s) [110.660128] [020/130] (914s left) perf_pmu (busy-accuracy-2) [110.700997] Starting subtest: busy-accuracy-2 [110.703395] Starting dynamic subtest: rcs0 [113.749076] Dynamic subtest rcs0: SUCCESS (3.046s) [113.758750] Starting dynamic subtest: bcs0 [116.814580] Dynamic subtest bcs0: SUCCESS (3.065s) [116.825154] Starting dynamic subtest: vcs0 [119.857790] Dynamic subtest vcs0: SUCCESS (3.043s) [119.868254] Starting dynamic subtest: vcs1 [122.906506] Dynamic subtest vcs1: SUCCESS (3.048s) [122.916297] Starting dynamic subtest: vecs0 [125.950120] Dynamic subtest vecs0: SUCCESS (3.043s) [125.960077] Starting dynamic subtest: ccs0 [129.012245] Dynamic subtest ccs0: SUCCESS (3.061s) [129.014950] Subtest busy-accuracy-2: SUCCESS (18.310s) [129.121179] [021/130] (895s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [129.231318] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [129.235442] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [129.328915] [022/130] (895s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [129.433656] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [129.438246] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [129.541644] [023/130] (895s left) syncobj_timeline (host-signal-points) [129.596062] Starting subtest: host-signal-points [129.601604] Subtest host-signal-points: SUCCESS (0.006s) [129.706145] [024/130] (895s left) kms_cursor_crc (cursor-sliding-64x21) [129.890646] Starting subtest: cursor-sliding-64x21 [129.931665] Subtest cursor-sliding-64x21: SKIP (0.035s) [130.184193] [025/130] (894s left) kms_big_fb (4-tiled-32bpp-rotate-0) [130.306589] Starting subtest: 4-tiled-32bpp-rotate-0 [131.929884] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.622s) [132.124933] [026/130] (892s left) kms_chamelium_color (ctm-negative) [132.228228] Subtest ctm-negative: SKIP (0.000s) [132.267505] [027/130] (892s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [132.340361] Starting subtest: y-tiled-ccs-to-x-tiled [132.344904] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [132.514326] [028/130] (892s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [132.579143] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [132.641449] [029/130] (892s left) intel_hwmon (hwmon-read) [132.702100] Subtest hwmon-read: SKIP (0.000s) [132.762456] [030/130] (892s left) kms_psr (fbc-psr2-sprite-plane-move) [132.864756] Starting subtest: fbc-psr2-sprite-plane-move [132.867150] Starting dynamic subtest: eDP-1 [132.871403] Dynamic subtest eDP-1: SKIP (0.000s) [132.875652] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s) [132.934034] [031/130] (892s left) perf (mi-rpc) [133.015666] Starting subtest: mi-rpc [133.020360] Subtest mi-rpc: SKIP (0.000s) [133.055375] [032/130] (892s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [133.168704] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [134.058614] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.892s) [134.282604] [033/130] (890s left) kms_flip (flip-vs-blocking-wf-vblank) [134.393519] Starting subtest: flip-vs-blocking-wf-vblank [134.395962] Starting dynamic subtest: A-eDP1 [143.322082] Dynamic subtest A-eDP1: SUCCESS (8.929s) [143.331124] Starting dynamic subtest: B-eDP1 [152.249497] Dynamic subtest B-eDP1: SUCCESS (8.927s) [152.262960] Starting dynamic subtest: C-eDP1 [161.157721] Dynamic subtest C-eDP1: SUCCESS (8.907s) [161.167236] Starting dynamic subtest: D-eDP1 [170.078076] Dynamic subtest D-eDP1: SUCCESS (8.918s) [170.080824] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.686s) [171.294510] [034/130] (853s left) kms_plane_scaling (plane-downscale-factor-0-25-with-rotation) [171.391029] Starting subtest: plane-downscale-factor-0-25-with-rotation [171.393529] Starting dynamic subtest: pipe-A [171.409350] Dynamic subtest pipe-A: SKIP (0.012s) [171.418169] Starting dynamic subtest: pipe-B [171.431904] Dynamic subtest pipe-B: SKIP (0.022s) [171.440579] Starting dynamic subtest: pipe-C [171.455105] Dynamic subtest pipe-C: SKIP (0.024s) [171.462824] Starting dynamic subtest: pipe-D [171.475612] Dynamic subtest pipe-D: SKIP (0.022s) [171.480060] Subtest plane-downscale-factor-0-25-with-rotation: SKIP (0.080s) [171.584184] [035/130] (853s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [171.679973] Starting subtest: plane-upscale-20x20-with-modifiers [171.682298] Starting dynamic subtest: pipe-A [172.017423] Dynamic subtest pipe-A: SUCCESS (0.337s) [172.026020] Starting dynamic subtest: pipe-B [173.388399] Dynamic subtest pipe-B: SUCCESS (1.371s) [173.397849] Starting dynamic subtest: pipe-C [174.817497] Dynamic subtest pipe-C: SUCCESS (1.429s) [174.826539] Starting dynamic subtest: pipe-D [176.241781] Dynamic subtest pipe-D: SUCCESS (1.424s) [176.244082] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.562s) [177.395986] [036/130] (847s left) gem_exec_balancer (full) [177.462833] Starting subtest: full [181.665972] Subtest full: SUCCESS (4.203s) [181.990310] [037/130] (843s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [182.090345] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [182.092723] Starting dynamic subtest: pipe-A-eDP-1 [182.152456] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [182.160783] Starting dynamic subtest: pipe-B-eDP-1 [182.217045] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [182.226213] Starting dynamic subtest: pipe-C-eDP-1 [182.284081] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [182.292931] Starting dynamic subtest: pipe-D-eDP-1 [182.351627] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [182.356367] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s) [184.242121] [038/130] (841s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [184.341164] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [184.343609] Starting dynamic subtest: pipe-A-eDP-1 [184.367411] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [184.377574] Starting dynamic subtest: pipe-B-eDP-1 [184.399782] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [184.407349] Starting dynamic subtest: pipe-C-eDP-1 [184.429214] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [184.436196] Starting dynamic subtest: pipe-D-eDP-1 [184.458213] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [184.462646] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s) [186.496420] [039/130] (838s left) perf_pmu (faulting-read) [186.539742] Starting subtest: faulting-read [186.542075] Starting dynamic subtest: wb [186.544230] Dynamic subtest wb: SUCCESS (0.001s) [186.551467] Starting dynamic subtest: wc [186.553313] Dynamic subtest wc: SUCCESS (0.000s) [186.560490] Starting dynamic subtest: uc [186.562378] Dynamic subtest uc: SUCCESS (0.000s) [186.564234] Subtest faulting-read: SUCCESS (0.002s) [186.638171] [040/130] (838s left) kms_vblank (wait-forked-hang) [186.737086] Starting subtest: wait-forked-hang [186.739484] Starting dynamic subtest: pipe-A-eDP-1 [213.732696] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.992s) [213.745712] Starting dynamic subtest: pipe-D-eDP-1 [238.751108] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.016s) [238.753595] Subtest wait-forked-hang: SUCCESS (52.012s) [239.544391] [041/130] (785s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [239.664450] Starting subtest: basic-flip-before-cursor-legacy [240.594701] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.929s) [241.466683] [042/130] (783s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [241.573270] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [244.204449] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.636s) [244.347706] [043/130] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite) [244.449791] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite [251.742477] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (7.294s) [251.876209] [044/130] (773s left) kms_plane_alpha_blend (alpha-7efc) [251.988046] Starting subtest: alpha-7efc [252.438345] Starting dynamic subtest: pipe-A-eDP-1 [253.018978] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s) [253.034507] Starting dynamic subtest: pipe-D-eDP-1 [254.245505] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s) [254.248085] Subtest alpha-7efc: SUCCESS (2.256s) [255.116831] [045/130] (770s left) syncobj_wait (wait-all-complex) [255.189776] Starting subtest: wait-all-complex [255.405867] Subtest wait-all-complex: SUCCESS (0.214s) [255.475341] [046/130] (770s left) kms_flip (2x-flip-vs-panning-vs-hang) [255.580074] Starting subtest: 2x-flip-vs-panning-vs-hang [255.591506] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s) [255.669536] [047/130] (769s left) kms_addfb_basic (bo-too-small) [255.771081] Starting subtest: bo-too-small [255.772987] Subtest bo-too-small: SUCCESS (0.000s) [255.878102] [048/130] (769s left) gem_exec_fence (syncobj-channel) [256.326419] Starting subtest: syncobj-channel [257.349421] Subtest syncobj-channel: SUCCESS (1.020s) [258.053952] [049/130] (767s left) syncobj_timeline (32bits-limit) [258.115047] Starting subtest: 32bits-limit [258.117505] Subtest 32bits-limit: SUCCESS (0.001s) [258.220371] [050/130] (767s left) kms_psr (fbc-pr-sprite-mmap-cpu) [258.317343] Starting subtest: fbc-pr-sprite-mmap-cpu [258.321895] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [258.385575] [051/130] (767s left) kms_joiner (invalid-modeset-ultra-joiner) [258.499445] Starting subtest: invalid-modeset-ultra-joiner [258.503824] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [258.557040] [052/130] (767s left) gem_exec_async (concurrent-writes) [258.623967] Starting subtest: concurrent-writes [258.626299] Starting dynamic subtest: rcs0 [258.641707] Dynamic subtest rcs0: SUCCESS (0.018s) [258.651575] Starting dynamic subtest: bcs0 [258.653642] Dynamic subtest bcs0: SUCCESS (0.006s) [258.665303] Starting dynamic subtest: vcs0 [258.667517] Dynamic subtest vcs0: SUCCESS (0.005s) [258.676963] Starting dynamic subtest: vcs1 [258.678982] Dynamic subtest vcs1: SUCCESS (0.009s) [258.686029] Starting dynamic subtest: vecs0 [258.687940] Dynamic subtest vecs0: SUCCESS (0.005s) [258.694988] Starting dynamic subtest: ccs0 [258.696876] Dynamic subtest ccs0: SUCCESS (0.004s) [258.698733] Subtest concurrent-writes: SUCCESS (0.049s) [258.915629] [053/130] (766s left) prime_mmap (test_dup) [258.971513] Starting subtest: test_dup [258.973636] Starting dynamic subtest: test_dup-smem [259.002375] Dynamic subtest test_dup-smem: SUCCESS (0.034s) [259.004887] Subtest test_dup: SUCCESS (0.034s) [259.072129] [054/130] (766s left) gem_sync (basic-all) [259.145529] Starting subtest: basic-all [262.919960] Subtest basic-all: SUCCESS (3.778s) [263.099084] [055/130] (762s left) kms_pm_rpm (modeset-lpsp-stress) [265.144058] Starting subtest: modeset-lpsp-stress [281.672579] Subtest modeset-lpsp-stress: SUCCESS (16.529s) [281.758191] [056/130] (744s left) api_intel_allocator (alloc-simple) [281.816547] Starting subtest: alloc-simple [281.819051] Subtest alloc-simple: SUCCESS (0.003s) [281.944925] [057/130] (744s left) perf_pmu (interrupts) [281.988308] Starting subtest: interrupts [283.067753] Subtest interrupts: SUCCESS (1.080s) [283.179181] [058/130] (742s left) gem_exec_schedule (u-independent) [283.252371] Starting subtest: u-independent [283.254433] Starting dynamic subtest: rcs0 [284.906569] Dynamic subtest rcs0: SUCCESS (1.662s) [284.917876] Starting dynamic subtest: vcs0 [286.964329] Dynamic subtest vcs0: SUCCESS (2.057s) [286.975689] Starting dynamic subtest: vcs1 [288.973814] Dynamic subtest vcs1: SUCCESS (2.008s) [288.985229] Starting dynamic subtest: vecs0 [290.971365] Dynamic subtest vecs0: SUCCESS (1.996s) [290.985311] Starting dynamic subtest: ccs0 [292.906892] Dynamic subtest ccs0: SUCCESS (1.933s) [292.910086] Subtest u-independent: SUCCESS (9.663s) [293.202151] [059/130] (732s left) kms_atomic_interruptible (legacy-cursor) [293.310707] Starting subtest: legacy-cursor [293.313071] Starting dynamic subtest: pipe-A-eDP-1 [300.732059] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.420s) [300.734419] Subtest legacy-cursor: SUCCESS (7.421s) [301.568729] [060/130] (724s left) gem_exec_reloc (basic-cpu-read) [301.643165] Subtest basic-cpu-read: SKIP (0.000s) [301.716898] [061/130] (724s left) kms_psr2_sf (pr-cursor-plane-update-sf) [306.714799] Starting subtest: pr-cursor-plane-update-sf [306.719353] Subtest pr-cursor-plane-update-sf: SKIP (0.002s) [307.572750] [062/130] (718s left) gem_exec_reloc (basic-wc-gtt-noreloc) [307.629658] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [307.719109] [063/130] (718s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [307.809420] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [307.811817] Starting dynamic subtest: pipe-A-default-mode [308.101636] Dynamic subtest pipe-A-default-mode: SKIP (0.289s) [308.106164] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.290s) [308.894088] [064/130] (717s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [308.994213] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [308.996426] Starting dynamic subtest: pipe-A-default-mode [309.280729] Dynamic subtest pipe-A-default-mode: SKIP (0.281s) [309.285318] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.282s) [310.115723] [065/130] (716s left) kms_cursor_crc (cursor-random-128x128) [310.303697] Starting subtest: cursor-random-128x128 [310.308437] Starting dynamic subtest: pipe-A-eDP-1 [314.136492] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.827s) [314.160401] Starting dynamic subtest: pipe-D-eDP-1 [318.516859] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.363s) [318.519543] Subtest cursor-random-128x128: SUCCESS (8.211s) [319.365992] [066/130] (706s left) syncobj_timeline (multi-wait-for-submit-signaled) [319.441420] Starting subtest: multi-wait-for-submit-signaled [319.443731] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [319.554982] [067/130] (706s left) kms_cursor_edge_walk (128x128-top-edge) [319.650027] Starting subtest: 128x128-top-edge [319.652244] Starting dynamic subtest: pipe-A-eDP-1 [323.114749] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s) [323.123808] Starting dynamic subtest: pipe-D-eDP-1 [326.231557] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s) [326.233883] Subtest 128x128-top-edge: SUCCESS (6.579s) [327.037074] [068/130] (699s left) kms_cursor_crc (cursor-alpha-transparent) [327.144462] Starting subtest: cursor-alpha-transparent [327.146775] Starting dynamic subtest: pipe-A-eDP-1 [327.785199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.642s) [327.794519] Starting dynamic subtest: pipe-D-eDP-1 [329.040605] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.253s) [329.042715] Subtest cursor-alpha-transparent: SUCCESS (1.898s) [329.895042] [069/130] (696s left) kms_psr (psr-suspend) [329.992389] Starting subtest: psr-suspend [329.994708] Starting dynamic subtest: eDP-1 [348.018622] Dynamic subtest eDP-1: SUCCESS (2.956s) [348.021000] Subtest psr-suspend: SUCCESS (2.957s) [348.867936] [070/130] (692s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt) [348.971317] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt [348.975770] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [349.051948] [071/130] (692s left) gem_exec_whisper (basic-fds-forked) [349.111880] Starting subtest: basic-fds-forked [372.864470] Subtest basic-fds-forked: SUCCESS (23.744s) [373.045858] [072/130] (668s left) kms_busy (extended-pageflip-hang-oldfb) [373.163334] Starting subtest: extended-pageflip-hang-oldfb [373.165653] Starting dynamic subtest: pipe-A [373.602716] Dynamic subtest pipe-A: SUCCESS (0.437s) [373.612621] Starting dynamic subtest: pipe-D [374.709198] Dynamic subtest pipe-D: SUCCESS (1.102s) [374.713547] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.543s) [375.526887] [073/130] (666s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [375.634598] Starting subtest: psr-1p-primscrn-cur-indfb-move [380.771357] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (5.140s) [380.917535] [074/130] (660s left) kms_dp_link_training (non-uhbr-sst) [381.019260] Starting subtest: non-uhbr-sst [381.027796] Subtest non-uhbr-sst: SKIP (0.000s) [381.090727] [075/130] (660s left) gem_ctx_shared (q-in-order) [381.161725] Starting subtest: Q-in-order [381.164156] Starting dynamic subtest: rcs0 [381.279816] Dynamic subtest rcs0: SUCCESS (0.116s) [381.292371] Starting dynamic subtest: vcs0 [381.367182] Dynamic subtest vcs0: SUCCESS (0.086s) [381.386078] Starting dynamic subtest: vcs1 [381.447069] Dynamic subtest vcs1: SUCCESS (0.079s) [381.463787] Starting dynamic subtest: vecs0 [381.527974] Dynamic subtest vecs0: SUCCESS (0.080s) [381.542305] Starting dynamic subtest: ccs0 [381.598871] Dynamic subtest ccs0: SUCCESS (0.070s) [381.601361] Subtest Q-in-order: SUCCESS (0.437s) [383.078272] [076/130] (658s left) syncobj_wait (multi-wait-for-submit-submitted) [383.135696] Starting subtest: multi-wait-for-submit-submitted [383.243942] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s) [383.315442] [077/130] (658s left) kms_big_fb (x-tiled-64bpp-rotate-180) [383.416046] Starting subtest: x-tiled-64bpp-rotate-180 [385.745903] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.329s) [385.978661] [078/130] (655s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [386.091281] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [389.520789] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (3.432s) [389.653933] [079/130] (652s left) kms_addfb_basic (clobberred-modifier) [389.708149] Starting subtest: clobberred-modifier [389.711956] Subtest clobberred-modifier: SKIP (0.000s) [389.848892] [080/130] (652s left) gem_lmem_swapping (heavy-verify-multi) [389.908351] Subtest heavy-verify-multi: SKIP (0.000s) [389.946048] [081/130] (651s left) gem_exec_reloc (basic-write-wc-noreloc) [390.006637] Subtest basic-write-wc-noreloc: SKIP (0.000s) [390.067459] [082/130] (651s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [390.195934] Starting subtest: cursorB-vs-flipB-toggle [390.199824] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [390.328382] [083/130] (651s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [390.431416] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [390.434689] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [390.520975] [084/130] (651s left) gem_softpin (evict-active-interruptible) [390.585573] Starting subtest: evict-active-interruptible [390.591323] Subtest evict-active-interruptible: SUCCESS (0.006s) [390.732061] [085/130] (651s left) kms_getfb (getfb2-handle-zero) [390.784387] Starting subtest: getfb2-handle-zero [390.786253] Subtest getfb2-handle-zero: SUCCESS (0.000s) [390.890941] [086/130] (651s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [390.983616] Starting subtest: fbc-rgb101010-draw-mmap-gtt [390.987105] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [391.079488] [087/130] (651s left) i915_pm_rps (fence-order) [391.134337] Starting subtest: fence-order [393.636962] Subtest fence-order: SUCCESS (2.500s) [393.713270] [088/130] (648s left) dumb_buffer (invalid-bpp) [393.780196] Starting subtest: invalid-bpp [393.782401] Subtest invalid-bpp: SUCCESS (0.000s) [393.893908] [089/130] (648s left) kms_psr2_su (page_flip-xrgb8888) [393.954282] Subtest page_flip-XRGB8888: SKIP (0.000s) [394.010227] [090/130] (648s left) syncobj_timeline (invalid-wait-illegal-handle) [394.067487] Starting subtest: invalid-wait-illegal-handle [394.069665] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [394.182616] [091/130] (648s left) gem_create (create-massive) [394.227566] Starting subtest: create-massive [394.229535] Subtest create-massive: SUCCESS (0.000s) [394.419967] [092/130] (647s left) kms_flip (modeset-vs-vblank-race) [394.532450] Starting subtest: modeset-vs-vblank-race [394.534872] Starting dynamic subtest: A-eDP1 [399.205301] Dynamic subtest A-eDP1: SUCCESS (4.671s) [399.216449] Starting dynamic subtest: B-eDP1 [403.901601] Dynamic subtest B-eDP1: SUCCESS (4.694s) [403.912586] Starting dynamic subtest: C-eDP1 [408.485983] Dynamic subtest C-eDP1: SUCCESS (4.581s) [408.502221] Starting dynamic subtest: D-eDP1 [412.996808] Dynamic subtest D-eDP1: SUCCESS (4.510s) [413.001749] Subtest modeset-vs-vblank-race: SUCCESS (18.468s) [414.246897] [093/130] (628s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [414.376459] Starting subtest: verify-pxp-stale-buf-optout-execution [415.433664] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.058s) [415.580312] [094/130] (626s left) gem_partial_pwrite_pread (reads) [415.636663] Subtest reads: SKIP (0.000s) [415.717385] [095/130] (626s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [415.812517] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [415.814848] Starting dynamic subtest: pipe-A-eDP-1 [415.837998] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [415.849150] Starting dynamic subtest: pipe-B-eDP-1 [415.871218] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [415.879406] Starting dynamic subtest: pipe-C-eDP-1 [415.900312] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [415.908520] Starting dynamic subtest: pipe-D-eDP-1 [415.929439] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [415.933315] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s) [417.996581] [096/130] (624s left) gem_ctx_persistence (heartbeat-hostile) [418.059643] Starting subtest: heartbeat-hostile [418.064226] Subtest heartbeat-hostile: SKIP (0.000s) [418.169708] [097/130] (624s left) gem_pxp (create-regular-buffer) [418.233937] Starting subtest: create-regular-buffer [418.236434] Subtest create-regular-buffer: SUCCESS (0.000s) [418.347885] [098/130] (624s left) kms_chamelium_hpd (dp-hpd-storm-disable) [418.729290] Subtest dp-hpd-storm-disable: SKIP (0.000s) [419.503973] [099/130] (623s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [419.618539] Starting subtest: yf-tiled-addfb-size-offset-overflow [419.622824] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [419.696681] [100/130] (622s left) kms_panel_fitting (legacy) [419.786278] Starting subtest: legacy [419.788570] Starting dynamic subtest: pipe-A-eDP-1 [420.389837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s) [420.417010] Starting dynamic subtest: pipe-B-eDP-1 [422.033844] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.624s) [422.061172] Starting dynamic subtest: pipe-C-eDP-1 [423.639844] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.585s) [423.667971] Starting dynamic subtest: pipe-D-eDP-1 [425.279433] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.618s) [425.281807] Subtest legacy: SUCCESS (5.491s) [426.534582] [101/130] (616s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt) [426.644482] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt [426.648855] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [426.748447] [102/130] (615s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [426.861960] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [426.866447] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [426.959897] [103/130] (615s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [427.066522] Starting subtest: fbcpsr-slowdraw [450.083834] Subtest fbcpsr-slowdraw: SUCCESS (23.017s) [450.222404] [104/130] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [450.332633] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [450.336706] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [450.442877] [105/130] (592s left) kms_psr (fbc-psr-sprite-plane-onoff) [450.541495] Starting subtest: fbc-psr-sprite-plane-onoff [450.543876] Starting dynamic subtest: eDP-1 [450.548398] Dynamic subtest eDP-1: SKIP (0.000s) [450.552867] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s) [450.614612] [106/130] (592s left) kms_flip (bo-too-big) [450.725931] Starting subtest: bo-too-big [450.728095] Starting dynamic subtest: A-eDP1 [452.493278] Dynamic subtest A-eDP1: SUCCESS (1.766s) [452.503938] Starting dynamic subtest: B-eDP1 [454.228289] Dynamic subtest B-eDP1: SUCCESS (1.734s) [454.240120] Starting dynamic subtest: C-eDP1 [455.965115] Dynamic subtest C-eDP1: SUCCESS (1.736s) [455.973808] Starting dynamic subtest: D-eDP1 [457.779075] Dynamic subtest D-eDP1: SUCCESS (1.811s) [457.785180] Subtest bo-too-big: SUCCESS (7.056s) [458.907508] [107/130] (583s left) syncobj_timeline (single-wait-for-submit-signaled) [458.971275] Starting subtest: single-wait-for-submit-signaled [458.973428] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [459.072657] [108/130] (583s left) api_intel_allocator (two-level-inception-interruptible) [459.133671] Starting subtest: two-level-inception-interruptible [464.548535] Subtest two-level-inception-interruptible: SUCCESS (5.416s) [464.665609] [109/130] (578s left) gem_exec_schedule (preempt-self) [464.744420] Starting subtest: preempt-self [464.746328] Starting dynamic subtest: rcs0 [464.774577] Dynamic subtest rcs0: SUCCESS (0.034s) [464.787676] Starting dynamic subtest: bcs0 [464.808875] Dynamic subtest bcs0: SUCCESS (0.032s) [464.820156] Starting dynamic subtest: vcs0 [464.840094] Dynamic subtest vcs0: SUCCESS (0.030s) [464.849616] Starting dynamic subtest: vcs1 [464.868794] Dynamic subtest vcs1: SUCCESS (0.028s) [464.878780] Starting dynamic subtest: vecs0 [464.898332] Dynamic subtest vecs0: SUCCESS (0.029s) [464.907503] Starting dynamic subtest: ccs0 [464.926329] Dynamic subtest ccs0: SUCCESS (0.027s) [464.928710] Subtest preempt-self: SUCCESS (0.186s) [466.087968] [110/130] (576s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [466.209508] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [466.213730] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [466.318435] [111/130] (576s left) drm_fdinfo (busy-hang) [466.359158] Starting subtest: busy-hang [466.361269] Starting dynamic subtest: rcs0 [466.408625] Dynamic subtest rcs0: SKIP (0.048s) [466.420671] Starting dynamic subtest: bcs0 [466.424830] Dynamic subtest bcs0: SKIP (0.001s) [466.436294] Starting dynamic subtest: vcs0 [466.440613] Dynamic subtest vcs0: SKIP (0.000s) [466.448955] Starting dynamic subtest: vcs1 [466.452877] Dynamic subtest vcs1: SKIP (0.001s) [466.461216] Starting dynamic subtest: vecs0 [466.465202] Dynamic subtest vecs0: SKIP (0.000s) [466.473164] Starting dynamic subtest: ccs0 [466.477129] Dynamic subtest ccs0: SKIP (0.001s) [466.481047] Subtest busy-hang: SKIP (0.056s) [466.513674] [112/130] (576s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [466.622766] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [466.626763] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [466.733272] [113/130] (576s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [466.839392] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [466.841672] Starting dynamic subtest: pipe-A [466.914835] Dynamic subtest pipe-A: SUCCESS (0.074s) [466.932161] Starting dynamic subtest: pipe-B [468.038553] Dynamic subtest pipe-B: SUCCESS (1.122s) [468.050103] Starting dynamic subtest: pipe-C [469.140355] Dynamic subtest pipe-C: SUCCESS (1.100s) [469.149814] Starting dynamic subtest: pipe-D [470.275859] Dynamic subtest pipe-D: SUCCESS (1.134s) [470.278330] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.436s) [471.413528] [114/130] (571s left) sriov_basic (bind-unbind-vf) [471.475631] Starting subtest: bind-unbind-vf [471.477957] Starting dynamic subtest: vf-1 [471.552903] Dynamic subtest vf-1: FAIL (0.004s) [471.563409] Starting dynamic subtest: vf-2 [471.637487] Dynamic subtest vf-2: FAIL (0.003s) [471.648249] Starting dynamic subtest: vf-3 [471.721999] Dynamic subtest vf-3: FAIL (0.003s) [471.732049] Starting dynamic subtest: vf-4 [471.800490] Dynamic subtest vf-4: FAIL (0.003s) [471.809511] Starting dynamic subtest: vf-5 [471.878964] Dynamic subtest vf-5: FAIL (0.004s) [471.887471] Starting dynamic subtest: vf-6 [471.960713] Dynamic subtest vf-6: FAIL (0.003s) [471.970841] Starting dynamic subtest: vf-7 [472.042617] Dynamic subtest vf-7: FAIL (0.004s) [472.051489] Starting dynamic subtest: vf-random [472.120291] Dynamic subtest vf-random: FAIL (0.003s) [472.128934] Starting dynamic subtest: vf-last [472.198176] Dynamic subtest vf-last: FAIL (0.506s) [472.200117] Subtest bind-unbind-vf: FAIL (0.540s) [472.231165] [115/130] (570s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render) [472.335269] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render [475.545688] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (3.219s) [475.656317] [116/130] (567s left) gem_mmap_gtt (flink-race) [475.710417] Subtest flink-race: SKIP (0.000s) [475.767404] [117/130] (567s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [475.861964] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [475.863955] Starting dynamic subtest: pipe-A-eDP-1 [476.053415] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.180s) [476.063438] Starting dynamic subtest: pipe-B-eDP-1 [476.083504] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [476.092566] Starting dynamic subtest: pipe-C-eDP-1 [476.112618] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [476.121869] Starting dynamic subtest: pipe-D-eDP-1 [476.141846] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [476.144113] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.188s) [478.295631] [118/130] (564s left) gem_spin_batch (spin-each) [478.357004] Starting subtest: spin-each [481.630605] Subtest spin-each: SUCCESS (3.266s) [482.009389] [119/130] (561s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [482.130786] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [482.134968] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [482.243522] [120/130] (561s left) sw_sync (timeline_closed) [482.282165] Starting subtest: timeline_closed [482.284494] Subtest timeline_closed: SUCCESS (0.000s) [482.338617] [121/130] (561s left) gem_mmap_wc (close) [482.404601] Subtest close: SKIP (0.000s) [482.467188] [122/130] (560s left) gem_softpin (allocator-basic-reserve) [482.533670] Starting subtest: allocator-basic-reserve [482.595041] Subtest allocator-basic-reserve: SUCCESS (0.061s) [482.738458] [123/130] (560s left) gem_mmap_offset (open-flood) [482.801183] Starting subtest: open-flood [504.295059] Subtest open-flood: SUCCESS (21.494s) [504.409587] [124/130] (539s left) kms_lease (multimaster-lease) [504.520057] Starting subtest: multimaster-lease [504.524554] Subtest multimaster-lease: SUCCESS (0.004s) [504.619421] [125/130] (538s left) kms_psr (psr2-primary-mmap-gtt) [504.717246] Starting subtest: psr2-primary-mmap-gtt [504.719241] Starting dynamic subtest: eDP-1 [506.185227] Dynamic subtest eDP-1: SKIP (1.463s) [506.190083] Subtest psr2-primary-mmap-gtt: SKIP (1.464s) [506.319252] [126/130] (537s left) gem_mmap_gtt (big-bo) [506.381943] Subtest big-bo: SKIP (0.000s) [506.460566] [127/130] (537s left) kms_psr (psr-sprite-mmap-gtt) [506.560522] Starting subtest: psr-sprite-mmap-gtt [506.562808] Starting dynamic subtest: eDP-1 [508.042402] Dynamic subtest eDP-1: SKIP (1.477s) [508.047395] Subtest psr-sprite-mmap-gtt: SKIP (1.478s) [508.230594] [128/130] (535s left) kms_addfb_basic (bad-pitch-999) [508.296206] Starting subtest: bad-pitch-999 [508.298567] Subtest bad-pitch-999: SUCCESS (0.000s) [508.443440] [129/130] (535s left) gem_ccs (block-copy-compressed) [508.524627] Starting subtest: block-copy-compressed [508.528947] Subtest block-copy-compressed: SKIP (0.000s) [508.617225] [130/130] (535s left) kms_concurrent (multi-plane-atomic-lowres) [508.725832] Starting subtest: multi-plane-atomic-lowres [508.727831] Starting dynamic subtest: pipe-A-eDP-1 [509.224047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.498s) [509.226510] Subtest multi-plane-atomic-lowres: SUCCESS (0.499s) [510.068522] Closing watchdogs Done.