[151.035628] Initializing watchdogs
[151.035677]   /dev/watchdog0
[151.051566] [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]
[151.057222] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[151.060960] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[151.062963] [001/155] (960s left) gem_exec_schedule (u-semaphore-noskip)
[151.137663] Starting subtest: u-semaphore-noskip
[151.605516] Subtest u-semaphore-noskip: SUCCESS (0.458s)
[151.936804] [002/155] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y)
[152.035417] Starting subtest: fbcpsrhdr-tiling-y
[152.037128] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s)
[152.132656] [003/155] (959s left) kms_frontbuffer_tracking (fbc-stridechange)
[152.227589] Starting subtest: fbc-stridechange
[155.823834] Subtest fbc-stridechange: SUCCESS (3.597s)
[156.963117] [004/155] (954s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[157.064509] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[157.734600] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[157.912559] [005/155] (953s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-pwrite)
[158.003623] Starting subtest: psrhdr-rgb101010-draw-pwrite
[158.005398] Subtest psrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[158.094190] [006/155] (953s left) gem_ctx_persistence (hostile)
[158.143371] Starting subtest: hostile
[167.654655] Subtest hostile: SUCCESS (9.501s)
[167.753964] [007/155] (943s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[167.843611] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[167.845457] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[167.940435] [008/155] (943s left) gem_mmap_gtt (fault-concurrent-y)
[167.988958] Subtest fault-concurrent-Y: SKIP (0.000s)
[168.034331] [009/155] (943s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[168.124575] Starting subtest: disable-crc-after-crtc
[168.125745] Starting dynamic subtest: pipe-A-eDP-1
[169.798184] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.678s)
[169.806665] Starting dynamic subtest: pipe-B-eDP-1
[172.159358] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.363s)
[172.166231] Starting dynamic subtest: pipe-C-eDP-1
[174.408960] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.250s)
[174.415608] Starting dynamic subtest: pipe-D-eDP-1
[176.675288] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.264s)
[176.676522] Subtest disable-crc-after-crtc: SUCCESS (8.559s)
[177.489433] [010/155] (934s left) gem_softpin (overlap)
[177.543166] Starting subtest: overlap
[178.470479] Subtest overlap: SUCCESS (0.918s)
[178.581353] [011/155] (933s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[178.670430] Starting subtest: plane-lut1d-ctm3x4
[178.819282] Starting dynamic subtest: pipe-A-plane-0
[179.017885] Dynamic subtest pipe-A-plane-0: SUCCESS (0.199s)
[179.024832] Starting dynamic subtest: pipe-A-plane-1
[179.173489] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[179.180919] Starting dynamic subtest: pipe-A-plane-2
[179.340385] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[180.520092] Starting dynamic subtest: pipe-B-plane-0
[180.713382] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[180.722395] Starting dynamic subtest: pipe-B-plane-1
[180.902173] Dynamic subtest pipe-B-plane-1: SUCCESS (0.189s)
[180.911820] Starting dynamic subtest: pipe-B-plane-2
[181.068913] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[182.223065] Starting dynamic subtest: pipe-C-plane-0
[182.383142] Dynamic subtest pipe-C-plane-0: SUCCESS (0.167s)
[182.390218] Starting dynamic subtest: pipe-C-plane-1
[182.538600] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[182.545343] Starting dynamic subtest: pipe-C-plane-2
[182.705285] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[183.879891] Starting dynamic subtest: pipe-D-plane-0
[184.029066] Dynamic subtest pipe-D-plane-0: SUCCESS (0.156s)
[184.036951] Starting dynamic subtest: pipe-D-plane-1
[184.195734] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[184.204138] Starting dynamic subtest: pipe-D-plane-2
[184.362474] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[184.646856] Subtest plane-lut1d-ctm3x4: SUCCESS (5.977s)
[185.540956] [012/155] (926s left) prime_self_import (basic-with_two_bos)
[185.570525] Starting subtest: basic-with_two_bos
[185.596523] Subtest basic-with_two_bos: SUCCESS (0.026s)
[185.689850] [013/155] (926s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[185.780942] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[185.782752] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[185.869929] [014/155] (926s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[185.959872] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[185.961783] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[186.054462] [015/155] (925s left) kms_atomic_interruptible (universal-setplane-cursor)
[186.146763] Starting subtest: universal-setplane-cursor
[186.147783] Starting dynamic subtest: pipe-A-eDP-1
[193.576949] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.425s)
[193.577915] Subtest universal-setplane-cursor: SUCCESS (7.426s)
[194.401259] [016/155] (917s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[194.519877] Starting subtest: short-flip-before-cursor-toggle
[195.433586] Subtest short-flip-before-cursor-toggle: SUCCESS (0.913s)
[196.223165] [017/155] (915s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt)
[196.317522] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt
[196.319366] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[196.411030] [018/155] (915s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[196.497604] Starting subtest: fbcpsr-rgb565-draw-pwrite
[203.656169] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.160s)
[203.769481] [019/155] (908s left) gem_mmap_wc (bad-size)
[203.819224] Subtest bad-size: SKIP (0.000s)
[203.869981] [020/155] (908s left) kms_plane_multiple (tiling-4)
[203.956169] Starting subtest: tiling-4
[203.957112] Starting dynamic subtest: pipe-A-eDP-1
[207.819325] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.862s)
[207.829332] Starting dynamic subtest: pipe-B-eDP-1
[212.454407] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.634s)
[212.462766] Starting dynamic subtest: pipe-C-eDP-1
[216.990798] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.536s)
[216.997708] Starting dynamic subtest: pipe-D-eDP-1
[221.361519] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.369s)
[221.362665] Subtest tiling-4: SUCCESS (17.404s)
[222.154383] [021/155] (890s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[222.244275] Starting subtest: psr-2p-primscrn-spr-indfb-move
[222.246195] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[222.333113] [022/155] (889s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[222.441018] Starting subtest: cursorA-vs-flipB-toggle
[222.442851] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[222.590172] [023/155] (889s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[222.836271] Starting subtest: cursor-rapid-movement-512x512
[222.838235] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[222.998400] [024/155] (889s left) syncobj_wait (wait-all-delayed-signal)
[223.044611] Starting subtest: wait-all-delayed-signal
[223.147822] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[223.241622] [025/155] (889s left) dmabuf (all-tests)
[223.269065] Starting subtest: all-tests
[223.270766] Subtest all-tests: SKIP (0.000s)
[223.313428] [026/155] (889s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[223.406681] Starting subtest: crc-primary-basic-yf-tiled-ccs
[223.407749] Starting dynamic subtest: pipe-A-eDP-1
[223.417149] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[223.424925] Starting dynamic subtest: pipe-B-eDP-1
[223.434802] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[223.441903] Starting dynamic subtest: pipe-C-eDP-1
[223.450618] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[223.457097] Starting dynamic subtest: pipe-D-eDP-1
[223.465962] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[223.467714] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[225.747225] [027/155] (886s left) syncobj_wait (multi-wait-all-submitted-signaled)
[225.800484] Starting subtest: multi-wait-all-submitted-signaled
[225.902832] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[225.973140] [028/155] (886s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[226.348224] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[227.128396] [029/155] (885s left) gem_exec_schedule (deep)
[227.309444] Starting subtest: deep
[227.310567] Starting dynamic subtest: rcs0
[232.552305] Dynamic subtest rcs0: SKIP (5.231s)
[232.568826] Starting dynamic subtest: vcs0
[242.626937] Dynamic subtest vcs0: SUCCESS (10.075s)
[242.638472] Starting dynamic subtest: vcs1
[254.537569] Dynamic subtest vcs1: SUCCESS (11.910s)
[254.547068] Starting dynamic subtest: vecs0
[266.501796] Dynamic subtest vecs0: SUCCESS (11.962s)
[266.509266] Starting dynamic subtest: ccs0
[278.538247] Dynamic subtest ccs0: SUCCESS (12.035s)
[278.539492] Subtest deep: SUCCESS (51.219s)
[280.572990] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[280.575566] [030/155] (831s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[280.665298] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[280.667267] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[280.746172] [031/155] (831s left) gem_mmap_wc (set-cache-level)
[280.804961] Subtest set-cache-level: SKIP (0.000s)
[280.853047] [032/155] (831s left) core_getversion (all-cards)
[280.887339] Starting subtest: all-cards
[280.895507] Subtest all-cards: SUCCESS (0.011s)
[280.933054] [033/155] (831s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[281.023158] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[282.125854] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.103s)
[282.244332] [034/155] (830s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[282.329386] Starting subtest: fb-8bpc-vs-panel-6bpc
[282.330725] Starting dynamic subtest: pipe-A-eDP-1
[283.722614] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.392s)
[283.723618] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.394s)
[284.600699] [035/155] (828s left) gem_softpin (allocator-basic-reserve)
[284.657115] Starting subtest: allocator-basic-reserve
[284.724595] Subtest allocator-basic-reserve: SUCCESS (0.067s)
[284.837139] [036/155] (827s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[284.881587] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[285.001057] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[285.065871] [037/155] (827s left) gem_ctx_engines (independent)
[285.121185] Starting subtest: independent
[285.122194] Starting dynamic subtest: rcs0
[285.258680] Dynamic subtest rcs0: SUCCESS (0.127s)
[285.266100] Starting dynamic subtest: bcs0
[285.363666] Dynamic subtest bcs0: SUCCESS (0.114s)
[285.370878] Starting dynamic subtest: vcs0
[285.497036] Dynamic subtest vcs0: SUCCESS (0.122s)
[285.505288] Starting dynamic subtest: vcs1
[285.613703] Dynamic subtest vcs1: SUCCESS (0.125s)
[285.621286] Starting dynamic subtest: vecs0
[285.748942] Dynamic subtest vecs0: SUCCESS (0.126s)
[285.756200] Starting dynamic subtest: ccs0
[285.880841] Dynamic subtest ccs0: SUCCESS (0.130s)
[285.887996] Starting dynamic subtest: all-engines
[286.389412] Dynamic subtest all-engines: SUCCESS (0.508s)
[286.390380] Subtest independent: SUCCESS (1.260s)
[287.459874] [038/155] (825s left) gem_exec_balancer (parallel-out-fence)
[287.741244] Starting subtest: parallel-out-fence
[289.003609] Subtest parallel-out-fence: SUCCESS (1.262s)
[289.110439] [039/155] (823s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite)
[289.213328] Starting subtest: hdr-rgb101010-draw-pwrite
[289.214829] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s)
[289.303360] [040/155] (823s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[289.392822] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[289.394658] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[289.499667] [041/155] (823s left) gem_exec_balancer (bonded-semaphore)
[289.565212] Starting subtest: bonded-semaphore
[289.567299] Subtest bonded-semaphore: SKIP (0.000s)
[289.896089] [042/155] (822s left) kms_dsc (dsc-with-bpc)
[289.992410] Starting subtest: dsc-with-bpc
[290.004949] Subtest dsc-with-bpc: SKIP (0.001s)
[290.071919] [043/155] (822s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[290.168381] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[290.169967] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[290.263746] [044/155] (822s left) kms_properties (get_properties-sanity-non-atomic)
[290.356824] Starting subtest: get_properties-sanity-non-atomic
[290.357702] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[290.424743] [045/155] (822s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[290.510835] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[290.512490] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[290.607298] [046/155] (822s left) gem_wait (write-wait)
[290.658062] Starting subtest: write-wait
[290.659264] Starting dynamic subtest: all-engines
[291.761732] Dynamic subtest all-engines: SUCCESS (1.103s)
[291.778038] Starting dynamic subtest: rcs0
[292.822333] Dynamic subtest rcs0: SUCCESS (1.059s)
[292.838425] Starting dynamic subtest: bcs0
[293.879629] Dynamic subtest bcs0: SUCCESS (1.055s)
[293.897040] Starting dynamic subtest: vcs0
[294.937799] Dynamic subtest vcs0: SUCCESS (1.054s)
[294.956112] Starting dynamic subtest: vcs1
[295.991659] Dynamic subtest vcs1: SUCCESS (1.052s)
[296.007644] Starting dynamic subtest: vecs0
[297.045418] Dynamic subtest vecs0: SUCCESS (1.052s)
[297.062469] Starting dynamic subtest: ccs0
[298.102756] Dynamic subtest ccs0: SUCCESS (1.056s)
[298.106594] Subtest write-wait: SUCCESS (7.445s)
[298.295953] [047/155] (814s left) vgem_basic (mmap)
[298.334137] Starting subtest: mmap
[298.344234] Subtest mmap: SUCCESS (0.011s)
[298.396409] [048/155] (814s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[298.485415] Starting subtest: addfb25-y-tiled-small-legacy
[298.487416] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[298.580814] [049/155] (814s left) gem_ctx_shared (q-out-order)
[298.640692] Starting subtest: Q-out-order
[298.641729] Starting dynamic subtest: rcs0
[298.751076] Dynamic subtest rcs0: SUCCESS (0.109s)
[298.764786] Starting dynamic subtest: vcs0
[298.828509] Dynamic subtest vcs0: SUCCESS (0.077s)
[298.845277] Starting dynamic subtest: vcs1
[298.906785] Dynamic subtest vcs1: SUCCESS (0.078s)
[298.924568] Starting dynamic subtest: vecs0
[298.990969] Dynamic subtest vecs0: SUCCESS (0.084s)
[299.009242] Starting dynamic subtest: ccs0
[299.079662] Dynamic subtest ccs0: SUCCESS (0.087s)
[299.081457] Subtest Q-out-order: SUCCESS (0.439s)
[300.403675] [050/155] (812s left) gem_eio (in-flight-10ms)
[300.618760] Starting subtest: in-flight-10ms
[309.051574] Subtest in-flight-10ms: SUCCESS (8.432s)
[309.227833] [051/155] (803s left) kms_async_flips (invalid-async-flip-atomic)
[309.310941] Starting subtest: invalid-async-flip-atomic
[309.684147] Starting dynamic subtest: pipe-A-eDP-1
[310.532626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.848s)
[310.893661] Starting dynamic subtest: pipe-B-eDP-1
[311.758819] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.873s)
[312.114607] Starting dynamic subtest: pipe-C-eDP-1
[312.904350] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.797s)
[313.256530] Starting dynamic subtest: pipe-D-eDP-1
[314.037224] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.787s)
[314.038491] Subtest invalid-async-flip-atomic: SUCCESS (4.727s)
[315.191298] [052/155] (798s left) kms_vblank (ts-continuation-modeset)
[315.284793] Starting subtest: ts-continuation-modeset
[315.285884] Starting dynamic subtest: pipe-A-eDP-1
[316.761020] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.475s)
[316.770448] Starting dynamic subtest: pipe-D-eDP-1
[318.928588] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.165s)
[318.929478] Subtest ts-continuation-modeset: SUCCESS (3.645s)
[319.737059] [053/155] (793s left) kms_vblank (invalid)
[319.832587] Starting subtest: invalid
[319.833526] Starting dynamic subtest: pipe-A-eDP-1
[320.241661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[320.242553] Subtest invalid: SUCCESS (0.410s)
[321.059601] [054/155] (792s left) gem_exec_reloc (basic-gtt-cpu-active)
[321.112101] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[321.179346] [055/155] (792s left) prime_busy (before-wait)
[321.235195] Starting subtest: before-wait
[321.238399] Starting dynamic subtest: rcs0
[321.273199] Dynamic subtest rcs0: SUCCESS (0.034s)
[321.286780] Starting dynamic subtest: bcs0
[321.322699] Dynamic subtest bcs0: SUCCESS (0.048s)
[321.331425] Starting dynamic subtest: vcs0
[321.364612] Dynamic subtest vcs0: SUCCESS (0.041s)
[321.372362] Starting dynamic subtest: vcs1
[321.405259] Dynamic subtest vcs1: SUCCESS (0.040s)
[321.412848] Starting dynamic subtest: vecs0
[321.447453] Dynamic subtest vecs0: SUCCESS (0.042s)
[321.454784] Starting dynamic subtest: ccs0
[321.486542] Dynamic subtest ccs0: SUCCESS (0.038s)
[321.603915] Subtest before-wait: SUCCESS (0.358s)
[321.679469] [056/155] (791s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[321.769471] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[328.593166] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.825s)
[328.745495] [057/155] (784s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[328.836368] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[328.837987] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[328.924980] [058/155] (784s left) gem_exec_schedule (pi-distinct-iova)
[329.098200] Starting subtest: pi-distinct-iova
[329.099102] Starting dynamic subtest: rcs0
[329.171899] Dynamic subtest rcs0: SUCCESS (0.080s)
[329.183240] Starting dynamic subtest: vcs0
[329.233589] Dynamic subtest vcs0: SUCCESS (0.060s)
[329.245665] Starting dynamic subtest: vcs1
[329.297884] Dynamic subtest vcs1: SUCCESS (0.064s)
[329.306160] Starting dynamic subtest: vecs0
[329.357401] Dynamic subtest vecs0: SUCCESS (0.059s)
[329.366908] Starting dynamic subtest: ccs0
[329.443593] Dynamic subtest ccs0: SUCCESS (0.084s)
[329.445240] Subtest pi-distinct-iova: SUCCESS (0.353s)
[330.418651] [059/155] (783s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[330.508264] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[337.113967] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.607s)
[337.244432] [060/155] (776s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[337.334798] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[344.892448] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.559s)
[345.035618] [061/155] (768s left) kms_psr (psr2-dpms)
[345.131229] Starting subtest: psr2-dpms
[345.132048] Starting dynamic subtest: eDP-1
[348.094452] Dynamic subtest eDP-1: SUCCESS (2.963s)
[348.095379] Subtest psr2-dpms: SUCCESS (2.963s)
[348.961490] [062/155] (764s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[349.058068] Starting subtest: hdr-2p-pri-indfb-multidraw
[349.059834] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[349.161466] [063/155] (764s left) kms_chamelium_edid (dp-mode-timings)
[349.557307] Subtest dp-mode-timings: SKIP (0.000s)
[350.396460] [064/155] (763s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[350.485463] Starting subtest: plane-all-modeset-transition-internal-panels
[350.486389] Starting dynamic subtest: pipe-A-eDP-1
[351.872025] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.376s)
[352.142540] Starting dynamic subtest: pipe-B-eDP-1
[353.198489] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.055s)
[353.455494] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.968s)
[354.286271] [065/155] (759s left) gem_mmap_offset (isolation)
[354.336284] Starting subtest: isolation
[354.344585] Subtest isolation: SUCCESS (0.006s)
[354.441239] [066/155] (759s left) kms_rotation_crc (bad-tiling)
[354.527951] Starting subtest: bad-tiling
[354.529793] Subtest bad-tiling: SKIP (0.001s)
[354.626154] [067/155] (759s left) i915_pm_rpm (reg-read-ioctl)
[356.460663] Starting subtest: reg-read-ioctl
[358.769839] Subtest reg-read-ioctl: SUCCESS (2.311s)
[359.160748] [068/155] (754s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[359.252326] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[359.253213] Starting dynamic subtest: pipe-A-eDP-1
[359.276167] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[359.286356] Starting dynamic subtest: pipe-B-eDP-1
[359.310668] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[359.318196] Starting dynamic subtest: pipe-C-eDP-1
[359.338369] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[359.345954] Starting dynamic subtest: pipe-D-eDP-1
[359.366366] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[359.367895] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[361.514688] [069/155] (752s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[361.607923] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[361.609728] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[361.735695] [070/155] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[361.821218] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[361.822821] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[361.912558] [071/155] (751s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render)
[362.013189] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render
[362.015709] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[362.110305] [072/155] (751s left) kms_plane_alpha_blend (constant-alpha-min)
[362.205584] Starting subtest: constant-alpha-min
[362.499127] Starting dynamic subtest: pipe-A-eDP-1
[363.259219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.759s)
[363.268395] Starting dynamic subtest: pipe-D-eDP-1
[364.698184] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.437s)
[364.699408] Subtest constant-alpha-min: SUCCESS (2.493s)
[365.588319] [073/155] (748s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[365.681564] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[369.857356] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.176s)
[370.979633] [074/155] (743s left) kms_cursor_crc (cursor-onscreen-128x42)
[371.196457] Starting subtest: cursor-onscreen-128x42
[371.242019] Subtest cursor-onscreen-128x42: SKIP (0.044s)
[371.449992] [075/155] (742s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[371.532226] Starting subtest: psr2-overlay-plane-update-continuous-sf
[371.533098] Starting dynamic subtest: pipe-A-eDP-1
[372.673212] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.140s)
[372.681502] Starting dynamic subtest: pipe-B-eDP-1
[374.441283] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.767s)
[374.442387] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.910s)
[375.239814] [076/155] (738s left) vgem_basic (bad-handle)
[375.274806] Starting subtest: bad-handle
[375.275667] Subtest bad-handle: SUCCESS (0.000s)
[375.341368] [077/155] (738s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[375.433287] Starting subtest: fbc-psr-sprite-mmap-gtt
[375.434082] Starting dynamic subtest: eDP-1
[375.435862] Dynamic subtest eDP-1: SKIP (0.000s)
[375.437607] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[375.502614] [078/155] (738s left) i915_query (query-topology-coherent-slice-mask)
[375.549443] Starting subtest: query-topology-coherent-slice-mask
[375.551470] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[375.643500] [079/155] (738s left) gem_close (many-handles-one-vma)
[375.690135] Starting subtest: many-handles-one-vma
[375.717887] Subtest many-handles-one-vma: SUCCESS (0.028s)
[375.828568] [080/155] (738s left) kms_getfb (getfb-handle-protection)
[375.922757] Starting subtest: getfb-handle-protection
[375.944066] Subtest getfb-handle-protection: SUCCESS (0.022s)
[376.061108] [081/155] (738s left) gem_lmem_swapping (parallel-multi)
[376.098497] Subtest parallel-multi: SKIP (0.000s)
[376.136241] [082/155] (738s left) kms_frontbuffer_tracking (fbchdr-2p-indfb-fliptrack-mmap-gtt)
[376.217974] Starting subtest: fbchdr-2p-indfb-fliptrack-mmap-gtt
[376.219692] Subtest fbchdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[376.294987] [083/155] (738s left) gem_exec_whisper (basic-forked-all)
[376.355036] Starting subtest: basic-forked-all
[389.581107] Subtest basic-forked-all: SUCCESS (13.224s)
[389.780674] [084/155] (724s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[389.885281] Starting subtest: fbc-psr2-sprite-mmap-cpu
[389.886066] Starting dynamic subtest: eDP-1
[389.887713] Dynamic subtest eDP-1: SKIP (0.000s)
[389.889236] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[389.957561] [085/155] (724s left) perf_pmu (idle)
[389.993326] Starting subtest: idle
[389.994289] Starting dynamic subtest: rcs0
[390.544053] Dynamic subtest rcs0: SUCCESS (0.540s)
[390.556301] Starting dynamic subtest: bcs0
[391.065616] Dynamic subtest bcs0: SUCCESS (0.517s)
[391.075626] Starting dynamic subtest: vcs0
[391.581601] Dynamic subtest vcs0: SUCCESS (0.513s)
[391.590781] Starting dynamic subtest: vcs1
[392.100770] Dynamic subtest vcs1: SUCCESS (0.518s)
[392.111470] Starting dynamic subtest: vecs0
[392.625708] Dynamic subtest vecs0: SUCCESS (0.522s)
[392.636801] Starting dynamic subtest: ccs0
[393.140221] Dynamic subtest ccs0: SUCCESS (0.512s)
[393.141270] Subtest idle: SUCCESS (3.138s)
[393.215886] [086/155] (721s left) gem_mmap_gtt (basic-short)
[393.264795] Subtest basic-short: SKIP (0.000s)
[393.317464] [087/155] (721s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[393.403265] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[393.404955] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[393.496533] [088/155] (720s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[393.548227] Starting subtest: y-tiled-to-vebox-y-tiled
[393.550042] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[393.732088] [089/155] (720s left) gem_render_copy_redux (flink)
[393.784036] Starting subtest: flink
[394.606955] Subtest flink: SUCCESS (0.823s)
[394.715921] [090/155] (719s left) gem_ctx_persistence (engines-mixed)
[394.786832] Starting subtest: engines-mixed
[394.787803] Starting dynamic subtest: rcs0
[394.880702] Dynamic subtest rcs0: SUCCESS (0.095s)
[394.893368] Starting dynamic subtest: bcs0
[394.938751] Dynamic subtest bcs0: SUCCESS (0.056s)
[394.950476] Starting dynamic subtest: vcs0
[394.984285] Dynamic subtest vcs0: SUCCESS (0.044s)
[394.994081] Starting dynamic subtest: vcs1
[395.037800] Dynamic subtest vcs1: SUCCESS (0.052s)
[395.049623] Starting dynamic subtest: vecs0
[395.097511] Dynamic subtest vecs0: SUCCESS (0.057s)
[395.109942] Starting dynamic subtest: ccs0
[395.146715] Dynamic subtest ccs0: SUCCESS (0.047s)
[395.148279] Subtest engines-mixed: SUCCESS (0.362s)
[395.234119] [091/155] (719s left) kms_vrr (seamless-rr-switch-drrs)
[395.326446] Starting subtest: seamless-rr-switch-drrs
[395.328991] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[395.411222] [092/155] (719s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[395.498725] Starting subtest: fbc-rgb101010-draw-blt
[398.055974] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.558s)
[399.254471] [093/155] (715s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-pwrite)
[399.343244] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-pwrite
[399.344820] Subtest hdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[399.432489] [094/155] (715s left) kms_invalid_mode (int-max-clock)
[399.515234] Starting subtest: int-max-clock
[399.516171] Starting dynamic subtest: pipe-A-eDP-1
[399.801306] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[399.810382] Starting dynamic subtest: pipe-B-eDP-1
[399.811270] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[399.819205] Starting dynamic subtest: pipe-C-eDP-1
[399.820244] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[399.828042] Starting dynamic subtest: pipe-D-eDP-1
[399.829250] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[399.830737] Subtest int-max-clock: SUCCESS (0.292s)
[400.668955] [095/155] (714s left) kms_flip (absolute-wf_vblank)
[400.759369] Starting subtest: absolute-wf_vblank
[400.761592] Starting dynamic subtest: A-eDP1
[409.559226] Dynamic subtest A-eDP1: SUCCESS (8.770s)
[409.570729] Starting dynamic subtest: B-eDP1
[418.286449] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[418.295545] Starting dynamic subtest: C-eDP1
[427.025208] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[427.033542] Starting dynamic subtest: D-eDP1
[435.755297] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[435.756586] Subtest absolute-wf_vblank: SUCCESS (34.961s)
[436.933957] [096/155] (677s left) kms_psr (psr-cursor-plane-move)
[437.025772] Starting subtest: psr-cursor-plane-move
[437.026863] Starting dynamic subtest: eDP-1
[438.729564] Dynamic subtest eDP-1: SUCCESS (1.703s)
[438.730471] Subtest psr-cursor-plane-move: SUCCESS (1.704s)
[439.598424] [097/155] (675s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-msflip-blt)
[439.697853] Starting subtest: fbchdr-2p-primscrn-indfb-msflip-blt
[439.699831] Subtest fbchdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[439.786601] [098/155] (675s left) kms_plane_scaling (invalid-num-scalers)
[439.880382] Starting subtest: invalid-num-scalers
[439.881192] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[439.900595] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.020s)
[439.910449] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[439.936585] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.035s)
[439.946800] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[439.972419] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[439.980812] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[440.006961] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[440.008042] Subtest invalid-num-scalers: SUCCESS (0.128s)
[440.107152] [099/155] (674s left) kms_flip (plain-flip-fb-recreate)
[440.193421] Starting subtest: plain-flip-fb-recreate
[440.194576] Starting dynamic subtest: A-eDP1
[449.091398] Dynamic subtest A-eDP1: SUCCESS (8.896s)
[449.103268] Starting dynamic subtest: B-eDP1
[457.940657] Dynamic subtest B-eDP1: SUCCESS (8.847s)
[457.951445] Starting dynamic subtest: C-eDP1
[466.765928] Dynamic subtest C-eDP1: SUCCESS (8.823s)
[466.776294] Starting dynamic subtest: D-eDP1
[475.601122] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[475.603760] Subtest plain-flip-fb-recreate: SUCCESS (35.409s)
[476.772607] [100/155] (638s left) api_intel_bb (blit-reloc-keep-cache)
[476.828919] Starting subtest: blit-reloc-keep-cache
[476.831065] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[476.937012] [101/155] (637s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[477.026408] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[477.028098] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[477.132158] [102/155] (637s left) kms_content_protection (mei-interface)
[477.268864] Starting subtest: mei-interface
[477.270896] Subtest mei-interface: SKIP (0.001s)
[477.411347] [103/155] (637s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[477.499634] Starting subtest: plane-upscale-20x20-with-modifiers
[477.500512] Starting dynamic subtest: pipe-A
[477.836945] Dynamic subtest pipe-A: SUCCESS (0.338s)
[477.845454] Starting dynamic subtest: pipe-B
[479.266329] Dynamic subtest pipe-B: SUCCESS (1.428s)
[479.282984] Starting dynamic subtest: pipe-C
[480.704446] Dynamic subtest pipe-C: SUCCESS (1.435s)
[480.719304] Starting dynamic subtest: pipe-D
[482.132092] Dynamic subtest pipe-D: SUCCESS (1.427s)
[482.132964] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.633s)
[483.292378] [104/155] (631s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[483.382361] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[483.383395] Starting dynamic subtest: pipe-A-eDP-1
[483.390833] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[483.399335] Starting dynamic subtest: pipe-B-eDP-1
[483.407064] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[483.417595] Starting dynamic subtest: pipe-C-eDP-1
[483.431343] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[483.439562] Starting dynamic subtest: pipe-D-eDP-1
[483.446638] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[483.447428] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[485.655808] [105/155] (629s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[485.703523] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[485.704615] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[485.820381] [106/155] (629s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[485.878503] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[485.958870] [107/155] (629s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[486.048603] Starting subtest: sprite-rotation-90-pos-100-0
[486.050186] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[486.133328] [108/155] (629s left) i915_drm_fdinfo (virtual-busy-idle-all)
[486.169718] Starting subtest: virtual-busy-idle-all
[486.171720] Subtest virtual-busy-idle-all: SKIP (0.000s)
[486.233231] [109/155] (629s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[486.317058] Starting subtest: fbchdr-rgb101010-draw-render
[486.318685] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[486.419949] [110/155] (628s left) kms_psr (fbc-pr-primary-mmap-cpu)
[486.509612] Starting subtest: fbc-pr-primary-mmap-cpu
[486.511524] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[486.578149] [111/155] (628s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[486.663572] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[486.665444] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[486.732174] [112/155] (628s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[486.818496] Starting subtest: psr-farfromfence-mmap-gtt
[486.820390] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[486.911340] [113/155] (628s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[487.005565] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[487.007181] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[487.092093] [114/155] (628s left) gem_ctx_param (invalid-param-set)
[487.141537] Starting subtest: invalid-param-set
[487.142595] Subtest invalid-param-set: SUCCESS (0.000s)
[487.206950] [115/155] (628s left) kms_big_fb (y-tiled-addfb)
[487.303794] Starting subtest: y-tiled-addfb
[487.305645] Subtest y-tiled-addfb: SKIP (0.000s)
[487.392543] [116/155] (628s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[487.446311] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[487.543233] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[487.628349] [117/155] (627s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite)
[487.714391] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite
[487.716167] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[487.827484] [118/155] (627s left) syncobj_wait (single-wait-all-signaled)
[487.875887] Starting subtest: single-wait-all-signaled
[487.876984] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[487.978792] [119/155] (627s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[488.069694] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[488.071486] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[488.159906] [120/155] (627s left) i915_drm_fdinfo (basics)
[488.197398] Starting subtest: basics
[488.198476] Subtest basics: SUCCESS (0.000s)
[488.257085] [121/155] (627s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[488.367618] Starting subtest: cursorA-vs-flipB-atomic-transitions
[488.369357] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[488.517538] [122/155] (627s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[488.573357] Starting subtest: yf-tiled-ccs-to-yf-tiled
[488.575110] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[488.765694] [123/155] (626s left) kms_big_fb (linear-64bpp-rotate-270)
[488.864288] Starting subtest: linear-64bpp-rotate-270
[488.884698] Subtest linear-64bpp-rotate-270: SKIP (0.020s)
[488.984466] [124/155] (626s left) sw_sync (sync_multi_consumer_producer)
[489.013590] Starting subtest: sync_multi_consumer_producer
[489.316106] Subtest sync_multi_consumer_producer: SUCCESS (0.297s)
[489.367505] [125/155] (626s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[489.461976] Starting subtest: yf-tiled-8bpp-rotate-90
[489.464261] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[489.565295] [126/155] (626s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[489.668894] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[489.670681] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[489.767379] [127/155] (626s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[489.888280] Starting subtest: cursorB-vs-flipB-legacy
[489.890056] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[490.027768] [128/155] (625s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt)
[490.126333] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt
[490.128071] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[490.216087] [129/155] (625s left) gem_flink_race (flink_close)
[490.243509] Starting subtest: flink_close
[495.336625] Subtest flink_close: SUCCESS (5.092s)
[495.411087] [130/155] (620s left) kms_chamelium_audio (dp-audio-edid)
[495.805329] Subtest dp-audio-edid: SKIP (0.000s)
[496.596429] [131/155] (619s left) kms_cursor_edge_walk (256x256-left-edge)
[496.690856] Starting subtest: 256x256-left-edge
[496.691773] Starting dynamic subtest: pipe-A-eDP-1
[500.183493] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s)
[500.191806] Starting dynamic subtest: pipe-D-eDP-1
[503.306520] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[503.307469] Subtest 256x256-left-edge: SUCCESS (6.616s)
[504.122950] [132/155] (611s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[504.218181] Starting subtest: primary-x-tiled-reflect-x-180
[511.279751] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.062s)
[512.500304] [133/155] (603s left) gem_exec_fence (syncobj-invalid-wait)
[512.933449] Starting subtest: syncobj-invalid-wait
[512.934521] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[514.396992] [134/155] (601s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[514.492404] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[514.494069] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[515.622404] [135/155] (600s left) syncobj_timeline (wait-all-snapshot)
[515.668918] Starting subtest: wait-all-snapshot
[515.753266] Subtest wait-all-snapshot: SUCCESS (0.084s)
[515.824755] [136/155] (600s left) fbdev (info)
[515.854184] Starting subtest: info
[515.855257] Subtest info: SUCCESS (0.000s)
[515.917648] [137/155] (600s left) perf (invalid-oa-exponent)
[516.038211] Starting subtest: invalid-oa-exponent
[516.052706] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[516.088510] [138/155] (600s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[516.177378] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[516.178273] Starting dynamic subtest: pipe-A-default-mode
[517.385878] Dynamic subtest pipe-A-default-mode: SKIP (1.206s)
[517.387655] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.208s)
[517.541418] [139/155] (598s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[517.627826] Starting subtest: flip-primary-invalidate-overlay
[529.283099] Subtest flip-primary-invalidate-overlay: SUCCESS (11.655s)
[529.408618] [140/155] (586s left) kms_pm_dc (dc5-psr)
[530.506876] Starting subtest: dc5-psr
[533.390244] Subtest dc5-psr: SUCCESS (2.884s)
[534.193483] [141/155] (582s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[534.253660] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[534.254677] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[534.334349] [142/155] (582s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-plflip-blt)
[534.419918] Starting subtest: psrhdr-1p-primscrn-shrfb-plflip-blt
[534.421546] Subtest psrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[534.529274] [143/155] (581s left) kms_prime (basic-crc-vgem)
[534.613967] Starting subtest: basic-crc-vgem
[534.614906] Starting dynamic subtest: second-to-first
[535.642577] Dynamic subtest second-to-first: SUCCESS (1.029s)
[535.643441] Subtest basic-crc-vgem: SUCCESS (1.030s)
[535.733226] [144/155] (580s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[535.859687] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[535.861437] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[535.950529] [145/155] (580s left) sw_sync (sync_multi_timeline_wait)
[535.982711] Starting subtest: sync_multi_timeline_wait
[535.983591] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[536.038392] [146/155] (580s left) gen9_exec_parse (bb-chained)
[536.102223] Subtest bb-chained: SKIP (0.000s)
[536.159737] [147/155] (580s left) kms_properties (colorop-properties-legacy)
[536.248233] Starting subtest: colorop-properties-legacy
[536.249086] Starting dynamic subtest: pipe-A-eDP-1
[536.620033] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.371s)
[536.629285] Starting dynamic subtest: pipe-B-eDP-1
[537.677218] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.055s)
[537.686082] Starting dynamic subtest: pipe-C-eDP-1
[538.726207] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.047s)
[538.734913] Starting dynamic subtest: pipe-D-eDP-1
[539.779265] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.053s)
[539.780117] Subtest colorop-properties-legacy: SUCCESS (3.532s)
[540.658607] [148/155] (575s left) kms_flip (2x-flip-vs-wf_vblank)
[540.740214] Starting subtest: 2x-flip-vs-wf_vblank
[540.753376] Subtest 2x-flip-vs-wf_vblank: SKIP (0.013s)
[540.853369] [149/155] (575s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[540.943076] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[540.943925] Starting dynamic subtest: pipe-A-eDP-1
[540.952458] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[540.961211] Starting dynamic subtest: pipe-B-eDP-1
[540.970074] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[540.979617] Starting dynamic subtest: pipe-C-eDP-1
[540.987314] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[540.995861] Starting dynamic subtest: pipe-D-eDP-1
[541.004626] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[541.006260] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[543.215183] [150/155] (573s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[543.308541] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[543.310077] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[543.410852] [151/155] (573s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[543.494474] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[547.093665] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.600s)
[548.235387] [152/155] (568s left) i915_query (query-topology-garbage-items)
[548.279883] Starting subtest: query-topology-garbage-items
[548.280790] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[548.390924] [153/155] (568s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[548.474489] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc
[548.476145] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[548.598680] [154/155] (568s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[548.695383] Starting subtest: x-tiled-16bpp-rotate-180
[550.041916] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.347s)
[550.176316] [155/155] (566s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[550.261735] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[550.263518] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[550.357833] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_pipe_crc_basic
results: parsing output: 9/ for test: gem_softpin
results: parsing output: 10/ for test: kms_color_pipeline
results: parsing output: 11/ for test: prime_self_import
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_atomic_interruptible
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_mmap_wc
results: parsing output: 19/ for test: kms_plane_multiple
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: dmabuf
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_chamelium_hpd
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: kms_plane
results: parsing output: 30/ for test: gem_mmap_wc
results: parsing output: 31/ for test: core_getversion
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_dither
results: parsing output: 34/ for test: gem_softpin
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_ctx_engines
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: kms_dsc
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_properties
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_wait
results: parsing output: 46/ for test: vgem_basic
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: gem_ctx_shared
results: parsing output: 49/ for test: gem_eio
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: kms_vblank
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: prime_busy
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_chamelium_edid
results: parsing output: 63/ for test: kms_atomic_transition
results: parsing output: 64/ for test: gem_mmap_offset
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: i915_pm_rpm
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_plane_alpha_blend
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: vgem_basic
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: i915_query
results: parsing output: 78/ for test: gem_close
results: parsing output: 79/ for test: kms_getfb
results: parsing output: 80/ for test: gem_lmem_swapping
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: gem_render_copy_redux
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_vrr
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_invalid_mode
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_content_protection
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_rotation_crc
results: parsing output: 107/ for test: i915_drm_fdinfo
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: i915_drm_fdinfo
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: sw_sync
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_flink_race
results: parsing output: 129/ for test: kms_chamelium_audio
results: parsing output: 130/ for test: kms_cursor_edge_walk
results: parsing output: 131/ for test: kms_rotation_crc
results: parsing output: 132/ for test: gem_exec_fence
results: parsing output: 133/ for test: kms_ccs
results: parsing output: 134/ for test: syncobj_timeline
results: parsing output: 135/ for test: fbdev
results: parsing output: 136/ for test: perf
results: parsing output: 137/ for test: kms_flip_scaled_crc
results: parsing output: 138/ for test: kms_psr_stress_test
results: parsing output: 139/ for test: kms_pm_dc
results: parsing output: 140/ for test: syncobj_timeline
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_prime
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: sw_sync
results: parsing output: 145/ for test: gen9_exec_parse
results: parsing output: 146/ for test: kms_properties
results: parsing output: 147/ for test: kms_flip
results: parsing output: 148/ for test: kms_ccs
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: i915_query
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.