[61.966029] Initializing watchdogs
[61.966076]   /dev/watchdog0
[61.980846] [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]
[61.985398] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.987757] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.991144] [001/132] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[62.125446] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[62.129682] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[62.256427] [002/132] (960s left) kms_vrr (seamless-rr-switch-virtual)
[62.347935] Starting subtest: seamless-rr-switch-virtual
[62.354153] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[62.440659] [003/132] (960s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[62.502889] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[62.559279] [004/132] (960s left) kms_content_protection (dp-mst-type-1)
[62.694157] Starting subtest: dp-mst-type-1
[62.698828] Subtest dp-mst-type-1: SKIP (0.000s)
[62.840487] [005/132] (959s left) core_setmaster (master-drop-set-shared-fd)
[62.938637] Starting subtest: master-drop-set-shared-fd
[62.960924] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[62.996409] [006/132] (959s left) i915_selftest (mock)
[66.311623] Starting subtest: mock
[66.313714] Starting dynamic subtest: sanitycheck
[67.457861] Dynamic subtest sanitycheck: SUCCESS (1.144s)
[67.467223] Starting dynamic subtest: shmem
[68.222221] Dynamic subtest shmem: SUCCESS (0.762s)
[68.231078] Starting dynamic subtest: fence
[76.084974] Dynamic subtest fence: SUCCESS (7.848s)
[76.093424] Starting dynamic subtest: scatterlist
[77.810708] Dynamic subtest scatterlist: SUCCESS (1.724s)
[77.819033] Starting dynamic subtest: syncmap
[81.377352] Dynamic subtest syncmap: SUCCESS (3.562s)
[81.386336] Starting dynamic subtest: uncore
[82.119220] Dynamic subtest uncore: SUCCESS (0.741s)
[82.127772] Starting dynamic subtest: ring
[82.878250] Dynamic subtest ring: SUCCESS (0.757s)
[82.886891] Starting dynamic subtest: engine
[83.621075] Dynamic subtest engine: SUCCESS (0.741s)
[83.629715] Starting dynamic subtest: timelines
[87.538660] Dynamic subtest timelines: SUCCESS (3.913s)
[87.546945] Starting dynamic subtest: requests
[90.828614] Dynamic subtest requests: SUCCESS (3.286s)
[90.837370] Starting dynamic subtest: objects
[91.643235] Dynamic subtest objects: SUCCESS (0.814s)
[91.651933] Starting dynamic subtest: phys
[92.469028] Dynamic subtest phys: SUCCESS (0.818s)
[92.478116] Starting dynamic subtest: dmabuf
[93.327339] Dynamic subtest dmabuf: SUCCESS (0.864s)
[93.334928] Starting dynamic subtest: vma
[98.743339] Dynamic subtest vma: SUCCESS (5.412s)
[98.753417] Starting dynamic subtest: evict
[100.173745] Dynamic subtest evict: SUCCESS (1.429s)
[100.186194] Starting dynamic subtest: gtt
[103.402586] Dynamic subtest gtt: SUCCESS (3.227s)
[103.411051] Starting dynamic subtest: hugepages
[104.329384] Dynamic subtest hugepages: SUCCESS (0.927s)
[104.337865] Starting dynamic subtest: memory_region
[107.025335] Dynamic subtest memory_region: SUCCESS (2.693s)
[107.028021] Subtest mock: SUCCESS (40.680s)
[107.054979] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[107.057955] [007/132] (915s left) kms_psr (psr-sprite-plane-onoff)
[108.679807] Starting subtest: psr-sprite-plane-onoff
[108.682203] Starting dynamic subtest: eDP-1
[110.428431] Dynamic subtest eDP-1: SUCCESS (1.748s)
[110.430820] Subtest psr-sprite-plane-onoff: SUCCESS (1.749s)
[111.297379] [FACT kms_psr (psr-sprite-plane-onoff)] new: kernel.kmod_is_loaded.i915: true
[111.300889] [008/132] (911s left) kms_psr (fbc-psr2-basic)
[111.401235] Starting subtest: fbc-psr2-basic
[111.403517] Starting dynamic subtest: eDP-1
[111.408091] Dynamic subtest eDP-1: SKIP (0.000s)
[111.412834] Subtest fbc-psr2-basic: SKIP (0.000s)
[111.496608] [009/132] (911s left) kms_atomic_transition (plane-all-transition-nonblocking)
[111.590964] Starting subtest: plane-all-transition-nonblocking
[111.593219] Starting dynamic subtest: pipe-A-eDP-1
[114.084833] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[114.402873] Starting dynamic subtest: pipe-B-eDP-1
[117.608289] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.214s)
[117.907286] Subtest plane-all-transition-nonblocking: SUCCESS (6.316s)
[118.749452] [010/132] (904s left) kms_fence_pin_leak
[118.934856] [011/132] (903s left) gem_partial_pwrite_pread (writes-after-reads-display)
[118.988359] Subtest writes-after-reads-display: SKIP (0.000s)
[119.064371] [012/132] (903s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[124.120621] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[124.123047] Starting dynamic subtest: pipe-A-eDP-1
[135.523724] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.399s)
[135.532899] Starting dynamic subtest: pipe-B-eDP-1
[146.940747] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.416s)
[146.943110] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.819s)
[147.830277] [013/132] (875s left) gem_mmap_gtt (big-bo-tiledx)
[147.896998] Subtest big-bo-tiledX: SKIP (0.000s)
[147.965450] [014/132] (875s left) kms_fbcon_fbt (psr)
[148.041981] Starting subtest: psr
[155.445726] Subtest psr: SUCCESS (7.413s)
[155.517181] [015/132] (867s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[155.619752] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[155.621679] Starting dynamic subtest: pipe-A-eDP-1
[157.814337] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.196s)
[157.822209] Starting dynamic subtest: pipe-B-eDP-1
[160.289196] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.474s)
[160.296544] Starting dynamic subtest: pipe-C-eDP-1
[162.449546] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.158s)
[162.458078] Starting dynamic subtest: pipe-D-eDP-1
[164.544264] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.093s)
[164.546197] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.926s)
[165.808956] [016/132] (857s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[165.925066] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[165.929233] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[166.032805] [017/132] (857s left) gem_exec_whisper (basic-contexts-all)
[166.085419] Starting subtest: basic-contexts-all
[176.969948] Subtest basic-contexts-all: SUCCESS (10.880s)
[177.176187] [018/132] (845s left) kms_cursor_crc (cursor-size-change)
[177.285893] Starting subtest: cursor-size-change
[177.288102] Starting dynamic subtest: pipe-A-eDP-1
[178.082923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.797s)
[178.095248] Starting dynamic subtest: pipe-D-eDP-1
[179.540333] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.455s)
[179.542607] Subtest cursor-size-change: SUCCESS (2.255s)
[180.381927] [019/132] (842s left) kms_lease (lease-revoke)
[180.477121] Starting subtest: lease-revoke
[180.479506] Starting dynamic subtest: pipe-A-eDP-1
[180.507086] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[180.518453] Starting dynamic subtest: pipe-B-eDP-1
[180.540084] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.029s)
[180.548667] Starting dynamic subtest: pipe-C-eDP-1
[180.566251] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[180.574853] Starting dynamic subtest: pipe-D-eDP-1
[180.596913] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[180.599068] Subtest lease-revoke: SUCCESS (0.120s)
[180.743582] [020/132] (842s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[180.798230] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[180.802592] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[181.005918] [021/132] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[181.117041] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[181.121550] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[181.233859] [022/132] (842s left) kms_flip (2x-blocking-wf_vblank)
[181.332216] Starting subtest: 2x-blocking-wf_vblank
[181.341191] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[181.445775] [023/132] (841s left) syncobj_timeline (single-wait-available-submitted)
[181.509341] Starting subtest: single-wait-available-submitted
[181.511385] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[181.622570] [024/132] (841s left) sriov_basic (enable-vfs-bind-unbind-each)
[181.690142] Starting subtest: enable-vfs-bind-unbind-each
[181.692381] Starting dynamic subtest: numvfs-1
[181.769817] Dynamic subtest numvfs-1: FAIL (0.030s)
[181.779799] Starting dynamic subtest: numvfs-2
[181.852982] Dynamic subtest numvfs-2: FAIL (0.004s)
[181.864057] Starting dynamic subtest: numvfs-3
[181.933780] Dynamic subtest numvfs-3: FAIL (0.004s)
[181.942875] Starting dynamic subtest: numvfs-4
[182.001784] Dynamic subtest numvfs-4: FAIL (0.004s)
[182.010739] Starting dynamic subtest: numvfs-5
[182.068692] Dynamic subtest numvfs-5: FAIL (0.004s)
[182.077685] Starting dynamic subtest: numvfs-6
[182.136548] Dynamic subtest numvfs-6: FAIL (0.004s)
[182.145770] Starting dynamic subtest: numvfs-7
[182.204836] Dynamic subtest numvfs-7: FAIL (0.004s)
[182.213571] Starting dynamic subtest: numvfs-random
[182.272049] Dynamic subtest numvfs-random: FAIL (0.004s)
[182.273995] Subtest enable-vfs-bind-unbind-each: FAIL (0.061s)
[182.308946] [025/132] (841s left) api_intel_bb (object-reloc-keep-cache)
[182.358234] Starting subtest: object-reloc-keep-cache
[182.361927] Subtest object-reloc-keep-cache: SKIP (0.003s)
[182.529897] [026/132] (840s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[182.630492] Starting subtest: fbc-psr2-sprite-mmap-gtt
[182.632297] Starting dynamic subtest: eDP-1
[182.635620] Dynamic subtest eDP-1: SKIP (0.000s)
[182.638940] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[182.723888] [027/132] (840s left) gem_exec_nop (basic-parallel)
[182.800297] Starting subtest: basic-parallel
[198.869908] Subtest basic-parallel: SUCCESS (16.074s)
[199.133664] [028/132] (824s left) i915_hangman (gt-engine-error)
[199.212752] Starting subtest: gt-engine-error
[199.215095] Starting dynamic subtest: rcs0
[200.882963] Dynamic subtest rcs0: SUCCESS (1.668s)
[200.893610] Starting dynamic subtest: bcs0
[202.867682] Dynamic subtest bcs0: SUCCESS (1.981s)
[202.879487] Starting dynamic subtest: vcs0
[204.851385] Dynamic subtest vcs0: SUCCESS (1.981s)
[204.863768] Starting dynamic subtest: vcs1
[206.834221] Dynamic subtest vcs1: SUCCESS (1.980s)
[206.845934] Starting dynamic subtest: vecs0
[208.882771] Dynamic subtest vecs0: SUCCESS (2.046s)
[208.893574] Starting dynamic subtest: ccs0
[210.866476] Dynamic subtest ccs0: SUCCESS (1.982s)
[210.869089] Subtest gt-engine-error: SUCCESS (11.654s)
[210.970519] [029/132] (812s left) kms_getfb (getfb-handle-protection)
[211.063717] Starting subtest: getfb-handle-protection
[211.089179] Subtest getfb-handle-protection: SUCCESS (0.025s)
[211.246571] [030/132] (812s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[211.337322] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[211.339558] Starting dynamic subtest: pipe-A-eDP-1
[211.359768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[211.370093] Starting dynamic subtest: pipe-B-eDP-1
[211.389854] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[211.398800] Starting dynamic subtest: pipe-C-eDP-1
[211.417231] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[211.425081] Starting dynamic subtest: pipe-D-eDP-1
[211.443187] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[211.445275] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[213.626621] [031/132] (810s left) gem_pxp (reject-modify-context-protection-off-1)
[213.765387] Starting subtest: reject-modify-context-protection-off-1
[213.767795] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[213.907096] [032/132] (809s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[214.022966] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[221.409835] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.390s)
[221.555862] [033/132] (802s left) api_intel_allocator (alloc-simple)
[221.620074] Starting subtest: alloc-simple
[221.622434] Subtest alloc-simple: SUCCESS (0.003s)
[221.783195] [034/132] (801s left) perf (blocking)
[221.937250] Starting subtest: blocking
[221.939602] Starting dynamic subtest: 0-rcs0
[231.965872] Dynamic subtest 0-rcs0: SUCCESS (10.026s)
[231.974710] Starting dynamic subtest: 1-vecs0
[241.991573] Dynamic subtest 1-vecs0: SUCCESS (10.024s)
[241.993868] Subtest blocking: SUCCESS (20.052s)
[242.037249] [035/132] (781s left) kms_frontbuffer_tracking (psr-slowdraw)
[242.146650] Starting subtest: psr-slowdraw
[267.492928] Subtest psr-slowdraw: SUCCESS (25.348s)
[267.647799] [036/132] (756s left) gem_mmap (short-mmap)
[267.714503] Subtest short-mmap: SKIP (0.000s)
[267.775332] [037/132] (756s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[267.863801] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[267.865991] Starting dynamic subtest: pipe-A-default-mode
[268.160749] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[268.165124] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.295s)
[269.027555] [038/132] (754s left) kms_invalid_mode (bad-htotal)
[269.132495] Starting subtest: bad-htotal
[269.134751] Starting dynamic subtest: pipe-A-eDP-1
[269.423580] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[269.432385] Starting dynamic subtest: pipe-B-eDP-1
[269.434291] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[269.441921] Starting dynamic subtest: pipe-C-eDP-1
[269.443783] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[269.451780] Starting dynamic subtest: pipe-D-eDP-1
[269.453900] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[269.456075] Subtest bad-htotal: SUCCESS (0.297s)
[270.256425] [039/132] (753s left) gem_exec_alignment (forked)
[270.324636] Starting subtest: forked
[308.044755] Subtest forked: SUCCESS (37.721s)
[308.748315] [040/132] (715s left) kms_psr (pr-cursor-mmap-gtt)
[308.889875] Starting subtest: pr-cursor-mmap-gtt
[308.894307] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[308.984010] [041/132] (715s left) gem_mmap_wc (read-write)
[309.048393] Subtest read-write: SKIP (0.000s)
[309.113844] [042/132] (714s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[309.203624] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[316.660502] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.459s)
[316.796581] [043/132] (707s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[316.899522] Starting subtest: fbc-rgb565-draw-pwrite
[321.444933] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.548s)
[322.609882] [044/132] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[322.709538] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[326.280033] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.574s)
[327.491258] [045/132] (696s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[327.590143] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[327.594140] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[327.716492] [046/132] (696s left) kms_cursor_crc (cursor-offscreen-128x42)
[327.931559] Starting subtest: cursor-offscreen-128x42
[327.980371] Subtest cursor-offscreen-128x42: SKIP (0.043s)
[328.205736] [047/132] (696s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[328.363096] Starting subtest: cursor-rapid-movement-32x10
[328.409829] Subtest cursor-rapid-movement-32x10: SKIP (0.043s)
[328.684916] [048/132] (695s left) gem_ctx_persistence (legacy-engines-persistence)
[328.758853] Starting subtest: legacy-engines-persistence
[328.760830] Starting dynamic subtest: render
[329.561044] Dynamic subtest render: SUCCESS (0.800s)
[329.574897] Starting dynamic subtest: bsd1
[330.305911] Dynamic subtest bsd1: SUCCESS (0.742s)
[330.319444] Starting dynamic subtest: bsd2
[331.069954] Dynamic subtest bsd2: SUCCESS (0.761s)
[331.080751] Starting dynamic subtest: blt
[331.883673] Dynamic subtest blt: SUCCESS (0.811s)
[331.897630] Starting dynamic subtest: vebox
[332.710691] Dynamic subtest vebox: SUCCESS (0.824s)
[332.713207] Subtest legacy-engines-persistence: SUCCESS (3.953s)
[332.815658] [049/132] (691s left) syncobj_wait (wait-any-complex)
[332.882561] Starting subtest: wait-any-complex
[332.943633] Subtest wait-any-complex: SUCCESS (0.063s)
[333.047290] [050/132] (691s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[333.143921] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[333.146172] Starting dynamic subtest: pipe-A-default-mode
[334.316683] Dynamic subtest pipe-A-default-mode: SKIP (1.171s)
[334.321604] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.172s)
[334.530098] [051/132] (689s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[334.635934] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[334.638057] Starting dynamic subtest: pipe-A
[334.657432] Dynamic subtest pipe-A: SKIP (0.019s)
[334.667049] Starting dynamic subtest: pipe-B
[334.691918] Dynamic subtest pipe-B: SKIP (0.033s)
[334.700768] Starting dynamic subtest: pipe-C
[334.725269] Dynamic subtest pipe-C: SKIP (0.033s)
[334.733917] Starting dynamic subtest: pipe-D
[334.758196] Dynamic subtest pipe-D: SKIP (0.033s)
[334.762243] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.120s)
[334.895312] [052/132] (689s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[334.996187] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[334.998443] Starting dynamic subtest: pipe-A-eDP-1
[335.020140] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[335.031053] Starting dynamic subtest: pipe-B-eDP-1
[335.052124] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[335.060104] Starting dynamic subtest: pipe-C-eDP-1
[335.080974] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[335.089205] Starting dynamic subtest: pipe-D-eDP-1
[335.110753] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[335.115106] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[337.286498] [053/132] (687s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[337.397294] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[337.401112] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[337.504520] [054/132] (687s left) drm_read (empty-nonblock)
[337.677227] Starting subtest: empty-nonblock
[337.679601] Subtest empty-nonblock: SUCCESS (0.000s)
[337.849881] [055/132] (686s left) gem_partial_pwrite_pread (write-display)
[337.914545] Subtest write-display: SKIP (0.000s)
[337.997935] [056/132] (686s left) gem_ctx_param (invalid-size-set)
[338.056538] Starting subtest: invalid-size-set
[338.058962] Subtest invalid-size-set: SUCCESS (0.001s)
[338.201390] [057/132] (686s left) gem_close_race (multigpu-basic-threads)
[338.273910] Starting subtest: multigpu-basic-threads
[338.277666] Subtest multigpu-basic-threads: SKIP (0.000s)
[338.512353] [058/132] (686s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[338.619289] Starting subtest: psr-dirtyfb-ioctl
[338.621431] Starting dynamic subtest: A-eDP-1
[342.545312] Dynamic subtest A-eDP-1: SUCCESS (3.925s)
[342.547186] Subtest psr-dirtyfb-ioctl: SUCCESS (3.926s)
[343.380099] [059/132] (681s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[343.489293] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[344.102081] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.614s)
[344.286105] [060/132] (680s left) gem_mmap_gtt (zero-extend)
[344.354265] Subtest zero-extend: SKIP (0.000s)
[344.426704] [061/132] (680s left) gem_lmem_swapping (massive-random)
[344.469345] Subtest massive-random: SKIP (0.000s)
[344.516133] [062/132] (680s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[344.618782] Starting subtest: 4-tiled-32bpp-rotate-270
[344.638081] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[344.800340] [063/132] (680s left) kms_plane_alpha_blend (alpha-basic)
[344.905178] Starting subtest: alpha-basic
[345.190264] Starting dynamic subtest: pipe-A-eDP-1
[347.108585] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.915s)
[347.134760] Starting dynamic subtest: pipe-D-eDP-1
[349.838729] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.708s)
[349.841240] Subtest alpha-basic: SUCCESS (4.933s)
[350.745533] [064/132] (674s left) kms_sequence (get-idle)
[350.847133] Starting subtest: get-idle
[350.849422] Starting dynamic subtest: pipe-A-eDP-1
[352.659977] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[352.669179] Starting dynamic subtest: pipe-B-eDP-1
[355.098435] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.435s)
[355.108097] Starting dynamic subtest: pipe-C-eDP-1
[357.517756] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.418s)
[357.527762] Starting dynamic subtest: pipe-D-eDP-1
[359.953176] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.434s)
[359.955441] Subtest get-idle: SUCCESS (9.106s)
[360.781044] [065/132] (664s left) syncobj_wait (multi-wait-all-submitted)
[360.841385] Starting subtest: multi-wait-all-submitted
[360.944991] Subtest multi-wait-all-submitted: SUCCESS (0.103s)
[361.044499] [066/132] (663s left) gem_exec_reloc (basic-cpu-read)
[361.109686] Subtest basic-cpu-read: SKIP (0.000s)
[361.199933] [067/132] (663s left) gem_exec_suspend (basic)
[361.270371] Starting subtest: basic
[361.272760] Starting dynamic subtest: smem
[362.900220] Dynamic subtest smem: SUCCESS (1.627s)
[362.902679] Subtest basic: SUCCESS (1.629s)
[363.108154] [068/132] (662s left) gem_exec_balancer (bonded-chain)
[363.170225] Starting subtest: bonded-chain
[370.153246] Subtest bonded-chain: SUCCESS (6.981s)
[370.900380] [069/132] (654s left) gem_ppgtt (shrink-vs-evict-any)
[370.972020] Starting subtest: shrink-vs-evict-any
[376.894276] Subtest shrink-vs-evict-any: SUCCESS (5.920s)
[377.021444] [070/132] (648s left) syncobj_basic (bad-create-flags)
[377.088359] Starting subtest: bad-create-flags
[377.090302] Subtest bad-create-flags: SUCCESS (0.000s)
[377.226392] [071/132] (648s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[377.288506] Starting subtest: etime-single-wait-all-for-submit-submitted
[377.392576] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[377.505204] [072/132] (647s left) kms_flip (2x-flip-vs-fences-interruptible)
[377.610063] Starting subtest: 2x-flip-vs-fences-interruptible
[377.614547] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[377.754539] [073/132] (647s left) gem_softpin (allocator-nopin)
[377.825570] Starting subtest: allocator-nopin
[377.919476] Subtest allocator-nopin: SUCCESS (0.094s)
[378.094468] [074/132] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[378.204174] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[378.208174] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[378.340886] [075/132] (647s left) prime_busy (before)
[378.405822] Starting subtest: before
[378.408128] Starting dynamic subtest: rcs0
[378.449966] Dynamic subtest rcs0: SUCCESS (0.042s)
[378.460637] Starting dynamic subtest: bcs0
[378.534680] Dynamic subtest bcs0: SUCCESS (0.084s)
[378.544682] Starting dynamic subtest: vcs0
[378.575171] Dynamic subtest vcs0: SUCCESS (0.040s)
[378.583953] Starting dynamic subtest: vcs1
[378.615726] Dynamic subtest vcs1: SUCCESS (0.039s)
[378.626342] Starting dynamic subtest: vecs0
[378.655411] Dynamic subtest vecs0: SUCCESS (0.039s)
[378.664502] Starting dynamic subtest: ccs0
[378.695445] Dynamic subtest ccs0: SUCCESS (0.039s)
[378.804201] Subtest before: SUCCESS (0.398s)
[378.905249] [076/132] (646s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[379.010949] Starting subtest: fbc-indfb-scaledprimary
[381.958420] Subtest fbc-indfb-scaledprimary: SUCCESS (2.952s)
[383.194502] [077/132] (642s left) gem_readwrite (read-write)
[383.253253] Subtest read-write: SKIP (0.000s)
[383.318518] [078/132] (642s left) gem_exec_reloc (basic-scanout)
[383.387508] Subtest basic-scanout: SKIP (0.000s)
[383.473917] [079/132] (642s left) gem_ctx_param (invalid-ctx-set)
[383.533055] Starting subtest: invalid-ctx-set
[383.535378] Subtest invalid-ctx-set: SUCCESS (0.002s)
[383.673737] [080/132] (641s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[383.734336] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[383.736695] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[383.862261] [081/132] (641s left) gem_readwrite (beyond-eob)
[383.927282] Subtest beyond-EOB: SKIP (0.000s)
[384.002636] [082/132] (641s left) kms_big_fb (linear-32bpp-rotate-0)
[384.103262] Starting subtest: linear-32bpp-rotate-0
[385.638825] Subtest linear-32bpp-rotate-0: SUCCESS (1.536s)
[385.803822] [083/132] (639s left) gem_mmap_gtt (basic-write)
[385.861035] Subtest basic-write: SKIP (0.000s)
[385.930850] [084/132] (639s left) fbdev (nullptr)
[385.980663] Starting subtest: nullptr
[385.982597] Subtest nullptr: SUCCESS (0.000s)
[386.062187] [085/132] (639s left) syncobj_wait (wait-all-complex)
[386.127318] Starting subtest: wait-all-complex
[386.341815] Subtest wait-all-complex: SUCCESS (0.214s)
[386.440337] [086/132] (639s left) gem_tiled_partial_pwrite_pread (reads)
[386.500313] Subtest reads: SKIP (0.000s)
[386.596011] [087/132] (639s left) syncobj_wait (wait-zero-handles)
[386.653565] Starting subtest: wait-zero-handles
[386.655979] Subtest wait-zero-handles: SUCCESS (0.000s)
[386.773982] [088/132] (639s left) kms_properties (crtc-properties-atomic)
[386.874524] Starting subtest: crtc-properties-atomic
[386.876444] Starting dynamic subtest: pipe-A-eDP-1
[387.316836] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[387.325969] Starting dynamic subtest: pipe-B-eDP-1
[388.524608] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.208s)
[388.534167] Starting dynamic subtest: pipe-C-eDP-1
[389.651190] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[389.663220] Starting dynamic subtest: pipe-D-eDP-1
[390.776744] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[390.779216] Subtest crtc-properties-atomic: SUCCESS (3.905s)
[391.609843] [089/132] (634s left) gem_ctx_persistence (engines-hostile-preempt)
[391.688978] Starting subtest: engines-hostile-preempt
[391.691177] Starting dynamic subtest: rcs0
[391.820170] Dynamic subtest rcs0: SUCCESS (0.134s)
[391.832547] Starting dynamic subtest: bcs0
[391.883055] Dynamic subtest bcs0: SUCCESS (0.060s)
[391.894743] Starting dynamic subtest: vcs0
[393.860847] Dynamic subtest vcs0: SUCCESS (1.974s)
[393.873759] Starting dynamic subtest: vcs1
[395.906314] Dynamic subtest vcs1: SUCCESS (2.043s)
[395.917656] Starting dynamic subtest: vecs0
[397.890447] Dynamic subtest vecs0: SUCCESS (1.981s)
[397.901206] Starting dynamic subtest: ccs0
[398.015376] Dynamic subtest ccs0: SUCCESS (0.123s)
[398.018288] Subtest engines-hostile-preempt: SUCCESS (6.330s)
[398.117561] [090/132] (627s left) syncobj_timeline (multi-wait-all-available-submitted)
[398.188432] Starting subtest: multi-wait-all-available-submitted
[398.190670] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[398.328208] [091/132] (627s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[398.437731] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[398.442062] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[398.579422] [092/132] (627s left) syncobj_wait (single-wait-submitted)
[398.642098] Starting subtest: single-wait-submitted
[398.745204] Subtest single-wait-submitted: SUCCESS (0.102s)
[398.846792] [093/132] (627s left) gem_exec_schedule (preempt-self)
[398.924615] Starting subtest: preempt-self
[398.926920] Starting dynamic subtest: rcs0
[398.939359] Dynamic subtest rcs0: SUCCESS (0.020s)
[398.950588] Starting dynamic subtest: bcs0
[398.959766] Dynamic subtest bcs0: SUCCESS (0.019s)
[398.973868] Starting dynamic subtest: vcs0
[398.991613] Dynamic subtest vcs0: SUCCESS (0.031s)
[399.001047] Starting dynamic subtest: vcs1
[399.007752] Dynamic subtest vcs1: SUCCESS (0.015s)
[399.016768] Starting dynamic subtest: vecs0
[399.024269] Dynamic subtest vecs0: SUCCESS (0.016s)
[399.033278] Starting dynamic subtest: ccs0
[399.042421] Dynamic subtest ccs0: SUCCESS (0.017s)
[399.044763] Subtest preempt-self: SUCCESS (0.124s)
[401.057202] [094/132] (625s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[401.177318] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[407.907172] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.729s)
[408.080257] [095/132] (618s left) sysfs_preempt_timeout (idempotent)
[408.140375] Starting subtest: idempotent
[408.142834] Starting dynamic subtest: vecs0
[408.145263] Dynamic subtest vecs0: SUCCESS (0.000s)
[408.156099] Starting dynamic subtest: ccs0
[408.158208] Dynamic subtest ccs0: SUCCESS (0.000s)
[408.167103] Starting dynamic subtest: vcs0
[408.168964] Dynamic subtest vcs0: SUCCESS (0.000s)
[408.177859] Starting dynamic subtest: bcs0
[408.180061] Dynamic subtest bcs0: SUCCESS (0.000s)
[408.188844] Starting dynamic subtest: rcs0
[408.191107] Dynamic subtest rcs0: SUCCESS (0.000s)
[408.199955] Starting dynamic subtest: vcs1
[408.202158] Dynamic subtest vcs1: SUCCESS (0.000s)
[408.204282] Subtest idempotent: SUCCESS (0.006s)
[408.239484] [096/132] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[408.338280] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[408.342138] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[408.453163] [097/132] (617s left) kms_atomic (crtc-invalid-params-fence)
[408.547070] Starting subtest: crtc-invalid-params-fence
[408.549184] Starting dynamic subtest: pipe-A-eDP-1
[408.965324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.417s)
[408.967438] Subtest crtc-invalid-params-fence: SUCCESS (0.418s)
[409.781777] [098/132] (616s left) gem_fence_thrash (bo-write-verify-threaded-x)
[409.823473] Starting subtest: bo-write-verify-threaded-x
[409.845941] Subtest bo-write-verify-threaded-x: SKIP (0.021s)
[409.915282] [099/132] (616s left) gem_wait (busy)
[409.976485] Starting subtest: busy
[409.978881] Starting dynamic subtest: all-engines
[411.924618] Dynamic subtest all-engines: SUCCESS (1.946s)
[411.936718] Starting dynamic subtest: rcs0
[412.464987] Dynamic subtest rcs0: SUCCESS (0.539s)
[412.476164] Starting dynamic subtest: bcs0
[413.005509] Dynamic subtest bcs0: SUCCESS (0.539s)
[413.017427] Starting dynamic subtest: vcs0
[414.932467] Dynamic subtest vcs0: SUCCESS (1.924s)
[414.943928] Starting dynamic subtest: vcs1
[416.916113] Dynamic subtest vcs1: SUCCESS (1.981s)
[416.928762] Starting dynamic subtest: vecs0
[418.900589] Dynamic subtest vecs0: SUCCESS (1.981s)
[418.912916] Starting dynamic subtest: ccs0
[419.442271] Dynamic subtest ccs0: SUCCESS (0.541s)
[419.444816] Subtest busy: SUCCESS (9.465s)
[419.665498] [100/132] (606s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[419.777430] Starting subtest: x-tiled-64bpp-rotate-180
[421.406775] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.629s)
[421.610473] [101/132] (604s left) kms_force_connector_basic (force-edid)
[421.694849] Starting subtest: force-edid
[422.063216] Subtest force-edid: SUCCESS (0.371s)
[422.225698] [102/132] (604s left) gem_ctx_param (basic-default)
[422.289158] Starting subtest: basic-default
[422.291582] Subtest basic-default: SUCCESS (0.000s)
[422.385320] [103/132] (604s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[422.487465] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[422.489750] Starting dynamic subtest: pipe-A-eDP-1
[438.968817] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.728s)
[438.979553] Starting dynamic subtest: pipe-B-eDP-1
[456.989131] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.850s)
[456.999456] Starting dynamic subtest: pipe-C-eDP-1
[474.955954] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.794s)
[474.966314] Starting dynamic subtest: pipe-D-eDP-1
[492.965582] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.834s)
[492.968016] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (11.212s)
[500.180478] [104/132] (532s left) kms_pm_rpm (modeset-stress-extra-wait)
[502.298320] Starting subtest: modeset-stress-extra-wait
[556.616971] Subtest modeset-stress-extra-wait: SUCCESS (54.051s)
[556.733015] [105/132] (475s left) kms_flip (2x-flip-vs-suspend)
[556.827024] Starting subtest: 2x-flip-vs-suspend
[556.838782] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[556.945493] [106/132] (475s left) kms_chamelium_frames (dp-crc-fast)
[557.334039] Subtest dp-crc-fast: SKIP (0.000s)
[558.172437] [107/132] (474s left) intel_hwmon (hwmon-write)
[558.242580] Subtest hwmon-write: SKIP (0.000s)
[558.317241] [108/132] (474s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[558.431279] Starting subtest: psr-rgb101010-draw-render
[565.707831] Subtest psr-rgb101010-draw-render: SUCCESS (7.278s)
[565.855548] [109/132] (466s left) gem_exec_flush (basic-wb-pro-default)
[565.915029] Starting subtest: basic-wb-pro-default
[571.372218] Subtest basic-wb-pro-default: SUCCESS (5.455s)
[571.587667] [110/132] (461s left) kms_prop_blob (invalid-get-prop)
[571.649905] Starting subtest: invalid-get-prop
[571.652016] Subtest invalid-get-prop: SUCCESS (0.000s)
[571.792271] [111/132] (461s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[571.902286] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[578.496114] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.593s)
[578.622504] [112/132] (454s left) kms_plane (plane-position-hole-dpms)
[578.718767] Starting subtest: plane-position-hole-dpms
[579.256653] Starting dynamic subtest: pipe-A-plane-1
[581.654203] Dynamic subtest pipe-A-plane-1: SUCCESS (2.394s)
[581.665813] Starting dynamic subtest: pipe-A-plane-2
[584.037780] Dynamic subtest pipe-A-plane-2: SUCCESS (2.384s)
[584.049274] Starting dynamic subtest: pipe-A-plane-3
[586.412081] Dynamic subtest pipe-A-plane-3: SUCCESS (2.369s)
[586.423045] Starting dynamic subtest: pipe-A-plane-4
[588.726037] Dynamic subtest pipe-A-plane-4: SUCCESS (2.312s)
[588.737020] Starting dynamic subtest: pipe-A-plane-5
[588.750129] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[589.972687] Starting dynamic subtest: pipe-B-plane-1
[592.325355] Dynamic subtest pipe-B-plane-1: SUCCESS (2.364s)
[592.336002] Starting dynamic subtest: pipe-B-plane-2
[594.729641] Dynamic subtest pipe-B-plane-2: SUCCESS (2.401s)
[594.741244] Starting dynamic subtest: pipe-B-plane-3
[597.146391] Dynamic subtest pipe-B-plane-3: SUCCESS (2.417s)
[597.157267] Starting dynamic subtest: pipe-B-plane-4
[599.558053] Dynamic subtest pipe-B-plane-4: SUCCESS (2.413s)
[599.578644] Starting dynamic subtest: pipe-B-plane-5
[599.586517] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[599.588624] Subtest plane-position-hole-dpms: SUCCESS (20.864s)
[600.411479] [113/132] (432s left) perf_pmu (busy-start)
[600.456553] Starting subtest: busy-start
[600.458630] Starting dynamic subtest: rcs0
[603.005918] Dynamic subtest rcs0: SUCCESS (2.551s)
[603.019057] Starting dynamic subtest: bcs0
[605.555267] Dynamic subtest bcs0: SUCCESS (2.548s)
[605.568038] Starting dynamic subtest: vcs0
[609.174459] Dynamic subtest vcs0: SUCCESS (3.616s)
[609.187748] Starting dynamic subtest: vcs1
[613.141900] Dynamic subtest vcs1: SUCCESS (3.965s)
[613.155063] Starting dynamic subtest: vecs0
[617.173977] Dynamic subtest vecs0: SUCCESS (4.030s)
[617.187169] Starting dynamic subtest: ccs0
[619.723348] Dynamic subtest ccs0: SUCCESS (2.548s)
[619.725732] Subtest busy-start: SUCCESS (19.273s)
[619.870184] [114/132] (413s left) kms_color_pipeline (plane-lut1d)
[619.979666] Starting subtest: plane-lut1d
[619.992786] Starting dynamic subtest: pipe-A-eDP-1
[620.708884] Dynamic subtest pipe-A-eDP-1: FAIL (0.331s)
[621.435366] Starting dynamic subtest: pipe-B-eDP-1
[622.249226] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[622.841603] Starting dynamic subtest: pipe-C-eDP-1
[623.672096] Dynamic subtest pipe-C-eDP-1: FAIL (0.245s)
[624.142442] Starting dynamic subtest: pipe-D-eDP-1
[624.980211] Dynamic subtest pipe-D-eDP-1: FAIL (0.258s)
[624.982541] Subtest plane-lut1d: FAIL (4.714s)
[625.515794] [115/132] (407s left) gen9_exec_parse (batch-zero-length)
[625.586331] Subtest batch-zero-length: SKIP (0.000s)
[625.675470] [116/132] (407s left) i915_drm_fdinfo (context-close-stress)
[625.718254] Starting subtest: context-close-stress
[636.464937] Subtest context-close-stress: SUCCESS (10.745s)
[636.569034] [117/132] (396s left) kms_chamelium_hpd (hdmi-hpd-storm)
[637.134743] Subtest hdmi-hpd-storm: SKIP (0.000s)
[637.966393] [118/132] (395s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[638.062310] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[638.064497] Starting dynamic subtest: pipe-A-eDP-1
[638.088545] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[638.099844] Starting dynamic subtest: pipe-B-eDP-1
[638.122716] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[638.132067] Starting dynamic subtest: pipe-C-eDP-1
[638.155434] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[638.165281] Starting dynamic subtest: pipe-D-eDP-1
[638.189145] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[638.193428] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[640.315362] [119/132] (392s left) syncobj_timeline (invalid-signal-bad-pad)
[640.378527] Starting subtest: invalid-signal-bad-pad
[640.380858] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[640.524854] [120/132] (392s left) gem_exec_fence (submit67)
[640.708592] Starting subtest: submit67
[640.712871] Subtest submit67: SKIP (0.000s)
[642.322243] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[642.325833] [121/132] (390s left) gem_eio (in-flight-internal-10ms)
[642.545236] Starting subtest: in-flight-internal-10ms
[644.276001] Subtest in-flight-internal-10ms: SUCCESS (1.730s)
[644.463991] [122/132] (388s left) gem_exec_schedule (preempt-contexts)
[644.539092] Starting subtest: preempt-contexts
[644.541076] Starting dynamic subtest: rcs0
[644.584646] Dynamic subtest rcs0: SUCCESS (0.052s)
[644.595610] Starting dynamic subtest: bcs0
[644.635868] Dynamic subtest bcs0: SUCCESS (0.050s)
[644.646632] Starting dynamic subtest: vcs0
[644.681538] Dynamic subtest vcs0: SUCCESS (0.045s)
[644.692596] Starting dynamic subtest: vcs1
[644.723540] Dynamic subtest vcs1: SUCCESS (0.041s)
[644.734424] Starting dynamic subtest: vecs0
[644.766757] Dynamic subtest vecs0: SUCCESS (0.042s)
[644.777525] Starting dynamic subtest: ccs0
[644.818792] Dynamic subtest ccs0: SUCCESS (0.052s)
[644.821039] Subtest preempt-contexts: SUCCESS (0.287s)
[646.282289] [123/132] (387s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[651.376020] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[651.380873] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[652.214190] [124/132] (381s left) kms_chamelium_audio (dp-audio)
[652.607665] Subtest dp-audio: SKIP (0.000s)
[653.382901] [125/132] (380s left) kms_psr (psr2-cursor-plane-onoff)
[653.482074] Starting subtest: psr2-cursor-plane-onoff
[653.484211] Starting dynamic subtest: eDP-1
[655.132304] Dynamic subtest eDP-1: SUCCESS (1.649s)
[655.134499] Subtest psr2-cursor-plane-onoff: SUCCESS (1.650s)
[656.017895] [126/132] (377s left) kms_plane_scaling (planes-downscale-factor-0-75)
[656.117031] Starting subtest: planes-downscale-factor-0-75
[656.119174] Starting dynamic subtest: pipe-A
[656.138936] Dynamic subtest pipe-A: SKIP (0.019s)
[656.150877] Starting dynamic subtest: pipe-B
[656.172350] Dynamic subtest pipe-B: SKIP (0.033s)
[656.183011] Starting dynamic subtest: pipe-C
[656.207579] Dynamic subtest pipe-C: SKIP (0.033s)
[656.217970] Starting dynamic subtest: pipe-D
[656.238932] Dynamic subtest pipe-D: SKIP (0.033s)
[656.242773] Subtest planes-downscale-factor-0-75: SKIP (0.121s)
[656.380429] [127/132] (377s left) kms_vblank (ts-continuation-modeset)
[656.474656] Starting subtest: ts-continuation-modeset
[656.476899] Starting dynamic subtest: pipe-A-eDP-1
[658.020967] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.546s)
[658.038045] Starting dynamic subtest: pipe-D-eDP-1
[660.230344] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.205s)
[660.232251] Subtest ts-continuation-modeset: SUCCESS (3.754s)
[661.106009] [128/132] (372s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[661.156827] Starting subtest: framebuffer-vs-set-tiling
[661.161094] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[661.330405] [129/132] (372s left) kms_cursor_crc (cursor-sliding-512x170)
[661.624109] Starting subtest: cursor-sliding-512x170
[661.628576] Subtest cursor-sliding-512x170: SKIP (0.001s)
[661.812678] [130/132] (371s left) gem_exec_capture (capture)
[661.874833] Starting subtest: capture
[661.876633] Starting dynamic subtest: rcs0-smem
[662.713056] Dynamic subtest rcs0-smem: SUCCESS (0.840s)
[662.723606] Starting dynamic subtest: bcs0-smem
[664.041431] Dynamic subtest bcs0-smem: SUCCESS (1.328s)
[664.051720] Starting dynamic subtest: vcs0-smem
[664.880584] Dynamic subtest vcs0-smem: SUCCESS (0.836s)
[664.891695] Starting dynamic subtest: vcs1-smem
[666.198606] Dynamic subtest vcs1-smem: SUCCESS (1.317s)
[666.211810] Starting dynamic subtest: vecs0-smem
[667.080238] Dynamic subtest vecs0-smem: FAIL (0.814s)
[667.092620] Starting dynamic subtest: ccs0-smem
[668.336454] Dynamic subtest ccs0-smem: SUCCESS (1.322s)
[668.338820] Subtest capture: FAIL (6.461s)
[668.486957] [131/132] (365s left) i915_pm_rps (min-max-config-idle)
[668.553743] Starting subtest: min-max-config-idle
[668.558566] Subtest min-max-config-idle: SKIP (0.001s)
[668.658969] [132/132] (365s left) kms_flip (2x-plain-flip)
[668.753038] Starting subtest: 2x-plain-flip
[668.764079] Subtest 2x-plain-flip: SKIP (0.011s)
[668.867816] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_vrr
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: core_setmaster
results: parsing output: 5/ for test: i915_selftest
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_atomic_transition
results: parsing output: 9/ for test: kms_fence_pin_leak
results: parsing output: 10/ for test: gem_partial_pwrite_pread
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: kms_fbcon_fbt
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_exec_whisper
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_lease
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: sriov_basic
results: parsing output: 24/ for test: api_intel_bb
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_exec_nop
results: parsing output: 27/ for test: i915_hangman
results: parsing output: 28/ for test: kms_getfb
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_pxp
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: api_intel_allocator
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_mmap
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_invalid_mode
results: parsing output: 38/ for test: gem_exec_alignment
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: gem_mmap_wc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: drm_read
results: parsing output: 54/ for test: gem_partial_pwrite_pread
results: parsing output: 55/ for test: gem_ctx_param
results: parsing output: 56/ for test: gem_close_race
results: parsing output: 57/ for test: kms_dirtyfb
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_plane_alpha_blend
results: parsing output: 63/ for test: kms_sequence
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: gem_exec_suspend
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: gem_ppgtt
results: parsing output: 69/ for test: syncobj_basic
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: prime_busy
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_readwrite
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: gem_ctx_param
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gem_readwrite
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: fbdev
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: kms_properties
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: sysfs_preempt_timeout
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_atomic
results: parsing output: 97/ for test: gem_fence_thrash
results: parsing output: 98/ for test: gem_wait
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_force_connector_basic
results: parsing output: 101/ for test: gem_ctx_param
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_pm_rpm
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: intel_hwmon
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_flush
results: parsing output: 109/ for test: kms_prop_blob
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: kms_color_pipeline
results: parsing output: 114/ for test: gen9_exec_parse
results: parsing output: 115/ for test: i915_drm_fdinfo
results: parsing output: 116/ for test: kms_chamelium_hpd
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_chamelium_audio
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_plane_scaling
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_exec_capture
results: parsing output: 130/ for test: i915_pm_rps
results: parsing output: 131/ for test: kms_flip
Done.