[62.035669] Initializing watchdogs
[62.035726]   /dev/watchdog0
[62.050443] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[62.054342] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.056324] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.059514] [001/133] (960s left) gen9_exec_parse (batch-zero-length)
[62.131997] Subtest batch-zero-length: SKIP (0.000s)
[62.206953] [002/133] (960s left) gem_tiled_partial_pwrite_pread (reads)
[62.269513] Subtest reads: SKIP (0.000s)
[62.333722] [003/133] (960s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[63.956249] Starting subtest: dpms-mode-unset-non-lpsp
[65.100920] Subtest dpms-mode-unset-non-lpsp: SKIP (1.141s)
[65.464632] [004/133] (957s left) gem_ppgtt (shrink-vs-evict-pinned)
[65.525843] Starting subtest: shrink-vs-evict-pinned
[70.838339] Subtest shrink-vs-evict-pinned: SUCCESS (5.304s)
[70.920949] [005/133] (951s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[71.020679] Starting subtest: psr-indfb-scaledprimary
[76.754802] Subtest psr-indfb-scaledprimary: SUCCESS (5.733s)
[76.932829] [006/133] (945s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[77.027077] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[77.029387] Starting dynamic subtest: pipe-A-default-mode
[79.777667] Dynamic subtest pipe-A-default-mode: SUCCESS (2.745s)
[79.780055] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.747s)
[80.617803] [007/133] (942s left) gem_mmap_gtt (flink-race)
[80.686462] Subtest flink-race: SKIP (0.000s)
[80.744059] [008/133] (942s left) gem_exec_store (pages)
[80.793724] Starting subtest: pages
[80.796412] Starting dynamic subtest: rcs0
[80.921835] Dynamic subtest rcs0: SUCCESS (0.128s)
[80.930500] Starting dynamic subtest: bcs0
[81.001840] Dynamic subtest bcs0: SUCCESS (0.080s)
[81.009975] Starting dynamic subtest: vcs0
[81.073940] Dynamic subtest vcs0: SUCCESS (0.071s)
[81.084540] Starting dynamic subtest: vcs1
[81.151307] Dynamic subtest vcs1: SUCCESS (0.078s)
[81.159493] Starting dynamic subtest: vecs0
[81.223678] Dynamic subtest vecs0: SUCCESS (0.072s)
[81.231340] Starting dynamic subtest: ccs0
[81.299722] Dynamic subtest ccs0: SUCCESS (0.075s)
[81.302335] Subtest pages: SUCCESS (0.506s)
[81.489407] [009/133] (941s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[81.571199] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[81.573598] Starting dynamic subtest: pipe-A-eDP-1
[81.668379] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[81.675774] Starting dynamic subtest: pipe-B-eDP-1
[82.793557] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[82.799222] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.224s)
[84.009831] [010/133] (938s left) kms_joiner (invalid-modeset-big-joiner)
[84.091846] Starting subtest: invalid-modeset-big-joiner
[84.096314] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[84.164656] [011/133] (938s left) gem_flink_race (flink_close)
[84.207905] Starting subtest: flink_close
[89.297315] Subtest flink_close: SUCCESS (5.089s)
[89.381870] [012/133] (933s left) kms_chamelium_hpd (dp-hpd-storm)
[89.767853] Subtest dp-hpd-storm: SKIP (0.000s)
[90.606366] [013/133] (932s left) kms_plane_alpha_blend (coverage-7efc)
[90.697315] Starting subtest: coverage-7efc
[90.981683] Starting dynamic subtest: pipe-A-eDP-1
[91.570103] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[91.601482] Starting dynamic subtest: pipe-D-eDP-1
[92.843426] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.249s)
[92.845612] Subtest coverage-7efc: SUCCESS (2.145s)
[93.707425] [014/133] (929s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[93.779699] Starting subtest: plane-all-modeset-transition-internal-panels
[93.782100] Starting dynamic subtest: pipe-A-eDP-1
[95.143950] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.362s)
[95.423600] Starting dynamic subtest: pipe-B-eDP-1
[96.477295] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.061s)
[96.749997] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.970s)
[97.588347] [015/133] (925s left) kms_draw_crc (fill-fb)
[97.659618] Starting subtest: fill-fb
[98.068085] Subtest fill-fb: SUCCESS (0.409s)
[98.183485] [016/133] (924s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[98.270767] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[98.274904] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[98.351931] [017/133] (924s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[98.420899] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[98.423237] Starting dynamic subtest: pipe-A
[98.771197] Dynamic subtest pipe-A: SUCCESS (0.351s)
[98.783153] Starting dynamic subtest: pipe-B
[100.195353] Dynamic subtest pipe-B: SUCCESS (1.423s)
[100.203713] Starting dynamic subtest: pipe-C
[101.613256] Dynamic subtest pipe-C: SUCCESS (1.417s)
[101.621972] Starting dynamic subtest: pipe-D
[103.029116] Dynamic subtest pipe-D: SUCCESS (1.415s)
[103.031422] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.608s)
[104.201687] [018/133] (919s left) syncobj_timeline (wait-any-snapshot)
[104.265958] Starting subtest: wait-any-snapshot
[104.346019] Subtest wait-any-snapshot: SUCCESS (0.081s)
[104.429874] [019/133] (918s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[104.506797] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[104.510803] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[104.601883] [020/133] (918s left) i915_hangman (engine-engine-hang)
[104.667325] Starting subtest: engine-engine-hang
[104.669504] Starting dynamic subtest: rcs0
[105.847255] Dynamic subtest rcs0: SUCCESS (1.178s)
[105.858389] Starting dynamic subtest: bcs0
[107.831000] Dynamic subtest bcs0: SUCCESS (1.981s)
[107.840800] Starting dynamic subtest: vcs0
[109.814783] Dynamic subtest vcs0: SUCCESS (1.982s)
[109.824142] Starting dynamic subtest: vcs1
[111.798543] Dynamic subtest vcs1: SUCCESS (1.982s)
[111.808953] Starting dynamic subtest: vecs0
[113.847920] Dynamic subtest vecs0: SUCCESS (2.047s)
[113.858067] Starting dynamic subtest: ccs0
[115.830413] Dynamic subtest ccs0: SUCCESS (1.981s)
[115.833215] Subtest engine-engine-hang: SUCCESS (11.159s)
[115.918580] [021/133] (907s left) kms_pm_rpm (modeset-lpsp)
[118.054031] Starting subtest: modeset-lpsp
[119.528364] Subtest modeset-lpsp: SUCCESS (1.478s)
[119.624405] [022/133] (903s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[119.709944] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[119.712286] Starting dynamic subtest: pipe-A-eDP-1
[119.721405] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[119.730851] Starting dynamic subtest: pipe-B-eDP-1
[119.740060] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[119.747229] Starting dynamic subtest: pipe-C-eDP-1
[119.755945] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[119.763075] Starting dynamic subtest: pipe-D-eDP-1
[119.771590] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[119.775884] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.003s)
[121.854149] [023/133] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[121.937446] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[121.941400] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[122.055255] [024/133] (901s left) sw_sync (sync_multi_timeline_wait)
[122.094880] Starting subtest: sync_multi_timeline_wait
[122.097297] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[122.166517] [025/133] (901s left) gem_mmap_gtt (basic-write-read-distinct)
[122.226739] Subtest basic-write-read-distinct: SKIP (0.000s)
[122.294730] [026/133] (901s left) kms_big_fb (4-tiled-addfb-size-overflow)
[122.384168] Starting subtest: 4-tiled-addfb-size-overflow
[122.386296] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[122.520701] [027/133] (901s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[122.894610] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[123.668079] [028/133] (899s left) gem_ccs (suspend-resume)
[123.731980] Starting subtest: suspend-resume
[123.736578] Subtest suspend-resume: SKIP (0.000s)
[123.852965] [029/133] (899s left) syncobj_timeline (wait-for-submit-delayed-submit)
[123.917781] Starting subtest: wait-for-submit-delayed-submit
[124.021400] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[124.108789] [030/133] (899s left) kms_color (ctm-0-50)
[124.186681] Starting subtest: ctm-0-50
[124.188869] Starting dynamic subtest: pipe-A-eDP-1
[127.610748] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.422s)
[127.618996] Starting dynamic subtest: pipe-B-eDP-1
[131.803154] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.192s)
[131.811161] Starting dynamic subtest: pipe-C-eDP-1
[135.782233] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.976s)
[135.790615] Starting dynamic subtest: pipe-D-eDP-1
[139.762551] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.979s)
[139.764838] Subtest ctm-0-50: SUCCESS (15.572s)
[140.615529] [031/133] (883s left) syncobj_eventfd (binary-wait-before-signal)
[140.675471] Starting subtest: binary-wait-before-signal
[140.705296] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[140.790431] [032/133] (882s left) kms_psr (fbc-psr2-primary-render)
[140.861706] Starting subtest: fbc-psr2-primary-render
[140.863564] Starting dynamic subtest: eDP-1
[140.867600] Dynamic subtest eDP-1: SKIP (0.000s)
[140.871715] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[140.941461] [033/133] (882s left) gem_lmem_swapping (random)
[140.980433] Subtest random: SKIP (0.000s)
[141.019064] [034/133] (882s left) dmabuf_sync_file (export-basic)
[141.109151] Starting subtest: export-basic
[141.111474] Subtest export-basic: SUCCESS (0.001s)
[141.189451] [FACT dmabuf_sync_file (export-basic)] new: kernel.kmod_is_loaded.vgem: true
[141.193007] [035/133] (882s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[141.254618] Starting subtest: x-tiled-to-vebox-y-tiled
[141.259605] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[141.446500] [036/133] (882s left) perf (create-destroy-userspace-config)
[141.562495] Starting subtest: create-destroy-userspace-config
[141.578898] Subtest create-destroy-userspace-config: SUCCESS (0.017s)
[141.620266] [037/133] (882s left) kms_psr (fbc-psr-cursor-plane-move)
[141.706213] Starting subtest: fbc-psr-cursor-plane-move
[141.708440] Starting dynamic subtest: eDP-1
[141.712487] Dynamic subtest eDP-1: SKIP (0.000s)
[141.716605] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[141.831832] [038/133] (882s left) gem_partial_pwrite_pread (write-display)
[141.896270] Subtest write-display: SKIP (0.000s)
[141.971576] [039/133] (882s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[142.055042] Starting subtest: fbcpsr-indfb-scaledprimary
[147.786429] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.746s)
[147.956948] [040/133] (876s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[148.044781] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[148.049213] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[148.154151] [041/133] (875s left) gem_exec_fence (syncobj-invalid-flags)
[148.564730] Starting subtest: syncobj-invalid-flags
[148.567244] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[149.958530] [042/133] (874s left) gem_ctx_persistence (legacy-engines-queued)
[150.007296] Starting subtest: legacy-engines-queued
[150.009565] Starting dynamic subtest: render
[150.076675] Dynamic subtest render: SUCCESS (0.069s)
[150.086610] Starting dynamic subtest: bsd1
[151.799523] Dynamic subtest bsd1: SUCCESS (1.721s)
[151.809971] Starting dynamic subtest: bsd2
[153.845818] Dynamic subtest bsd2: SUCCESS (2.045s)
[153.856563] Starting dynamic subtest: blt
[153.913501] Dynamic subtest blt: SUCCESS (0.067s)
[153.923573] Starting dynamic subtest: vebox
[155.830550] Dynamic subtest vebox: SUCCESS (1.913s)
[155.833084] Subtest legacy-engines-queued: SUCCESS (5.824s)
[155.919807] [043/133] (868s left) gem_ctx_shared (q-in-order)
[155.989178] Starting subtest: Q-in-order
[155.991472] Starting dynamic subtest: rcs0
[156.145201] Dynamic subtest rcs0: SUCCESS (0.155s)
[156.163833] Starting dynamic subtest: vcs0
[156.247830] Dynamic subtest vcs0: SUCCESS (0.103s)
[156.263268] Starting dynamic subtest: vcs1
[156.350887] Dynamic subtest vcs1: SUCCESS (0.102s)
[156.366711] Starting dynamic subtest: vecs0
[156.449378] Dynamic subtest vecs0: SUCCESS (0.099s)
[156.464706] Starting dynamic subtest: ccs0
[156.561535] Dynamic subtest ccs0: SUCCESS (0.111s)
[156.564070] Subtest Q-in-order: SUCCESS (0.573s)
[157.986096] [044/133] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[158.073718] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[165.338357] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.268s)
[165.507420] [045/133] (858s left) prime_mmap (test_errors)
[165.574573] Starting subtest: test_errors
[165.576565] Starting dynamic subtest: test_errors-smem
[165.716297] Dynamic subtest test_errors-smem: SUCCESS (0.142s)
[165.718922] Subtest test_errors: SUCCESS (0.143s)
[165.846073] [046/133] (858s left) kms_flip (nonexisting-fb-interruptible)
[165.947847] Starting subtest: nonexisting-fb-interruptible
[165.950183] Starting dynamic subtest: A-eDP1
[167.057855] Dynamic subtest A-eDP1: SUCCESS (1.109s)
[167.066091] Starting dynamic subtest: B-eDP1
[168.180309] Dynamic subtest B-eDP1: SUCCESS (1.122s)
[168.191602] Starting dynamic subtest: C-eDP1
[169.317797] Dynamic subtest C-eDP1: SUCCESS (1.137s)
[169.326446] Starting dynamic subtest: D-eDP1
[170.447113] Dynamic subtest D-eDP1: SUCCESS (1.128s)
[170.449404] Subtest nonexisting-fb-interruptible: SUCCESS (4.502s)
[171.624862] [047/133] (852s left) kms_atomic (crtc-invalid-params)
[171.706512] Starting subtest: crtc-invalid-params
[171.708789] Starting dynamic subtest: pipe-A-eDP-1
[172.062627] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.356s)
[172.065028] Subtest crtc-invalid-params: SUCCESS (0.358s)
[172.949531] [048/133] (851s left) kms_cursor_crc (cursor-offscreen-512x170)
[173.191762] Starting subtest: cursor-offscreen-512x170
[173.196287] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[173.362968] [049/133] (851s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[173.444733] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[173.447015] Starting dynamic subtest: pipe-A-eDP-1
[173.467099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[173.476754] Starting dynamic subtest: pipe-B-eDP-1
[173.497056] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[173.505233] Starting dynamic subtest: pipe-C-eDP-1
[173.525706] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[173.533966] Starting dynamic subtest: pipe-D-eDP-1
[173.554495] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[173.556843] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.090s)
[175.735812] [050/133] (848s left) kms_flip (flip-vs-expired-vblank-interruptible)
[175.813858] Starting subtest: flip-vs-expired-vblank-interruptible
[175.816609] Starting dynamic subtest: A-eDP1
[184.439246] Dynamic subtest A-eDP1: SUCCESS (8.620s)
[184.448314] Starting dynamic subtest: B-eDP1
[193.061073] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[193.071129] Starting dynamic subtest: C-eDP1
[201.672096] Dynamic subtest C-eDP1: SUCCESS (8.610s)
[201.680832] Starting dynamic subtest: D-eDP1
[210.310076] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[210.312459] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.500s)
[211.502122] [051/133] (812s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[211.630859] Starting subtest: cursor-rapid-movement-32x32
[211.672427] Subtest cursor-rapid-movement-32x32: SKIP (0.038s)
[211.963891] [052/133] (812s left) api_intel_bb (object-reloc-purge-cache)
[212.021320] Starting subtest: object-reloc-purge-cache
[212.028374] Subtest object-reloc-purge-cache: SKIP (0.004s)
[212.173342] [053/133] (812s left) gem_ctx_isolation (clean)
[212.240077] Starting subtest: clean
[212.242480] Starting dynamic subtest: rcs0
[212.272372] Dynamic subtest rcs0: SUCCESS (0.032s)
[212.282598] Starting dynamic subtest: bcs0
[212.316073] Dynamic subtest bcs0: SUCCESS (0.043s)
[212.324865] Starting dynamic subtest: vcs0
[212.399124] Dynamic subtest vcs0: SUCCESS (0.082s)
[212.407667] Starting dynamic subtest: vcs1
[213.885157] Dynamic subtest vcs1: SUCCESS (1.485s)
[213.893732] Starting dynamic subtest: vecs0
[215.871983] Dynamic subtest vecs0: SUCCESS (1.985s)
[215.879863] Starting dynamic subtest: ccs0
[217.820269] Dynamic subtest ccs0: SUCCESS (1.947s)
[217.822969] Subtest clean: SUCCESS (5.580s)
[218.065042] [054/133] (806s left) kms_psr (psr-suspend)
[218.139995] Starting subtest: psr-suspend
[218.142436] Starting dynamic subtest: eDP-1
[235.381700] Dynamic subtest eDP-1: SUCCESS (3.131s)
[235.383766] Subtest psr-suspend: SUCCESS (3.132s)
[236.298088] [055/133] (788s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[236.424234] Starting subtest: cursorB-vs-flipA-atomic
[236.429000] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[236.571353] [056/133] (788s left) kms_psr (psr-cursor-blt)
[236.657118] Starting subtest: psr-cursor-blt
[236.659350] Starting dynamic subtest: eDP-1
[238.424487] Dynamic subtest eDP-1: SUCCESS (1.725s)
[238.426838] Subtest psr-cursor-blt: SUCCESS (1.726s)
[239.341749] [057/133] (785s left) kms_force_connector_basic (prune-stale-modes)
[239.405985] Subtest prune-stale-modes: SKIP (0.000s)
[239.477330] [058/133] (785s left) kms_big_fb (linear-16bpp-rotate-0)
[239.557032] Starting subtest: linear-16bpp-rotate-0
[240.892247] Subtest linear-16bpp-rotate-0: SUCCESS (1.313s)
[241.042493] [059/133] (783s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[241.126132] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[241.129513] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[241.215722] [060/133] (783s left) fbdev (pan)
[241.260915] Starting subtest: pan
[241.293973] Subtest pan: SUCCESS (0.035s)
[241.377377] [061/133] (783s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[241.454598] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[241.456410] Starting dynamic subtest: pipe-A-default-mode
[242.633255] Dynamic subtest pipe-A-default-mode: SKIP (1.159s)
[242.637774] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.161s)
[242.825584] [062/133] (782s left) gem_userptr_blits (sd-probe)
[242.894880] Starting subtest: sd-probe
[242.897167] Subtest sd-probe: SUCCESS (0.000s)
[243.057833] [063/133] (781s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[243.143073] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[247.399976] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.224s)
[248.566167] [064/133] (776s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[248.685499] Starting subtest: cursor-vs-flip-legacy
[277.932842] Subtest cursor-vs-flip-legacy: SUCCESS (29.196s)
[278.741280] [065/133] (746s left) sw_sync (sync_merge_invalid)
[278.786129] Starting subtest: sync_merge_invalid
[278.815870] Subtest sync_merge_invalid: SUCCESS (0.029s)
[278.902322] [066/133] (746s left) kms_psr (fbc-pr-primary-mmap-cpu)
[278.980900] Starting subtest: fbc-pr-primary-mmap-cpu
[278.985383] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[279.068099] [067/133] (746s left) gem_exec_big (single)
[279.129626] Starting subtest: single
[280.174254] Subtest single: SUCCESS (1.043s)
[280.343480] [068/133] (744s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[280.469280] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[280.473254] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[280.549668] [069/133] (744s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[280.647773] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[280.652429] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.001s)
[280.762576] [070/133] (744s left) gem_exec_balancer (full-pulse)
[280.828003] Starting subtest: full-pulse
[285.769191] Subtest full-pulse: SUCCESS (4.938s)
[286.134721] [071/133] (739s left) kms_lease (lease-again)
[286.215564] Starting subtest: lease-again
[286.217828] Starting dynamic subtest: pipe-A-eDP-1
[286.220351] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[286.233238] Starting dynamic subtest: pipe-B-eDP-1
[286.235577] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[286.244812] Starting dynamic subtest: pipe-C-eDP-1
[286.246677] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[286.255641] Starting dynamic subtest: pipe-D-eDP-1
[286.257572] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[286.259427] Subtest lease-again: SUCCESS (0.013s)
[286.363420] [072/133] (738s left) gem_mmap_gtt (fault-concurrent)
[286.433066] Subtest fault-concurrent: SKIP (0.000s)
[286.500359] [073/133] (738s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[286.576553] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[290.673885] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.100s)
[291.862493] [074/133] (733s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[291.928984] Starting subtest: etime-single-wait-available-unsubmitted
[292.039267] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.108s)
[292.126810] [075/133] (733s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[292.213304] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[292.217392] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[292.334226] [076/133] (733s left) gem_lmem_evict (dontneed-evict-race)
[292.377281] Subtest dontneed-evict-race: SKIP (0.000s)
[292.416608] [077/133] (733s left) kms_feature_discovery (psr1)
[292.502132] Starting subtest: psr1
[292.504342] Subtest psr1: SUCCESS (0.000s)
[292.650164] [078/133] (732s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[292.729780] Starting subtest: primary-x-tiled-reflect-x-180
[299.663533] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.932s)
[300.911707] [079/133] (724s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[301.020919] Starting subtest: 2x-flip-vs-cursor-legacy
[301.025987] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[301.186704] [080/133] (724s left) kms_chamelium_audio (dp-audio)
[301.557489] Subtest dp-audio: SKIP (0.000s)
[302.421025] [081/133] (723s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[302.472017] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[302.474508] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[302.596593] [082/133] (723s left) gem_ctx_param (basic-default)
[302.659976] Starting subtest: basic-default
[302.662267] Subtest basic-default: SUCCESS (0.000s)
[302.745044] [083/133] (723s left) gem_exec_parallel (userptr)
[302.794042] Starting subtest: userptr
[302.796318] Starting dynamic subtest: rcs0
[304.241973] Dynamic subtest rcs0: SUCCESS (1.447s)
[304.252051] Starting dynamic subtest: bcs0
[305.703375] Dynamic subtest bcs0: SUCCESS (1.459s)
[305.713774] Starting dynamic subtest: vcs0
[308.915486] Dynamic subtest vcs0: SUCCESS (3.207s)
[308.928747] Starting dynamic subtest: vcs1
[310.898952] Dynamic subtest vcs1: SUCCESS (1.980s)
[310.911987] Starting dynamic subtest: vecs0
[312.947494] Dynamic subtest vecs0: SUCCESS (2.045s)
[312.960206] Starting dynamic subtest: ccs0
[314.447947] Dynamic subtest ccs0: SUCCESS (1.499s)
[314.450682] Subtest userptr: SUCCESS (11.648s)
[314.644023] [084/133] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[314.736918] Starting subtest: psr-1p-primscrn-spr-indfb-move
[322.287553] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.549s)
[322.449575] [085/133] (703s left) kms_hdr (invalid-metadata-sizes)
[322.529110] Starting subtest: invalid-metadata-sizes
[322.535134] Subtest invalid-metadata-sizes: SKIP (0.000s)
[322.610655] [086/133] (703s left) kms_properties (invalid-properties-legacy)
[322.687286] Starting subtest: invalid-properties-legacy
[322.782674] Subtest invalid-properties-legacy: SUCCESS (0.096s)
[322.871183] [087/133] (703s left) gem_mmap_gtt (coherency)
[322.935028] Subtest coherency: SKIP (0.000s)
[323.001450] [088/133] (703s left) kms_vblank (wait-busy)
[323.079383] Starting subtest: wait-busy
[323.081636] Starting dynamic subtest: pipe-A-eDP-1
[324.959628] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[324.974345] Starting dynamic subtest: pipe-D-eDP-1
[327.554159] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.593s)
[327.556602] Subtest wait-busy: SUCCESS (4.474s)
[328.361632] [089/133] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[328.447825] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[328.452104] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[328.567953] [090/133] (697s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[328.643454] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[335.997358] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.360s)
[336.155143] [091/133] (689s left) perf (whitelisted-registers-userspace-config)
[336.272935] Starting subtest: whitelisted-registers-userspace-config
[336.275312] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[336.313077] [092/133] (689s left) gem_exec_schedule (pi-shared-iova)
[336.507448] Starting subtest: pi-shared-iova
[336.509510] Starting dynamic subtest: rcs0
[336.580238] Dynamic subtest rcs0: SUCCESS (0.076s)
[336.593477] Starting dynamic subtest: vcs0
[336.635072] Dynamic subtest vcs0: SUCCESS (0.054s)
[336.648247] Starting dynamic subtest: vcs1
[336.687906] Dynamic subtest vcs1: SUCCESS (0.052s)
[336.699464] Starting dynamic subtest: vecs0
[336.736599] Dynamic subtest vecs0: SUCCESS (0.049s)
[336.747161] Starting dynamic subtest: ccs0
[336.792785] Dynamic subtest ccs0: SUCCESS (0.054s)
[336.795249] Subtest pi-shared-iova: SUCCESS (0.289s)
[338.086114] [093/133] (688s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[338.144364] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[338.245727] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[338.334081] [094/133] (687s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[338.403244] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[338.407628] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[338.523449] [095/133] (687s left) gem_softpin (full)
[338.596769] Starting subtest: full
[338.604756] Subtest full: SUCCESS (0.008s)
[338.742505] [096/133] (687s left) kms_flip (wf_vblank-ts-check)
[338.821856] Starting subtest: wf_vblank-ts-check
[338.824076] Starting dynamic subtest: A-eDP1
[347.739597] Dynamic subtest A-eDP1: SUCCESS (8.921s)
[347.754205] Starting dynamic subtest: B-eDP1
[356.669704] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[356.684156] Starting dynamic subtest: C-eDP1
[365.581017] Dynamic subtest C-eDP1: SUCCESS (8.908s)
[365.591375] Starting dynamic subtest: D-eDP1
[374.518607] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[374.523842] Subtest wf_vblank-ts-check: SUCCESS (35.706s)
[375.757124] [097/133] (650s left) api_intel_allocator (two-level-inception)
[375.811569] Starting subtest: two-level-inception
[381.211099] Subtest two-level-inception: SUCCESS (5.400s)
[381.346671] [098/133] (645s left) prime_busy (after)
[381.419747] Starting subtest: after
[381.424404] Starting dynamic subtest: rcs0
[381.484547] Dynamic subtest rcs0: SUCCESS (0.060s)
[381.496378] Starting dynamic subtest: bcs0
[381.573520] Dynamic subtest bcs0: SUCCESS (0.088s)
[381.584912] Starting dynamic subtest: vcs0
[381.616669] Dynamic subtest vcs0: SUCCESS (0.043s)
[381.626918] Starting dynamic subtest: vcs1
[381.659578] Dynamic subtest vcs1: SUCCESS (0.042s)
[381.669757] Starting dynamic subtest: vecs0
[381.702547] Dynamic subtest vecs0: SUCCESS (0.042s)
[381.714450] Starting dynamic subtest: ccs0
[381.745883] Dynamic subtest ccs0: SUCCESS (0.043s)
[381.853759] Subtest after: SUCCESS (0.432s)
[381.944857] [099/133] (644s left) gem_tiled_wb
[382.101801] [100/133] (644s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[382.180198] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[382.184817] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[382.381331] [101/133] (644s left) i915_pm_rpm (system-suspend-execbuf)
[384.123192] Starting subtest: system-suspend-execbuf
[445.781091] Subtest system-suspend-execbuf: SUCCESS (46.724s)
[446.162213] [102/133] (580s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[446.249925] Starting subtest: bad-rotation-90-yf-tiled-ccs
[446.252279] Starting dynamic subtest: pipe-A-eDP-1
[446.275193] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[446.286003] Starting dynamic subtest: pipe-B-eDP-1
[446.307899] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[446.316911] Starting dynamic subtest: pipe-C-eDP-1
[446.338639] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[446.347583] Starting dynamic subtest: pipe-D-eDP-1
[446.369289] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[446.373561] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s)
[448.496294] [103/133] (578s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[448.577573] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[455.827210] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.251s)
[455.985818] [104/133] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[456.084021] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[462.677072] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.601s)
[462.826868] [105/133] (563s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[462.924189] Starting subtest: x-tiled-addfb-size-offset-overflow
[462.926507] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[463.045594] [106/133] (563s left) perf_pmu (busy-check-all)
[463.087776] Starting subtest: busy-check-all
[463.089673] Starting dynamic subtest: rcs0
[463.636446] Dynamic subtest rcs0: SUCCESS (0.550s)
[463.651611] Starting dynamic subtest: bcs0
[464.187891] Dynamic subtest bcs0: SUCCESS (0.548s)
[464.201375] Starting dynamic subtest: vcs0
[465.613066] Dynamic subtest vcs0: SUCCESS (1.421s)
[465.625617] Starting dynamic subtest: vcs1
[467.660962] Dynamic subtest vcs1: SUCCESS (2.044s)
[467.674032] Starting dynamic subtest: vecs0
[469.645001] Dynamic subtest vecs0: SUCCESS (1.980s)
[469.657363] Starting dynamic subtest: ccs0
[470.202190] Dynamic subtest ccs0: SUCCESS (0.556s)
[470.204979] Subtest busy-check-all: SUCCESS (7.115s)
[470.336641] [107/133] (556s left) gem_partial_pwrite_pread (reads-uncached)
[470.406708] Subtest reads-uncached: SKIP (0.000s)
[470.506277] [108/133] (556s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[470.576644] Starting subtest: framebuffer-vs-set-tiling
[470.580792] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[470.744078] [109/133] (556s left) kms_content_protection (dp-mst-type-0)
[470.867520] Starting subtest: dp-mst-type-0
[470.872151] Subtest dp-mst-type-0: SKIP (0.000s)
[471.021559] [110/133] (555s left) i915_selftest (perf)
[474.541145] Starting subtest: perf
[474.546998] Starting dynamic subtest: engine_cs
[479.099050] Dynamic subtest engine_cs: SUCCESS (4.556s)
[479.109030] Starting dynamic subtest: request
[486.454193] Dynamic subtest request: SUCCESS (7.349s)
[486.470166] Starting dynamic subtest: migrate
[490.915406] Dynamic subtest migrate: SUCCESS (4.457s)
[490.931171] Starting dynamic subtest: region
[497.000610] Dynamic subtest region: SUCCESS (6.080s)
[497.003055] Subtest perf: SUCCESS (22.451s)
[497.030914] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[497.031615] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[497.035171] [111/133] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[498.558455] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[498.562648] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[498.667863] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[498.669156] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[498.673002] [112/133] (528s left) kms_psr (pr-dpms)
[498.752486] Starting subtest: pr-dpms
[498.756694] Subtest pr-dpms: SKIP (0.000s)
[498.838681] [113/133] (528s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[498.913535] Starting subtest: plane-use-after-nonblocking-unbind
[498.915682] Starting dynamic subtest: pipe-A-eDP-1
[499.014983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.101s)
[499.313074] Starting dynamic subtest: pipe-B-eDP-1
[500.126351] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.821s)
[500.413179] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.498s)
[501.291951] [114/133] (525s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[501.381484] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[501.408166] Starting dynamic subtest: pipe-A-plane-0
[501.829613] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[501.839116] Starting dynamic subtest: pipe-A-plane-3
[502.109700] Dynamic subtest pipe-A-plane-3: SUCCESS (0.277s)
[502.119708] Starting dynamic subtest: pipe-A-plane-5
[502.124065] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[503.260997] Starting dynamic subtest: pipe-B-plane-0
[503.686670] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[503.696766] Starting dynamic subtest: pipe-B-plane-3
[503.954493] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[503.969363] Starting dynamic subtest: pipe-B-plane-5
[503.977542] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[504.275503] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.893s)
[505.369399] [115/133] (521s left) perf_pmu (semaphore-busy)
[505.414047] Starting subtest: semaphore-busy
[505.416414] Starting dynamic subtest: rcs0
[507.068021] Dynamic subtest rcs0: SUCCESS (1.652s)
[507.079979] Starting dynamic subtest: bcs0
[508.699014] Dynamic subtest bcs0: SUCCESS (1.627s)
[508.711274] Starting dynamic subtest: vcs0
[513.159297] Dynamic subtest vcs0: SUCCESS (4.458s)
[513.176401] Starting dynamic subtest: vcs1
[519.175361] Dynamic subtest vcs1: SUCCESS (6.014s)
[519.187959] Starting dynamic subtest: vecs0
[525.126926] Dynamic subtest vecs0: SUCCESS (5.948s)
[525.139422] Starting dynamic subtest: ccs0
[528.267357] Dynamic subtest ccs0: SUCCESS (3.137s)
[528.269730] Subtest semaphore-busy: SUCCESS (22.851s)
[528.403748] [116/133] (498s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[528.507924] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[528.512362] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[528.647124] [117/133] (498s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[528.725480] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[528.727806] Starting dynamic subtest: pipe-A-eDP-1
[528.752846] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[528.763460] Starting dynamic subtest: pipe-B-eDP-1
[528.786921] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[528.796529] Starting dynamic subtest: pipe-C-eDP-1
[528.821273] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[528.831950] Starting dynamic subtest: pipe-D-eDP-1
[528.856391] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[528.860489] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[530.931590] [118/133] (496s left) syncobj_wait (wait-all-for-submit-snapshot)
[531.004289] Starting subtest: wait-all-for-submit-snapshot
[531.085152] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[531.170188] [119/133] (496s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[531.283512] Starting subtest: short-busy-flip-before-cursor-toggle
[531.287994] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[531.439412] [120/133] (495s left) i915_drm_fdinfo (virtual-busy-hang)
[531.476606] Starting subtest: virtual-busy-hang
[531.481078] Subtest virtual-busy-hang: SKIP (0.000s)
[531.562236] [121/133] (495s left) kms_cursor_edge_walk (256x256-left-edge)
[531.644424] Starting subtest: 256x256-left-edge
[531.646717] Starting dynamic subtest: pipe-A-eDP-1
[535.084579] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.437s)
[535.095371] Starting dynamic subtest: pipe-D-eDP-1
[538.197684] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[538.200063] Subtest 256x256-left-edge: SUCCESS (6.552s)
[539.016489] [122/133] (488s left) syncobj_wait (invalid-signal-bad-pad)
[539.074492] Starting subtest: invalid-signal-bad-pad
[539.076792] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[539.184127] [123/133] (488s left) syncobj_timeline (multi-wait-for-submit-signaled)
[539.235920] Starting subtest: multi-wait-for-submit-signaled
[539.237900] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[539.362914] [124/133] (488s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[539.463717] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[540.413155] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.948s)
[541.242868] [125/133] (486s left) kms_atomic_interruptible (legacy-setmode)
[541.321954] Starting subtest: legacy-setmode
[541.324289] Starting dynamic subtest: pipe-A-eDP-1
[548.218578] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.893s)
[548.220835] Subtest legacy-setmode: SUCCESS (6.894s)
[549.090558] [126/133] (478s left) gem_ppgtt (blt-vs-render-ctxn)
[549.145706] Starting subtest: blt-vs-render-ctxN
[582.048532] Subtest blt-vs-render-ctxN: SUCCESS (32.892s)
[582.197946] [127/133] (445s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[582.324958] Starting subtest: yf-tiled-8bpp-rotate-270
[582.329855] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[582.434489] [128/133] (445s left) gem_exec_schedule (u-semaphore-noskip)
[582.517148] Starting subtest: u-semaphore-noskip
[582.913583] Subtest u-semaphore-noskip: SUCCESS (0.401s)
[583.266601] [129/133] (444s left) gem_mmap_wc (write-read-distinct)
[583.326809] Subtest write-read-distinct: SKIP (0.000s)
[583.384732] [130/133] (444s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[583.472247] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[583.598200] [131/133] (444s left) kms_vblank (query-forked)
[583.673034] Starting subtest: query-forked
[583.675331] Starting dynamic subtest: pipe-A-eDP-1
[585.511760] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.835s)
[585.527163] Starting dynamic subtest: pipe-D-eDP-1
[588.008857] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.496s)
[588.011185] Subtest query-forked: SUCCESS (4.336s)
[588.873200] [132/133] (438s left) syncobj_wait (single-wait-all-for-submit-submitted)
[588.951823] Starting subtest: single-wait-all-for-submit-submitted
[589.056754] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[589.143306] [133/133] (438s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[589.224262] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[589.226518] Starting dynamic subtest: pipe-A
[589.559945] Dynamic subtest pipe-A: SUCCESS (0.338s)
[589.570054] Starting dynamic subtest: pipe-B
[590.941219] Dynamic subtest pipe-B: SUCCESS (1.380s)
[590.951340] Starting dynamic subtest: pipe-C
[592.371113] Dynamic subtest pipe-C: SUCCESS (1.429s)
[592.381259] Starting dynamic subtest: pipe-D
[593.801366] Dynamic subtest pipe-D: SUCCESS (1.429s)
[593.803613] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.578s)
[594.978450] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: gem_ppgtt
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: gem_exec_store
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_joiner
results: parsing output: 10/ for test: gem_flink_race
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: kms_plane_alpha_blend
results: parsing output: 13/ for test: kms_atomic_transition
results: parsing output: 14/ for test: kms_draw_crc
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: kms_plane_scaling
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: i915_hangman
results: parsing output: 20/ for test: kms_pm_rpm
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: sw_sync
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_chamelium_edid
results: parsing output: 27/ for test: gem_ccs
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_color
results: parsing output: 30/ for test: syncobj_eventfd
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: dmabuf_sync_file
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: perf
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_partial_pwrite_pread
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_exec_fence
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: gem_ctx_shared
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: prime_mmap
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_atomic
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: api_intel_bb
results: parsing output: 52/ for test: gem_ctx_isolation
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_force_connector_basic
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: fbdev
results: parsing output: 60/ for test: kms_flip_scaled_crc
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: sw_sync
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_exec_big
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_lmem_evict
results: parsing output: 76/ for test: kms_feature_discovery
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_chamelium_audio
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_ctx_param
results: parsing output: 82/ for test: gem_exec_parallel
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_hdr
results: parsing output: 85/ for test: kms_properties
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: kms_vblank
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_softpin
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: api_intel_allocator
results: parsing output: 97/ for test: prime_busy
results: parsing output: 98/ for test: gem_tiled_wb
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: i915_pm_rpm
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: gem_partial_pwrite_pread
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: i915_selftest
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_atomic_transition
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: i915_drm_fdinfo
results: parsing output: 120/ for test: kms_cursor_edge_walk
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: kms_atomic_interruptible
results: parsing output: 125/ for test: gem_ppgtt
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: gem_mmap_wc
results: parsing output: 129/ for test: kms_addfb_basic
results: parsing output: 130/ for test: kms_vblank
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: kms_plane_scaling
Done.