[59.755928] Initializing watchdogs
[59.755977]   /dev/watchdog0
[59.770017] [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]
[59.774124] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.776440] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.779701] [001/133] (960s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[59.892308] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[59.896801] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[59.962023] [002/133] (960s left) kms_content_protection (dp-mst-type-1)
[60.108511] Starting subtest: dp-mst-type-1
[60.113030] Subtest dp-mst-type-1: SKIP (0.000s)
[60.232607] [003/133] (960s left) i915_query (query-topology-kernel-writes)
[60.291814] Starting subtest: query-topology-kernel-writes
[60.294042] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[60.381641] [004/133] (960s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[60.483119] Starting subtest: y-tiled-32bpp-rotate-180
[60.487324] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[60.576253] [005/133] (959s left) kms_chamelium_frames (hdmi-crc-multiple)
[60.958523] Subtest hdmi-crc-multiple: SKIP (0.000s)
[61.786385] [006/133] (958s left) syncobj_timeline (signal)
[61.842896] Starting subtest: signal
[61.845278] Subtest signal: SUCCESS (0.000s)
[61.962221] [007/133] (958s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[62.064418] Starting subtest: 4-tiled-addfb-size-offset-overflow
[62.066618] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[62.160468] [008/133] (958s left) kms_chamelium_hpd (vga-hpd-fast)
[62.551433] Subtest vga-hpd-fast: SKIP (0.000s)
[63.401637] [009/133] (957s left) kms_psr (fbc-psr-cursor-render)
[63.501950] Starting subtest: fbc-psr-cursor-render
[63.504283] Starting dynamic subtest: eDP-1
[63.508615] Dynamic subtest eDP-1: SKIP (0.000s)
[63.512990] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[63.584146] [010/133] (957s left) gem_tiled_wb
[63.704885] [011/133] (956s left) gem_mmap_gtt (big-bo)
[63.765097] Subtest big-bo: SKIP (0.000s)
[63.824335] [012/133] (956s left) gem_exec_async (concurrent-writes)
[63.886073] Starting subtest: concurrent-writes
[63.888454] Starting dynamic subtest: rcs0
[63.900471] Dynamic subtest rcs0: SUCCESS (0.014s)
[63.910385] Starting dynamic subtest: bcs0
[63.912643] Dynamic subtest bcs0: SUCCESS (0.006s)
[63.920783] Starting dynamic subtest: vcs0
[63.923090] Dynamic subtest vcs0: SUCCESS (0.006s)
[63.930178] Starting dynamic subtest: vcs1
[63.932541] Dynamic subtest vcs1: SUCCESS (0.006s)
[63.939092] Starting dynamic subtest: vecs0
[63.940979] Dynamic subtest vecs0: SUCCESS (0.006s)
[63.947722] Starting dynamic subtest: ccs0
[63.949635] Dynamic subtest ccs0: SUCCESS (0.005s)
[63.951646] Subtest concurrent-writes: SUCCESS (0.046s)
[64.150870] [013/133] (956s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[64.239141] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[64.242865] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[64.321804] [014/133] (956s left) kms_addfb_basic (too-wide)
[64.421542] Starting subtest: too-wide
[64.423287] Subtest too-wide: SUCCESS (0.000s)
[64.509074] [015/133] (956s left) syncobj_wait (invalid-signal-illegal-handle)
[64.568511] Starting subtest: invalid-signal-illegal-handle
[64.570595] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[64.675623] [016/133] (956s left) syncobj_wait (multi-wait-all-submitted-signaled)
[64.733963] Starting subtest: multi-wait-all-submitted-signaled
[64.843743] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[64.917173] [017/133] (955s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[65.033714] Starting subtest: cursorB-vs-flipA-toggle
[65.038415] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[65.187446] [018/133] (955s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[65.285729] Starting subtest: fbcpsr-modesetfrombusy
[71.467559] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.169s)
[71.617107] [019/133] (949s left) gem_exercise_blt (fast-copy)
[71.682200] Starting subtest: fast-copy
[71.683952] Starting dynamic subtest: linear-smem-smem
[71.708521] Dynamic subtest linear-smem-smem: SUCCESS (0.027s)
[71.715689] Starting dynamic subtest: xmajor-smem-smem
[71.726202] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[71.733287] Starting dynamic subtest: tile4-smem-smem
[71.743829] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[71.752411] Starting dynamic subtest: tile64-smem-smem
[71.761103] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[71.763076] Subtest fast-copy: SUCCESS (0.079s)
[71.868191] [020/133] (949s left) gem_exec_schedule (pi-distinct-iova)
[72.049168] Starting subtest: pi-distinct-iova
[72.051205] Starting dynamic subtest: rcs0
[72.130078] Dynamic subtest rcs0: SUCCESS (0.083s)
[72.138717] Starting dynamic subtest: vcs0
[72.185306] Dynamic subtest vcs0: SUCCESS (0.055s)
[72.194797] Starting dynamic subtest: vcs1
[72.244920] Dynamic subtest vcs1: SUCCESS (0.060s)
[72.253053] Starting dynamic subtest: vecs0
[72.299486] Dynamic subtest vecs0: SUCCESS (0.054s)
[72.313783] Starting dynamic subtest: ccs0
[72.358786] Dynamic subtest ccs0: SUCCESS (0.057s)
[72.361225] Subtest pi-distinct-iova: SUCCESS (0.311s)
[73.447699] [021/133] (947s left) kms_atomic (test-only)
[73.584633] Starting subtest: test-only
[73.665903] Starting dynamic subtest: pipe-A-eDP-1
[76.139038] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.475s)
[76.141399] Subtest test-only: SUCCESS (2.552s)
[76.942636] [022/133] (944s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[76.996061] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[77.099378] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[77.185320] [023/133] (943s left) i915_selftest (perf)
[78.856864] Starting subtest: perf
[78.859565] Starting dynamic subtest: engine_cs
[83.215208] Dynamic subtest engine_cs: SUCCESS (4.356s)
[83.223968] Starting dynamic subtest: request
[90.462674] Dynamic subtest request: SUCCESS (7.244s)
[90.471594] Starting dynamic subtest: migrate
[94.742054] Dynamic subtest migrate: SUCCESS (4.277s)
[94.751147] Starting dynamic subtest: region
[100.799769] Dynamic subtest region: SUCCESS (6.056s)
[100.802600] Subtest perf: SUCCESS (21.935s)
[100.830548] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[100.833838] [024/133] (920s left) kms_color (ctm-negative)
[102.385556] Starting subtest: ctm-negative
[102.388032] Starting dynamic subtest: pipe-A-eDP-1
[103.111540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.727s)
[103.120406] Starting dynamic subtest: pipe-B-eDP-1
[104.529662] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s)
[104.538461] Starting dynamic subtest: pipe-C-eDP-1
[105.892471] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.362s)
[105.901244] Starting dynamic subtest: pipe-D-eDP-1
[107.231121] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[107.233349] Subtest ctm-negative: SUCCESS (4.844s)
[108.075400] [FACT kms_color (ctm-negative)] new: kernel.kmod_is_loaded.i915: true
[108.081031] [025/133] (913s left) kms_addfb_basic (addfb25-modifier-no-flag)
[108.176827] Starting subtest: addfb25-modifier-no-flag
[108.178727] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[108.265395] [026/133] (912s left) gem_mmap_gtt (cpuset-medium-copy)
[108.314611] Subtest cpuset-medium-copy: SKIP (0.000s)
[108.372266] [027/133] (912s left) kms_flip (2x-plain-flip)
[108.469418] Starting subtest: 2x-plain-flip
[108.479972] Subtest 2x-plain-flip: SKIP (0.010s)
[108.595301] [028/133] (912s left) gem_create (busy-create)
[108.652874] Starting subtest: busy-create
[108.655095] Starting dynamic subtest: smem0
[142.285738] Dynamic subtest smem0: SUCCESS (33.630s)
[142.288542] Subtest busy-create: SUCCESS (33.631s)
[142.483244] [029/133] (878s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[142.547706] Starting subtest: y-tiled-to-vebox-y-tiled
[142.552024] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[142.727906] [030/133] (878s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[142.855929] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[147.730248] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.878s)
[148.856719] [031/133] (872s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[148.956764] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[156.557181] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.603s)
[156.665996] [032/133] (864s left) kms_flip (plain-flip-ts-check-interruptible)
[156.779067] Starting subtest: plain-flip-ts-check-interruptible
[156.781432] Starting dynamic subtest: A-eDP1
[165.619134] Dynamic subtest A-eDP1: SUCCESS (8.838s)
[165.628715] Starting dynamic subtest: B-eDP1
[174.455441] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[174.463918] Starting dynamic subtest: C-eDP1
[183.269645] Dynamic subtest C-eDP1: SUCCESS (8.811s)
[183.279230] Starting dynamic subtest: D-eDP1
[192.101792] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[192.104282] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.324s)
[193.287895] [033/133] (828s left) kms_rotation_crc (multiplane-rotation)
[193.373835] Starting subtest: multiplane-rotation
[210.822993] Subtest multiplane-rotation: SUCCESS (17.450s)
[210.931326] [034/133] (810s left) kms_invalid_mode (uint-max-clock)
[211.037572] Starting subtest: uint-max-clock
[211.039479] Starting dynamic subtest: pipe-A-eDP-1
[211.336366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[211.347198] Starting dynamic subtest: pipe-B-eDP-1
[211.349518] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[211.357029] Starting dynamic subtest: pipe-C-eDP-1
[211.359437] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[211.366987] Starting dynamic subtest: pipe-D-eDP-1
[211.369454] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[211.371649] Subtest uint-max-clock: SUCCESS (0.302s)
[212.136595] [035/133] (809s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[212.236174] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[212.238439] Starting dynamic subtest: pipe-A-eDP-1
[212.260959] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[212.270657] Starting dynamic subtest: pipe-B-eDP-1
[212.291623] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[212.299228] Starting dynamic subtest: pipe-C-eDP-1
[212.320061] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[212.327606] Starting dynamic subtest: pipe-D-eDP-1
[212.348868] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[212.353173] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[214.507947] [036/133] (807s left) gem_exec_create (legacy)
[214.586402] Starting subtest: legacy
[214.588814] Starting dynamic subtest: smem
[218.248664] Dynamic subtest smem: SUCCESS (3.660s)
[218.251315] Subtest legacy: SUCCESS (3.662s)
[218.434383] [037/133] (803s left) gem_exec_schedule (implicit-boths)
[218.521833] Starting subtest: implicit-boths
[218.524064] Starting dynamic subtest: rcs0
[218.702605] Dynamic subtest rcs0: SUCCESS (0.181s)
[218.713724] Starting dynamic subtest: vcs0
[218.805764] Dynamic subtest vcs0: SUCCESS (0.102s)
[218.816236] Starting dynamic subtest: vcs1
[218.942992] Dynamic subtest vcs1: SUCCESS (0.137s)
[218.950957] Starting dynamic subtest: vecs0
[219.053114] Dynamic subtest vecs0: SUCCESS (0.109s)
[219.063719] Starting dynamic subtest: ccs0
[219.180637] Dynamic subtest ccs0: SUCCESS (0.127s)
[219.183059] Subtest implicit-boths: SUCCESS (0.661s)
[220.386106] [038/133] (801s left) perf_pmu (busy-idle-no-semaphores)
[220.427454] Starting subtest: busy-idle-no-semaphores
[220.429859] Starting dynamic subtest: rcs0
[221.095419] Dynamic subtest rcs0: SUCCESS (0.668s)
[221.104524] Starting dynamic subtest: bcs0
[221.752462] Dynamic subtest bcs0: SUCCESS (0.654s)
[221.762720] Starting dynamic subtest: vcs0
[222.408046] Dynamic subtest vcs0: SUCCESS (0.652s)
[222.419554] Starting dynamic subtest: vcs1
[223.917851] Dynamic subtest vcs1: SUCCESS (1.507s)
[223.929359] Starting dynamic subtest: vecs0
[225.903826] Dynamic subtest vecs0: SUCCESS (1.983s)
[225.915698] Starting dynamic subtest: ccs0
[227.891458] Dynamic subtest ccs0: SUCCESS (1.985s)
[227.894246] Subtest busy-idle-no-semaphores: SUCCESS (7.465s)
[228.006869] [039/133] (793s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[228.107374] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[228.111722] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[228.201165] [040/133] (793s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[228.289626] Starting subtest: stress-xrgb8888-yftiled
[228.294118] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[228.352894] [041/133] (793s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[228.448684] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[228.453316] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[228.552318] [042/133] (793s left) prime_mmap (test_forked_cpu_write)
[228.609062] Starting subtest: test_forked_cpu_write
[228.610950] Starting dynamic subtest: test_forked_cpu_write-smem
[228.618389] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[228.620818] Subtest test_forked_cpu_write: SUCCESS (0.011s)
[228.728914] [043/133] (793s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[228.825125] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[228.829608] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[228.913357] [044/133] (793s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[229.011605] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[229.013524] Starting dynamic subtest: pipe-A
[229.122569] Dynamic subtest pipe-A: SKIP (0.107s)
[229.130967] Starting dynamic subtest: pipe-B
[230.286769] Dynamic subtest pipe-B: SKIP (1.163s)
[230.295485] Starting dynamic subtest: pipe-C
[231.518462] Dynamic subtest pipe-C: SUCCESS (1.236s)
[231.527162] Starting dynamic subtest: pipe-D
[232.672607] Dynamic subtest pipe-D: SUCCESS (1.154s)
[232.674983] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.663s)
[233.874126] [045/133] (788s left) gem_softpin (allocator-nopin)
[233.941269] Starting subtest: allocator-nopin
[234.018034] Subtest allocator-nopin: SUCCESS (0.077s)
[234.130205] [046/133] (787s left) kms_psr (pr-cursor-plane-move)
[234.212291] Starting subtest: pr-cursor-plane-move
[234.216224] Subtest pr-cursor-plane-move: SKIP (0.000s)
[234.285339] [047/133] (787s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[234.401734] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[237.934381] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.534s)
[239.059342] [048/133] (783s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[239.162819] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[246.416759] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.257s)
[246.550819] [049/133] (775s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[246.653944] Starting subtest: bo-too-small-due-to-tiling
[246.658261] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[246.745670] [050/133] (775s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[246.799084] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[246.801378] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[246.882130] [051/133] (775s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[247.117846] Starting subtest: cursor-rapid-movement-256x256
[247.122685] Starting dynamic subtest: pipe-A-eDP-1
[247.655656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.533s)
[247.681869] Starting dynamic subtest: pipe-D-eDP-1
[248.875501] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.200s)
[248.877923] Subtest cursor-rapid-movement-256x256: SUCCESS (1.757s)
[249.728679] [052/133] (772s left) kms_vblank (wait-forked-busy-hang)
[249.823201] Starting subtest: wait-forked-busy-hang
[249.825499] Starting dynamic subtest: pipe-A-eDP-1
[276.095268] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.270s)
[276.108866] Starting dynamic subtest: pipe-D-eDP-1
[301.057108] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.956s)
[301.059058] Subtest wait-forked-busy-hang: SUCCESS (51.231s)
[301.865020] [053/133] (720s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[301.968888] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[308.576573] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.610s)
[308.700134] [054/133] (713s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[308.749907] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[308.752088] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[308.840611] [055/133] (713s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[308.927928] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[308.932528] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[309.024284] [056/133] (713s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[309.081603] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[309.143194] [057/133] (713s left) api_intel_bb (intel-bb-blit-x)
[309.197242] Starting subtest: intel-bb-blit-x
[312.891639] Subtest intel-bb-blit-x: SUCCESS (3.694s)
[312.999314] [058/133] (709s left) drm_read (invalid-buffer)
[313.139172] Starting subtest: invalid-buffer
[313.141701] Subtest invalid-buffer: SUCCESS (0.000s)
[313.261982] [059/133] (709s left) gem_workarounds (suspend-resume-context)
[313.329021] Starting subtest: suspend-resume-context
[329.238811] Subtest suspend-resume-context: SUCCESS (1.259s)
[329.370726] [060/133] (693s left) gem_exec_fence (syncobj-export)
[329.864010] Starting subtest: syncobj-export
[329.870991] Subtest syncobj-export: SUCCESS (0.006s)
[331.024394] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true
[331.028398] [061/133] (691s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[331.139708] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[340.578024] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.318s)
[340.720530] [062/133] (681s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[340.834945] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[340.839369] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[340.901843] [063/133] (681s left) syncobj_wait (wait-delayed-signal)
[340.959746] Starting subtest: wait-delayed-signal
[341.061549] Subtest wait-delayed-signal: SUCCESS (0.102s)
[341.149759] [064/133] (681s left) gem_pwrite (basic-self)
[341.211547] Subtest basic-self: SKIP (0.000s)
[341.270110] [065/133] (681s left) gem_ctx_persistence (engines-queued)
[341.323960] Starting subtest: engines-queued
[341.326293] Starting dynamic subtest: rcs0
[341.395824] Dynamic subtest rcs0: SUCCESS (0.071s)
[341.412422] Starting dynamic subtest: bcs0
[341.444255] Dynamic subtest bcs0: SUCCESS (0.045s)
[341.456247] Starting dynamic subtest: vcs0
[342.947065] Dynamic subtest vcs0: SUCCESS (1.492s)
[342.960207] Starting dynamic subtest: vcs1
[344.928490] Dynamic subtest vcs1: SUCCESS (1.969s)
[344.941030] Starting dynamic subtest: vecs0
[346.849249] Dynamic subtest vecs0: SUCCESS (1.909s)
[346.862167] Starting dynamic subtest: ccs0
[347.014335] Dynamic subtest ccs0: SUCCESS (0.164s)
[347.017161] Subtest engines-queued: SUCCESS (5.665s)
[347.094910] [066/133] (675s left) kms_feature_discovery (psr1)
[347.191263] Starting subtest: psr1
[347.193647] Subtest psr1: SUCCESS (0.000s)
[347.276664] [067/133] (675s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[347.374950] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[348.155642] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s)
[348.353251] [068/133] (674s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[350.090591] Starting subtest: dpms-mode-unset-lpsp
[354.125077] Subtest dpms-mode-unset-lpsp: SUCCESS (4.031s)
[354.494645] [069/133] (668s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[354.585847] Starting subtest: addfb25-y-tiled-legacy
[354.588039] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[354.677637] [070/133] (668s left) gem_fence_thrash (bo-write-verify-y)
[354.723094] Starting subtest: bo-write-verify-y
[354.742044] Subtest bo-write-verify-y: SKIP (0.018s)
[354.805593] [071/133] (668s left) i915_drm_fdinfo (virtual-idle)
[354.850525] Starting subtest: virtual-idle
[357.894205] Subtest virtual-idle: SUCCESS (3.039s)
[357.972963] [072/133] (665s left) gem_mmap_gtt (basic-read-write)
[358.020968] Subtest basic-read-write: SKIP (0.000s)
[358.084297] [073/133] (665s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[358.148209] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[358.245504] [074/133] (664s left) syncobj_eventfd (timeline-wait-before-signal)
[358.299703] Starting subtest: timeline-wait-before-signal
[358.329072] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[358.409647] [075/133] (664s left) gem_madvise (dontneed-before-mmap)
[358.449633] Starting subtest: dontneed-before-mmap
[358.472441] Subtest dontneed-before-mmap: SUCCESS (0.022s)
[358.577879] [076/133] (664s left) gem_exec_schedule (preempt-self)
[358.654443] Starting subtest: preempt-self
[358.656259] Starting dynamic subtest: rcs0
[358.699263] Dynamic subtest rcs0: SUCCESS (0.050s)
[358.710210] Starting dynamic subtest: bcs0
[358.737650] Dynamic subtest bcs0: SUCCESS (0.037s)
[358.748912] Starting dynamic subtest: vcs0
[358.768070] Dynamic subtest vcs0: SUCCESS (0.030s)
[358.780785] Starting dynamic subtest: vcs1
[358.794666] Dynamic subtest vcs1: SUCCESS (0.026s)
[358.804329] Starting dynamic subtest: vecs0
[358.829854] Dynamic subtest vecs0: SUCCESS (0.033s)
[358.840431] Starting dynamic subtest: ccs0
[358.855875] Dynamic subtest ccs0: SUCCESS (0.026s)
[358.858078] Subtest preempt-self: SUCCESS (0.207s)
[360.056781] [077/133] (663s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[360.161462] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[360.165672] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[360.242681] [078/133] (663s left) kms_plane_cursor (overlay)
[360.334368] Starting subtest: overlay
[360.338187] Starting dynamic subtest: pipe-A-eDP-1-size-64
[362.840683] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.507s)
[362.903855] Starting dynamic subtest: pipe-A-eDP-1-size-128
[365.330988] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.438s)
[365.391481] Starting dynamic subtest: pipe-A-eDP-1-size-256
[367.876756] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.494s)
[368.224150] Starting dynamic subtest: pipe-B-eDP-1-size-64
[371.454492] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.239s)
[371.514944] Starting dynamic subtest: pipe-B-eDP-1-size-128
[373.935377] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.427s)
[373.992961] Starting dynamic subtest: pipe-B-eDP-1-size-256
[376.411741] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.427s)
[376.765544] Starting dynamic subtest: pipe-C-eDP-1-size-64
[379.522552] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.767s)
[379.560818] Starting dynamic subtest: pipe-C-eDP-1-size-128
[381.681389] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.127s)
[381.723539] Starting dynamic subtest: pipe-C-eDP-1-size-256
[383.801822] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.092s)
[384.133898] Starting dynamic subtest: pipe-D-eDP-1-size-64
[386.938090] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.815s)
[386.975693] Starting dynamic subtest: pipe-D-eDP-1-size-128
[389.130418] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.161s)
[389.167437] Starting dynamic subtest: pipe-D-eDP-1-size-256
[391.230286] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.071s)
[391.547571] Subtest overlay: SUCCESS (31.205s)
[392.429834] [079/133] (630s left) kms_vblank (invalid)
[392.540277] Starting subtest: invalid
[392.542412] Starting dynamic subtest: pipe-A-eDP-1
[392.960892] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[392.963073] Subtest invalid: SUCCESS (0.421s)
[393.767363] [080/133] (629s left) gem_mmap_gtt (zero-extend)
[393.831993] Subtest zero-extend: SKIP (0.000s)
[393.895067] [081/133] (629s left) kms_lease (lease-revoke)
[393.986165] Starting subtest: lease-revoke
[393.988428] Starting dynamic subtest: pipe-A-eDP-1
[394.019166] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[394.029986] Starting dynamic subtest: pipe-B-eDP-1
[394.047085] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[394.057471] Starting dynamic subtest: pipe-C-eDP-1
[394.073310] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[394.083685] Starting dynamic subtest: pipe-D-eDP-1
[394.104664] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[394.106807] Subtest lease-revoke: SUCCESS (0.118s)
[394.228390] [082/133] (629s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[394.328046] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[394.330272] Starting dynamic subtest: pipe-A-eDP-1
[394.339243] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[394.351517] Starting dynamic subtest: pipe-B-eDP-1
[394.360141] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[394.369688] Starting dynamic subtest: pipe-C-eDP-1
[394.377818] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[394.386830] Starting dynamic subtest: pipe-D-eDP-1
[394.394828] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[394.398762] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[396.624148] [083/133] (626s left) vgem_basic (bad-handle)
[396.674306] Starting subtest: bad-handle
[396.676578] Subtest bad-handle: SUCCESS (0.000s)
[396.734131] [084/133] (626s left) kms_psr (psr2-cursor-mmap-cpu)
[396.827813] Starting subtest: psr2-cursor-mmap-cpu
[396.830046] Starting dynamic subtest: eDP-1
[398.491964] Dynamic subtest eDP-1: SUCCESS (1.663s)
[398.494300] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.664s)
[399.278525] [085/133] (624s left) gem_mmap_gtt (big-copy-odd)
[399.345876] Subtest big-copy-odd: SKIP (0.000s)
[399.410625] [086/133] (624s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[399.513507] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[400.148803] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.636s)
[400.324701] [087/133] (623s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[400.415788] Starting subtest: flip-vs-dpms-off-vs-modeset
[400.418167] Starting dynamic subtest: A-eDP1
[403.986774] Dynamic subtest A-eDP1: SUCCESS (3.569s)
[404.000947] Starting dynamic subtest: B-eDP1
[407.183212] Dynamic subtest B-eDP1: SUCCESS (3.195s)
[407.196680] Starting dynamic subtest: C-eDP1
[410.297274] Dynamic subtest C-eDP1: SUCCESS (3.112s)
[410.307913] Starting dynamic subtest: D-eDP1
[413.425660] Dynamic subtest D-eDP1: SUCCESS (3.126s)
[413.427989] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.010s)
[414.228824] [088/133] (609s left) kms_setmode (clone-exclusive-crtc)
[414.287855] Starting subtest: clone-exclusive-crtc
[414.293977] Subtest clone-exclusive-crtc: SKIP (0.000s)
[414.387316] [089/133] (609s left) gem_exec_suspend (basic-s4-devices)
[414.442804] Starting subtest: basic-S4-devices
[414.445141] Starting dynamic subtest: smem
[425.985441] Dynamic subtest smem: SUCCESS (11.536s)
[425.988270] Subtest basic-S4-devices: SUCCESS (11.538s)
[433.189751] [090/133] (597s left) gem_eio (in-flight-10ms)
[433.455057] Starting subtest: in-flight-10ms
[442.030343] Subtest in-flight-10ms: SUCCESS (8.572s)
[442.169583] [091/133] (588s left) perf (non-zero-reason)
[442.302618] Starting subtest: non-zero-reason
[442.304931] Starting dynamic subtest: 0-rcs0
[447.607384] Dynamic subtest 0-rcs0: SUCCESS (5.303s)
[447.621826] Starting dynamic subtest: 1-vcs0
[451.471298] Dynamic subtest 1-vcs0: SUCCESS (3.863s)
[451.474032] Subtest non-zero-reason: SUCCESS (9.168s)
[451.522476] [092/133] (579s left) api_intel_allocator (two-level-inception-interruptible)
[451.584671] Starting subtest: two-level-inception-interruptible
[457.007537] Subtest two-level-inception-interruptible: SUCCESS (5.422s)
[457.137400] [093/133] (573s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[457.241009] Starting subtest: fbcpsr-1p-rte
[464.259124] Subtest fbcpsr-1p-rte: SUCCESS (7.021s)
[464.407349] [094/133] (566s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[464.509323] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[464.511610] Starting dynamic subtest: pipe-A-eDP-1
[464.567516] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[464.578236] Starting dynamic subtest: pipe-B-eDP-1
[464.633697] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[464.645335] Starting dynamic subtest: pipe-C-eDP-1
[464.702110] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[464.713314] Starting dynamic subtest: pipe-D-eDP-1
[464.770624] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[464.774942] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[466.845427] [095/133] (564s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[466.944262] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[466.946630] Starting dynamic subtest: pipe-A-eDP-1
[472.841790] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.898s)
[472.852607] Starting dynamic subtest: pipe-B-eDP-1
[479.506504] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.662s)
[479.508724] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.564s)
[480.391879] [096/133] (550s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[480.506523] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[489.832638] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.323s)
[490.635728] [097/133] (540s left) kms_dp_linktrain_fallback (dp-fallback)
[490.738624] Starting subtest: dp-fallback
[490.745313] Subtest dp-fallback: SKIP (0.000s)
[490.813790] [098/133] (540s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[490.907643] Starting subtest: x-tiled-16bpp-rotate-270
[490.927035] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[491.043074] [099/133] (540s left) kms_frontbuffer_tracking (psr-1p-rte)
[491.131821] Starting subtest: psr-1p-rte
[496.577323] Subtest psr-1p-rte: SUCCESS (5.449s)
[496.690003] [100/133] (534s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[496.779398] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[496.781568] Starting dynamic subtest: pipe-A-eDP-1
[496.803833] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[496.816382] Starting dynamic subtest: pipe-B-eDP-1
[496.837380] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[496.846948] Starting dynamic subtest: pipe-C-eDP-1
[496.867942] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[496.877729] Starting dynamic subtest: pipe-D-eDP-1
[496.898626] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[496.902801] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[498.961682] [101/133] (532s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[499.064275] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[499.066485] Starting dynamic subtest: pipe-A-eDP-1
[499.091706] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[499.104271] Starting dynamic subtest: pipe-B-eDP-1
[499.128295] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[499.138009] Starting dynamic subtest: pipe-C-eDP-1
[499.161716] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[499.171453] Starting dynamic subtest: pipe-D-eDP-1
[499.195108] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[499.199425] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[501.327570] [102/133] (530s left) kms_pm_rpm (i2c)
[503.159589] Starting subtest: i2c
[508.557899] Subtest i2c: SUCCESS (5.402s)
[508.694685] [103/133] (522s left) dmabuf_sync_file (export-wait-after-attach)
[508.742062] Starting subtest: export-wait-after-attach
[508.744351] Subtest export-wait-after-attach: SUCCESS (0.001s)
[508.801825] [104/133] (522s left) kms_getfb (getfb-handle-closed)
[508.899230] Starting subtest: getfb-handle-closed
[508.901525] Subtest getfb-handle-closed: SUCCESS (0.000s)
[509.007453] [105/133] (522s left) gem_exec_suspend (basic-s3)
[509.065518] Starting subtest: basic-S3
[509.067826] Starting dynamic subtest: smem
[529.123830] Dynamic subtest smem: SUCCESS (6.802s)
[529.126818] Subtest basic-S3: SUCCESS (6.804s)
[529.316284] [106/133] (502s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[529.421753] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[529.424142] Starting dynamic subtest: pipe-A-eDP-1
[529.509304] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[529.523150] Starting dynamic subtest: pipe-B-eDP-1
[530.656202] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[530.660876] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.214s)
[531.883341] [107/133] (499s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[531.946377] Starting subtest: etime-single-wait-available-unsubmitted
[532.054983] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s)
[532.137669] [108/133] (499s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[532.256346] Starting subtest: verify-pxp-execution-after-suspend-resume
[539.284612] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (6.960s)
[539.431741] [109/133] (492s left) gem_tiled_blits (basic)
[539.520233] Subtest basic: SKIP (0.000s)
[539.594056] [110/133] (492s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[539.688375] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[539.693234] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[539.791137] [111/133] (491s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[539.889328] Starting subtest: psr-rgb101010-draw-mmap-cpu
[546.883214] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.984s)
[546.987899] [112/133] (484s left) gem_ctx_persistence (heartbeat-close)
[547.048896] Starting subtest: heartbeat-close
[547.053511] Subtest heartbeat-close: SKIP (0.000s)
[547.175011] [113/133] (484s left) gen9_exec_parse (secure-batches)
[547.235250] Subtest secure-batches: SKIP (0.000s)
[547.309081] [114/133] (484s left) kms_plane_scaling (planes-scaler-unity-scaling)
[547.401530] Starting subtest: planes-scaler-unity-scaling
[547.403800] Starting dynamic subtest: pipe-A
[547.463499] Dynamic subtest pipe-A: SUCCESS (0.064s)
[547.475344] Starting dynamic subtest: pipe-B
[548.600377] Dynamic subtest pipe-B: SUCCESS (1.131s)
[548.612541] Starting dynamic subtest: pipe-C
[549.710612] Dynamic subtest pipe-C: SUCCESS (1.110s)
[549.727387] Starting dynamic subtest: pipe-D
[550.847613] Dynamic subtest pipe-D: SUCCESS (1.133s)
[550.849834] Subtest planes-scaler-unity-scaling: SUCCESS (3.443s)
[552.006350] [115/133] (479s left) fbdev (pan)
[552.048907] Starting subtest: pan
[552.077116] Subtest pan: SUCCESS (0.032s)
[552.151082] [116/133] (479s left) i915_pm_rps (min-max-config-idle)
[552.206983] Starting subtest: min-max-config-idle
[552.211359] Subtest min-max-config-idle: SKIP (0.001s)
[552.341099] [117/133] (479s left) gem_vm_create (invalid-create)
[552.390570] Starting subtest: invalid-create
[552.393051] Subtest invalid-create: SUCCESS (0.002s)
[552.515240] [118/133] (479s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[552.615571] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[552.619977] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[552.719793] [119/133] (479s left) gem_mmap_wc (copy)
[552.780730] Subtest copy: SKIP (0.000s)
[552.838074] [120/133] (479s left) perf (disabled-read-error)
[552.927844] Starting subtest: disabled-read-error
[552.942393] Subtest disabled-read-error: SUCCESS (0.015s)
[553.026774] [121/133] (479s left) kms_cursor_crc (cursor-sliding-256x85)
[553.281165] Starting subtest: cursor-sliding-256x85
[553.326460] Subtest cursor-sliding-256x85: SKIP (0.040s)
[553.500512] [122/133] (478s left) i915_drm_fdinfo (all-busy-check-all)
[553.545225] Starting subtest: all-busy-check-all
[553.552270] Subtest all-busy-check-all: SKIP (0.005s)
[553.626214] [123/133] (478s left) syncobj_wait (single-wait-submitted)
[553.716258] Starting subtest: single-wait-submitted
[553.822798] Subtest single-wait-submitted: SUCCESS (0.104s)
[553.906238] [124/133] (478s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[554.011230] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[554.015504] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[554.108976] [125/133] (478s left) sriov_basic (enable-vfs-bind-unbind-each)
[554.169946] Starting subtest: enable-vfs-bind-unbind-each
[554.172224] Starting dynamic subtest: numvfs-1
[554.176723] Dynamic subtest numvfs-1: SKIP (0.001s)
[554.188543] Starting dynamic subtest: numvfs-2
[554.192565] Dynamic subtest numvfs-2: SKIP (0.000s)
[554.202463] Starting dynamic subtest: numvfs-3
[554.206699] Dynamic subtest numvfs-3: SKIP (0.000s)
[554.216360] Starting dynamic subtest: numvfs-4
[554.220363] Dynamic subtest numvfs-4: SKIP (0.000s)
[554.230154] Starting dynamic subtest: numvfs-5
[554.234139] Dynamic subtest numvfs-5: SKIP (0.000s)
[554.243679] Starting dynamic subtest: numvfs-6
[554.247568] Dynamic subtest numvfs-6: SKIP (0.000s)
[554.257207] Starting dynamic subtest: numvfs-7
[554.261190] Dynamic subtest numvfs-7: SKIP (0.000s)
[554.270640] Starting dynamic subtest: numvfs-random
[554.274673] Dynamic subtest numvfs-random: SKIP (0.000s)
[554.278658] Subtest enable-vfs-bind-unbind-each: SKIP (0.009s)
[554.316928] [126/133] (478s left) kms_cursor_crc (cursor-onscreen-128x42)
[554.541541] Starting subtest: cursor-onscreen-128x42
[554.588028] Subtest cursor-onscreen-128x42: SKIP (0.040s)
[554.778338] [127/133] (477s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[554.872674] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[554.876091] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[554.978388] [128/133] (477s left) syncobj_timeline (invalid-query-bad-pad)
[555.027800] Starting subtest: invalid-query-bad-pad
[555.029821] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[555.111351] [129/133] (477s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[555.205598] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[558.808391] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.600s)
[560.037425] [130/133] (472s left) kms_psr (fbc-psr2-dpms)
[560.144654] Starting subtest: fbc-psr2-dpms
[560.147093] Starting dynamic subtest: eDP-1
[560.151360] Dynamic subtest eDP-1: SKIP (0.000s)
[560.155625] Subtest fbc-psr2-dpms: SKIP (0.001s)
[560.221516] [131/133] (472s left) gem_exec_whisper (basic-contexts-priority)
[560.280574] Starting subtest: basic-contexts-priority
[583.751820] Subtest basic-contexts-priority: SUCCESS (23.444s)
[583.930506] [132/133] (448s left) gem_exec_balancer (full-late)
[583.982322] Starting subtest: full-late
[589.036423] Subtest full-late: SUCCESS (5.051s)
[589.312797] [133/133] (443s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[589.416420] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[589.420627] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[589.488478] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: i915_query
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_chamelium_frames
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_chamelium_hpd
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_tiled_wb
results: parsing output: 10/ for test: gem_mmap_gtt
results: parsing output: 11/ for test: gem_exec_async
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_addfb_basic
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_exercise_blt
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: kms_atomic
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: i915_selftest
results: parsing output: 23/ for test: kms_color
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: gem_render_copy
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: kms_invalid_mode
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_exec_create
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_pipe_stress
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: prime_mmap
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: gem_softpin
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_pipe_b_c_ivb
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: drm_read
results: parsing output: 58/ for test: gem_workarounds
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_pwrite
results: parsing output: 64/ for test: gem_ctx_persistence
results: parsing output: 65/ for test: kms_feature_discovery
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_pm_rpm
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: gem_fence_thrash
results: parsing output: 70/ for test: i915_drm_fdinfo
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: syncobj_eventfd
results: parsing output: 74/ for test: gem_madvise
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_plane_cursor
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: vgem_basic
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_setmode
results: parsing output: 88/ for test: gem_exec_suspend
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_dp_linktrain_fallback
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: dmabuf_sync_file
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: gem_exec_suspend
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: gem_pxp
results: parsing output: 108/ for test: gem_tiled_blits
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: fbdev
results: parsing output: 115/ for test: i915_pm_rps
results: parsing output: 116/ for test: gem_vm_create
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_mmap_wc
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: i915_drm_fdinfo
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: sriov_basic
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_exec_whisper
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: kms_flip_scaled_crc
Done.