[62.201980] Initializing watchdogs
[62.202052]   /dev/watchdog0
[62.216738] [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]
[62.221173] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.223430] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.225405] [001/134] (960s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[62.336025] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[62.337881] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[62.453316] [002/134] (960s left) gem_exec_balancer (parallel-keep-in-fence)
[62.706880] Starting subtest: parallel-keep-in-fence
[63.752786] Subtest parallel-keep-in-fence: SUCCESS (1.049s)
[63.879199] [003/134] (958s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[63.965255] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[63.966193] Starting dynamic subtest: pipe-A-default-mode
[65.082538] Dynamic subtest pipe-A-default-mode: SKIP (1.120s)
[65.084311] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.121s)
[65.261103] [004/134] (957s left) gem_exec_flush (basic-batch-kernel-default-wb)
[65.323204] Starting subtest: basic-batch-kernel-default-wb
[72.780311] Subtest basic-batch-kernel-default-wb: SUCCESS (7.471s)
[72.990684] [005/134] (949s left) gem_mmap_gtt (basic-wc)
[73.098998] Subtest basic-wc: SKIP (0.000s)
[73.180226] [006/134] (949s left) kms_flip (2x-flip-vs-panning-interruptible)
[73.348123] Starting subtest: 2x-flip-vs-panning-interruptible
[73.360075] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[73.454934] [007/134] (949s left) kms_atomic (plane-immutable-zpos)
[73.545970] Starting subtest: plane-immutable-zpos
[73.546916] Starting dynamic subtest: pipe-A-eDP-1
[74.183396] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.637s)
[74.184385] Subtest plane-immutable-zpos: SUCCESS (0.638s)
[74.979753] [008/134] (947s left) kms_colorop (plane-xr30-xr30-ctm_3x4_bt709_enc)
[75.100749] Subtest plane-XR30-XR30-ctm_3x4_bt709_enc: SKIP (0.000s)
[75.184642] [009/134] (947s left) drm_read (empty-block)
[75.321862] Starting subtest: empty-block
[76.323378] Subtest empty-block: SUCCESS (1.001s)
[76.493168] [010/134] (946s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[76.556285] Starting subtest: saturated-hostile-nopreempt
[76.557370] Starting dynamic subtest: rcs0
[76.618534] Dynamic subtest rcs0: SKIP (0.061s)
[76.625901] Starting dynamic subtest: bcs0
[76.662435] Dynamic subtest bcs0: SKIP (0.043s)
[76.670210] Starting dynamic subtest: vcs0
[76.684093] Dynamic subtest vcs0: SKIP (0.021s)
[76.689809] Starting dynamic subtest: vcs1
[76.701052] Dynamic subtest vcs1: SKIP (0.016s)
[76.706599] Starting dynamic subtest: vecs0
[76.712899] Dynamic subtest vecs0: SKIP (0.011s)
[76.718385] Starting dynamic subtest: ccs0
[76.729203] Dynamic subtest ccs0: SKIP (0.016s)
[76.730913] Subtest saturated-hostile-nopreempt: SKIP (0.172s)
[76.806732] [011/134] (946s left) dmabuf_sync_file (export-before-signal)
[76.869621] Starting subtest: export-before-signal
[76.870480] Subtest export-before-signal: SUCCESS (0.002s)
[76.944785] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[76.946334] [012/134] (946s left) kms_flip (plain-flip-ts-check)
[77.028588] Starting subtest: plain-flip-ts-check
[77.031115] Starting dynamic subtest: A-eDP1
[85.878375] Dynamic subtest A-eDP1: SUCCESS (8.851s)
[85.886949] Starting dynamic subtest: B-eDP1
[94.708581] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[94.716422] Starting dynamic subtest: C-eDP1
[103.531418] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[103.538851] Starting dynamic subtest: D-eDP1
[112.358249] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[112.360496] Subtest plain-flip-ts-check: SUCCESS (35.333s)
[113.540180] [013/134] (909s left) kms_atomic_interruptible (legacy-cursor)
[113.628200] Starting subtest: legacy-cursor
[113.629128] Starting dynamic subtest: pipe-A-eDP-1
[121.053944] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.425s)
[121.054830] Subtest legacy-cursor: SUCCESS (7.426s)
[121.901699] [014/134] (901s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[121.996975] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[121.997842] Starting dynamic subtest: pipe-A-eDP-1
[122.001279] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[122.007187] Starting dynamic subtest: pipe-B-eDP-1
[122.010531] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[122.016425] Starting dynamic subtest: pipe-C-eDP-1
[122.019765] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[122.025547] Starting dynamic subtest: pipe-D-eDP-1
[122.028791] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[122.030479] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s)
[124.188745] [015/134] (898s left) perf_pmu (invalid-open)
[124.229350] Starting subtest: invalid-open
[124.230653] Subtest invalid-open: SUCCESS (0.000s)
[124.328043] [016/134] (898s left) i915_query (query-topology-matches-eu-total)
[124.371406] Starting subtest: query-topology-matches-eu-total
[124.372417] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[124.467013] [017/134] (898s left) kms_vblank (ts-continuation-modeset-rpm)
[124.559483] Starting subtest: ts-continuation-modeset-rpm
[124.560532] Starting dynamic subtest: pipe-A-eDP-1
[127.084442] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.524s)
[127.092240] Starting dynamic subtest: pipe-D-eDP-1
[129.337363] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.251s)
[129.338249] Subtest ts-continuation-modeset-rpm: SUCCESS (4.779s)
[130.142672] [018/134] (893s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[130.236312] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[130.237598] Starting dynamic subtest: pipe-A-eDP-1
[130.247866] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[130.254395] Starting dynamic subtest: pipe-B-eDP-1
[130.263670] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[130.269572] Starting dynamic subtest: pipe-C-eDP-1
[130.278701] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[130.284444] Starting dynamic subtest: pipe-D-eDP-1
[130.293824] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[130.295495] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[132.429756] [019/134] (890s left) syncobj_timeline (wait-all-delayed-signal)
[132.486244] Starting subtest: wait-all-delayed-signal
[132.591713] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[132.681596] [020/134] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[132.782301] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[132.784103] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[132.901991] [021/134] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[133.000710] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[137.014893] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.014s)
[138.213965] [022/134] (885s left) gem_eio (create)
[138.444760] Starting subtest: create
[138.809077] Subtest create: SUCCESS (0.365s)
[138.965275] [023/134] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[139.058475] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[139.060070] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[139.169833] [024/134] (884s left) kms_chamelium_frames (dp-crc-single)
[139.542095] Subtest dp-crc-single: SKIP (0.000s)
[140.313128] [025/134] (883s left) kms_colorop (plane-xr24-xr24-multiply_125)
[140.447883] Subtest plane-XR24-XR24-multiply_125: SKIP (0.000s)
[140.528261] [026/134] (883s left) sw_sync (alloc_fence)
[140.554666] Starting subtest: alloc_fence
[140.555452] Subtest alloc_fence: SUCCESS (0.000s)
[140.626311] [027/134] (882s left) kms_flip (2x-modeset-vs-vblank-race)
[140.721631] Starting subtest: 2x-modeset-vs-vblank-race
[140.731583] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[140.848203] [028/134] (882s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[140.940782] Starting subtest: x-tiled-32bpp-rotate-270
[140.960190] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[141.117102] [029/134] (882s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[141.176545] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[141.282488] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[141.372186] [030/134] (882s left) kms_addfb_basic (bad-pitch-0)
[141.419524] Starting subtest: bad-pitch-0
[141.420513] Subtest bad-pitch-0: SUCCESS (0.000s)
[141.555887] [031/134] (882s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[146.522181] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[146.525063] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[147.381379] [032/134] (876s left) gem_exec_create (madvise)
[147.431745] Starting subtest: madvise
[147.432687] Starting dynamic subtest: smem
[167.960366] Dynamic subtest smem: SUCCESS (20.525s)
[167.962012] Subtest madvise: SUCCESS (20.526s)
[168.702346] [033/134] (855s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[169.267932] Starting subtest: syncobj-timeline-multiple-ext-nodes
[169.272550] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.007s)
[171.032373] [034/134] (852s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[171.126182] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[171.127128] Starting dynamic subtest: pipe-A
[171.143579] Dynamic subtest pipe-A: SKIP (0.016s)
[171.150474] Starting dynamic subtest: pipe-B
[171.171575] Dynamic subtest pipe-B: SKIP (0.028s)
[171.178227] Starting dynamic subtest: pipe-C
[171.202325] Dynamic subtest pipe-C: SKIP (0.029s)
[171.208769] Starting dynamic subtest: pipe-D
[171.230563] Dynamic subtest pipe-D: SKIP (0.028s)
[171.232199] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.103s)
[171.338431] [035/134] (852s left) gem_tiled_pread_pwrite
[171.445676] [036/134] (852s left) kms_cursor_crc (cursor-sliding-128x42)
[171.653337] Starting subtest: cursor-sliding-128x42
[171.696702] Subtest cursor-sliding-128x42: SKIP (0.040s)
[171.923059] [037/134] (851s left) perf_pmu (init-busy)
[171.956774] Starting subtest: init-busy
[171.957584] Starting dynamic subtest: rcs0
[171.958413] Dynamic subtest rcs0: SUCCESS (0.001s)
[171.965356] Starting dynamic subtest: bcs0
[171.966131] Dynamic subtest bcs0: SUCCESS (0.000s)
[171.972213] Starting dynamic subtest: vcs0
[171.973032] Dynamic subtest vcs0: SUCCESS (0.000s)
[171.979096] Starting dynamic subtest: vcs1
[171.979920] Dynamic subtest vcs1: SUCCESS (0.001s)
[171.985866] Starting dynamic subtest: vecs0
[171.986794] Dynamic subtest vecs0: SUCCESS (0.000s)
[171.992851] Starting dynamic subtest: ccs0
[171.993765] Dynamic subtest ccs0: SUCCESS (0.000s)
[171.994671] Subtest init-busy: SUCCESS (0.005s)
[172.078908] [038/134] (851s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[172.180823] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[173.028689] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.848s)
[173.218337] [039/134] (850s left) gem_ctx_engines (none)
[173.270468] Starting subtest: none
[173.273102] Subtest none: SUCCESS (0.001s)
[173.469061] [040/134] (850s left) syncobj_basic (bad-flags-handle-to-fd)
[173.526684] Starting subtest: bad-flags-handle-to-fd
[173.527616] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[173.664643] [041/134] (850s left) gem_exec_async (forked-writes)
[173.729456] Starting subtest: forked-writes
[173.730457] Starting dynamic subtest: rcs0
[173.753525] Dynamic subtest rcs0: SUCCESS (0.025s)
[173.761901] Starting dynamic subtest: bcs0
[173.777657] Dynamic subtest bcs0: SUCCESS (0.023s)
[173.784642] Starting dynamic subtest: vcs0
[173.797359] Dynamic subtest vcs0: SUCCESS (0.019s)
[173.805410] Starting dynamic subtest: vcs1
[173.818147] Dynamic subtest vcs1: SUCCESS (0.020s)
[173.825513] Starting dynamic subtest: vecs0
[173.840505] Dynamic subtest vecs0: SUCCESS (0.022s)
[173.850961] Starting dynamic subtest: ccs0
[173.862090] Dynamic subtest ccs0: SUCCESS (0.021s)
[173.862962] Subtest forked-writes: SUCCESS (0.134s)
[174.135867] [042/134] (849s left) kms_cursor_crc (cursor-offscreen-64x64)
[174.314416] Starting subtest: cursor-offscreen-64x64
[174.318527] Starting dynamic subtest: pipe-A-eDP-1
[176.259625] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[176.285994] Starting dynamic subtest: pipe-D-eDP-1
[178.857514] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.578s)
[178.858425] Subtest cursor-offscreen-64x64: SUCCESS (4.543s)
[179.708982] [043/134] (844s left) gen3_render_tiledy_blits
[179.830111] [044/134] (844s left) kms_big_fb (4-tiled-addfb)
[179.931928] Starting subtest: 4-tiled-addfb
[179.932794] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[180.051672] [045/134] (844s left) kms_flip (2x-nonexisting-fb-interruptible)
[180.143455] Starting subtest: 2x-nonexisting-fb-interruptible
[180.155702] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[180.246888] [046/134] (843s left) kms_chamelium_hpd (vga-hpd-fast)
[180.620495] Subtest vga-hpd-fast: SKIP (0.000s)
[181.417186] [047/134] (842s left) gem_huc_copy (huc-copy)
[181.470651] Starting subtest: huc-copy
[181.473801] Subtest huc-copy: SUCCESS (0.003s)
[181.650633] [048/134] (842s left) prime_vgem (fence-flip-hang)
[181.728583] Subtest fence-flip-hang: SKIP (0.000s)
[181.856204] [049/134] (842s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[181.945218] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[182.027707] [050/134] (842s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[182.079864] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[182.133349] [051/134] (842s left) gem_basic (multigpu-create-close)
[182.180542] Starting subtest: multigpu-create-close
[182.182241] Subtest multigpu-create-close: SKIP (0.000s)
[182.299844] [052/134] (842s left) perf (short-reads)
[182.422015] Starting subtest: short-reads
[182.438879] Subtest short-reads: SUCCESS (0.017s)
[182.476586] [053/134] (841s left) kms_plane_scaling (invalid-num-scalers)
[182.567324] Starting subtest: invalid-num-scalers
[182.568202] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[182.585139] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.017s)
[182.592044] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[182.614057] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.028s)
[182.621330] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[182.643621] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.028s)
[182.650139] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[182.672942] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[182.673808] Subtest invalid-num-scalers: SUCCESS (0.107s)
[182.806422] [054/134] (841s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[182.896304] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[182.897220] Starting dynamic subtest: pipe-A-eDP-1
[182.920110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s)
[182.928113] Starting dynamic subtest: pipe-B-eDP-1
[182.942970] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[182.949623] Starting dynamic subtest: pipe-C-eDP-1
[182.966214] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[182.973616] Starting dynamic subtest: pipe-D-eDP-1
[182.988624] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[182.989605] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s)
[185.323328] [055/134] (839s left) prime_self_import (export-vs-gem_close-race)
[185.349507] Starting subtest: export-vs-gem_close-race
[190.440738] Subtest export-vs-gem_close-race: SUCCESS (5.091s)
[190.523349] [056/134] (833s left) i915_suspend (basic-s3-without-i915)
[190.551420] Starting subtest: basic-s3-without-i915
[194.164876] Subtest basic-s3-without-i915: SKIP (3.611s)
[195.600129] [057/134] (828s left) kms_draw_crc (fill-fb)
[195.699168] Starting subtest: fill-fb
[196.184932] Subtest fill-fb: SUCCESS (0.486s)
[196.305757] [058/134] (828s left) syncobj_timeline (invalid-signal-bad-pad)
[196.358692] Starting subtest: invalid-signal-bad-pad
[196.359805] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[196.453950] [059/134] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[196.548461] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[196.551074] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[196.668501] [060/134] (827s left) kms_pipe_crc_basic (bad-source)
[196.757550] Starting subtest: bad-source
[196.758499] Subtest bad-source: SUCCESS (0.000s)
[196.842797] [061/134] (827s left) kms_psr (psr2-basic)
[196.937712] Starting subtest: psr2-basic
[196.938776] Starting dynamic subtest: eDP-1
[198.571810] Dynamic subtest eDP-1: SUCCESS (1.634s)
[198.572817] Subtest psr2-basic: SUCCESS (1.635s)
[199.379493] [062/134] (825s left) kms_frontbuffer_tracking (psr-slowdraw)
[199.466724] Starting subtest: psr-slowdraw
[224.600426] Subtest psr-slowdraw: SUCCESS (25.134s)
[224.751524] [063/134] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[224.853092] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[224.854951] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[224.973334] [064/134] (799s left) gem_exec_params (readonly)
[225.017551] Starting subtest: readonly
[225.020133] Subtest readonly: SUCCESS (0.002s)
[225.174323] [065/134] (799s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[225.250048] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[229.316882] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.067s)
[230.507705] [066/134] (794s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[230.598681] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[230.600326] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[230.720524] [067/134] (794s left) i915_drm_fdinfo (most-busy-check-all)
[230.752428] Starting subtest: most-busy-check-all
[230.753398] Starting dynamic subtest: rcs0
[230.756454] Dynamic subtest rcs0: SKIP (0.004s)
[230.763485] Starting dynamic subtest: bcs0
[230.765201] Dynamic subtest bcs0: SKIP (0.000s)
[230.771286] Starting dynamic subtest: vcs0
[230.772968] Dynamic subtest vcs0: SKIP (0.000s)
[230.779218] Starting dynamic subtest: vcs1
[230.780895] Dynamic subtest vcs1: SKIP (0.000s)
[230.786816] Starting dynamic subtest: vecs0
[230.788583] Dynamic subtest vecs0: SKIP (0.000s)
[230.794414] Starting dynamic subtest: ccs0
[230.796175] Dynamic subtest ccs0: SKIP (0.000s)
[230.797829] Subtest most-busy-check-all: SKIP (0.009s)
[230.827314] [068/134] (794s left) kms_display_modes (extended-mode-basic)
[230.951323] Starting subtest: extended-mode-basic
[230.953024] Subtest extended-mode-basic: SKIP (0.000s)
[230.988928] [069/134] (793s left) syncobj_eventfd (binary-wait-before-signal)
[231.032785] Starting subtest: binary-wait-before-signal
[231.063155] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[231.148463] [070/134] (793s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[231.237182] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[238.208503] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.973s)
[238.352941] [071/134] (786s left) perf_pmu (all-busy-idle-check-all)
[238.388137] Starting subtest: all-busy-idle-check-all
[239.895069] Subtest all-busy-idle-check-all: SUCCESS (1.504s)
[240.009427] [072/134] (784s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[240.105097] Starting subtest: y-tiled-16bpp-rotate-90
[240.107032] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[240.239500] [073/134] (784s left) api_intel_bb (full-batch)
[240.283247] Starting subtest: full-batch
[240.290447] Subtest full-batch: SUCCESS (0.008s)
[240.419585] [074/134] (784s left) gem_exec_schedule (u-submit-late-slice)
[240.481284] Starting subtest: u-submit-late-slice
[240.482311] Starting dynamic subtest: rcs0
[240.520366] Dynamic subtest rcs0: SUCCESS (0.039s)
[240.530566] Starting dynamic subtest: bcs0
[240.548225] Dynamic subtest bcs0: SUCCESS (0.027s)
[240.555616] Starting dynamic subtest: vcs0
[240.576971] Dynamic subtest vcs0: SUCCESS (0.028s)
[240.586181] Starting dynamic subtest: vcs1
[240.605408] Dynamic subtest vcs1: SUCCESS (0.028s)
[240.612588] Starting dynamic subtest: vecs0
[240.633563] Dynamic subtest vecs0: SUCCESS (0.027s)
[240.641237] Starting dynamic subtest: ccs0
[240.661232] Dynamic subtest ccs0: SUCCESS (0.027s)
[240.662228] Subtest u-submit-late-slice: SUCCESS (0.180s)
[241.992267] [075/134] (783s left) gem_exec_schedule (in-order)
[242.043360] Starting subtest: in-order
[242.044361] Starting dynamic subtest: rcs0
[242.143806] Dynamic subtest rcs0: SUCCESS (0.100s)
[242.152910] Starting dynamic subtest: vcs0
[242.221995] Dynamic subtest vcs0: SUCCESS (0.077s)
[242.231435] Starting dynamic subtest: vcs1
[242.297954] Dynamic subtest vcs1: SUCCESS (0.075s)
[242.307069] Starting dynamic subtest: vecs0
[242.370415] Dynamic subtest vecs0: SUCCESS (0.072s)
[242.379711] Starting dynamic subtest: ccs0
[242.451897] Dynamic subtest ccs0: SUCCESS (0.080s)
[242.453317] Subtest in-order: SUCCESS (0.409s)
[244.063696] [076/134] (781s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[244.167089] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[251.084368] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.915s)
[251.239380] [077/134] (773s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[251.326900] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[251.328551] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[251.442058] [078/134] (773s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[251.533357] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[251.534281] Starting dynamic subtest: pipe-A-eDP-1
[251.542551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[251.549568] Starting dynamic subtest: pipe-B-eDP-1
[251.557811] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[251.566762] Starting dynamic subtest: pipe-C-eDP-1
[251.575554] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[251.582119] Starting dynamic subtest: pipe-D-eDP-1
[251.590394] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[251.591307] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[253.722079] [079/134] (771s left) gen9_exec_parse (secure-batches)
[253.782177] Subtest secure-batches: SKIP (0.000s)
[253.859822] [080/134] (771s left) kms_flip (dpms-off-confusion-interruptible)
[253.946819] Starting subtest: dpms-off-confusion-interruptible
[253.949142] Starting dynamic subtest: A-eDP1
[262.614203] Dynamic subtest A-eDP1: SUCCESS (8.665s)
[262.623858] Starting dynamic subtest: B-eDP1
[271.242399] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[271.252177] Starting dynamic subtest: C-eDP1
[279.871601] Dynamic subtest C-eDP1: SUCCESS (8.626s)
[279.880830] Starting dynamic subtest: D-eDP1
[288.502518] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[288.504956] Subtest dpms-off-confusion-interruptible: SUCCESS (34.556s)
[289.665757] [081/134] (735s left) kms_lease (possible-crtcs-filtering)
[289.740164] Starting subtest: possible-crtcs-filtering
[289.746053] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[289.863947] [082/134] (735s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[289.962482] Starting subtest: cursorB-vs-flipB-legacy
[289.964288] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[290.115423] [083/134] (735s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[290.203235] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[290.204029] Starting dynamic subtest: pipe-A-default-mode
[291.341386] Dynamic subtest pipe-A-default-mode: SKIP (1.136s)
[291.343117] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.138s)
[291.527794] [084/134] (733s left) kms_vblank (wait-idle-hang)
[291.621270] Starting subtest: wait-idle-hang
[291.622152] Starting dynamic subtest: pipe-A-eDP-1
[318.674266] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.050s)
[318.685023] Starting dynamic subtest: pipe-D-eDP-1
[343.640974] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.963s)
[343.641970] Subtest wait-idle-hang: SUCCESS (52.018s)
[344.501053] [085/134] (680s left) gem_exec_reloc (basic-softpin)
[344.553867] Subtest basic-softpin: SKIP (0.000s)
[344.627918] [086/134] (680s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[344.730093] Starting subtest: 2x-cursor-vs-flip-legacy
[344.732913] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[344.892222] [087/134] (680s left) gem_pxp (fail-invalid-protected-context)
[345.009406] Starting subtest: fail-invalid-protected-context
[345.011062] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[345.154402] [088/134] (680s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[345.214306] Starting subtest: invalid-bsd2-flag-on-blt
[345.215326] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[345.340210] [089/134] (680s left) prime_mmap (test_aperture_limit)
[345.383486] Starting subtest: test_aperture_limit
[345.384471] Starting dynamic subtest: test_aperture_limit-smem
[345.391812] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[345.393880] Subtest test_aperture_limit: SKIP (0.009s)
[345.497697] [090/134] (680s left) kms_pm_dc (dc5-dpms-negative)
[346.596877] Starting subtest: dc5-dpms-negative
[346.598645] Subtest dc5-dpms-negative: SKIP (0.000s)
[346.683670] [091/134] (678s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[346.783214] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[347.872726] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.090s)
[348.026983] [092/134] (677s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[348.114327] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[348.115135] Starting dynamic subtest: pipe-A-eDP-1
[348.122996] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[348.130078] Starting dynamic subtest: pipe-B-eDP-1
[348.138317] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[348.145746] Starting dynamic subtest: pipe-C-eDP-1
[348.153656] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[348.160425] Starting dynamic subtest: pipe-D-eDP-1
[348.168588] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[348.170173] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[350.352477] [093/134] (675s left) kms_psr (fbc-pr-suspend)
[350.443450] Starting subtest: fbc-pr-suspend
[350.445362] Subtest fbc-pr-suspend: SKIP (0.000s)
[350.522197] [094/134] (675s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[355.501384] Starting subtest: pr-plane-move-sf-dmg-area
[355.504606] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s)
[356.368162] [095/134] (669s left) kms_dsc (dsc-with-output-formats)
[356.460545] Starting subtest: dsc-with-output-formats
[356.469605] Subtest dsc-with-output-formats: SKIP (0.000s)
[356.538922] [096/134] (669s left) gem_pwrite_snooped
[356.674240] [097/134] (669s left) vgem_basic (bad-pad)
[356.712381] Starting subtest: bad-pad
[356.713394] Subtest bad-pad: SUCCESS (0.000s)
[356.775233] [098/134] (669s left) gem_spin_batch (legacy)
[356.824089] Starting subtest: legacy
[356.825156] Starting dynamic subtest: default
[360.065790] Dynamic subtest default: SUCCESS (3.236s)
[360.075718] Starting dynamic subtest: render
[363.302934] Dynamic subtest render: SUCCESS (3.234s)
[363.311761] Starting dynamic subtest: bsd
[366.541904] Dynamic subtest bsd: SUCCESS (3.235s)
[366.557397] Starting dynamic subtest: bsd1
[369.776974] Dynamic subtest bsd1: SUCCESS (3.233s)
[369.786492] Starting dynamic subtest: bsd2
[373.015226] Dynamic subtest bsd2: SUCCESS (3.235s)
[373.024827] Starting dynamic subtest: blt
[376.252363] Dynamic subtest blt: SUCCESS (3.234s)
[376.261869] Starting dynamic subtest: vebox
[379.488596] Dynamic subtest vebox: SUCCESS (3.233s)
[379.489878] Subtest legacy: SUCCESS (22.661s)
[380.997549] [099/134] (644s left) kms_color (invalid-ctm-matrix-sizes)
[381.085367] Starting subtest: invalid-ctm-matrix-sizes
[381.086290] Starting dynamic subtest: pipe-A
[381.087163] Dynamic subtest pipe-A: SUCCESS (0.002s)
[381.094341] Starting dynamic subtest: pipe-B
[381.095282] Dynamic subtest pipe-B: SUCCESS (0.003s)
[381.102082] Starting dynamic subtest: pipe-C
[381.102964] Dynamic subtest pipe-C: SUCCESS (0.003s)
[381.109571] Starting dynamic subtest: pipe-D
[381.110499] Dynamic subtest pipe-D: SUCCESS (0.004s)
[381.111424] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[381.189397] [100/134] (644s left) kms_psr (fbc-psr-basic)
[381.265254] Starting subtest: fbc-psr-basic
[381.266166] Starting dynamic subtest: eDP-1
[381.267960] Dynamic subtest eDP-1: SKIP (0.000s)
[381.269768] Subtest fbc-psr-basic: SKIP (0.001s)
[381.344824] [101/134] (644s left) gem_pxp (create-regular-buffer)
[381.409023] Starting subtest: create-regular-buffer
[381.410108] Subtest create-regular-buffer: SUCCESS (0.000s)
[381.534680] [102/134] (644s left) gem_exec_schedule (semaphore-noskip)
[381.600056] Starting subtest: semaphore-noskip
[382.019228] Subtest semaphore-noskip: SUCCESS (0.417s)
[382.349402] [103/134] (643s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[382.403752] Starting subtest: y-tiled-to-vebox-y-tiled
[382.405560] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[382.596496] [104/134] (643s left) gem_ctx_exec (basic-nohangcheck)
[382.655023] Starting subtest: basic-nohangcheck
[382.910631] Subtest basic-nohangcheck: SUCCESS (0.256s)
[383.055113] [105/134] (642s left) i915_pm_rc6_residency (rc6-idle)
[383.101718] Starting subtest: rc6-idle
[383.122240] Starting dynamic subtest: gt0-rcs0
[407.407213] Dynamic subtest gt0-rcs0: SUCCESS (24.284s)
[407.416276] Starting dynamic subtest: gt0-bcs0
[431.775381] Dynamic subtest gt0-bcs0: SUCCESS (24.366s)
[431.785653] Starting dynamic subtest: gt0-ccs0
[456.118053] Dynamic subtest gt0-ccs0: SUCCESS (24.340s)
[456.128837] Starting dynamic subtest: gt1-vcs0
[462.292905] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[462.302169] Starting dynamic subtest: gt1-vecs0
[468.464682] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[468.465922] Subtest rc6-idle: SUCCESS (85.362s)
[468.550501] [106/134] (557s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[468.660183] Starting subtest: cursorA-vs-flipB-atomic-transitions
[468.661885] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[468.823009] [107/134] (557s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[468.905927] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[468.907763] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[469.042538] [108/134] (557s left) syncobj_basic (bad-pad-handle-to-fd)
[469.096967] Starting subtest: bad-pad-handle-to-fd
[469.097969] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[469.226112] [109/134] (556s left) gem_wait (wait)
[469.286691] Starting subtest: wait
[469.287800] Starting dynamic subtest: all-engines
[470.934392] Dynamic subtest all-engines: SUCCESS (1.645s)
[470.944244] Starting dynamic subtest: rcs0
[471.981706] Dynamic subtest rcs0: SUCCESS (1.047s)
[471.994583] Starting dynamic subtest: bcs0
[473.031959] Dynamic subtest bcs0: SUCCESS (1.047s)
[473.047113] Starting dynamic subtest: vcs0
[474.076267] Dynamic subtest vcs0: SUCCESS (1.042s)
[474.087889] Starting dynamic subtest: vcs1
[475.120344] Dynamic subtest vcs1: SUCCESS (1.042s)
[475.130743] Starting dynamic subtest: vecs0
[476.167172] Dynamic subtest vecs0: SUCCESS (1.044s)
[476.185168] Starting dynamic subtest: ccs0
[477.216713] Dynamic subtest ccs0: SUCCESS (1.046s)
[477.218238] Subtest wait: SUCCESS (7.930s)
[477.433809] [110/134] (548s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[477.526175] Starting subtest: coverage-vs-premult-vs-constant
[477.801178] Starting dynamic subtest: pipe-A-eDP-1
[478.386777] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[478.395137] Starting dynamic subtest: pipe-D-eDP-1
[479.684297] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.295s)
[479.685428] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.159s)
[480.545520] [111/134] (545s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[480.586575] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[480.587593] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[480.716326] [112/134] (545s left) i915_pm_freq_api (freq-reset-multiple)
[480.773545] Starting subtest: freq-reset-multiple
[480.775017] Starting dynamic subtest: gt0
[489.438327] Dynamic subtest gt0: SUCCESS (8.664s)
[489.445877] Starting dynamic subtest: gt1
[496.816980] Dynamic subtest gt1: SUCCESS (7.375s)
[496.818743] Subtest freq-reset-multiple: SUCCESS (16.041s)
[496.900144] [113/134] (529s left) kms_invalid_mode (bad-vtotal)
[496.990117] Starting subtest: bad-vtotal
[496.991025] Starting dynamic subtest: pipe-A-eDP-1
[497.273696] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[497.283160] Starting dynamic subtest: pipe-B-eDP-1
[497.284050] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[497.290775] Starting dynamic subtest: pipe-C-eDP-1
[497.291564] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[497.298286] Starting dynamic subtest: pipe-D-eDP-1
[497.299082] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[497.299863] Subtest bad-vtotal: SUCCESS (0.292s)
[498.161969] [114/134] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[498.261191] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[505.014878] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.754s)
[505.167622] [115/134] (521s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[510.124494] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[510.127742] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[510.973419] [116/134] (515s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[511.075356] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[533.384144] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.310s)
[533.534252] [117/134] (492s left) kms_pm_rpm (dpms-non-lpsp)
[535.043929] Starting subtest: dpms-non-lpsp
[535.046073] Subtest dpms-non-lpsp: SKIP (0.001s)
[535.824056] [118/134] (490s left) tools_test (tools_test)
[535.857679] Starting subtest: tools_test
[535.913869] Subtest tools_test: SUCCESS (0.062s)
[535.992401] [119/134] (490s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[536.054390] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[536.055514] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[536.196411] [120/134] (490s left) kms_cursor_legacy (forked-move)
[536.305191] Starting subtest: forked-move
[536.306062] Starting dynamic subtest: pipe-A
[541.773474] Dynamic subtest pipe-A: SUCCESS (5.466s)
[541.786583] Starting dynamic subtest: pipe-B
[547.239580] Dynamic subtest pipe-B: SUCCESS (5.463s)
[547.250163] Starting dynamic subtest: pipe-C
[552.699578] Dynamic subtest pipe-C: SUCCESS (5.457s)
[552.707164] Starting dynamic subtest: pipe-D
[558.167522] Dynamic subtest pipe-D: SUCCESS (5.466s)
[558.177771] Starting dynamic subtest: all-pipes
[563.666077] Dynamic subtest all-pipes: SUCCESS (5.496s)
[563.667224] Subtest forked-move: SUCCESS (27.358s)
[563.820120] [121/134] (462s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[563.902648] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[563.903674] Starting dynamic subtest: pipe-A-eDP-1
[564.122897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.205s)
[564.130492] Starting dynamic subtest: pipe-B-eDP-1
[565.363303] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s)
[565.371104] Starting dynamic subtest: pipe-C-eDP-1
[566.565563] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s)
[566.573232] Starting dynamic subtest: pipe-D-eDP-1
[567.807961] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[567.808897] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.896s)
[569.066942] [122/134] (457s left) kms_frontbuffer_tracking (fbc-1p-rte)
[569.168883] Starting subtest: fbc-1p-rte
[574.668514] Subtest fbc-1p-rte: SUCCESS (5.501s)
[575.894803] [123/134] (450s left) gem_mmap_offset (isolation)
[575.948173] Starting subtest: isolation
[575.955534] Subtest isolation: SUCCESS (0.005s)
[576.084291] [124/134] (450s left) gem_exec_reloc (basic-range)
[576.141348] Subtest basic-range: SKIP (0.000s)
[576.213636] [125/134] (450s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[576.301180] Starting subtest: async-flip-with-page-flip-events-tiled
[576.674117] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[577.655887] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: FAIL (0.765s)
[577.665765] Starting dynamic subtest: pipe-A-eDP-1-4
[577.801484] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.180s)
[577.809261] Starting dynamic subtest: pipe-A-eDP-1-4
[577.857783] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.008s)
[577.867319] Starting dynamic subtest: pipe-A-eDP-1-x
[577.997082] Dynamic subtest pipe-A-eDP-1-x: FAIL (0.180s)
[578.181204] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[579.197495] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: FAIL (0.942s)
[579.207256] Starting dynamic subtest: pipe-B-eDP-1-4
[579.434523] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.187s)
[579.443173] Starting dynamic subtest: pipe-B-eDP-1-4
[579.496116] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.008s)
[579.503841] Starting dynamic subtest: pipe-B-eDP-1-x
[579.637825] Dynamic subtest pipe-B-eDP-1-x: FAIL (0.179s)
[579.875527] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[582.607454] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.736s)
[582.615416] Starting dynamic subtest: pipe-C-eDP-1-4
[584.770962] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.162s)
[584.778412] Starting dynamic subtest: pipe-C-eDP-1-4
[586.781629] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[586.789611] Starting dynamic subtest: pipe-C-eDP-1-x
[588.949458] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.166s)
[589.311015] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[592.040062] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.733s)
[592.050449] Starting dynamic subtest: pipe-D-eDP-1-4
[594.214277] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[594.221662] Starting dynamic subtest: pipe-D-eDP-1-4
[596.225576] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[596.235088] Starting dynamic subtest: pipe-D-eDP-1-x
[598.403928] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[598.404882] Subtest async-flip-with-page-flip-events-tiled: FAIL (22.100s)
[599.635731] [126/134] (427s left) gem_eio (in-flight-internal-1us)
[599.856389] Starting subtest: in-flight-internal-1us
[600.988913] Subtest in-flight-internal-1us: SUCCESS (1.133s)
[601.143076] [127/134] (425s left) kms_psr (psr-primary-render)
[601.232831] Starting subtest: psr-primary-render
[601.233657] Starting dynamic subtest: eDP-1
[602.925514] Dynamic subtest eDP-1: SUCCESS (1.693s)
[602.926444] Subtest psr-primary-render: SUCCESS (1.694s)
[603.805679] [128/134] (422s left) kms_selftest (drm_damage_helper)
[603.835455] Starting subtest: drm_damage_helper
[603.869087] Starting dynamic subtest: drm_test_damage_iter_no_damage
[603.992704] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.125s)
[604.002060] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[604.096887] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.101s)
[604.105910] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[604.194047] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.097s)
[604.202876] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[604.341271] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.145s)
[604.348726] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[604.470258] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.128s)
[604.477567] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[604.569048] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.098s)
[604.582119] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[604.709094] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.138s)
[604.716861] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[604.840267] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.130s)
[604.847742] Starting dynamic subtest: drm_test_damage_iter_single_damage
[604.973453] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.133s)
[604.980740] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[605.096465] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.122s)
[605.103695] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[605.238645] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.142s)
[605.249302] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[605.364481] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.122s)
[605.372626] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[605.486267] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.121s)
[605.493529] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[605.625429] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.137s)
[605.632719] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[605.768831] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.143s)
[605.776198] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[605.887295] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.117s)
[605.894718] Starting dynamic subtest: drm_test_damage_iter_damage
[606.019235] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.131s)
[606.026615] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[606.165507] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.145s)
[606.172877] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[606.309038] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.144s)
[606.316930] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[606.467259] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.156s)
[606.475046] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[606.616112] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.149s)
[606.617034] Subtest drm_damage_helper: SUCCESS (2.778s)
[606.825093] [129/134] (419s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[606.920338] Starting subtest: fbc-psr-sprite-mmap-gtt
[606.921200] Starting dynamic subtest: eDP-1
[606.922839] Dynamic subtest eDP-1: SKIP (0.000s)
[606.924536] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[607.018099] [130/134] (419s left) perf (disabled-read-error)
[607.134168] Starting subtest: disabled-read-error
[607.149967] Subtest disabled-read-error: SUCCESS (0.017s)
[607.188065] [131/134] (419s left) kms_content_protection (mei-interface)
[607.327720] Starting subtest: mei-interface
[607.329943] Subtest mei-interface: SKIP (0.001s)
[607.469467] [132/134] (419s left) kms_flip (nonblocking-read)
[607.554636] Starting subtest: nonblocking-read
[607.555569] Subtest nonblocking-read: SUCCESS (0.000s)
[607.676982] [133/134] (419s left) gem_mmap_gtt (cpuset-big-copy-xy)
[607.731686] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[607.789941] [134/134] (419s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[607.884602] Starting subtest: psr-rgb565-draw-mmap-cpu
[614.600710] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.716s)
[614.705831] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: kms_flip_scaled_crc
results: parsing output: 3/ for test: gem_exec_flush
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_atomic
results: parsing output: 7/ for test: kms_colorop
results: parsing output: 8/ for test: drm_read
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: dmabuf_sync_file
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_atomic_interruptible
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: i915_query
results: parsing output: 16/ for test: kms_vblank
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_eio
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_chamelium_frames
results: parsing output: 24/ for test: kms_colorop
results: parsing output: 25/ for test: sw_sync
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: gem_exec_create
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: gem_tiled_pread_pwrite
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_ctx_engines
results: parsing output: 39/ for test: syncobj_basic
results: parsing output: 40/ for test: gem_exec_async
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: gen3_render_tiledy_blits
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_chamelium_hpd
results: parsing output: 46/ for test: gem_huc_copy
results: parsing output: 47/ for test: prime_vgem
results: parsing output: 48/ for test: kms_joiner
results: parsing output: 49/ for test: gem_mmap_wc
results: parsing output: 50/ for test: gem_basic
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: prime_self_import
results: parsing output: 55/ for test: i915_suspend
results: parsing output: 56/ for test: kms_draw_crc
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_pipe_crc_basic
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: i915_drm_fdinfo
results: parsing output: 67/ for test: kms_display_modes
results: parsing output: 68/ for test: syncobj_eventfd
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gen9_exec_parse
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: kms_vblank
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: gem_pxp
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: prime_mmap
results: parsing output: 89/ for test: kms_pm_dc
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_dsc
results: parsing output: 95/ for test: gem_pwrite_snooped
results: parsing output: 96/ for test: vgem_basic
results: parsing output: 97/ for test: gem_spin_batch
results: parsing output: 98/ for test: kms_color
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_pxp
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: gem_ctx_exec
results: parsing output: 104/ for test: i915_pm_rc6_residency
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: syncobj_basic
results: parsing output: 108/ for test: gem_wait
results: parsing output: 109/ for test: kms_plane_alpha_blend
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: i915_pm_freq_api
results: parsing output: 112/ for test: kms_invalid_mode
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: tools_test
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_mmap_offset
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_async_flips
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_selftest
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: perf
results: parsing output: 130/ for test: kms_content_protection
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: gem_mmap_gtt
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.