[57.152382] Initializing watchdogs
[57.152433]   /dev/watchdog0
[57.167441] [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]
[57.172022] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.174317] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.178763] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[57.314192] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[57.318461] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[57.418867] [002/133] (960s left) gem_exec_schedule (u-semaphore-noskip)
[57.493333] Starting subtest: u-semaphore-noskip
[57.892359] Subtest u-semaphore-noskip: SUCCESS (0.400s)
[58.249777] [003/133] (959s left) gem_ppgtt (shrink-vs-evict-pinned)
[58.315875] Starting subtest: shrink-vs-evict-pinned
[64.330989] Subtest shrink-vs-evict-pinned: SUCCESS (5.960s)
[64.370797] [004/133] (953s left) kms_setmode (basic)
[64.431128] Starting subtest: basic
[64.801634] Starting dynamic subtest: pipe-A-eDP-1
[66.825361] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.019s)
[67.172367] Starting dynamic subtest: pipe-B-eDP-1
[69.255069] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.085s)
[69.567150] Subtest basic: SUCCESS (5.137s)
[70.400552] [005/133] (947s left) kms_atomic_transition (plane-all-transition-fencing)
[70.488570] Starting subtest: plane-all-transition-fencing
[70.490781] Starting dynamic subtest: pipe-A-eDP-1
[73.027282] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.540s)
[73.334286] Starting dynamic subtest: pipe-B-eDP-1
[76.541369] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.216s)
[76.850946] Subtest plane-all-transition-fencing: SUCCESS (6.362s)
[77.680739] [006/133] (940s left) kms_color (invalid-ctm-matrix-sizes)
[77.785100] Starting subtest: invalid-ctm-matrix-sizes
[77.787400] Starting dynamic subtest: pipe-A
[77.789778] Dynamic subtest pipe-A: SUCCESS (0.002s)
[77.799221] Starting dynamic subtest: pipe-B
[77.801084] Dynamic subtest pipe-B: SUCCESS (0.003s)
[77.808654] Starting dynamic subtest: pipe-C
[77.811055] Dynamic subtest pipe-C: SUCCESS (0.003s)
[77.818957] Starting dynamic subtest: pipe-D
[77.821296] Dynamic subtest pipe-D: SUCCESS (0.004s)
[77.823193] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.013s)
[77.864594] [007/133] (940s left) kms_lease (lease-get)
[77.960455] Starting subtest: lease-get
[77.962912] Starting dynamic subtest: pipe-A-eDP-1
[77.965256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[77.977091] Starting dynamic subtest: pipe-B-eDP-1
[77.979209] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[77.987187] Starting dynamic subtest: pipe-C-eDP-1
[77.989303] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[77.997095] Starting dynamic subtest: pipe-D-eDP-1
[77.999137] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[78.001168] Subtest lease-get: SUCCESS (0.007s)
[78.065918] [008/133] (939s left) kms_cursor_crc (cursor-sliding-512x170)
[78.353924] Starting subtest: cursor-sliding-512x170
[78.357790] Subtest cursor-sliding-512x170: SKIP (0.001s)
[78.487147] [009/133] (939s left) syncobj_timeline (device-submit-unordered)
[78.546830] Starting subtest: device-submit-unordered
[78.549119] Subtest device-submit-unordered: SUCCESS (0.001s)
[78.636594] [010/133] (939s left) kms_flip (dpms-off-confusion)
[78.728026] Starting subtest: dpms-off-confusion
[78.730270] Starting dynamic subtest: A-eDP1
[87.417529] Dynamic subtest A-eDP1: SUCCESS (8.655s)
[87.425530] Starting dynamic subtest: B-eDP1
[96.043810] Dynamic subtest B-eDP1: SUCCESS (8.622s)
[96.054884] Starting dynamic subtest: C-eDP1
[104.680733] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[104.693818] Starting dynamic subtest: D-eDP1
[113.317195] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[113.319231] Subtest dpms-off-confusion: SUCCESS (34.543s)
[114.451996] [011/133] (903s left) gem_lmem_swapping (random-engines)
[114.499029] Subtest random-engines: SKIP (0.000s)
[114.538297] [012/133] (903s left) gem_exec_whisper (basic-forked)
[114.600026] Starting subtest: basic-forked
[121.819235] Subtest basic-forked: SUCCESS (7.216s)
[121.999829] [013/133] (896s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[122.105714] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[128.866077] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.765s)
[129.000441] [014/133] (889s left) kms_psr (fbc-pr-cursor-blt)
[129.099539] Starting subtest: fbc-pr-cursor-blt
[129.103830] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[129.168757] [015/133] (889s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[129.310545] Starting subtest: dp-mst-type-0-suspend-resume
[129.315417] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[129.424007] [016/133] (888s left) kms_dp_linktrain_fallback (dp-fallback)
[129.502693] Starting subtest: dp-fallback
[129.509308] Subtest dp-fallback: SKIP (0.000s)
[129.585294] [017/133] (888s left) gem_mmap_gtt (zero-extend)
[129.646263] Subtest zero-extend: SKIP (0.000s)
[129.706225] [018/133] (888s left) gem_mmap_gtt (basic-small-bo-tiledx)
[129.771770] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[129.837609] [019/133] (888s left) kms_properties (crtc-properties-legacy)
[129.926082] Starting subtest: crtc-properties-legacy
[129.927899] Starting dynamic subtest: pipe-A-eDP-1
[130.371431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.445s)
[130.381506] Starting dynamic subtest: pipe-B-eDP-1
[131.552395] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.180s)
[131.562636] Starting dynamic subtest: pipe-C-eDP-1
[132.675210] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[132.684956] Starting dynamic subtest: pipe-D-eDP-1
[133.812429] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[133.814340] Subtest crtc-properties-legacy: SUCCESS (3.886s)
[134.615797] [020/133] (883s left) kms_big_fb (yf-tiled-addfb)
[134.711223] Starting subtest: yf-tiled-addfb
[134.715526] Subtest yf-tiled-addfb: SKIP (0.000s)
[134.801423] [021/133] (883s left) syncobj_basic (bad-destroy)
[134.868073] Starting subtest: bad-destroy
[134.870350] Subtest bad-destroy: SUCCESS (0.000s)
[134.980463] [022/133] (883s left) kms_sequence (get-forked-busy)
[135.064150] Starting subtest: get-forked-busy
[135.066479] Starting dynamic subtest: pipe-A-eDP-1
[136.999915] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[137.009958] Starting dynamic subtest: pipe-B-eDP-1
[139.617443] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.619s)
[139.626670] Starting dynamic subtest: pipe-C-eDP-1
[142.242372] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.621s)
[142.255620] Starting dynamic subtest: pipe-D-eDP-1
[144.887094] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.643s)
[144.889287] Subtest get-forked-busy: SUCCESS (9.823s)
[145.749923] [023/133] (872s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[145.842572] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[145.846893] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[145.932962] [024/133] (872s left) kms_cursor_crc (cursor-offscreen-128x42)
[146.165645] Starting subtest: cursor-offscreen-128x42
[146.214434] Subtest cursor-offscreen-128x42: SKIP (0.043s)
[146.425262] [025/133] (872s left) fbdev (unaligned-read)
[146.474102] Starting subtest: unaligned-read
[146.488504] Subtest unaligned-read: SUCCESS (0.014s)
[146.558147] [026/133] (872s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[146.651121] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[146.653453] Starting dynamic subtest: pipe-A-eDP-1
[146.676726] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[146.687429] Starting dynamic subtest: pipe-B-eDP-1
[146.706324] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[146.714320] Starting dynamic subtest: pipe-C-eDP-1
[146.732387] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[146.740340] Starting dynamic subtest: pipe-D-eDP-1
[146.758524] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[146.762098] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[148.827921] [027/133] (869s left) kms_psr (pr-cursor-mmap-gtt)
[148.924713] Starting subtest: pr-cursor-mmap-gtt
[148.929229] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[149.003707] [028/133] (869s left) kms_rotation_crc (sprite-rotation-270)
[149.102952] Starting subtest: sprite-rotation-270
[149.107602] Subtest sprite-rotation-270: SKIP (0.001s)
[149.173134] [029/133] (869s left) gem_ctx_sseu (engines)
[149.235220] Subtest engines: SKIP (0.000s)
[149.299385] [030/133] (869s left) kms_dsc (dsc-with-bpc)
[149.401713] Starting subtest: dsc-with-bpc
[149.431260] Subtest dsc-with-bpc: SKIP (0.001s)
[149.485555] [031/133] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[149.585998] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[149.590248] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[149.675966] [032/133] (869s left) kms_invalid_mode (clock-too-high)
[149.778113] Starting subtest: clock-too-high
[149.779883] Starting dynamic subtest: pipe-A-eDP-1
[150.070189] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[150.080832] Starting dynamic subtest: pipe-B-eDP-1
[150.085284] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[150.093787] Starting dynamic subtest: pipe-C-eDP-1
[150.097890] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[150.108357] Starting dynamic subtest: pipe-D-eDP-1
[150.112789] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[150.115058] Subtest clock-too-high: SUCCESS (0.298s)
[150.871182] [033/133] (868s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[150.973954] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[150.978049] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[151.045288] [034/133] (867s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[151.151181] Starting subtest: 4-tiled-64bpp-rotate-180
[152.741563] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.591s)
[152.931205] [035/133] (866s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[153.034604] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[153.047178] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[153.122957] [036/133] (865s left) gem_userptr_blits (sync-unmap-cycles)
[153.195381] Starting subtest: sync-unmap-cycles
[158.570686] Subtest sync-unmap-cycles: SUCCESS (5.375s)
[158.704377] [037/133] (860s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[158.808557] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[158.811814] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[158.902690] [038/133] (860s left) syncobj_basic (bad-pad-fd-to-handle)
[158.963649] Starting subtest: bad-pad-fd-to-handle
[158.965337] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[159.062588] [039/133] (860s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[159.156994] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[159.158887] Starting dynamic subtest: pipe-A-eDP-1
[159.166342] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[159.176091] Starting dynamic subtest: pipe-B-eDP-1
[159.183483] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[159.192580] Starting dynamic subtest: pipe-C-eDP-1
[159.198735] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[159.206867] Starting dynamic subtest: pipe-D-eDP-1
[159.213815] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[159.217192] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[161.434132] [040/133] (857s left) syncobj_wait (multi-wait-all-signaled)
[161.490298] Starting subtest: multi-wait-all-signaled
[161.492173] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[161.585425] [041/133] (857s left) prime_vgem (fence-wait)
[161.737671] Starting subtest: fence-wait
[161.739978] Starting dynamic subtest: rcs0
[162.782419] Dynamic subtest rcs0: SUCCESS (1.043s)
[162.796728] Starting dynamic subtest: bcs0
[163.832438] Dynamic subtest bcs0: SUCCESS (1.048s)
[163.843930] Starting dynamic subtest: vcs0
[164.876469] Dynamic subtest vcs0: SUCCESS (1.042s)
[164.887937] Starting dynamic subtest: vcs1
[165.921078] Dynamic subtest vcs1: SUCCESS (1.043s)
[165.932620] Starting dynamic subtest: vecs0
[166.962643] Dynamic subtest vecs0: SUCCESS (1.040s)
[166.974226] Starting dynamic subtest: ccs0
[168.006543] Dynamic subtest ccs0: SUCCESS (1.042s)
[168.009473] Subtest fence-wait: SUCCESS (6.269s)
[168.114196] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[168.117714] [042/133] (851s left) gem_exec_balancer (hog)
[168.181859] Starting subtest: hog
[168.186536] Subtest hog: SKIP (0.000s)
[168.487895] [043/133] (850s left) gem_exec_parallel (userptr)
[168.554185] Starting subtest: userptr
[168.556537] Starting dynamic subtest: rcs0
[170.062592] Dynamic subtest rcs0: SUCCESS (1.508s)
[170.074685] Starting dynamic subtest: bcs0
[171.567692] Dynamic subtest bcs0: SUCCESS (1.503s)
[171.581203] Starting dynamic subtest: vcs0
[173.245122] Dynamic subtest vcs0: SUCCESS (1.673s)
[173.255039] Starting dynamic subtest: vcs1
[175.293430] Dynamic subtest vcs1: SUCCESS (2.046s)
[175.305684] Starting dynamic subtest: vecs0
[177.276639] Dynamic subtest vecs0: SUCCESS (1.980s)
[177.289864] Starting dynamic subtest: ccs0
[178.773633] Dynamic subtest ccs0: SUCCESS (1.497s)
[178.776074] Subtest userptr: SUCCESS (10.221s)
[178.964352] [044/133] (840s left) kms_getfb (getfb-handle-zero)
[179.065078] Starting subtest: getfb-handle-zero
[179.067399] Subtest getfb-handle-zero: SUCCESS (0.000s)
[179.187398] [045/133] (840s left) prime_vgem (basic-read)
[179.259812] Starting subtest: basic-read
[179.282253] Subtest basic-read: SKIP (0.020s)
[179.377722] [046/133] (840s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[179.475891] Starting subtest: disable-crc-after-crtc
[179.478077] Starting dynamic subtest: pipe-A-eDP-1
[181.180939] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.703s)
[181.190910] Starting dynamic subtest: pipe-B-eDP-1
[183.552211] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.372s)
[183.563393] Starting dynamic subtest: pipe-C-eDP-1
[185.810285] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.257s)
[185.820458] Starting dynamic subtest: pipe-D-eDP-1
[188.077088] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.264s)
[188.079227] Subtest disable-crc-after-crtc: SUCCESS (8.602s)
[188.900621] [047/133] (830s left) i915_hangman (gt-engine-error)
[188.966388] Starting subtest: gt-engine-error
[188.968445] Starting dynamic subtest: rcs0
[190.235133] Dynamic subtest rcs0: SUCCESS (1.269s)
[190.245980] Starting dynamic subtest: bcs0
[192.282356] Dynamic subtest bcs0: SUCCESS (2.044s)
[192.294824] Starting dynamic subtest: vcs0
[194.267049] Dynamic subtest vcs0: SUCCESS (1.982s)
[194.278908] Starting dynamic subtest: vcs1
[196.252530] Dynamic subtest vcs1: SUCCESS (1.983s)
[196.264221] Starting dynamic subtest: vecs0
[198.235904] Dynamic subtest vecs0: SUCCESS (1.981s)
[198.250014] Starting dynamic subtest: ccs0
[200.282884] Dynamic subtest ccs0: SUCCESS (2.045s)
[200.285675] Subtest gt-engine-error: SUCCESS (11.318s)
[200.365674] [048/133] (819s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[200.419796] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[200.424326] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[200.601829] [049/133] (818s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[200.701873] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[200.704204] Starting dynamic subtest: pipe-A-default-mode
[203.423182] Dynamic subtest pipe-A-default-mode: SUCCESS (2.716s)
[203.427291] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.718s)
[204.296853] [050/133] (815s left) device_reset (unbind-cold-reset-rebind)
[204.347721] Starting subtest: unbind-cold-reset-rebind
[204.352317] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[204.421559] [051/133] (815s left) gem_lmem_swapping (heavy-random)
[204.466453] Subtest heavy-random: SKIP (0.000s)
[204.510319] [052/133] (815s left) kms_flip (nonexisting-fb-interruptible)
[204.613369] Starting subtest: nonexisting-fb-interruptible
[204.615663] Starting dynamic subtest: A-eDP1
[205.783504] Dynamic subtest A-eDP1: SUCCESS (1.169s)
[205.796133] Starting dynamic subtest: B-eDP1
[206.915722] Dynamic subtest B-eDP1: SUCCESS (1.129s)
[206.926099] Starting dynamic subtest: C-eDP1
[208.046887] Dynamic subtest C-eDP1: SUCCESS (1.130s)
[208.059461] Starting dynamic subtest: D-eDP1
[209.173085] Dynamic subtest D-eDP1: SUCCESS (1.124s)
[209.178055] Subtest nonexisting-fb-interruptible: SUCCESS (4.565s)
[210.343588] [053/133] (809s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[210.431957] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[210.436435] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[210.506543] [054/133] (809s left) kms_async_flips (test-time-stamp-atomic)
[210.594945] Starting subtest: test-time-stamp-atomic
[210.966763] Starting dynamic subtest: pipe-A-eDP-1
[211.746106] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.777s)
[212.131381] Starting dynamic subtest: pipe-B-eDP-1
[212.874400] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.754s)
[213.251453] Starting dynamic subtest: pipe-C-eDP-1
[214.002511] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.756s)
[214.367633] Starting dynamic subtest: pipe-D-eDP-1
[215.131323] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[215.133746] Subtest test-time-stamp-atomic: SUCCESS (4.537s)
[216.289744] [055/133] (803s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[216.392570] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[217.371997] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.980s)
[217.528627] [056/133] (802s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[217.579828] Starting subtest: wait-all-for-submit-delayed-submit
[217.682339] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[217.775073] [057/133] (802s left) kms_vrr (flip-suspend)
[217.873504] Starting subtest: flip-suspend
[217.878935] Subtest flip-suspend: SKIP (0.000s)
[217.946887] [058/133] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[218.048748] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[225.336998] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.289s)
[225.461826] [059/133] (794s left) kms_plane (plane-position-hole)
[225.548922] Starting subtest: plane-position-hole
[226.056705] Starting dynamic subtest: pipe-A-plane-1
[227.293424] Dynamic subtest pipe-A-plane-1: SUCCESS (1.236s)
[227.303104] Starting dynamic subtest: pipe-A-plane-2
[228.520075] Dynamic subtest pipe-A-plane-2: SUCCESS (1.226s)
[228.530633] Starting dynamic subtest: pipe-A-plane-3
[229.869434] Dynamic subtest pipe-A-plane-3: SUCCESS (1.347s)
[229.879668] Starting dynamic subtest: pipe-A-plane-4
[231.192061] Dynamic subtest pipe-A-plane-4: SUCCESS (1.321s)
[231.202080] Starting dynamic subtest: pipe-A-plane-5
[231.216933] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[232.421812] Starting dynamic subtest: pipe-B-plane-1
[233.738442] Dynamic subtest pipe-B-plane-1: SUCCESS (1.327s)
[233.749902] Starting dynamic subtest: pipe-B-plane-2
[235.056372] Dynamic subtest pipe-B-plane-2: SUCCESS (1.315s)
[235.066771] Starting dynamic subtest: pipe-B-plane-3
[236.290597] Dynamic subtest pipe-B-plane-3: SUCCESS (1.233s)
[236.300174] Starting dynamic subtest: pipe-B-plane-4
[237.569256] Dynamic subtest pipe-B-plane-4: SUCCESS (1.278s)
[237.579028] Starting dynamic subtest: pipe-B-plane-5
[237.595020] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[237.597498] Subtest plane-position-hole: SUCCESS (12.046s)
[238.415148] [060/133] (781s left) kms_plane (pixel-format-linear-modifier)
[238.518215] Starting subtest: pixel-format-linear-modifier
[238.547641] Starting dynamic subtest: pipe-A-plane-0
[242.022443] Dynamic subtest pipe-A-plane-0: SUCCESS (3.477s)
[242.031338] Starting dynamic subtest: pipe-A-plane-3
[243.700767] Dynamic subtest pipe-A-plane-3: SUCCESS (1.677s)
[243.710863] Starting dynamic subtest: pipe-A-plane-5
[243.911483] Dynamic subtest pipe-A-plane-5: SUCCESS (0.209s)
[245.000339] Starting dynamic subtest: pipe-B-plane-0
[248.470065] Dynamic subtest pipe-B-plane-0: SUCCESS (3.478s)
[248.479433] Starting dynamic subtest: pipe-B-plane-3
[250.116767] Dynamic subtest pipe-B-plane-3: SUCCESS (1.643s)
[250.126080] Starting dynamic subtest: pipe-B-plane-5
[250.325800] Dynamic subtest pipe-B-plane-5: SUCCESS (0.208s)
[250.642367] Subtest pixel-format-linear-modifier: SUCCESS (12.123s)
[251.467433] [061/133] (768s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[251.579678] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[251.583770] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[251.696240] [062/133] (768s left) kms_cursor_crc (cursor-sliding-128x42)
[251.914064] Starting subtest: cursor-sliding-128x42
[251.966610] Subtest cursor-sliding-128x42: SKIP (0.047s)
[252.146381] [063/133] (768s left) kms_getfb (getfb2-handle-closed)
[252.237577] Starting subtest: getfb2-handle-closed
[252.239668] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[252.340581] [064/133] (767s left) syncobj_wait (wait-for-submit-snapshot)
[252.396962] Starting subtest: wait-for-submit-snapshot
[252.477033] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[252.553960] [065/133] (767s left) perf_pmu (rc6-suspend)
[252.602216] Starting subtest: rc6-suspend
[275.508671] Subtest rc6-suspend: SUCCESS (7.612s)
[276.388122] [066/133] (743s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[277.943631] Starting subtest: modeset-lpsp-stress-no-wait
[288.189004] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.243s)
[288.277792] [067/133] (732s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[288.368636] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[288.372762] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[288.464977] [068/133] (731s left) kms_atomic_interruptible (atomic-setmode)
[288.553632] Starting subtest: atomic-setmode
[288.555757] Starting dynamic subtest: pipe-A-eDP-1
[295.425116] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.867s)
[295.427414] Subtest atomic-setmode: SUCCESS (6.868s)
[296.242374] [069/133] (724s left) kms_frontbuffer_tracking (psr-slowdraw)
[296.346369] Starting subtest: psr-slowdraw
[321.555496] Subtest psr-slowdraw: SUCCESS (25.211s)
[321.685589] [070/133] (698s left) kms_prop_blob (blob-prop-lifetime)
[321.740165] Starting subtest: blob-prop-lifetime
[321.742490] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[321.833550] [071/133] (698s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[321.922869] Starting subtest: bad-rotation-90-y-tiled-ccs
[321.925153] Starting dynamic subtest: pipe-A-eDP-1
[321.946704] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[321.958106] Starting dynamic subtest: pipe-B-eDP-1
[321.978332] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[321.987556] Starting dynamic subtest: pipe-C-eDP-1
[322.008407] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[322.017590] Starting dynamic subtest: pipe-D-eDP-1
[322.039931] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[322.044292] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[324.132171] [072/133] (696s left) gem_ctx_isolation (dirty-switch)
[324.203894] Starting subtest: dirty-switch
[324.206270] Starting dynamic subtest: rcs0
[324.413368] Dynamic subtest rcs0: SUCCESS (0.209s)
[324.426779] Starting dynamic subtest: bcs0
[324.646489] Dynamic subtest bcs0: SUCCESS (0.232s)
[324.659572] Starting dynamic subtest: vcs0
[324.878733] Dynamic subtest vcs0: SUCCESS (0.231s)
[324.889688] Starting dynamic subtest: vcs1
[326.770734] Dynamic subtest vcs1: SUCCESS (1.891s)
[326.783339] Starting dynamic subtest: vecs0
[328.771782] Dynamic subtest vecs0: SUCCESS (1.999s)
[328.782712] Starting dynamic subtest: ccs0
[330.756141] Dynamic subtest ccs0: SUCCESS (1.984s)
[330.758549] Subtest dirty-switch: SUCCESS (6.552s)
[331.000700] [073/133] (689s left) gem_pxp (reject-modify-context-protection-on)
[331.149788] Starting subtest: reject-modify-context-protection-on
[331.152237] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[331.270351] [074/133] (689s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[331.374543] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[331.378988] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[331.468256] [075/133] (689s left) kms_big_fb (y-tiled-addfb-size-overflow)
[331.568318] Starting subtest: y-tiled-addfb-size-overflow
[331.572742] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[331.664750] [076/133] (689s left) kms_vblank (wait-forked)
[331.756199] Starting subtest: wait-forked
[331.758125] Starting dynamic subtest: pipe-A-eDP-1
[333.578888] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.823s)
[333.594900] Starting dynamic subtest: pipe-D-eDP-1
[336.119977] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.536s)
[336.122374] Subtest wait-forked: SUCCESS (4.364s)
[336.989436] [077/133] (683s left) kms_addfb_basic (too-high)
[337.081133] Starting subtest: too-high
[337.083458] Subtest too-high: SUCCESS (0.000s)
[337.182207] [078/133] (683s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[337.280858] Starting subtest: plane-upscale-20x20-with-modifiers
[337.283130] Starting dynamic subtest: pipe-A
[337.616337] Dynamic subtest pipe-A: SUCCESS (0.338s)
[337.626612] Starting dynamic subtest: pipe-B
[338.985262] Dynamic subtest pipe-B: SUCCESS (1.368s)
[338.996298] Starting dynamic subtest: pipe-C
[340.412748] Dynamic subtest pipe-C: SUCCESS (1.426s)
[340.423712] Starting dynamic subtest: pipe-D
[341.839427] Dynamic subtest pipe-D: SUCCESS (1.425s)
[341.841734] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.561s)
[343.013652] [079/133] (677s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[343.117088] Starting subtest: yf-tiled-16bpp-rotate-270
[343.121466] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[343.228321] [080/133] (677s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[343.323828] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[343.327911] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[343.434375] [081/133] (677s left) syncobj_timeline (wait-for-submit-delayed-submit)
[343.498817] Starting subtest: wait-for-submit-delayed-submit
[343.600561] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[343.696806] [082/133] (677s left) gem_ctx_bad_destroy (invalid-ctx)
[343.769273] Starting subtest: invalid-ctx
[343.771417] Subtest invalid-ctx: SUCCESS (0.000s)
[343.846315] [083/133] (677s left) gem_exec_reloc (basic-gtt-noreloc)
[343.911488] Subtest basic-gtt-noreloc: SKIP (0.000s)
[343.980339] [084/133] (677s left) gem_exec_fence (parallel)
[344.158971] Starting subtest: parallel
[344.161697] Starting dynamic subtest: rcs0
[346.313243] Dynamic subtest rcs0: SUCCESS (2.154s)
[346.324712] Starting dynamic subtest: bcs0
[348.466610] Dynamic subtest bcs0: SUCCESS (2.152s)
[348.481338] Starting dynamic subtest: vcs0
[350.620074] Dynamic subtest vcs0: SUCCESS (2.152s)
[350.631956] Starting dynamic subtest: vcs1
[352.772332] Dynamic subtest vcs1: SUCCESS (2.151s)
[352.783958] Starting dynamic subtest: vecs0
[354.922999] Dynamic subtest vecs0: SUCCESS (2.150s)
[354.933012] Starting dynamic subtest: ccs0
[357.077952] Dynamic subtest ccs0: SUCCESS (2.154s)
[357.079958] Subtest parallel: SUCCESS (12.918s)
[357.707924] [085/133] (663s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[357.851008] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[357.855725] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[358.008481] [086/133] (663s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[358.099298] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[358.101574] Starting dynamic subtest: pipe-A-eDP-1
[358.126159] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[358.138902] Starting dynamic subtest: pipe-B-eDP-1
[358.162211] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[358.171946] Starting dynamic subtest: pipe-C-eDP-1
[358.195010] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[358.205037] Starting dynamic subtest: pipe-D-eDP-1
[358.228461] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[358.232489] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[360.292633] [087/133] (660s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[360.679777] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[361.508986] [088/133] (659s left) kms_psr (psr-cursor-plane-move)
[361.600868] Starting subtest: psr-cursor-plane-move
[361.603087] Starting dynamic subtest: eDP-1
[363.325651] Dynamic subtest eDP-1: SUCCESS (1.722s)
[363.327539] Subtest psr-cursor-plane-move: SUCCESS (1.723s)
[364.192738] [089/133] (657s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[364.293939] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[364.298419] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[364.392370] [090/133] (656s left) kms_psr (psr-sprite-blt)
[364.492934] Starting subtest: psr-sprite-blt
[364.495242] Starting dynamic subtest: eDP-1
[366.217807] Dynamic subtest eDP-1: SUCCESS (1.725s)
[366.220188] Subtest psr-sprite-blt: SUCCESS (1.726s)
[367.059744] [091/133] (654s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[367.170075] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[367.174269] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[367.265514] [092/133] (654s left) core_getstats (basic)
[367.334693] Starting subtest: basic
[367.337209] Subtest basic: SUCCESS (0.000s)
[367.453809] [093/133] (654s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[367.525785] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[367.657817] [094/133] (653s left) i915_selftest (mock)
[370.901386] Starting subtest: mock
[370.904004] Starting dynamic subtest: sanitycheck
[371.579217] Dynamic subtest sanitycheck: SUCCESS (0.682s)
[371.590032] Starting dynamic subtest: shmem
[372.245175] Dynamic subtest shmem: SUCCESS (0.663s)
[372.255907] Starting dynamic subtest: fence
[379.686245] Dynamic subtest fence: SUCCESS (7.438s)
[379.697082] Starting dynamic subtest: scatterlist
[381.341087] Dynamic subtest scatterlist: SUCCESS (1.654s)
[381.351720] Starting dynamic subtest: syncmap
[384.637398] Dynamic subtest syncmap: SUCCESS (3.294s)
[384.648743] Starting dynamic subtest: uncore
[385.320210] Dynamic subtest uncore: SUCCESS (0.681s)
[385.330402] Starting dynamic subtest: ring
[385.994483] Dynamic subtest ring: SUCCESS (0.672s)
[386.011951] Starting dynamic subtest: engine
[386.681423] Dynamic subtest engine: SUCCESS (0.684s)
[386.692128] Starting dynamic subtest: timelines
[390.571656] Dynamic subtest timelines: SUCCESS (3.887s)
[390.582140] Starting dynamic subtest: requests
[394.146121] Dynamic subtest requests: SUCCESS (3.573s)
[394.156746] Starting dynamic subtest: objects
[394.918977] Dynamic subtest objects: SUCCESS (0.771s)
[394.930040] Starting dynamic subtest: phys
[395.687987] Dynamic subtest phys: SUCCESS (0.768s)
[395.699006] Starting dynamic subtest: dmabuf
[396.474537] Dynamic subtest dmabuf: SUCCESS (0.785s)
[396.484939] Starting dynamic subtest: vma
[402.228390] Dynamic subtest vma: SUCCESS (5.752s)
[402.238187] Starting dynamic subtest: evict
[403.674517] Dynamic subtest evict: SUCCESS (1.445s)
[403.683327] Starting dynamic subtest: gtt
[407.020629] Dynamic subtest gtt: SUCCESS (3.345s)
[407.029460] Starting dynamic subtest: hugepages
[407.901268] Dynamic subtest hugepages: SUCCESS (0.879s)
[407.912321] Starting dynamic subtest: memory_region
[410.449167] Dynamic subtest memory_region: SUCCESS (2.546s)
[410.451751] Subtest mock: SUCCESS (39.554s)
[410.482292] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[410.482996] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[410.486176] [095/133] (611s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[412.112744] Starting subtest: short-flip-before-cursor-toggle
[413.053826] Subtest short-flip-before-cursor-toggle: SUCCESS (0.941s)
[413.978189] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[413.979439] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true
[413.983740] [096/133] (607s left) kms_properties (invalid-properties-legacy)
[414.080931] Starting subtest: invalid-properties-legacy
[414.190321] Subtest invalid-properties-legacy: SUCCESS (0.109s)
[414.274121] [097/133] (607s left) syncobj_wait (wait-for-submit-delayed-submit)
[414.333496] Starting subtest: wait-for-submit-delayed-submit
[414.438826] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[414.535912] [098/133] (607s left) syncobj_timeline (invalid-query-bad-pad)
[414.598006] Starting subtest: invalid-query-bad-pad
[414.600640] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[414.723740] [099/133] (607s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[414.834718] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[414.839099] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[414.924523] [100/133] (606s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[415.029230] Starting subtest: x-tiled-32bpp-rotate-90
[415.053012] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s)
[415.156293] [101/133] (606s left) i915_pm_rpm (system-suspend-devices)
[416.682650] Starting subtest: system-suspend-devices
[424.343747] Subtest system-suspend-devices: SUCCESS (7.663s)
[424.725712] [102/133] (597s left) kms_pm_dc (dc3co-vpb-simulation)
[425.838137] Starting subtest: dc3co-vpb-simulation
[434.937700] Subtest dc3co-vpb-simulation: SKIP (9.095s)
[435.059485] [103/133] (586s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[435.167861] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[435.172108] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[435.266278] [104/133] (586s left) i915_drm_fdinfo (virtual-busy-all)
[435.310429] Starting subtest: virtual-busy-all
[435.315184] Subtest virtual-busy-all: SKIP (0.000s)
[435.376783] [105/133] (586s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[435.472228] Starting subtest: fbc-rgb101010-draw-blt
[440.068747] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.597s)
[441.254500] [106/133] (580s left) kms_plane_multiple (tiling-none)
[441.350443] Starting subtest: tiling-none
[441.352365] Starting dynamic subtest: pipe-A-eDP-1
[445.073297] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.722s)
[445.083740] Starting dynamic subtest: pipe-B-eDP-1
[449.504717] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.432s)
[449.515233] Starting dynamic subtest: pipe-C-eDP-1
[453.845479] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.336s)
[453.856620] Starting dynamic subtest: pipe-D-eDP-1
[458.212315] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.366s)
[458.214231] Subtest tiling-none: SUCCESS (16.861s)
[459.016907] [107/133] (563s left) gem_mmap (basic-small-bo)
[459.082168] Subtest basic-small-bo: SKIP (0.000s)
[459.142039] [108/133] (563s left) perf (per-context-mode-unprivileged)
[459.278462] Starting subtest: per-context-mode-unprivileged
[459.282155] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[459.328875] [109/133] (562s left) kms_flip (plain-flip-ts-check-interruptible)
[459.423649] Starting subtest: plain-flip-ts-check-interruptible
[459.425874] Starting dynamic subtest: A-eDP1
[468.330564] Dynamic subtest A-eDP1: SUCCESS (8.872s)
[468.342520] Starting dynamic subtest: B-eDP1
[477.161706] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[477.174954] Starting dynamic subtest: C-eDP1
[485.994569] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[486.006096] Starting dynamic subtest: D-eDP1
[494.825975] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[494.828226] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.359s)
[495.972492] [110/133] (526s left) gem_ctx_engines (none)
[496.038418] Starting subtest: none
[496.040717] Subtest none: SUCCESS (0.001s)
[496.227423] [111/133] (526s left) gem_exec_params (invalid-bsd-ring)
[496.286855] Starting subtest: invalid-bsd-ring
[496.289192] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[496.390956] [112/133] (525s left) api_intel_allocator (reopen-fork)
[496.438999] Starting subtest: reopen-fork
[499.812746] Subtest reopen-fork: SUCCESS (3.375s)
[499.889766] [113/133] (522s left) kms_async_flips (alternate-sync-async-flip-atomic)
[499.985966] Starting subtest: alternate-sync-async-flip-atomic
[500.373130] Starting dynamic subtest: pipe-A-eDP-1
[503.165495] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.794s)
[503.550999] Starting dynamic subtest: pipe-B-eDP-1
[506.291552] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.750s)
[506.661828] Starting dynamic subtest: pipe-C-eDP-1
[509.419373] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[509.786928] Starting dynamic subtest: pipe-D-eDP-1
[512.553235] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[512.556131] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.570s)
[513.719961] [114/133] (508s left) syncobj_timeline (reset-unsignaled)
[513.777324] Starting subtest: reset-unsignaled
[513.779597] Subtest reset-unsignaled: SUCCESS (0.000s)
[513.880287] [115/133] (508s left) kms_chamelium_edid (vga-edid-read)
[514.266840] Subtest vga-edid-read: SKIP (0.000s)
[515.064489] [116/133] (507s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[515.155090] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[515.159298] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[515.226427] [117/133] (507s left) gem_ctx_persistence (legacy-engines-cleanup)
[515.291772] Starting subtest: legacy-engines-cleanup
[515.294117] Starting dynamic subtest: render
[515.356591] Dynamic subtest render: SUCCESS (0.064s)
[515.373551] Starting dynamic subtest: bsd1
[515.421843] Dynamic subtest bsd1: SUCCESS (0.062s)
[515.436042] Starting dynamic subtest: bsd2
[515.451522] Dynamic subtest bsd2: SUCCESS (0.027s)
[515.468096] Starting dynamic subtest: blt
[515.522684] Dynamic subtest blt: SUCCESS (0.069s)
[515.537050] Starting dynamic subtest: vebox
[515.550461] Dynamic subtest vebox: SUCCESS (0.025s)
[515.552674] Subtest legacy-engines-cleanup: SUCCESS (0.260s)
[515.662826] [118/133] (506s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[515.764628] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[522.835305] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.075s)
[522.975486] [119/133] (499s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[523.075517] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[523.079686] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[523.176984] [120/133] (499s left) kms_flip (2x-plain-flip)
[523.268100] Starting subtest: 2x-plain-flip
[523.279099] Subtest 2x-plain-flip: SKIP (0.010s)
[523.369995] [121/133] (499s left) gem_gtt_cpu_tlb
[523.489163] [122/133] (499s left) gem_ctx_param (invalid-param-get)
[523.541974] Starting subtest: invalid-param-get
[523.544273] Subtest invalid-param-get: SUCCESS (0.001s)
[523.643623] [123/133] (499s left) gem_exec_fence (basic-await)
[523.823116] Starting subtest: basic-await
[523.825905] Starting dynamic subtest: rcs0
[523.899943] Dynamic subtest rcs0: SUCCESS (0.077s)
[523.915390] Starting dynamic subtest: bcs0
[523.973730] Dynamic subtest bcs0: SUCCESS (0.072s)
[523.986268] Starting dynamic subtest: vcs0
[524.045189] Dynamic subtest vcs0: SUCCESS (0.071s)
[524.058360] Starting dynamic subtest: vcs1
[524.118689] Dynamic subtest vcs1: SUCCESS (0.071s)
[524.132010] Starting dynamic subtest: vecs0
[524.192994] Dynamic subtest vecs0: SUCCESS (0.073s)
[524.205870] Starting dynamic subtest: ccs0
[524.265386] Dynamic subtest ccs0: SUCCESS (0.070s)
[524.267846] Subtest basic-await: SUCCESS (0.444s)
[525.637433] [124/133] (497s left) gem_exec_schedule (pi-common)
[525.813647] Starting subtest: pi-common
[525.815834] Starting dynamic subtest: rcs0
[525.845121] Dynamic subtest rcs0: SUCCESS (0.033s)
[525.858980] Starting dynamic subtest: bcs0
[525.875037] Dynamic subtest bcs0: SUCCESS (0.029s)
[525.888679] Starting dynamic subtest: vcs0
[525.906387] Dynamic subtest vcs0: SUCCESS (0.030s)
[525.920081] Starting dynamic subtest: vcs1
[525.937572] Dynamic subtest vcs1: SUCCESS (0.030s)
[525.947550] Starting dynamic subtest: vecs0
[525.969814] Dynamic subtest vecs0: SUCCESS (0.031s)
[525.983272] Starting dynamic subtest: ccs0
[526.000451] Dynamic subtest ccs0: SUCCESS (0.030s)
[526.002698] Subtest pi-common: SUCCESS (0.189s)
[526.241673] [125/133] (496s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[526.331142] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[526.335718] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[527.498582] [126/133] (495s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[527.590736] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[534.325903] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.737s)
[534.431991] [127/133] (488s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[534.535108] Starting subtest: fbc-psr-sprite-mmap-gtt
[534.537301] Starting dynamic subtest: eDP-1
[534.541227] Dynamic subtest eDP-1: SKIP (0.000s)
[534.545194] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[534.616223] [128/133] (488s left) perf_pmu (frequency)
[534.660126] Starting subtest: frequency
[534.664538] Starting dynamic subtest: gt0
[536.809303] Dynamic subtest gt0: SUCCESS (2.139s)
[536.821111] Starting dynamic subtest: idle-gt0
[537.315015] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[537.331261] Starting dynamic subtest: gt1
[541.552373] Dynamic subtest gt1: SUCCESS (4.232s)
[541.564078] Starting dynamic subtest: idle-gt1
[542.057840] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[542.060751] Subtest frequency: SUCCESS (7.399s)
[542.151845] [129/133] (480s left) gem_softpin (allocator-nopin)
[542.207693] Starting subtest: allocator-nopin
[542.318180] Subtest allocator-nopin: SUCCESS (0.108s)
[542.447215] [130/133] (480s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[542.539009] Starting subtest: fbc-psr2-primary-mmap-gtt
[542.541385] Starting dynamic subtest: eDP-1
[542.545540] Dynamic subtest eDP-1: SKIP (0.000s)
[542.549758] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[542.625597] [131/133] (480s left) sw_sync (timeline_closed_signaled)
[542.658159] Starting subtest: timeline_closed_signaled
[542.660079] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[542.715677] [132/133] (480s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[542.768556] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[542.869997] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[542.963263] [133/133] (480s left) gen9_exec_parse (batch-zero-length)
[543.017777] Subtest batch-zero-length: SKIP (0.000s)
[543.077989] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: gem_ppgtt
results: parsing output: 3/ for test: kms_setmode
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: gem_lmem_swapping
results: parsing output: 11/ for test: gem_exec_whisper
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_content_protection
results: parsing output: 15/ for test: kms_dp_linktrain_fallback
results: parsing output: 16/ for test: gem_mmap_gtt
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: kms_properties
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: syncobj_basic
results: parsing output: 21/ for test: kms_sequence
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: fbdev
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_rotation_crc
results: parsing output: 28/ for test: gem_ctx_sseu
results: parsing output: 29/ for test: kms_dsc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_invalid_mode
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: syncobj_basic
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: prime_vgem
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: gem_exec_parallel
results: parsing output: 43/ for test: kms_getfb
results: parsing output: 44/ for test: prime_vgem
results: parsing output: 45/ for test: kms_pipe_crc_basic
results: parsing output: 46/ for test: i915_hangman
results: parsing output: 47/ for test: gem_render_copy
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: device_reset
results: parsing output: 50/ for test: gem_lmem_swapping
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_vrr
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_plane
results: parsing output: 59/ for test: kms_plane
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: kms_getfb
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_pm_rpm
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_atomic_interruptible
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_prop_blob
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_ctx_isolation
results: parsing output: 72/ for test: gem_pxp
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_ctx_bad_destroy
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_chamelium_hpd
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: core_getstats
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: i915_selftest
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_properties
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: i915_pm_rpm
results: parsing output: 101/ for test: kms_pm_dc
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: i915_drm_fdinfo
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_plane_multiple
results: parsing output: 106/ for test: gem_mmap
results: parsing output: 107/ for test: perf
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: gem_ctx_engines
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: kms_async_flips
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_chamelium_edid
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_gtt_cpu_tlb
results: parsing output: 121/ for test: gem_ctx_param
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: gem_softpin
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: sw_sync
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: gen9_exec_parse
Done.