[63.788646] Initializing watchdogs
[63.788694]   /dev/watchdog0
[63.812871] [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.817546] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.819926] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.823875] [001/155] (960s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[63.918087] Starting subtest: saturated-hostile-nopreempt
[63.920090] Starting dynamic subtest: rcs0
[63.989604] Dynamic subtest rcs0: SKIP (0.071s)
[63.999456] Starting dynamic subtest: bcs0
[64.008525] Dynamic subtest bcs0: SKIP (0.019s)
[64.015666] Starting dynamic subtest: vcs0
[64.030649] Dynamic subtest vcs0: SKIP (0.021s)
[64.037999] Starting dynamic subtest: vcs1
[64.047767] Dynamic subtest vcs1: SKIP (0.016s)
[64.055090] Starting dynamic subtest: vecs0
[64.065493] Dynamic subtest vecs0: SKIP (0.017s)
[64.072354] Starting dynamic subtest: ccs0
[64.083702] Dynamic subtest ccs0: SKIP (0.018s)
[64.088284] Subtest saturated-hostile-nopreempt: SKIP (0.165s)
[64.160982] [002/155] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[64.273596] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[64.277907] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[64.358805] [003/155] (960s left) syncobj_timeline (wait-all-delayed-signal)
[64.415587] Starting subtest: wait-all-delayed-signal
[64.520832] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[64.605830] [004/155] (959s left) kms_psr (pr-cursor-mmap-cpu)
[64.703427] Starting subtest: pr-cursor-mmap-cpu
[64.707843] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[64.774327] [005/155] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[64.873288] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[64.877370] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[64.991942] [006/155] (959s left) kms_feature_discovery (psr2)
[65.084504] Starting subtest: psr2
[65.086391] Subtest psr2: SUCCESS (0.000s)
[65.168301] [007/155] (959s left) api_intel_allocator (reopen-fork)
[65.229768] Starting subtest: reopen-fork
[68.539306] Subtest reopen-fork: SUCCESS (3.297s)
[68.625479] [008/155] (955s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[68.722249] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[68.724539] Starting dynamic subtest: pipe-A-eDP-1
[68.747259] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.757600] Starting dynamic subtest: pipe-B-eDP-1
[68.778959] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.785949] Starting dynamic subtest: pipe-C-eDP-1
[68.806895] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.813930] Starting dynamic subtest: pipe-D-eDP-1
[68.835037] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.839113] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[71.219224] [009/155] (953s left) kms_fbcon_fbt (fbc-suspend)
[71.281720] Starting subtest: fbc-suspend
[120.892310] Subtest fbc-suspend: SUCCESS (20.325s)
[129.255685] [010/155] (902s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[129.363551] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[129.365917] Starting dynamic subtest: pipe-A-default-mode
[132.137249] Dynamic subtest pipe-A-default-mode: SUCCESS (2.723s)
[132.139530] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.724s)
[133.002458] [011/155] (898s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[133.108581] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[133.113067] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[133.207360] [012/155] (898s left) kms_addfb_basic (bad-pitch-0)
[133.264171] Starting subtest: bad-pitch-0
[133.266092] Subtest bad-pitch-0: SUCCESS (0.000s)
[133.412768] [013/155] (898s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[133.509429] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[133.535674] Starting dynamic subtest: pipe-A-plane-0
[133.852743] Dynamic subtest pipe-A-plane-0: SUCCESS (0.311s)
[133.863178] Starting dynamic subtest: pipe-A-plane-3
[134.098488] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[134.107830] Starting dynamic subtest: pipe-A-plane-5
[134.112126] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[135.226430] Starting dynamic subtest: pipe-B-plane-0
[135.532479] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[135.543144] Starting dynamic subtest: pipe-B-plane-3
[135.778624] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[135.787254] Starting dynamic subtest: pipe-B-plane-5
[135.791809] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[136.079378] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.539s)
[136.920932] [014/155] (894s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt)
[137.024153] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt
[137.028743] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[137.124027] [015/155] (894s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[137.223540] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[137.227805] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[137.304803] [016/155] (894s left) kms_psr (pr-sprite-mmap-cpu)
[137.389151] Starting subtest: pr-sprite-mmap-cpu
[137.393447] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[137.458158] [017/155] (894s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt)
[137.562858] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt
[137.567388] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[137.656823] [018/155] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[137.749387] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[145.169766] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.385s)
[145.283202] [019/155] (886s left) kms_joiner (basic-force-ultra-joiner)
[145.380231] Starting subtest: basic-force-ultra-joiner
[145.384741] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[145.445917] [020/155] (886s left) gem_exec_balancer (waits)
[145.510936] Starting subtest: waits
[152.151694] Subtest waits: SUCCESS (6.570s)
[152.405223] [021/155] (879s left) gem_ctx_shared (disjoint-timelines)
[152.461386] Starting subtest: disjoint-timelines
[152.516073] Subtest disjoint-timelines: SUCCESS (0.054s)
[152.747038] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[152.750202] [022/155] (879s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[152.854670] Starting subtest: fbcpsr-rgb101010-draw-blt
[157.689205] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.833s)
[157.814976] [023/155] (874s left) gem_close_race (multigpu-basic-process)
[157.882925] Starting subtest: multigpu-basic-process
[157.887093] Subtest multigpu-basic-process: SKIP (0.000s)
[158.118170] [024/155] (874s left) i915_drm_fdinfo (busy-check-all)
[158.158391] Starting subtest: busy-check-all
[158.160562] Starting dynamic subtest: rcs0
[158.164837] Dynamic subtest rcs0: SKIP (0.005s)
[158.174487] Starting dynamic subtest: bcs0
[158.178419] Dynamic subtest bcs0: SKIP (0.001s)
[158.187255] Starting dynamic subtest: vcs0
[158.191738] Dynamic subtest vcs0: SKIP (0.001s)
[158.200498] Starting dynamic subtest: vcs1
[158.204636] Dynamic subtest vcs1: SKIP (0.001s)
[158.213045] Starting dynamic subtest: vecs0
[158.217205] Dynamic subtest vecs0: SKIP (0.000s)
[158.225622] Starting dynamic subtest: ccs0
[158.229722] Dynamic subtest ccs0: SKIP (0.000s)
[158.233831] Subtest busy-check-all: SKIP (0.012s)
[158.271251] [025/155] (874s left) kms_cursor_edge_walk (256x256-top-edge)
[158.384697] Starting subtest: 256x256-top-edge
[158.387016] Starting dynamic subtest: pipe-A-eDP-1
[161.891992] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.505s)
[161.902613] Starting dynamic subtest: pipe-D-eDP-1
[165.027963] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[165.030279] Subtest 256x256-top-edge: SUCCESS (6.641s)
[165.847960] [026/155] (866s left) gem_partial_pwrite_pread (reads-display)
[165.905305] Subtest reads-display: SKIP (0.000s)
[165.964725] [027/155] (866s left) gem_exec_schedule (u-submit-late-slice)
[166.039633] Starting subtest: u-submit-late-slice
[166.041737] Starting dynamic subtest: rcs0
[166.068269] Dynamic subtest rcs0: SUCCESS (0.035s)
[166.077056] Starting dynamic subtest: bcs0
[166.097807] Dynamic subtest bcs0: SUCCESS (0.029s)
[166.106754] Starting dynamic subtest: vcs0
[166.128961] Dynamic subtest vcs0: SUCCESS (0.031s)
[166.138732] Starting dynamic subtest: vcs1
[166.157939] Dynamic subtest vcs1: SUCCESS (0.029s)
[166.169512] Starting dynamic subtest: vecs0
[166.189121] Dynamic subtest vecs0: SUCCESS (0.031s)
[166.198595] Starting dynamic subtest: ccs0
[166.219675] Dynamic subtest ccs0: SUCCESS (0.030s)
[166.221820] Subtest u-submit-late-slice: SUCCESS (0.187s)
[167.679107] [028/155] (864s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[167.779677] Starting subtest: crc-primary-basic-y-tiled-ccs
[167.781889] Starting dynamic subtest: pipe-A-eDP-1
[167.804469] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[167.815262] Starting dynamic subtest: pipe-B-eDP-1
[167.836657] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[167.845532] Starting dynamic subtest: pipe-C-eDP-1
[167.867397] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[167.876097] Starting dynamic subtest: pipe-D-eDP-1
[167.897796] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[167.901897] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[170.102845] [029/155] (862s left) kms_chamelium_hpd (dp-hpd)
[170.484715] Subtest dp-hpd: SKIP (0.000s)
[171.328129] [030/155] (861s left) vgem_basic (second-client)
[171.374324] Starting subtest: second-client
[171.396794] Subtest second-client: SUCCESS (0.022s)
[171.456264] [031/155] (861s left) perf_pmu (busy-start)
[171.497539] Starting subtest: busy-start
[171.499707] Starting dynamic subtest: rcs0
[174.048236] Dynamic subtest rcs0: SUCCESS (2.551s)
[174.063016] Starting dynamic subtest: bcs0
[176.617379] Dynamic subtest bcs0: SUCCESS (2.549s)
[176.628445] Starting dynamic subtest: vcs0
[180.598297] Dynamic subtest vcs0: SUCCESS (3.995s)
[180.610850] Starting dynamic subtest: vcs1
[184.565280] Dynamic subtest vcs1: SUCCESS (3.965s)
[184.577279] Starting dynamic subtest: vecs0
[188.599248] Dynamic subtest vecs0: SUCCESS (4.031s)
[188.610837] Starting dynamic subtest: ccs0
[191.168078] Dynamic subtest ccs0: SUCCESS (2.548s)
[191.170741] Subtest busy-start: SUCCESS (19.648s)
[191.248909] [032/155] (841s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[191.340517] Starting subtest: random-ccs-data-yf-tiled-ccs
[191.343459] Starting dynamic subtest: pipe-A-eDP-1
[191.370166] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[191.381094] Starting dynamic subtest: pipe-B-eDP-1
[191.404627] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[191.413025] Starting dynamic subtest: pipe-C-eDP-1
[191.436601] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[191.445517] Starting dynamic subtest: pipe-D-eDP-1
[191.470269] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[191.474955] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s)
[193.601080] [033/155] (839s left) gem_exec_reloc (basic-concurrent0)
[193.660270] Subtest basic-concurrent0: SKIP (0.000s)
[193.731602] [034/155] (838s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[193.820202] Starting subtest: fbc-psr2-primary-mmap-gtt
[193.822485] Starting dynamic subtest: eDP-1
[193.826561] Dynamic subtest eDP-1: SKIP (0.000s)
[193.830896] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[193.893581] [035/155] (838s left) kms_rotation_crc (multiplane-rotation)
[193.992653] Starting subtest: multiplane-rotation
[211.434332] Subtest multiplane-rotation: SUCCESS (17.437s)
[211.543914] [036/155] (821s left) device_reset (cold-reset-bound)
[211.595579] Starting subtest: cold-reset-bound
[211.599573] Subtest cold-reset-bound: SKIP (0.000s)
[211.683005] [037/155] (821s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[211.742518] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[211.744518] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[211.827959] [038/155] (821s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[211.928917] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[211.932831] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[212.031484] [039/155] (820s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[212.126047] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[212.127957] Starting dynamic subtest: pipe-A-eDP-1
[212.177944] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[212.188912] Starting dynamic subtest: pipe-B-eDP-1
[212.235662] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[212.245735] Starting dynamic subtest: pipe-C-eDP-1
[212.293202] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[212.302981] Starting dynamic subtest: pipe-D-eDP-1
[212.350039] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[212.353543] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[214.383357] [040/155] (818s left) kms_plane_alpha_blend (constant-alpha-mid)
[214.496535] Starting subtest: constant-alpha-mid
[214.790243] Starting dynamic subtest: pipe-A-eDP-1
[215.662841] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.870s)
[215.672297] Starting dynamic subtest: pipe-D-eDP-1
[217.158793] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.496s)
[217.161466] Subtest constant-alpha-mid: SUCCESS (2.663s)
[218.040582] [041/155] (814s left) i915_selftest (mock)
[219.808260] Starting subtest: mock
[219.810591] Starting dynamic subtest: sanitycheck
[220.487792] Dynamic subtest sanitycheck: SUCCESS (0.680s)
[220.501224] Starting dynamic subtest: shmem
[221.165736] Dynamic subtest shmem: SUCCESS (0.675s)
[221.175882] Starting dynamic subtest: fence
[228.710117] Dynamic subtest fence: SUCCESS (7.541s)
[228.720696] Starting dynamic subtest: scatterlist
[230.386838] Dynamic subtest scatterlist: SUCCESS (1.675s)
[230.397125] Starting dynamic subtest: syncmap
[233.494811] Dynamic subtest syncmap: SUCCESS (3.107s)
[233.505373] Starting dynamic subtest: uncore
[234.176247] Dynamic subtest uncore: SUCCESS (0.680s)
[234.186692] Starting dynamic subtest: ring
[234.867368] Dynamic subtest ring: SUCCESS (0.690s)
[234.878098] Starting dynamic subtest: engine
[235.537569] Dynamic subtest engine: SUCCESS (0.667s)
[235.547967] Starting dynamic subtest: timelines
[239.360593] Dynamic subtest timelines: SUCCESS (3.823s)
[239.369123] Starting dynamic subtest: requests
[242.829103] Dynamic subtest requests: SUCCESS (3.466s)
[242.844442] Starting dynamic subtest: objects
[243.628840] Dynamic subtest objects: SUCCESS (0.799s)
[243.639108] Starting dynamic subtest: phys
[244.415286] Dynamic subtest phys: SUCCESS (0.784s)
[244.425464] Starting dynamic subtest: dmabuf
[245.196765] Dynamic subtest dmabuf: SUCCESS (0.780s)
[245.207329] Starting dynamic subtest: vma
[250.924440] Dynamic subtest vma: SUCCESS (5.725s)
[250.934508] Starting dynamic subtest: evict
[252.352462] Dynamic subtest evict: SUCCESS (1.427s)
[252.362807] Starting dynamic subtest: gtt
[255.676457] Dynamic subtest gtt: SUCCESS (3.322s)
[255.686680] Starting dynamic subtest: hugepages
[256.603198] Dynamic subtest hugepages: SUCCESS (0.926s)
[256.612854] Starting dynamic subtest: memory_region
[259.119978] Dynamic subtest memory_region: SUCCESS (2.514s)
[259.122651] Subtest mock: SUCCESS (39.315s)
[259.152386] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[259.153068] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[259.156289] [042/155] (773s left) sysfs_heartbeat_interval (precise)
[260.721595] Starting subtest: precise
[260.724013] Starting dynamic subtest: vecs0
[268.591914] Dynamic subtest vecs0: SUCCESS (7.871s)
[268.605397] Starting dynamic subtest: ccs0
[269.534247] Dynamic subtest ccs0: SUCCESS (0.939s)
[269.546533] Starting dynamic subtest: vcs0
[277.556688] Dynamic subtest vcs0: SUCCESS (8.018s)
[277.569155] Starting dynamic subtest: bcs0
[278.562189] Dynamic subtest bcs0: SUCCESS (1.004s)
[278.574580] Starting dynamic subtest: rcs0
[279.574490] Dynamic subtest rcs0: SUCCESS (1.010s)
[279.586276] Starting dynamic subtest: vcs1
[287.606046] Dynamic subtest vcs1: SUCCESS (8.029s)
[287.608787] Subtest precise: SUCCESS (26.881s)
[287.650607] [FACT sysfs_heartbeat_interval (precise)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[287.651866] [FACT sysfs_heartbeat_interval (precise)] new: kernel.kmod_is_loaded.i915: true
[287.655696] [043/155] (745s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[287.717961] Starting subtest: mixed-tiled-to-y-tiled-ccs
[287.722587] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[287.904838] [044/155] (745s left) gem_exec_reloc (basic-wc-noreloc)
[287.961477] Subtest basic-wc-noreloc: SKIP (0.000s)
[288.036160] [045/155] (745s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[288.139195] Starting subtest: addfb25-y-tiled-small-legacy
[288.143082] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[288.234594] [046/155] (744s left) gem_partial_pwrite_pread (write)
[288.283308] Subtest write: SKIP (0.000s)
[288.348312] [047/155] (744s left) gem_exec_suspend (basic)
[288.423262] Starting subtest: basic
[288.425329] Starting dynamic subtest: smem
[289.591878] Dynamic subtest smem: SUCCESS (1.168s)
[289.594783] Subtest basic: SUCCESS (1.171s)
[289.782393] [048/155] (743s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[289.874504] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[289.876791] Starting dynamic subtest: pipe-A
[289.894680] Dynamic subtest pipe-A: SKIP (0.017s)
[289.904095] Starting dynamic subtest: pipe-B
[289.930481] Dynamic subtest pipe-B: SKIP (0.034s)
[289.939596] Starting dynamic subtest: pipe-C
[289.965556] Dynamic subtest pipe-C: SKIP (0.034s)
[289.975494] Starting dynamic subtest: pipe-D
[290.000631] Dynamic subtest pipe-D: SKIP (0.035s)
[290.004250] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.123s)
[290.100511] [049/155] (743s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[290.202246] Starting subtest: fbc-pr-sprite-mmap-gtt
[290.206590] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[290.289768] [050/155] (743s left) i915_pm_rps (min-max-config-idle)
[290.356094] Starting subtest: min-max-config-idle
[290.360998] Subtest min-max-config-idle: SKIP (0.001s)
[290.466764] [051/155] (742s left) sriov_basic (enable-vfs-autoprobe-on)
[290.526340] Starting subtest: enable-vfs-autoprobe-on
[290.528293] Starting dynamic subtest: numvfs-1
[290.604638] Dynamic subtest numvfs-1: FAIL (0.012s)
[290.616976] Starting dynamic subtest: numvfs-2
[290.685608] Dynamic subtest numvfs-2: FAIL (0.004s)
[290.695604] Starting dynamic subtest: numvfs-3
[290.756308] Dynamic subtest numvfs-3: FAIL (0.004s)
[290.764916] Starting dynamic subtest: numvfs-4
[290.822316] Dynamic subtest numvfs-4: FAIL (0.004s)
[290.831827] Starting dynamic subtest: numvfs-5
[290.892753] Dynamic subtest numvfs-5: FAIL (0.004s)
[290.903042] Starting dynamic subtest: numvfs-6
[290.962994] Dynamic subtest numvfs-6: FAIL (0.004s)
[290.972926] Starting dynamic subtest: numvfs-7
[291.031648] Dynamic subtest numvfs-7: FAIL (0.004s)
[291.040166] Starting dynamic subtest: numvfs-random
[291.097476] Dynamic subtest numvfs-random: FAIL (0.004s)
[291.106282] Starting dynamic subtest: numvfs-all
[291.162782] Dynamic subtest numvfs-all: FAIL (0.446s)
[291.164370] Subtest enable-vfs-autoprobe-on: FAIL (0.493s)
[291.201645] [052/155] (742s left) kms_setmode (basic)
[291.250903] Starting subtest: basic
[291.584383] Starting dynamic subtest: pipe-A-eDP-1
[293.683946] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.095s)
[294.027898] Starting dynamic subtest: pipe-B-eDP-1
[296.121181] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.097s)
[296.427972] Subtest basic: SUCCESS (5.173s)
[297.265129] [053/155] (736s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[297.378731] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[297.382836] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[297.474625] [054/155] (736s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[297.568036] Starting subtest: fbcpsrhdr-tiling-linear
[297.572093] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[297.660891] [055/155] (735s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[297.704640] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[297.707019] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[297.808194] [056/155] (735s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[297.898822] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[297.901009] Starting dynamic subtest: pipe-A-eDP-1
[298.022802] Dynamic subtest pipe-A-eDP-1: SKIP (0.125s)
[298.033966] Starting dynamic subtest: pipe-B-eDP-1
[299.144870] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[299.149586] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.247s)
[300.429951] [057/155] (733s left) gem_exec_suspend (basic-s3-devices)
[300.490737] Starting subtest: basic-S3-devices
[300.492760] Starting dynamic subtest: smem
[312.628687] Dynamic subtest smem: SUCCESS (12.137s)
[312.631204] Subtest basic-S3-devices: SUCCESS (12.138s)
[321.899690] [058/155] (720s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[322.007836] Starting subtest: blocking-absolute-wf_vblank-interruptible
[322.010229] Starting dynamic subtest: A-eDP1
[330.810003] Dynamic subtest A-eDP1: SUCCESS (8.769s)
[330.821975] Starting dynamic subtest: B-eDP1
[339.544302] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[339.555460] Starting dynamic subtest: C-eDP1
[348.272029] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[348.282547] Starting dynamic subtest: D-eDP1
[356.950952] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[356.955929] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.949s)
[358.166300] [059/155] (684s left) gem_userptr_blits (vma-merge)
[358.242189] Starting subtest: vma-merge
[358.286608] Subtest vma-merge: SUCCESS (0.044s)
[358.432813] [060/155] (684s left) kms_vblank (query-busy-hang)
[358.521539] Starting subtest: query-busy-hang
[358.523763] Starting dynamic subtest: pipe-A-eDP-1
[385.399752] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.875s)
[385.414726] Starting dynamic subtest: pipe-D-eDP-1
[410.371938] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.966s)
[410.373908] Subtest query-busy-hang: SUCCESS (51.845s)
[411.244731] [061/155] (631s left) kms_pm_rpm (dpms-lpsp)
[412.777937] Starting subtest: dpms-lpsp
[413.429352] Subtest dpms-lpsp: SUCCESS (0.654s)
[413.518801] [062/155] (629s left) kms_big_fb (y-tiled-addfb-size-overflow)
[413.615689] Starting subtest: y-tiled-addfb-size-overflow
[413.619801] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[413.702404] [063/155] (629s left) perf_pmu (busy-accuracy-98)
[413.738340] Starting subtest: busy-accuracy-98
[413.740595] Starting dynamic subtest: rcs0
[416.779345] Dynamic subtest rcs0: SUCCESS (3.038s)
[416.789883] Starting dynamic subtest: bcs0
[419.879082] Dynamic subtest bcs0: SUCCESS (3.048s)
[419.890912] Starting dynamic subtest: vcs0
[422.921364] Dynamic subtest vcs0: SUCCESS (3.042s)
[422.933642] Starting dynamic subtest: vcs1
[425.966343] Dynamic subtest vcs1: SUCCESS (3.041s)
[425.977464] Starting dynamic subtest: vecs0
[429.006574] Dynamic subtest vecs0: SUCCESS (3.036s)
[429.018064] Starting dynamic subtest: ccs0
[432.056776] Dynamic subtest ccs0: SUCCESS (3.047s)
[432.058846] Subtest busy-accuracy-98: SUCCESS (18.267s)
[432.173275] [064/155] (610s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[432.276187] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[432.280507] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[432.349726] [065/155] (610s left) prime_vgem (fence-read-hang)
[432.416197] Subtest fence-read-hang: SKIP (0.000s)
[432.508529] [066/155] (610s left) gem_ctx_persistence (engines-queued)
[432.569483] Starting subtest: engines-queued
[432.571668] Starting dynamic subtest: rcs0
[432.640047] Dynamic subtest rcs0: SUCCESS (0.073s)
[432.651967] Starting dynamic subtest: bcs0
[432.691175] Dynamic subtest bcs0: SUCCESS (0.049s)
[432.703281] Starting dynamic subtest: vcs0
[434.579601] Dynamic subtest vcs0: SUCCESS (1.883s)
[434.590036] Starting dynamic subtest: vcs1
[436.564450] Dynamic subtest vcs1: SUCCESS (1.984s)
[436.576358] Starting dynamic subtest: vecs0
[438.604082] Dynamic subtest vecs0: SUCCESS (1.983s)
[438.616046] Starting dynamic subtest: ccs0
[438.727583] Dynamic subtest ccs0: SUCCESS (0.175s)
[438.729984] Subtest engines-queued: SUCCESS (6.159s)
[438.862910] [067/155] (604s left) kms_lease (lease-revoke)
[438.973323] Starting subtest: lease-revoke
[438.975598] Starting dynamic subtest: pipe-A-eDP-1
[439.005563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.033s)
[439.020295] Starting dynamic subtest: pipe-B-eDP-1
[439.038596] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.030s)
[439.052739] Starting dynamic subtest: pipe-C-eDP-1
[439.064734] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[439.076471] Starting dynamic subtest: pipe-D-eDP-1
[439.099926] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.034s)
[439.102464] Subtest lease-revoke: SUCCESS (0.129s)
[439.216872] [068/155] (603s left) perf (gen8-unprivileged-single-ctx-counters)
[439.337773] Starting subtest: gen8-unprivileged-single-ctx-counters
[439.341983] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[439.384391] [069/155] (603s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[439.480430] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[439.484640] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[439.575405] [070/155] (603s left) gem_exec_schedule (pi-common)
[439.755190] Starting subtest: pi-common
[439.757689] Starting dynamic subtest: rcs0
[439.808142] Dynamic subtest rcs0: SUCCESS (0.055s)
[439.818371] Starting dynamic subtest: bcs0
[439.848402] Dynamic subtest bcs0: SUCCESS (0.039s)
[439.858236] Starting dynamic subtest: vcs0
[439.884058] Dynamic subtest vcs0: SUCCESS (0.035s)
[439.897708] Starting dynamic subtest: vcs1
[439.913509] Dynamic subtest vcs1: SUCCESS (0.028s)
[439.927045] Starting dynamic subtest: vecs0
[439.943558] Dynamic subtest vecs0: SUCCESS (0.029s)
[439.958795] Starting dynamic subtest: ccs0
[439.973717] Dynamic subtest ccs0: SUCCESS (0.029s)
[439.975883] Subtest pi-common: SUCCESS (0.221s)
[440.225327] [071/155] (603s left) api_intel_bb (simple-bb-ctx)
[440.283635] Starting subtest: simple-bb-ctx
[440.290974] Subtest simple-bb-ctx: SUCCESS (0.009s)
[440.377637] [072/155] (602s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[440.472589] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[440.476573] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[440.574489] [073/155] (602s left) kms_color (legacy-gamma-reset)
[440.675759] Starting subtest: legacy-gamma-reset
[440.677656] Starting dynamic subtest: pipe-A-eDP-1
[441.046921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.373s)
[441.057321] Starting dynamic subtest: pipe-B-eDP-1
[441.059530] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[441.069362] Starting dynamic subtest: pipe-C-eDP-1
[441.071647] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[441.081524] Starting dynamic subtest: pipe-D-eDP-1
[441.083770] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[441.086056] Subtest legacy-gamma-reset: SUCCESS (0.410s)
[441.915266] [074/155] (601s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[442.022516] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[442.026794] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[442.112137] [075/155] (601s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-blt)
[442.206515] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-blt
[442.210598] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[442.310205] [076/155] (601s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[442.601324] Starting subtest: cursor-rapid-movement-512x170
[442.605792] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[442.739603] [077/155] (600s left) kms_atomic_interruptible (legacy-cursor)
[442.832978] Starting subtest: legacy-cursor
[442.834873] Starting dynamic subtest: pipe-A-eDP-1
[450.237118] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.403s)
[450.239623] Subtest legacy-cursor: SUCCESS (7.404s)
[451.079796] [078/155] (592s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[451.181548] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[451.195164] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.012s)
[451.276470] [079/155] (592s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[451.376036] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite
[451.380385] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[451.453853] [080/155] (592s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[451.543816] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[451.548252] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[451.642951] [081/155] (592s left) kms_addfb_basic (invalid-get-prop)
[451.690125] Starting subtest: invalid-get-prop
[451.692563] Subtest invalid-get-prop: SUCCESS (0.000s)
[451.851349] [082/155] (591s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[451.940718] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[451.943002] Starting dynamic subtest: pipe-A-eDP-1
[452.774119] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.826s)
[452.784949] Starting dynamic subtest: pipe-B-eDP-1
[454.416718] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.639s)
[454.427502] Starting dynamic subtest: pipe-C-eDP-1
[455.919721] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.502s)
[455.930885] Starting dynamic subtest: pipe-D-eDP-1
[457.454711] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s)
[457.457004] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.504s)
[458.625246] [083/155] (585s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[458.677837] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[458.786270] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[458.864516] [084/155] (585s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[458.918647] Starting subtest: etime-multi-wait-all-available-unsubmitted
[459.026639] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.105s)
[459.107882] [085/155] (584s left) gem_exec_fence (syncobj-timeline-chain-engines)
[459.646359] Starting subtest: syncobj-timeline-chain-engines
[459.752293] Subtest syncobj-timeline-chain-engines: SUCCESS (0.106s)
[460.694913] [086/155] (583s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[460.792641] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[460.796627] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[460.904762] [087/155] (583s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[460.996748] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[461.001193] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[461.096268] [088/155] (582s left) kms_cursor_crc (cursor-offscreen-128x42)
[461.325340] Starting subtest: cursor-offscreen-128x42
[461.373588] Subtest cursor-offscreen-128x42: SKIP (0.042s)
[461.582157] [089/155] (582s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[461.682838] Starting subtest: extended-pageflip-modeset-hang-oldfb
[461.684648] Starting dynamic subtest: pipe-A
[469.581501] Dynamic subtest pipe-A: SUCCESS (7.898s)
[469.594772] Starting dynamic subtest: pipe-D
[478.245014] Dynamic subtest pipe-D: SUCCESS (8.659s)
[478.247250] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.561s)
[479.106672] [090/155] (565s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[479.213357] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[479.217587] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[479.312900] [091/155] (564s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-render)
[479.412095] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-render
[479.416042] Subtest fbchdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[479.517223] [092/155] (564s left) kms_psr (psr2-primary-mmap-cpu)
[479.605289] Starting subtest: psr2-primary-mmap-cpu
[479.607503] Starting dynamic subtest: eDP-1
[481.390912] Dynamic subtest eDP-1: SUCCESS (1.785s)
[481.393569] Subtest psr2-primary-mmap-cpu: SUCCESS (1.786s)
[482.255218] [093/155] (562s left) core_setmaster_vs_auth
[482.422718] [094/155] (561s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[482.519647] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[482.523961] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[482.634008] [095/155] (561s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-render)
[482.736741] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-render
[482.741098] Subtest fbchdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[482.833547] [096/155] (561s left) gem_exec_balancer (bonded-true-hang)
[483.098927] Starting subtest: bonded-true-hang
[483.104292] Subtest bonded-true-hang: SKIP (0.000s)
[483.232865] [097/155] (561s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[483.336931] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[483.340816] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[483.434460] [098/155] (561s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[483.549631] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[483.553965] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[483.650352] [099/155] (560s left) gem_flink_basic (double-flink)
[483.708577] Starting subtest: double-flink
[483.710465] Subtest double-flink: SUCCESS (0.000s)
[483.796696] [100/155] (560s left) kms_chamelium_color (gamma)
[483.884057] Subtest gamma: SKIP (0.000s)
[483.932548] [101/155] (560s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[484.030920] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[484.035145] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[484.122846] [102/155] (560s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[484.211191] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[484.214518] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[484.314185] [103/155] (560s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[484.419731] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[489.212399] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.795s)
[490.387888] [104/155] (554s left) kms_big_fb (linear-64bpp-rotate-180)
[490.485271] Starting subtest: linear-64bpp-rotate-180
[492.219852] Subtest linear-64bpp-rotate-180: SUCCESS (1.734s)
[492.400415] [105/155] (552s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[492.449337] Starting subtest: multi-wait-available-unsubmitted-submitted
[492.451324] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[492.544820] [106/155] (552s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-wc)
[492.640268] Starting subtest: psrhdr-rgb101010-draw-mmap-wc
[492.643771] Subtest psrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[492.746095] [107/155] (552s left) kms_getfb (getfb2-accept-nv12)
[492.839769] Starting subtest: getfb2-accept-nv12
[492.841712] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[492.939416] [108/155] (551s left) kms_fbcon_fbt (psr-suspend)
[492.989367] Starting subtest: psr-suspend
[543.692586] Subtest psr-suspend: SUCCESS (20.412s)
[547.804496] [109/155] (501s left) i915_getparams_basic (basic-eu-total)
[547.872993] Starting subtest: basic-eu-total
[547.877358] Subtest basic-eu-total: SUCCESS (0.000s)
[547.954597] [110/155] (501s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[548.056488] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[548.058864] Starting dynamic subtest: pipe-A
[549.113345] Dynamic subtest pipe-A: SUCCESS (1.049s)
[549.133556] Starting dynamic subtest: pipe-B
[551.238384] Dynamic subtest pipe-B: SUCCESS (2.107s)
[551.249001] Starting dynamic subtest: pipe-C
[552.442039] Dynamic subtest pipe-C: SUCCESS (1.196s)
[552.453263] Starting dynamic subtest: pipe-D
[553.681574] Dynamic subtest pipe-D: SUCCESS (1.232s)
[553.683779] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.590s)
[554.894200] [111/155] (494s left) gem_tiled_blits (basic)
[554.949055] Subtest basic: SKIP (0.000s)
[555.021862] [112/155] (494s left) gem_spin_batch (spin-all)
[555.082291] Starting subtest: spin-all
[555.095217] Subtest spin-all: SUCCESS (0.015s)
[556.736284] [113/155] (492s left) gem_sync (basic-each)
[556.799837] Starting subtest: basic-each
[559.154104] Subtest basic-each: SUCCESS (2.358s)
[559.342915] [114/155] (489s left) kms_addfb_basic (too-wide)
[559.433554] Starting subtest: too-wide
[559.435903] Subtest too-wide: SUCCESS (0.000s)
[559.547312] [115/155] (489s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[559.660835] Starting subtest: basic-flip-before-cursor-varying-size
[560.588688] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.926s)
[561.434778] [116/155] (487s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[561.487170] Starting subtest: yf-tiled-to-vebox-yf-tiled
[561.491774] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[561.673323] [117/155] (487s left) gem_pxp (hw-rejects-pxp-buffer)
[561.789474] Starting subtest: hw-rejects-pxp-buffer
[561.794196] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[561.893791] [118/155] (487s left) perf (sysctl-defaults)
[561.963346] Starting subtest: sysctl-defaults
[561.966038] Subtest sysctl-defaults: SUCCESS (0.000s)
[562.037960] [119/155] (487s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[562.129964] Starting subtest: psr-1p-primscrn-spr-indfb-move
[569.504957] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.370s)
[569.651914] [120/155] (479s left) perf (invalid-oa-metric-set-id)
[569.730554] Starting subtest: invalid-oa-metric-set-id
[569.744911] Subtest invalid-oa-metric-set-id: SUCCESS (0.015s)
[569.796504] [121/155] (479s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[569.897399] Starting subtest: 4-tiled-16bpp-rotate-0
[571.222078] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.325s)
[571.358344] [122/155] (478s left) kms_pm_rpm (pm-caching)
[572.885077] Starting subtest: pm-caching
[572.889749] Subtest pm-caching: SKIP (0.000s)
[573.618160] [123/155] (476s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[573.708921] Starting subtest: hdr-rgb565-draw-render
[573.713112] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[573.828204] [124/155] (475s left) i915_query (query-topology-matches-eu-total)
[573.876239] Starting subtest: query-topology-matches-eu-total
[573.878541] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[573.977831] [125/155] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[574.087179] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[574.091427] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[574.192576] [126/155] (475s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[574.293106] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[581.708834] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.421s)
[581.823958] [127/155] (467s left) kms_plane_lowres (tiling-yf)
[581.927532] Starting subtest: tiling-yf
[581.931470] Subtest tiling-yf: SKIP (0.000s)
[582.000553] [128/155] (467s left) syncobj_timeline (invalid-signal-bad-pad)
[582.052824] Starting subtest: invalid-signal-bad-pad
[582.055031] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[582.163564] [129/155] (467s left) syncobj_basic (bad-flags-fd-to-handle)
[582.215543] Starting subtest: bad-flags-fd-to-handle
[582.217653] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[582.308032] [130/155] (467s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[582.426588] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[582.431003] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[582.575687] [131/155] (467s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[582.673546] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[586.693362] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.024s)
[587.900454] [132/155] (462s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[588.002367] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[588.006547] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[588.108425] [133/155] (461s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[588.209023] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[588.213013] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[588.310356] [134/155] (461s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[588.420249] Starting subtest: flip-vs-cursor-busy-crc-atomic
[589.110021] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.688s)
[589.925989] [135/155] (460s left) fbdev (pan)
[589.960171] Starting subtest: pan
[589.984608] Subtest pan: SUCCESS (0.028s)
[590.068232] [136/155] (460s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[590.171534] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[591.194986] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.023s)
[591.295467] [137/155] (458s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-move)
[591.394635] Starting subtest: psrhdr-2p-primscrn-cur-indfb-move
[591.398198] Subtest psrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[591.487380] [138/155] (458s left) kms_content_protection (uevent)
[591.624212] Starting subtest: uevent
[591.628025] Subtest uevent: SKIP (0.000s)
[591.756412] [139/155] (458s left) kms_vblank (wait-busy-hang)
[591.849613] Starting subtest: wait-busy-hang
[591.851412] Starting dynamic subtest: pipe-A-eDP-1
[618.462771] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.607s)
[618.478161] Starting dynamic subtest: pipe-D-eDP-1
[643.474432] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.005s)
[643.476974] Subtest wait-busy-hang: SUCCESS (51.616s)
[644.290994] [140/155] (406s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[644.404166] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[644.408736] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[644.515753] [141/155] (405s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[644.617508] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[644.621637] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[644.714870] [142/155] (405s left) gem_lmem_swapping (verify-ccs)
[644.754306] Subtest verify-ccs: SKIP (0.000s)
[644.798272] [143/155] (405s left) prime_mmap (test_correct)
[644.862957] Starting subtest: test_correct
[644.864913] Starting dynamic subtest: test_correct-smem
[644.895750] Dynamic subtest test_correct-smem: SUCCESS (0.033s)
[644.898336] Subtest test_correct: SUCCESS (0.034s)
[645.001213] [144/155] (405s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[645.116790] Starting subtest: x-tiled-32bpp-rotate-180
[646.495341] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.381s)
[646.646418] [145/155] (403s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[646.743698] Starting subtest: psr-rgb101010-draw-blt
[654.091949] Subtest psr-rgb101010-draw-blt: SUCCESS (7.353s)
[654.212366] [146/155] (396s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[654.311387] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[658.890427] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.585s)
[660.110870] [147/155] (390s left) gen9_exec_parse (bb-start-out)
[660.177312] Subtest bb-start-out: SKIP (0.000s)
[660.252400] [148/155] (390s left) gem_mmap_offset (mmap-unmap)
[660.317425] Starting subtest: mmap-unmap
[660.319558] Starting dynamic subtest: smem0
[684.464358] Dynamic subtest smem0: SUCCESS (24.095s)
[684.466923] Subtest mmap-unmap: SUCCESS (24.097s)
[684.532297] [149/155] (366s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt)
[684.645431] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt
[684.649947] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[684.755085] [150/155] (366s left) gem_mmap_gtt (basic-wc)
[684.807206] Subtest basic-wc: SKIP (0.000s)
[684.867905] [151/155] (366s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[684.964342] Starting subtest: 4-tiled-8bpp-rotate-0
[686.167157] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.203s)
[686.301298] [152/155] (364s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[686.394722] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[686.398298] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[686.496399] [153/155] (364s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[686.589075] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[686.592505] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[686.661197] [154/155] (364s left) gem_exec_schedule (u-fairslice)
[686.731583] Starting subtest: u-fairslice
[686.733468] Starting dynamic subtest: rcs0
[688.749309] Dynamic subtest rcs0: SUCCESS (2.018s)
[688.759789] Starting dynamic subtest: bcs0
[690.766825] Dynamic subtest bcs0: SUCCESS (2.019s)
[690.777823] Starting dynamic subtest: vcs0
[692.847882] Dynamic subtest vcs0: SUCCESS (2.019s)
[692.860405] Starting dynamic subtest: vcs1
[694.808942] Dynamic subtest vcs1: SUCCESS (2.019s)
[694.822174] Starting dynamic subtest: vecs0
[696.878975] Dynamic subtest vecs0: SUCCESS (2.019s)
[696.890574] Starting dynamic subtest: ccs0
[698.850383] Dynamic subtest ccs0: SUCCESS (2.019s)
[698.852645] Subtest u-fairslice: SUCCESS (12.120s)
[699.167018] [155/155] (351s left) gem_gpgpu_fill (offset-16x16)
[699.221982] Starting subtest: offset-16x16
[699.232887] Subtest offset-16x16: SUCCESS (0.012s)
[699.362704] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_feature_discovery
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_fbcon_fbt
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_joiner
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: gem_ctx_shared
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_close_race
results: parsing output: 23/ for test: i915_drm_fdinfo
results: parsing output: 24/ for test: kms_cursor_edge_walk
results: parsing output: 25/ for test: gem_partial_pwrite_pread
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: vgem_basic
results: parsing output: 30/ for test: perf_pmu
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_rotation_crc
results: parsing output: 35/ for test: device_reset
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_plane_alpha_blend
results: parsing output: 40/ for test: i915_selftest
results: parsing output: 41/ for test: sysfs_heartbeat_interval
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: gem_partial_pwrite_pread
results: parsing output: 46/ for test: gem_exec_suspend
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: i915_pm_rps
results: parsing output: 50/ for test: sriov_basic
results: parsing output: 51/ for test: kms_setmode
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: gem_exec_suspend
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: kms_pm_rpm
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: prime_vgem
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: kms_lease
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_color
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_atomic_interruptible
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: kms_busy
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: core_setmaster_vs_auth
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_flink_basic
results: parsing output: 99/ for test: kms_chamelium_color
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: kms_fbcon_fbt
results: parsing output: 108/ for test: i915_getparams_basic
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: gem_tiled_blits
results: parsing output: 111/ for test: gem_spin_batch
results: parsing output: 112/ for test: gem_sync
results: parsing output: 113/ for test: kms_addfb_basic
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: gem_pxp
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_pm_rpm
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: i915_query
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_plane_lowres
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: syncobj_basic
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_cursor_legacy
results: parsing output: 134/ for test: fbdev
results: parsing output: 135/ for test: kms_big_fb
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_content_protection
results: parsing output: 138/ for test: kms_vblank
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_lmem_swapping
results: parsing output: 142/ for test: prime_mmap
results: parsing output: 143/ for test: kms_big_fb
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: gen9_exec_parse
results: parsing output: 147/ for test: gem_mmap_offset
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_mmap_gtt
results: parsing output: 150/ for test: kms_big_fb
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_psr2_sf
results: parsing output: 153/ for test: gem_exec_schedule
results: parsing output: 154/ for test: gem_gpgpu_fill
Done.