[91.575191] Initializing watchdogs
[91.575238]   /dev/watchdog0
[91.590283] [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]
[91.594662] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.597018] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.600272] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[91.739424] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[91.743733] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[91.841629] [002/133] (960s left) kms_feature_discovery (display-1x)
[91.934738] Starting subtest: display-1x
[91.936935] Subtest display-1x: SUCCESS (0.000s)
[92.003925] [003/133] (960s left) kms_vrr (flipline)
[92.102631] Starting subtest: flipline
[92.109156] Subtest flipline: SKIP (0.000s)
[92.171781] [004/133] (960s left) sw_sync (sync_busy_fork_unixsocket)
[92.207672] Starting subtest: sync_busy_fork_unixsocket
[92.212581] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[92.269528] [005/133] (959s left) kms_rotation_crc (bad-tiling)
[92.364455] Starting subtest: bad-tiling
[92.368643] Subtest bad-tiling: SKIP (0.001s)
[92.431888] [006/133] (959s left) gem_exec_reloc (basic-cpu-active)
[92.488219] Subtest basic-cpu-active: SKIP (0.000s)
[92.554796] [007/133] (959s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[92.615841] Starting subtest: y-tiled-ccs-to-yf-tiled
[92.619326] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[92.793424] [008/133] (959s left) gem_exec_fence (basic-busy)
[92.979245] Starting subtest: basic-busy
[92.981560] Starting dynamic subtest: rcs0
[93.074921] Dynamic subtest rcs0: SUCCESS (0.095s)
[93.083321] Starting dynamic subtest: bcs0
[93.134325] Dynamic subtest bcs0: SUCCESS (0.059s)
[93.142636] Starting dynamic subtest: vcs0
[93.201066] Dynamic subtest vcs0: SUCCESS (0.063s)
[93.208583] Starting dynamic subtest: vcs1
[93.251561] Dynamic subtest vcs1: SUCCESS (0.053s)
[93.259308] Starting dynamic subtest: vecs0
[93.301491] Dynamic subtest vecs0: SUCCESS (0.049s)
[93.308821] Starting dynamic subtest: ccs0
[93.357908] Dynamic subtest ccs0: SUCCESS (0.056s)
[93.360484] Subtest basic-busy: SUCCESS (0.379s)
[95.378564] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[95.381754] [009/133] (957s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[95.492554] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[95.497032] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[95.577130] [010/133] (956s left) gem_caching (writes)
[95.640824] Subtest writes: SKIP (0.000s)
[95.707656] [011/133] (956s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[95.767767] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[95.770041] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[95.864116] [012/133] (956s left) syncobj_timeline (wait-all-for-submit-snapshot)
[95.918685] Starting subtest: wait-all-for-submit-snapshot
[95.998823] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[96.073570] [013/133] (956s left) kms_sequence (queue-busy)
[96.180856] Starting subtest: queue-busy
[96.182908] Starting dynamic subtest: pipe-A-eDP-1
[98.146434] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.964s)
[98.155384] Starting dynamic subtest: pipe-B-eDP-1
[100.740461] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.594s)
[100.750103] Starting dynamic subtest: pipe-C-eDP-1
[103.332987] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.591s)
[103.342820] Starting dynamic subtest: pipe-D-eDP-1
[105.886426] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s)
[105.888921] Subtest queue-busy: SUCCESS (9.706s)
[106.770315] [014/133] (945s left) core_getstats (basic)
[106.830778] Starting subtest: basic
[106.832705] Subtest basic: SUCCESS (0.000s)
[106.932013] [015/133] (945s left) gem_exec_schedule (timeslicing)
[107.010302] Starting subtest: timeslicing
[107.012238] Starting dynamic subtest: rcs0
[107.025297] Dynamic subtest rcs0: SUCCESS (0.022s)
[107.033613] Starting dynamic subtest: bcs0
[107.048343] Dynamic subtest bcs0: SUCCESS (0.023s)
[107.058095] Starting dynamic subtest: vcs0
[107.069538] Dynamic subtest vcs0: SUCCESS (0.020s)
[107.078203] Starting dynamic subtest: vcs1
[107.089609] Dynamic subtest vcs1: SUCCESS (0.020s)
[107.100439] Starting dynamic subtest: vecs0
[107.110156] Dynamic subtest vecs0: SUCCESS (0.020s)
[107.117814] Starting dynamic subtest: ccs0
[107.129666] Dynamic subtest ccs0: SUCCESS (0.019s)
[107.131795] Subtest timeslicing: SUCCESS (0.127s)
[108.349046] [016/133] (944s left) kms_plane_alpha_blend (constant-alpha-min)
[108.435920] Starting subtest: constant-alpha-min
[108.719626] Starting dynamic subtest: pipe-A-eDP-1
[109.435341] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[109.444082] Starting dynamic subtest: pipe-D-eDP-1
[110.977350] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.540s)
[110.979738] Subtest constant-alpha-min: SUCCESS (2.542s)
[111.836012] [017/133] (940s left) kms_addfb_basic (unused-modifier)
[111.884813] Starting subtest: unused-modifier
[111.887167] Subtest unused-modifier: SUCCESS (0.000s)
[112.023213] [018/133] (940s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[112.131985] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[112.136551] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[112.223729] [019/133] (940s left) dmabuf (all-tests)
[112.266648] Starting subtest: all-tests
[112.271333] Subtest all-tests: SKIP (0.000s)
[112.319437] [020/133] (940s left) gem_ctx_engines (execute-oneforall)
[112.383672] Starting subtest: execute-oneforall
[112.863625] Subtest execute-oneforall: SUCCESS (0.482s)
[114.444102] [021/133] (938s left) kms_properties (crtc-properties-legacy)
[114.533830] Starting subtest: crtc-properties-legacy
[114.536165] Starting dynamic subtest: pipe-A-eDP-1
[115.008030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.474s)
[115.017266] Starting dynamic subtest: pipe-B-eDP-1
[116.204054] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.195s)
[116.212869] Starting dynamic subtest: pipe-C-eDP-1
[117.339588] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.135s)
[117.347096] Starting dynamic subtest: pipe-D-eDP-1
[118.474721] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[118.477081] Subtest crtc-properties-legacy: SUCCESS (3.943s)
[119.283800] [022/133] (933s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[119.369283] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[119.373573] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[119.468472] [023/133] (933s left) kms_addfb_basic (bad-pitch-256)
[119.526571] Starting subtest: bad-pitch-256
[119.528874] Subtest bad-pitch-256: SUCCESS (0.000s)
[119.662044] [024/133] (933s left) kms_big_fb (x-tiled-addfb-size-overflow)
[119.761555] Starting subtest: x-tiled-addfb-size-overflow
[119.763875] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[119.857893] [025/133] (933s left) gem_ctx_persistence (hang)
[119.919838] Starting subtest: hang
[119.924472] Subtest hang: SKIP (0.000s)
[120.066454] [026/133] (933s left) gem_mmap_wc (close)
[120.126971] Subtest close: SKIP (0.000s)
[120.194959] [027/133] (932s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[120.277991] Starting subtest: bad-rotation-90-yf-tiled-ccs
[120.279904] Starting dynamic subtest: pipe-A-eDP-1
[120.298026] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[120.306148] Starting dynamic subtest: pipe-B-eDP-1
[120.323984] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[120.330637] Starting dynamic subtest: pipe-C-eDP-1
[120.347660] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[120.354843] Starting dynamic subtest: pipe-D-eDP-1
[120.372326] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[120.375636] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[122.435100] [028/133] (930s left) sw_sync (alloc_fence)
[122.472110] Starting subtest: alloc_fence
[122.474598] Subtest alloc_fence: SUCCESS (0.000s)
[122.519122] [029/133] (930s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[122.614350] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[122.618488] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[122.707404] [030/133] (930s left) i915_suspend (fence-restore-tiled2untiled)
[122.763805] Starting subtest: fence-restore-tiled2untiled
[122.768542] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[122.849043] [031/133] (930s left) i915_hangman (gt-engine-error)
[122.911515] Starting subtest: gt-engine-error
[122.913463] Starting dynamic subtest: rcs0
[124.265308] Dynamic subtest rcs0: SUCCESS (1.353s)
[124.274593] Starting dynamic subtest: bcs0
[126.246224] Dynamic subtest bcs0: SUCCESS (1.980s)
[126.259716] Starting dynamic subtest: vcs0
[128.293812] Dynamic subtest vcs0: SUCCESS (2.046s)
[128.303393] Starting dynamic subtest: vcs1
[130.277214] Dynamic subtest vcs1: SUCCESS (1.982s)
[130.288596] Starting dynamic subtest: vecs0
[132.263717] Dynamic subtest vecs0: SUCCESS (1.985s)
[132.274635] Starting dynamic subtest: ccs0
[134.247887] Dynamic subtest ccs0: SUCCESS (1.982s)
[134.251053] Subtest gt-engine-error: SUCCESS (11.335s)
[134.361997] [032/133] (918s left) kms_content_protection (dp-mst-type-1)
[134.520732] Starting subtest: dp-mst-type-1
[134.525302] Subtest dp-mst-type-1: SKIP (0.000s)
[134.625180] [033/133] (918s left) kms_big_fb (linear-32bpp-rotate-90)
[134.733841] Starting subtest: linear-32bpp-rotate-90
[134.752924] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[134.851983] [034/133] (918s left) kms_plane_cursor (primary)
[134.939548] Starting subtest: primary
[134.943854] Starting dynamic subtest: pipe-A-eDP-1-size-64
[137.513445] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.574s)
[137.536838] Starting dynamic subtest: pipe-A-eDP-1-size-128
[140.125482] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.594s)
[140.149494] Starting dynamic subtest: pipe-A-eDP-1-size-256
[142.716385] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[143.030952] Starting dynamic subtest: pipe-B-eDP-1-size-64
[146.292175] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.273s)
[146.315227] Starting dynamic subtest: pipe-B-eDP-1-size-128
[148.882103] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.572s)
[148.905281] Starting dynamic subtest: pipe-B-eDP-1-size-256
[151.440030] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.539s)
[151.753847] Starting dynamic subtest: pipe-C-eDP-1-size-64
[154.668053] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.922s)
[154.693394] Starting dynamic subtest: pipe-C-eDP-1-size-128
[156.890337] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[156.916450] Starting dynamic subtest: pipe-C-eDP-1-size-256
[159.146291] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.236s)
[159.464684] Starting dynamic subtest: pipe-D-eDP-1-size-64
[162.426716] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.969s)
[162.451545] Starting dynamic subtest: pipe-D-eDP-1-size-128
[164.635107] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[164.660706] Starting dynamic subtest: pipe-D-eDP-1-size-256
[166.846226] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.192s)
[167.157080] Subtest primary: SUCCESS (32.217s)
[167.966237] [035/133] (885s left) kms_psr (fbc-pr-primary-render)
[168.070294] Starting subtest: fbc-pr-primary-render
[168.074592] Subtest fbc-pr-primary-render: SKIP (0.000s)
[168.160954] [036/133] (885s left) gem_lmem_swapping (parallel-random)
[168.208509] Subtest parallel-random: SKIP (0.000s)
[168.252419] [037/133] (885s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[168.306057] Starting subtest: invalid-multi-wait-unsubmitted
[168.308366] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[168.429289] [038/133] (885s left) kms_cursor_crc (cursor-random-64x21)
[168.616887] Starting subtest: cursor-random-64x21
[168.661869] Subtest cursor-random-64x21: SKIP (0.041s)
[168.884587] [039/133] (884s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[168.970460] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[168.972120] Starting dynamic subtest: pipe-A-eDP-1
[171.085576] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.115s)
[171.093256] Starting dynamic subtest: pipe-B-eDP-1
[173.433055] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.345s)
[173.441237] Starting dynamic subtest: pipe-C-eDP-1
[175.634092] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.201s)
[175.643875] Starting dynamic subtest: pipe-D-eDP-1
[177.912961] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.278s)
[177.914880] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.944s)
[179.091192] [040/133] (874s left) gem_caching (read-writes)
[179.161390] Subtest read-writes: SKIP (0.000s)
[179.233705] [041/133] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[179.329279] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[179.333474] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[179.420985] [042/133] (874s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[179.514711] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[183.947473] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.437s)
[185.096179] [043/133] (868s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[185.198061] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[192.532850] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.337s)
[192.682536] [044/133] (861s left) gem_ctx_persistence (engines-mixed)
[192.743278] Starting subtest: engines-mixed
[192.745637] Starting dynamic subtest: rcs0
[192.820915] Dynamic subtest rcs0: SUCCESS (0.076s)
[192.832099] Starting dynamic subtest: bcs0
[192.876960] Dynamic subtest bcs0: SUCCESS (0.055s)
[192.889728] Starting dynamic subtest: vcs0
[192.934897] Dynamic subtest vcs0: SUCCESS (0.056s)
[192.945960] Starting dynamic subtest: vcs1
[192.984055] Dynamic subtest vcs1: SUCCESS (0.047s)
[192.994487] Starting dynamic subtest: vecs0
[193.036409] Dynamic subtest vecs0: SUCCESS (0.050s)
[193.049276] Starting dynamic subtest: ccs0
[193.093973] Dynamic subtest ccs0: SUCCESS (0.056s)
[193.097263] Subtest engines-mixed: SUCCESS (0.352s)
[193.173266] [045/133] (860s left) gen7_exec_parse (basic-offset)
[193.230055] Subtest basic-offset: SKIP (0.000s)
[193.312621] [046/133] (860s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[193.413458] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[193.417495] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[193.524996] [047/133] (860s left) gem_exec_whisper (basic-fds-forked-all)
[193.592349] Starting subtest: basic-fds-forked-all
[213.479296] Subtest basic-fds-forked-all: SUCCESS (19.882s)
[213.661425] [048/133] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[213.765572] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[213.770060] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[213.880856] [049/133] (840s left) kms_joiner (invalid-modeset-force-big-joiner)
[213.975479] Starting subtest: invalid-modeset-force-big-joiner
[213.979686] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[214.043413] [050/133] (840s left) gem_mmap_gtt (big-bo)
[214.102484] Subtest big-bo: SKIP (0.000s)
[214.173707] [051/133] (839s left) gem_exec_alignment (many)
[214.235905] Starting subtest: many
[237.980065] Subtest many: SUCCESS (23.742s)
[239.473693] [052/133] (814s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[239.578530] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[239.684361] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[239.762729] [053/133] (814s left) gem_render_copy (y-tiled)
[239.830445] Starting subtest: y-tiled
[239.834792] Subtest y-tiled: SKIP (0.000s)
[240.014872] [054/133] (814s left) gem_mmap_wc (write-wc-read-gtt)
[240.075553] Subtest write-wc-read-gtt: SKIP (0.000s)
[240.135338] [055/133] (814s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[240.231861] Starting subtest: fb-8bpc-vs-panel-6bpc
[240.234202] Starting dynamic subtest: pipe-A-eDP-1
[241.669311] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.436s)
[241.671467] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.437s)
[242.474120] [056/133] (811s left) kms_vblank (wait-forked-hang)
[242.560412] Starting subtest: wait-forked-hang
[242.562727] Starting dynamic subtest: pipe-A-eDP-1
[269.075519] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.512s)
[269.090466] Starting dynamic subtest: pipe-D-eDP-1
[284.118603] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.042s)
[284.120845] Subtest wait-forked-hang: SUCCESS (41.559s)
[284.926260] [057/133] (769s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[285.039403] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[289.451198] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.414s)
[290.674875] [058/133] (763s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[290.788043] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[291.434486] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[291.608343] [059/133] (762s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[291.704453] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[295.953051] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.251s)
[297.131700] [060/133] (757s left) sw_sync (sync_merge_same)
[297.173543] Starting subtest: sync_merge_same
[297.175936] Subtest sync_merge_same: SUCCESS (0.000s)
[297.223984] [061/133] (757s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[297.323828] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[297.328066] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[297.414090] [062/133] (757s left) kms_busy (basic)
[297.506217] Starting subtest: basic
[297.508457] Starting dynamic subtest: flip
[298.100938] Dynamic subtest flip: SUCCESS (0.594s)
[298.110792] Starting dynamic subtest: modeset
[301.539587] Dynamic subtest modeset: SUCCESS (3.438s)
[301.541827] Subtest basic: SUCCESS (4.036s)
[302.363519] [063/133] (752s left) gem_lmem_swapping (verify-random-ccs)
[302.411540] Subtest verify-random-ccs: SKIP (0.000s)
[302.456503] [064/133] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[302.558647] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[302.562979] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[302.666590] [065/133] (752s left) kms_prop_blob (blob-multiple)
[302.719796] Starting subtest: blob-multiple
[302.722202] Subtest blob-multiple: SUCCESS (0.002s)
[302.819113] [066/133] (751s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[302.905031] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[302.908942] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[302.993076] [067/133] (751s left) kms_psr (fbc-pr-primary-mmap-cpu)
[303.082945] Starting subtest: fbc-pr-primary-mmap-cpu
[303.087372] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[303.169727] [068/133] (751s left) gem_mmap_gtt (zero-extend)
[303.231959] Subtest zero-extend: SKIP (0.000s)
[303.296994] [069/133] (751s left) gem_exec_fence (syncobj-timeline-export)
[303.870515] Starting subtest: syncobj-timeline-export
[303.876697] Subtest syncobj-timeline-export: SUCCESS (0.008s)
[305.369570] [070/133] (749s left) kms_psr (fbc-psr-sprite-plane-onoff)
[305.464908] Starting subtest: fbc-psr-sprite-plane-onoff
[305.467256] Starting dynamic subtest: eDP-1
[305.471573] Dynamic subtest eDP-1: SKIP (0.000s)
[305.475997] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[305.553565] [071/133] (749s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[305.643662] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[305.645891] Starting dynamic subtest: pipe-A-eDP-1
[305.668376] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[305.679307] Starting dynamic subtest: pipe-B-eDP-1
[305.700795] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[305.709779] Starting dynamic subtest: pipe-C-eDP-1
[305.731969] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[305.742750] Starting dynamic subtest: pipe-D-eDP-1
[305.765538] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[305.769855] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[307.901518] [072/133] (747s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[308.027487] Starting subtest: cursorA-vs-flipA-legacy
[319.155761] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.127s)
[320.053098] [073/133] (735s left) kms_atomic_interruptible (legacy-setmode)
[320.156040] Starting subtest: legacy-setmode
[320.158347] Starting dynamic subtest: pipe-A-eDP-1
[327.067937] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.911s)
[327.070218] Subtest legacy-setmode: SUCCESS (6.913s)
[327.933752] [074/133] (727s left) i915_pm_rps (reset)
[327.996345] Starting subtest: reset
[336.455755] Subtest reset: SUCCESS (8.458s)
[336.565990] [075/133] (718s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[336.657912] Starting subtest: crc-primary-suspend-y-tiled-ccs
[336.660239] Starting dynamic subtest: pipe-A-eDP-1
[336.669324] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[336.680155] Starting dynamic subtest: pipe-B-eDP-1
[336.689342] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[336.698511] Starting dynamic subtest: pipe-C-eDP-1
[336.707100] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[336.715916] Starting dynamic subtest: pipe-D-eDP-1
[336.724402] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[336.728441] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[338.906450] [076/133] (716s left) kms_addfb_basic (small-bo)
[338.997708] Starting subtest: small-bo
[338.999549] Subtest small-bo: SUCCESS (0.000s)
[339.090393] [077/133] (716s left) kms_addfb_basic (invalid-get-prop-any)
[339.146780] Starting subtest: invalid-get-prop-any
[339.148752] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[339.283112] [078/133] (716s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[339.381103] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[339.396613] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.014s)
[339.494374] [079/133] (715s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[339.587227] Starting subtest: psr-indfb-scaledprimary
[345.394130] Subtest psr-indfb-scaledprimary: SUCCESS (5.810s)
[345.534656] [080/133] (709s left) gem_close (many-handles-one-vma)
[345.594710] Starting subtest: many-handles-one-vma
[345.619494] Subtest many-handles-one-vma: SUCCESS (0.025s)
[345.732321] [081/133] (709s left) kms_plane (plane-panning-bottom-right)
[345.826030] Starting subtest: plane-panning-bottom-right
[345.828258] Starting dynamic subtest: pipe-A
[347.493728] Dynamic subtest pipe-A: SUCCESS (1.665s)
[347.503745] Starting dynamic subtest: pipe-B
[349.880765] Dynamic subtest pipe-B: SUCCESS (2.386s)
[349.882952] Subtest plane-panning-bottom-right: SUCCESS (4.055s)
[350.688269] [082/133] (704s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[350.801378] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[350.805883] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[350.945854] [083/133] (704s left) kms_cursor_edge_walk (128x128-top-edge)
[351.043214] Starting subtest: 128x128-top-edge
[351.045519] Starting dynamic subtest: pipe-A-eDP-1
[354.468831] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[354.481585] Starting dynamic subtest: pipe-D-eDP-1
[357.590984] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[357.593617] Subtest 128x128-top-edge: SUCCESS (6.550s)
[358.405085] [084/133] (697s left) gen7_exec_parse (chained-batch)
[358.481540] Subtest chained-batch: SKIP (0.000s)
[358.558503] [085/133] (697s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[358.645926] Starting subtest: primary-yf-tiled-reflect-x-180
[358.705681] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[358.810685] [086/133] (696s left) kms_frontbuffer_tracking (fbc-tiling-y)
[358.919762] Starting subtest: fbc-tiling-y
[358.924082] Subtest fbc-tiling-y: SKIP (0.000s)
[359.014809] [087/133] (696s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[359.060112] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[359.164061] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[359.254070] [088/133] (696s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[359.356732] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[359.361110] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[359.446050] [089/133] (696s left) kms_cursor_crc (cursor-onscreen-64x21)
[359.640727] Starting subtest: cursor-onscreen-64x21
[359.688918] Subtest cursor-onscreen-64x21: SKIP (0.044s)
[359.941028] [090/133] (695s left) kms_rmfb (close-fd)
[360.045727] Starting subtest: close-fd
[360.047904] Starting dynamic subtest: pipe-A-eDP-1
[360.158044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.110s)
[360.167561] Starting dynamic subtest: pipe-B-eDP-1
[361.368343] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.210s)
[361.381436] Starting dynamic subtest: pipe-C-eDP-1
[362.581323] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s)
[362.591783] Starting dynamic subtest: pipe-D-eDP-1
[363.726042] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.143s)
[363.728228] Subtest close-fd: SUCCESS (3.681s)
[364.936475] [091/133] (690s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[365.063440] Starting subtest: 2x-long-cursor-vs-flip-legacy
[365.068063] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[365.223953] [092/133] (690s left) gem_softpin (evict-prime-sanity-check)
[365.279634] Starting subtest: evict-prime-sanity-check
[365.282017] Starting dynamic subtest: rcs0
[366.425257] Dynamic subtest rcs0: SUCCESS (1.145s)
[366.437885] Starting dynamic subtest: bcs0
[367.551037] Dynamic subtest bcs0: SUCCESS (1.123s)
[367.563461] Starting dynamic subtest: vcs0
[369.289420] Dynamic subtest vcs0: SUCCESS (1.735s)
[369.301945] Starting dynamic subtest: vcs1
[371.272309] Dynamic subtest vcs1: SUCCESS (1.981s)
[371.284885] Starting dynamic subtest: vecs0
[373.249268] Dynamic subtest vecs0: SUCCESS (1.974s)
[373.264239] Starting dynamic subtest: ccs0
[374.364982] Dynamic subtest ccs0: SUCCESS (1.115s)
[374.378075] Starting dynamic subtest: all
[375.485784] Dynamic subtest all: SUCCESS (1.118s)
[375.488407] Subtest evict-prime-sanity-check: SUCCESS (10.206s)
[375.571160] [093/133] (680s left) kms_psr (pr-basic)
[375.664867] Starting subtest: pr-basic
[375.669153] Subtest pr-basic: SKIP (0.000s)
[375.754305] [094/133] (680s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[375.817337] Starting subtest: multi-wait-all-for-submit-signaled
[375.819257] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[375.904603] [095/133] (680s left) i915_drm_fdinfo (busy-idle)
[375.946747] Starting subtest: busy-idle
[375.949058] Starting dynamic subtest: rcs0
[375.966679] Dynamic subtest rcs0: SKIP (0.017s)
[375.976729] Starting dynamic subtest: bcs0
[375.981355] Dynamic subtest bcs0: SKIP (0.008s)
[375.990565] Starting dynamic subtest: vcs0
[375.994621] Dynamic subtest vcs0: SKIP (0.000s)
[376.003638] Starting dynamic subtest: vcs1
[376.008031] Dynamic subtest vcs1: SKIP (0.001s)
[376.017187] Starting dynamic subtest: vecs0
[376.021201] Dynamic subtest vecs0: SKIP (0.000s)
[376.029746] Starting dynamic subtest: ccs0
[376.033985] Dynamic subtest ccs0: SKIP (0.001s)
[376.038165] Subtest busy-idle: SKIP (0.037s)
[376.077498] [096/133] (680s left) kms_plane_scaling (planes-downscale-factor-0-5)
[376.166059] Starting subtest: planes-downscale-factor-0-5
[376.168296] Starting dynamic subtest: pipe-A
[376.188195] Dynamic subtest pipe-A: SKIP (0.018s)
[376.198307] Starting dynamic subtest: pipe-B
[376.220522] Dynamic subtest pipe-B: SKIP (0.031s)
[376.230655] Starting dynamic subtest: pipe-C
[376.251269] Dynamic subtest pipe-C: SKIP (0.031s)
[376.260866] Starting dynamic subtest: pipe-D
[376.283075] Dynamic subtest pipe-D: SKIP (0.031s)
[376.286847] Subtest planes-downscale-factor-0-5: SKIP (0.113s)
[376.405416] [097/133] (679s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[376.513773] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[376.517437] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[376.621065] [098/133] (679s left) gem_ccs (large-ctrl-surf-copy)
[376.667576] Starting subtest: large-ctrl-surf-copy
[376.671165] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[376.764151] [099/133] (679s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[376.867965] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[376.871456] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[376.976316] [100/133] (679s left) perf_pmu (invalid-open)
[377.025500] Starting subtest: invalid-open
[377.027256] Subtest invalid-open: SUCCESS (0.000s)
[377.128382] [101/133] (679s left) gem_exec_balancer (nop)
[377.204568] Starting subtest: nop
[423.857543] Subtest nop: SUCCESS (46.651s)
[424.175049] [102/133] (632s left) vgem_basic (bad-pad)
[424.228200] Starting subtest: bad-pad
[424.230372] Subtest bad-pad: SUCCESS (0.000s)
[424.288414] [103/133] (632s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[424.383646] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[424.385500] Starting dynamic subtest: pipe-A-eDP-1
[425.671783] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.287s)
[425.953445] Starting dynamic subtest: pipe-B-eDP-1
[427.038733] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.093s)
[427.308579] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.924s)
[428.118593] [104/133] (628s left) kms_atomic_transition (modeset-transition)
[428.227074] Starting subtest: modeset-transition
[428.229229] Starting dynamic subtest: 1x-outputs
[439.071075] Dynamic subtest 1x-outputs: SUCCESS (10.844s)
[439.073579] Subtest modeset-transition: SUCCESS (10.846s)
[439.935842] [105/133] (616s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[440.325680] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[441.151470] [106/133] (615s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[441.208769] Starting subtest: multi-wait-available-unsubmitted-submitted
[441.210992] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[441.319881] [107/133] (615s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[441.365480] Starting subtest: yf-tiled-ccs-to-x-tiled
[441.369969] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[441.552756] [108/133] (615s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[441.646157] Starting subtest: addfb25-y-tiled-legacy
[441.648323] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[441.757340] [109/133] (614s left) sw_sync (timeline_closed_signaled)
[441.793756] Starting subtest: timeline_closed_signaled
[441.795980] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[441.846782] [110/133] (614s left) kms_cdclk (mode-transition)
[441.942197] Starting subtest: mode-transition
[441.944411] Starting dynamic subtest: pipe-A-eDP-1
[442.233250] Dynamic subtest pipe-A-eDP-1: SKIP (0.290s)
[442.242920] Starting dynamic subtest: pipe-B-eDP-1
[442.247635] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[442.258667] Starting dynamic subtest: pipe-C-eDP-1
[442.263367] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[442.274067] Starting dynamic subtest: pipe-D-eDP-1
[442.278056] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[442.282013] Subtest mode-transition: SKIP (0.298s)
[443.102423] [111/133] (613s left) gem_exec_reloc (basic-wc-read)
[443.166022] Subtest basic-wc-read: SKIP (0.000s)
[443.252120] [112/133] (613s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[443.350803] Starting subtest: plane-lut1d-ctm3x4
[443.508556] Starting dynamic subtest: pipe-A-plane-0
[443.685973] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[443.702448] Starting dynamic subtest: pipe-A-plane-1
[443.863657] Dynamic subtest pipe-A-plane-1: SUCCESS (0.176s)
[443.873496] Starting dynamic subtest: pipe-A-plane-2
[444.030182] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[445.179393] Starting dynamic subtest: pipe-B-plane-0
[445.337371] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[445.347632] Starting dynamic subtest: pipe-B-plane-1
[445.504613] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[445.519609] Starting dynamic subtest: pipe-B-plane-2
[445.715980] Dynamic subtest pipe-B-plane-2: SUCCESS (0.207s)
[446.906722] Starting dynamic subtest: pipe-C-plane-0
[447.054789] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[447.067238] Starting dynamic subtest: pipe-C-plane-1
[447.199307] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[447.209078] Starting dynamic subtest: pipe-C-plane-2
[447.343443] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[448.540804] Starting dynamic subtest: pipe-D-plane-0
[448.676870] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[448.688175] Starting dynamic subtest: pipe-D-plane-1
[448.831481] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[448.842693] Starting dynamic subtest: pipe-D-plane-2
[448.975842] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[449.262590] Subtest plane-lut1d-ctm3x4: SUCCESS (5.913s)
[450.121507] [113/133] (606s left) kms_pm_rpm (drm-resources-equal)
[451.653742] Starting subtest: drm-resources-equal
[457.006068] Subtest drm-resources-equal: SUCCESS (5.354s)
[457.109277] [114/133] (599s left) perf (i915-ref-count)
[457.195463] Starting subtest: i915-ref-count
[457.257049] Subtest i915-ref-count: SUCCESS (0.059s)
[457.314021] [115/133] (599s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[457.406721] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[464.300912] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.897s)
[464.407585] [116/133] (592s left) api_intel_bb (bb-with-allocator)
[464.463807] Starting subtest: bb-with-allocator
[464.468604] Subtest bb-with-allocator: SUCCESS (0.006s)
[464.586710] [117/133] (592s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[464.674443] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[464.678426] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[464.750157] [118/133] (592s left) gem_tiled_blits (normal)
[464.810531] Subtest normal: SKIP (0.000s)
[464.876992] [119/133] (592s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[464.967929] Starting subtest: pixel-format-y-tiled-ccs-modifier
[464.972106] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[465.040049] [120/133] (592s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[465.162818] Starting subtest: cursorA-vs-flipB-varying-size
[465.167218] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[465.316854] [121/133] (591s left) gem_mmap_wc (write-cpu-read-wc)
[465.386110] Subtest write-cpu-read-wc: SKIP (0.000s)
[465.458581] [122/133] (591s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[465.554611] Starting subtest: pr-plane-move-sf-dmg-area
[465.558110] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[465.625925] [123/133] (591s left) kms_legacy_colorkey (invalid-plane)
[465.708512] Starting subtest: invalid-plane
[465.710515] Starting dynamic subtest: zero-id
[465.712136] Dynamic subtest zero-id: SUCCESS (0.000s)
[465.728843] Starting dynamic subtest: outrange-id
[465.731097] Dynamic subtest outrange-id: SUCCESS (0.000s)
[465.733266] Subtest invalid-plane: SUCCESS (0.001s)
[465.796210] [124/133] (591s left) kms_properties (colorop-properties-legacy)
[465.882447] Starting subtest: colorop-properties-legacy
[465.884212] Starting dynamic subtest: pipe-A-eDP-1
[466.245032] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s)
[466.255104] Starting dynamic subtest: pipe-B-eDP-1
[467.329104] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.082s)
[467.339757] Starting dynamic subtest: pipe-C-eDP-1
[468.364591] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.032s)
[468.375635] Starting dynamic subtest: pipe-D-eDP-1
[469.407350] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.043s)
[469.409624] Subtest colorop-properties-legacy: SUCCESS (3.526s)
[470.205989] [125/133] (587s left) gem_create (create-valid-nonaligned)
[470.267561] Starting subtest: create-valid-nonaligned
[470.269734] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[470.480386] [126/133] (586s left) gem_render_copy_redux (flink-interruptible)
[470.548556] Starting subtest: flink-interruptible
[471.376502] Subtest flink-interruptible: SUCCESS (0.828s)
[471.517699] [127/133] (585s left) kms_psr (psr-basic)
[471.613511] Starting subtest: psr-basic
[471.615475] Starting dynamic subtest: eDP-1
[473.204797] Dynamic subtest eDP-1: SUCCESS (1.591s)
[473.207085] Subtest psr-basic: SUCCESS (1.592s)
[474.090999] [128/133] (583s left) kms_psr (psr-primary-render)
[474.197282] Starting subtest: psr-primary-render
[474.199386] Starting dynamic subtest: eDP-1
[475.896084] Dynamic subtest eDP-1: SUCCESS (1.699s)
[475.898218] Subtest psr-primary-render: SUCCESS (1.700s)
[476.750640] [129/133] (580s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[476.842469] Starting subtest: yf-tiled-64bpp-rotate-90
[476.846937] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[476.975998] [130/133] (580s left) gem_exec_schedule (pi-shared-iova)
[477.155942] Starting subtest: pi-shared-iova
[477.157894] Starting dynamic subtest: rcs0
[477.234098] Dynamic subtest rcs0: SUCCESS (0.079s)
[477.245927] Starting dynamic subtest: vcs0
[477.292293] Dynamic subtest vcs0: SUCCESS (0.058s)
[477.303089] Starting dynamic subtest: vcs1
[477.355020] Dynamic subtest vcs1: SUCCESS (0.062s)
[477.368023] Starting dynamic subtest: vecs0
[477.415929] Dynamic subtest vecs0: SUCCESS (0.061s)
[477.427131] Starting dynamic subtest: ccs0
[477.486101] Dynamic subtest ccs0: SUCCESS (0.069s)
[477.488337] Subtest pi-shared-iova: SUCCESS (0.333s)
[479.402087] [131/133] (578s left) gem_exec_reloc (basic-active)
[479.458341] Subtest basic-active: SKIP (0.000s)
[479.532182] [132/133] (578s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[479.924227] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[480.748433] [133/133] (576s left) prime_busy (hang-wait)
[480.804579] Starting subtest: hang-wait
[480.806912] Starting dynamic subtest: rcs0
[506.787102] Dynamic subtest rcs0: SUCCESS (25.976s)
[506.798664] Starting dynamic subtest: bcs0
[513.879687] Dynamic subtest bcs0: SUCCESS (7.093s)
[513.891375] Starting dynamic subtest: vcs0
[520.922277] Dynamic subtest vcs0: SUCCESS (7.039s)
[520.933815] Starting dynamic subtest: vcs1
[527.893866] Dynamic subtest vcs1: SUCCESS (6.969s)
[527.904748] Starting dynamic subtest: vecs0
[534.934568] Dynamic subtest vecs0: SUCCESS (7.039s)
[534.944226] Starting dynamic subtest: ccs0
[548.774622] Dynamic subtest ccs0: SUCCESS (13.837s)
[548.776779] Subtest hang-wait: SUCCESS (67.965s)
[548.890987] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_feature_discovery
results: parsing output: 2/ for test: kms_vrr
results: parsing output: 3/ for test: sw_sync
results: parsing output: 4/ for test: kms_rotation_crc
results: parsing output: 5/ for test: gem_exec_reloc
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_caching
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_sequence
results: parsing output: 13/ for test: core_getstats
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_plane_alpha_blend
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: dmabuf
results: parsing output: 19/ for test: gem_ctx_engines
results: parsing output: 20/ for test: kms_properties
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: gem_mmap_wc
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: sw_sync
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: i915_suspend
results: parsing output: 30/ for test: i915_hangman
results: parsing output: 31/ for test: kms_content_protection
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_plane_cursor
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_lmem_swapping
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_caching
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: gen7_exec_parse
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_whisper
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_joiner
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: gem_exec_alignment
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: gem_mmap_wc
results: parsing output: 54/ for test: kms_dither
results: parsing output: 55/ for test: kms_vblank
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: sw_sync
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_busy
results: parsing output: 62/ for test: gem_lmem_swapping
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_prop_blob
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: gem_exec_fence
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_atomic_interruptible
results: parsing output: 73/ for test: i915_pm_rps
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_close
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_cursor_edge_walk
results: parsing output: 83/ for test: gen7_exec_parse
results: parsing output: 84/ for test: kms_rotation_crc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_rmfb
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_softpin
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_ccs
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: vgem_basic
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: kms_atomic_transition
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: sw_sync
results: parsing output: 109/ for test: kms_cdclk
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: kms_color_pipeline
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: gem_tiled_blits
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: kms_legacy_colorkey
results: parsing output: 123/ for test: kms_properties
results: parsing output: 124/ for test: gem_create
results: parsing output: 125/ for test: gem_render_copy_redux
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_chamelium_edid
results: parsing output: 132/ for test: prime_busy
Done.