[54.623840] Initializing watchdogs
[54.623888]   /dev/watchdog0
[54.637183] [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]
[54.641265] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.643310] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.646350] [001/131] (960s left) kms_pm_rpm (pm-caching)
[56.205565] Starting subtest: pm-caching
[56.211458] Subtest pm-caching: SKIP (0.000s)
[56.909307] [002/131] (958s left) kms_async_flips (test-cursor)
[57.017175] Starting subtest: test-cursor
[57.026869] Subtest test-cursor: SKIP (0.000s)
[58.224812] [003/131] (956s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[58.343564] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[58.348099] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[58.436168] [004/131] (956s left) kms_properties (invalid-properties-atomic)
[58.535794] Starting subtest: invalid-properties-atomic
[58.781120] Subtest invalid-properties-atomic: SUCCESS (0.244s)
[58.848210] [005/131] (956s left) i915_hangman (gt-engine-error)
[58.924292] Starting subtest: gt-engine-error
[58.926616] Starting dynamic subtest: rcs0
[60.852785] Dynamic subtest rcs0: SUCCESS (1.928s)
[60.863121] Starting dynamic subtest: bcs0
[62.897220] Dynamic subtest bcs0: SUCCESS (2.043s)
[62.907135] Starting dynamic subtest: vcs0
[64.883193] Dynamic subtest vcs0: SUCCESS (1.986s)
[64.892792] Starting dynamic subtest: vcs1
[66.864858] Dynamic subtest vcs1: SUCCESS (1.981s)
[66.875663] Starting dynamic subtest: vecs0
[68.849878] Dynamic subtest vecs0: SUCCESS (1.984s)
[68.859427] Starting dynamic subtest: ccs0
[70.896373] Dynamic subtest ccs0: SUCCESS (2.046s)
[70.898764] Subtest gt-engine-error: SUCCESS (11.972s)
[70.973293] [006/131] (944s left) dmabuf_sync_file (import-multiple-read-only)
[71.161872] Starting subtest: import-multiple-read-only
[71.164430] Subtest import-multiple-read-only: SUCCESS (0.006s)
[71.245686] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[71.251566] [007/131] (944s left) gem_exec_balancer (smoke)
[71.391349] Starting subtest: smoke
[94.157160] Subtest smoke: SUCCESS (22.760s)
[95.200992] [008/131] (920s left) kms_flip (flip-vs-blocking-wf-vblank)
[95.312247] Starting subtest: flip-vs-blocking-wf-vblank
[95.314944] Starting dynamic subtest: A-eDP1
[104.279271] Dynamic subtest A-eDP1: SUCCESS (8.967s)
[104.291197] Starting dynamic subtest: B-eDP1
[113.211720] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[113.222116] Starting dynamic subtest: C-eDP1
[122.139071] Dynamic subtest C-eDP1: SUCCESS (8.926s)
[122.148544] Starting dynamic subtest: D-eDP1
[131.070260] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[131.072541] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.760s)
[132.300613] [009/131] (883s left) gem_reg_read (timestamp-monotonic)
[132.364621] Starting subtest: timestamp-monotonic
[136.605598] Subtest timestamp-monotonic: SUCCESS (4.241s)
[136.674478] [010/131] (878s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[136.775983] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[136.778434] Starting dynamic subtest: pipe-A-eDP-1
[136.798641] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[136.806330] Starting dynamic subtest: pipe-B-eDP-1
[136.825161] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[136.831783] Starting dynamic subtest: pipe-C-eDP-1
[136.850929] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[136.857589] Starting dynamic subtest: pipe-D-eDP-1
[136.876119] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[136.878265] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[138.971172] [011/131] (876s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[139.059099] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[139.061503] Starting dynamic subtest: pipe-A
[139.399596] Dynamic subtest pipe-A: SUCCESS (0.340s)
[139.408311] Starting dynamic subtest: pipe-B
[140.763933] Dynamic subtest pipe-B: SUCCESS (1.364s)
[140.773181] Starting dynamic subtest: pipe-C
[142.200275] Dynamic subtest pipe-C: SUCCESS (1.436s)
[142.209168] Starting dynamic subtest: pipe-D
[143.634396] Dynamic subtest pipe-D: SUCCESS (1.434s)
[143.636789] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.575s)
[144.797504] [012/131] (870s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[144.887060] Starting subtest: crc-primary-suspend-y-tiled-ccs
[144.889445] Starting dynamic subtest: pipe-A-eDP-1
[144.898736] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[144.907380] Starting dynamic subtest: pipe-B-eDP-1
[144.917228] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[144.926044] Starting dynamic subtest: pipe-C-eDP-1
[144.934626] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[144.942054] Starting dynamic subtest: pipe-D-eDP-1
[144.950536] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[144.954743] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.002s)
[147.082679] [013/131] (868s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[147.208957] Starting subtest: flip-vs-cursor-busy-crc-atomic
[148.001467] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.793s)
[148.816951] [014/131] (866s left) kms_plane_lowres (tiling-none)
[148.922047] Starting subtest: tiling-none
[148.924416] Starting dynamic subtest: pipe-A-eDP-1
[148.928975] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[149.233753] Starting dynamic subtest: pipe-B-eDP-1
[149.238179] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[149.244865] Starting dynamic subtest: pipe-C-eDP-1
[149.249501] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[149.256421] Starting dynamic subtest: pipe-D-eDP-1
[149.260782] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[149.265155] Subtest tiling-none: SKIP (0.307s)
[150.044402] [015/131] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[150.146651] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[150.150787] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[150.260309] [016/131] (865s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[150.365107] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[153.959285] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.599s)
[155.174046] [017/131] (860s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[155.270581] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[162.161256] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.893s)
[162.256402] [018/131] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[162.348362] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[162.352726] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[162.458861] [019/131] (853s left) kms_cursor_crc (cursor-dpms)
[162.586643] Starting subtest: cursor-dpms
[162.588996] Starting dynamic subtest: pipe-A-eDP-1
[165.630224] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.040s)
[165.637558] Starting dynamic subtest: pipe-D-eDP-1
[169.238332] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.606s)
[169.240518] Subtest cursor-dpms: SUCCESS (6.650s)
[170.086691] [020/131] (845s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[170.148077] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[170.150438] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[170.245468] [021/131] (845s left) gem_softpin (allocator-fork)
[170.309633] Starting subtest: allocator-fork
[172.526182] Subtest allocator-fork: SUCCESS (2.216s)
[172.663401] [022/131] (843s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[172.761167] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[172.763515] Starting dynamic subtest: pipe-A-default-mode
[175.526507] Dynamic subtest pipe-A-default-mode: SUCCESS (2.764s)
[175.528956] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.765s)
[176.383623] [023/131] (839s left) kms_invalid_mode (uint-max-clock)
[176.470137] Starting subtest: uint-max-clock
[176.472402] Starting dynamic subtest: pipe-A-eDP-1
[176.755160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[176.766451] Starting dynamic subtest: pipe-B-eDP-1
[176.768622] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[176.776023] Starting dynamic subtest: pipe-C-eDP-1
[176.778499] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[176.786311] Starting dynamic subtest: pipe-D-eDP-1
[176.788579] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[176.790855] Subtest uint-max-clock: SUCCESS (0.288s)
[177.617209] [024/131] (838s left) gem_exec_whisper (basic-queues)
[177.685452] Starting subtest: basic-queues
[182.963543] Subtest basic-queues: SUCCESS (5.276s)
[183.141066] [025/131] (832s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[183.203550] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[183.310565] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[183.385210] [026/131] (832s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[183.507445] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[183.511749] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[183.617062] [027/131] (832s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[183.719344] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[183.721735] Starting dynamic subtest: pipe-A-default-mode
[184.005812] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[184.010505] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.287s)
[184.846330] [028/131] (831s left) gem_eio (suspend)
[185.072101] Starting subtest: suspend
[197.075574] Subtest suspend: SUCCESS (12.001s)
[197.187023] [029/131] (819s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[197.283062] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[197.285989] Starting dynamic subtest: pipe-A-eDP-1
[197.309192] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[197.320433] Starting dynamic subtest: pipe-B-eDP-1
[197.342269] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[197.350480] Starting dynamic subtest: pipe-C-eDP-1
[197.372292] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[197.380383] Starting dynamic subtest: pipe-D-eDP-1
[197.402641] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[197.406717] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[199.481816] [030/131] (816s left) kms_addfb_basic (invalid-set-prop)
[199.532174] Starting subtest: invalid-set-prop
[199.534064] Subtest invalid-set-prop: SUCCESS (0.000s)
[199.686119] [031/131] (816s left) kms_dsc (dsc-with-output-formats)
[199.774345] Starting subtest: dsc-with-output-formats
[199.796596] Subtest dsc-with-output-formats: SKIP (0.001s)
[199.848984] [032/131] (816s left) kms_psr (psr-primary-mmap-gtt)
[199.941349] Starting subtest: psr-primary-mmap-gtt
[199.943537] Starting dynamic subtest: eDP-1
[201.383571] Dynamic subtest eDP-1: SKIP (1.437s)
[201.388502] Subtest psr-primary-mmap-gtt: SKIP (1.438s)
[201.559499] [033/131] (814s left) kms_pm_rpm (modeset-lpsp)
[203.083055] Starting subtest: modeset-lpsp
[204.555087] Subtest modeset-lpsp: SUCCESS (1.471s)
[204.678147] [034/131] (811s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[209.687929] Starting subtest: fbc-psr2-cursor-plane-update-sf
[209.690258] Starting dynamic subtest: pipe-A-eDP-1
[210.477985] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s)
[210.486399] Starting dynamic subtest: pipe-B-eDP-1
[211.603410] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[211.607781] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.915s)
[212.774482] [035/131] (803s left) kms_addfb_basic (basic-y-tiled-legacy)
[212.835679] Starting subtest: basic-y-tiled-legacy
[212.840046] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[212.981065] [036/131] (803s left) gem_exec_basic (basic)
[213.032718] Starting subtest: basic
[213.035212] Starting dynamic subtest: rcs0-smem
[213.037616] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[213.048318] Starting dynamic subtest: bcs0-smem
[213.050687] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[213.060072] Starting dynamic subtest: vcs0-smem
[213.062024] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[213.069562] Starting dynamic subtest: vcs1-smem
[213.071505] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[213.079040] Starting dynamic subtest: vecs0-smem
[213.080949] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[213.088404] Starting dynamic subtest: ccs0-smem
[213.090314] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[213.092245] Subtest basic: SUCCESS (0.019s)
[214.922409] [037/131] (801s left) gem_mmap_wc (copy)
[214.981857] Subtest copy: SKIP (0.000s)
[215.044290] [038/131] (801s left) i915_pm_rpm (system-suspend-execbuf)
[217.066558] Starting subtest: system-suspend-execbuf
[275.083512] Subtest system-suspend-execbuf: SUCCESS (43.001s)
[275.447665] [039/131] (741s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[275.541715] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[275.546184] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[275.656256] [040/131] (741s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[275.754259] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[275.758688] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[275.863019] [041/131] (740s left) kms_chamelium_edid (dp-edid-read)
[276.241812] Subtest dp-edid-read: SKIP (0.000s)
[277.047765] [042/131] (739s left) gem_userptr_blits (sync-unmap)
[277.105457] Starting subtest: sync-unmap
[277.117610] Subtest sync-unmap: SUCCESS (0.013s)
[277.251754] [043/131] (739s left) api_intel_bb (object-noreloc-purge-cache-simple)
[277.307438] Starting subtest: object-noreloc-purge-cache-simple
[277.312387] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.004s)
[277.454981] [044/131] (739s left) kms_hdr (bpc-switch-dpms)
[277.546099] Starting subtest: bpc-switch-dpms
[278.640287] Starting dynamic subtest: pipe-A-eDP-1
[283.180229] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.539s)
[283.182100] Subtest bpc-switch-dpms: SUCCESS (5.633s)
[283.316932] [045/131] (733s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[283.414684] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[284.182925] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.770s)
[284.365135] [046/131] (732s left) gem_exec_await (wide-contexts)
[284.579321] Starting subtest: wide-contexts
[307.818516] Subtest wide-contexts: SUCCESS (23.236s)
[308.012866] [047/131] (708s left) kms_psr (fbc-pr-sprite-render)
[308.163349] Starting subtest: fbc-pr-sprite-render
[308.167643] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[308.237354] [048/131] (708s left) kms_cursor_crc (cursor-tearing-position-change)
[308.359432] Starting subtest: cursor-tearing-position-change
[308.361770] Starting dynamic subtest: pipe-A-eDP-1
[308.949831] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[308.960988] Starting dynamic subtest: pipe-D-eDP-1
[310.172939] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[310.174752] Subtest cursor-tearing-position-change: SUCCESS (1.812s)
[311.001281] [049/131] (706s left) syncobj_wait (signal)
[311.062051] Starting subtest: signal
[311.064453] Subtest signal: SUCCESS (0.000s)
[311.150740] [050/131] (705s left) kms_cursor_crc (cursor-sliding-512x512)
[311.417675] Starting subtest: cursor-sliding-512x512
[311.422445] Subtest cursor-sliding-512x512: SKIP (0.001s)
[311.613467] [051/131] (705s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[311.725293] Starting subtest: yf-tiled-64bpp-rotate-0
[311.730111] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[311.848203] [052/131] (705s left) gem_exec_parallel (basic)
[311.910213] Starting subtest: basic
[311.912642] Starting dynamic subtest: rcs0
[313.380028] Dynamic subtest rcs0: SUCCESS (1.468s)
[313.389379] Starting dynamic subtest: bcs0
[314.863460] Dynamic subtest bcs0: SUCCESS (1.483s)
[314.872687] Starting dynamic subtest: vcs0
[316.849310] Dynamic subtest vcs0: SUCCESS (1.982s)
[316.861927] Starting dynamic subtest: vcs1
[318.899966] Dynamic subtest vcs1: SUCCESS (2.048s)
[318.912246] Starting dynamic subtest: vecs0
[320.881588] Dynamic subtest vecs0: SUCCESS (1.980s)
[320.893817] Starting dynamic subtest: ccs0
[322.367267] Dynamic subtest ccs0: SUCCESS (1.486s)
[322.369611] Subtest basic: SUCCESS (10.457s)
[322.553464] [053/131] (694s left) kms_flip (flip-vs-rmfb)
[322.666261] Starting subtest: flip-vs-rmfb
[322.668539] Starting dynamic subtest: A-eDP1
[331.290166] Dynamic subtest A-eDP1: SUCCESS (8.623s)
[331.300766] Starting dynamic subtest: B-eDP1
[339.922779] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[339.933243] Starting dynamic subtest: C-eDP1
[348.543754] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[348.555117] Starting dynamic subtest: D-eDP1
[357.175025] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[357.179995] Subtest flip-vs-rmfb: SUCCESS (34.513s)
[358.352334] [054/131] (658s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[358.442234] Starting subtest: sprite-rotation-90-pos-100-0
[358.446745] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[358.514945] [055/131] (658s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[358.608814] Starting subtest: plane-upscale-20x20-with-rotation
[358.611070] Starting dynamic subtest: pipe-A
[358.835695] Dynamic subtest pipe-A: SUCCESS (0.226s)
[358.844993] Starting dynamic subtest: pipe-B
[360.148470] Dynamic subtest pipe-B: SUCCESS (1.312s)
[360.157982] Starting dynamic subtest: pipe-C
[361.483761] Dynamic subtest pipe-C: SUCCESS (1.334s)
[361.493778] Starting dynamic subtest: pipe-D
[362.805492] Dynamic subtest pipe-D: SUCCESS (1.320s)
[362.807739] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.197s)
[363.990759] [056/131] (653s left) gem_ctx_create (basic)
[364.055323] Starting subtest: basic
[364.057526] Subtest basic: SUCCESS (0.000s)
[364.237186] [057/131] (653s left) gem_ctx_param (invalid-get-ringsize)
[364.295420] Starting subtest: invalid-get-ringsize
[364.297814] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[364.415469] [058/131] (652s left) prime_busy (hang-wait)
[364.486850] Starting subtest: hang-wait
[364.489121] Starting dynamic subtest: rcs0
[390.348716] Dynamic subtest rcs0: SUCCESS (25.857s)
[390.358063] Starting dynamic subtest: bcs0
[397.503905] Dynamic subtest bcs0: SUCCESS (7.152s)
[397.514095] Starting dynamic subtest: vcs0
[404.541558] Dynamic subtest vcs0: SUCCESS (7.037s)
[404.550644] Starting dynamic subtest: vcs1
[411.521940] Dynamic subtest vcs1: SUCCESS (6.978s)
[411.533220] Starting dynamic subtest: vecs0
[418.553964] Dynamic subtest vecs0: SUCCESS (7.030s)
[418.565115] Starting dynamic subtest: ccs0
[432.457145] Dynamic subtest ccs0: SUCCESS (13.901s)
[432.459354] Subtest hang-wait: SUCCESS (67.965s)
[432.603495] [059/131] (584s left) kms_lease (multimaster-lease)
[432.726160] Starting subtest: multimaster-lease
[432.730983] Subtest multimaster-lease: SUCCESS (0.003s)
[432.838905] [060/131] (584s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[432.930675] Starting subtest: fbc-psr2-sprite-mmap-cpu
[432.932470] Starting dynamic subtest: eDP-1
[432.936304] Dynamic subtest eDP-1: SKIP (0.000s)
[432.940170] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[433.011714] [061/131] (584s left) gem_exec_gttfill (multigpu-basic)
[433.186346] Starting subtest: multigpu-basic
[448.995281] Subtest multigpu-basic: SUCCESS (15.808s)
[449.074599] [062/131] (568s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[449.224644] Starting subtest: psr-rgb101010-draw-pwrite
[456.617432] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.398s)
[456.719003] [063/131] (560s left) gem_exec_flush (basic-wb-ro-before-default)
[456.783451] Starting subtest: basic-wb-ro-before-default
[462.230665] Subtest basic-wb-ro-before-default: SUCCESS (5.448s)
[462.413368] [064/131] (555s left) kms_big_fb (linear-32bpp-rotate-270)
[462.521756] Starting subtest: linear-32bpp-rotate-270
[462.541114] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[462.702049] [065/131] (554s left) drm_read (invalid-buffer)
[462.874052] Starting subtest: invalid-buffer
[462.876088] Subtest invalid-buffer: SUCCESS (0.000s)
[463.016599] [066/131] (554s left) syncobj_timeline (single-wait-all-available-submitted)
[463.080488] Starting subtest: single-wait-all-available-submitted
[463.083156] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[463.175959] [067/131] (554s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[463.302885] Starting subtest: cursorA-vs-flipB-varying-size
[463.307621] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[463.444684] [068/131] (554s left) prime_vgem (basic-write)
[463.512708] Starting subtest: basic-write
[463.525796] Subtest basic-write: SKIP (0.011s)
[463.655058] [069/131] (554s left) kms_cursor_crc (cursor-random-512x170)
[463.920724] Starting subtest: cursor-random-512x170
[463.924784] Subtest cursor-random-512x170: SKIP (0.001s)
[464.058650] [070/131] (553s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[464.143598] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[464.145560] Starting dynamic subtest: pipe-A-eDP-1
[464.204076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.059s)
[464.217786] Starting dynamic subtest: pipe-B-eDP-1
[464.263404] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s)
[464.274681] Starting dynamic subtest: pipe-C-eDP-1
[464.322592] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.058s)
[464.331913] Starting dynamic subtest: pipe-D-eDP-1
[464.382144] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.059s)
[464.384068] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.239s)
[466.682427] [071/131] (551s left) gen3_mixed_blits
[466.807647] [072/131] (551s left) gem_exec_schedule (pi-shared-iova)
[466.980287] Starting subtest: pi-shared-iova
[466.982861] Starting dynamic subtest: rcs0
[467.056815] Dynamic subtest rcs0: SUCCESS (0.078s)
[467.070906] Starting dynamic subtest: vcs0
[467.108442] Dynamic subtest vcs0: SUCCESS (0.051s)
[467.126777] Starting dynamic subtest: vcs1
[467.160851] Dynamic subtest vcs1: SUCCESS (0.052s)
[467.171552] Starting dynamic subtest: vecs0
[467.210879] Dynamic subtest vecs0: SUCCESS (0.049s)
[467.226185] Starting dynamic subtest: ccs0
[467.273427] Dynamic subtest ccs0: SUCCESS (0.062s)
[467.275791] Subtest pi-shared-iova: SUCCESS (0.295s)
[469.003890] [073/131] (548s left) kms_dp_linktrain_fallback (dsc-fallback)
[469.108314] Starting subtest: dsc-fallback
[469.114480] Subtest dsc-fallback: SKIP (0.000s)
[469.181110] [074/131] (548s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[469.285521] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[469.289706] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[469.388421] [075/131] (548s left) gem_exec_reloc (basic-active)
[469.441544] Subtest basic-active: SKIP (0.000s)
[469.537448] [076/131] (548s left) gem_exec_schedule (u-independent)
[469.612269] Starting subtest: u-independent
[469.614314] Starting dynamic subtest: rcs0
[470.897701] Dynamic subtest rcs0: SUCCESS (1.295s)
[470.909898] Starting dynamic subtest: vcs0
[472.897076] Dynamic subtest vcs0: SUCCESS (1.998s)
[472.907212] Starting dynamic subtest: vcs1
[474.975895] Dynamic subtest vcs1: SUCCESS (2.077s)
[474.992590] Starting dynamic subtest: vecs0
[476.968604] Dynamic subtest vecs0: SUCCESS (1.990s)
[476.979925] Starting dynamic subtest: ccs0
[478.897915] Dynamic subtest ccs0: SUCCESS (1.927s)
[478.900994] Subtest u-independent: SUCCESS (9.296s)
[479.192932] [077/131] (538s left) gem_render_copy (linear-to-vebox-y-tiled)
[479.267646] Starting subtest: linear-to-vebox-y-tiled
[479.272344] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[479.453023] [078/131] (538s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[479.558610] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[486.280096] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.724s)
[486.465846] [079/131] (531s left) perf_pmu (semaphore-busy)
[486.507741] Starting subtest: semaphore-busy
[486.509841] Starting dynamic subtest: rcs0
[488.133675] Dynamic subtest rcs0: SUCCESS (1.624s)
[488.144905] Starting dynamic subtest: bcs0
[489.763872] Dynamic subtest bcs0: SUCCESS (1.628s)
[489.774502] Starting dynamic subtest: vcs0
[493.419732] Dynamic subtest vcs0: SUCCESS (3.654s)
[493.432567] Starting dynamic subtest: vcs1
[499.436333] Dynamic subtest vcs1: SUCCESS (6.014s)
[499.447397] Starting dynamic subtest: vecs0
[505.452277] Dynamic subtest vecs0: SUCCESS (6.013s)
[505.463658] Starting dynamic subtest: ccs0
[508.527281] Dynamic subtest ccs0: SUCCESS (3.073s)
[508.529477] Subtest semaphore-busy: SUCCESS (22.019s)
[508.641390] [080/131] (509s left) gen9_exec_parse (unaligned-jump)
[508.701124] Subtest unaligned-jump: SKIP (0.000s)
[508.763207] [081/131] (509s left) kms_scaling_modes (scaling-mode-none)
[508.851171] Starting subtest: scaling-mode-none
[508.853484] Starting dynamic subtest: pipe-A-eDP-1
[508.949851] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s)
[508.960208] Starting dynamic subtest: pipe-B-eDP-1
[508.984494] Dynamic subtest pipe-B-eDP-1: SKIP (0.031s)
[508.993725] Starting dynamic subtest: pipe-C-eDP-1
[509.021435] Dynamic subtest pipe-C-eDP-1: SKIP (0.037s)
[509.030935] Starting dynamic subtest: pipe-D-eDP-1
[509.052370] Dynamic subtest pipe-D-eDP-1: SKIP (0.030s)
[509.056507] Subtest scaling-mode-none: SKIP (0.199s)
[509.183401] [082/131] (509s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[509.564500] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[510.342730] [083/131] (508s left) gen7_exec_parse (oacontrol-tracking)
[510.407223] Subtest oacontrol-tracking: SKIP (0.000s)
[510.495083] [084/131] (507s left) gem_mmap_gtt (flink-race)
[510.549634] Subtest flink-race: SKIP (0.000s)
[510.612995] [085/131] (507s left) kms_psr (psr2-cursor-render)
[510.705462] Starting subtest: psr2-cursor-render
[510.707738] Starting dynamic subtest: eDP-1
[512.427297] Dynamic subtest eDP-1: SUCCESS (1.722s)
[512.429214] Subtest psr2-cursor-render: SUCCESS (1.722s)
[513.219983] [086/131] (505s left) gem_pxp (verify-pxp-stale-buf-execution)
[513.349747] Starting subtest: verify-pxp-stale-buf-execution
[514.410839] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.062s)
[514.551746] [087/131] (504s left) kms_vblank (wait-forked)
[514.646806] Starting subtest: wait-forked
[514.649096] Starting dynamic subtest: pipe-A-eDP-1
[516.444529] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.795s)
[516.460104] Starting dynamic subtest: pipe-D-eDP-1
[518.893578] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.447s)
[518.896188] Subtest wait-forked: SUCCESS (4.245s)
[519.774574] [088/131] (498s left) gem_userptr_blits (huge-split)
[519.844771] Starting subtest: huge-split
[519.851510] Subtest huge-split: SUCCESS (0.006s)
[519.980779] [089/131] (498s left) gem_exec_reloc (basic-gtt-wc)
[520.041552] Subtest basic-gtt-wc: SKIP (0.000s)
[520.133449] [090/131] (498s left) gem_set_tiling_vs_pwrite
[520.262454] [091/131] (498s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[525.254797] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[525.257218] Starting dynamic subtest: pipe-A-eDP-1
[532.229437] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.971s)
[532.262966] Starting dynamic subtest: pipe-B-eDP-1
[539.354819] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.124s)
[539.357095] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.100s)
[540.189820] [092/131] (478s left) i915_module_load (reload-with-fault-injection)
[540.233040] Starting subtest: reload-with-fault-injection
[585.428320] Subtest reload-with-fault-injection: SUCCESS (45.193s)
[585.458094] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[585.458777] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[585.462053] [093/131] (433s left) kms_chamelium_hpd (common-hpd-after-suspend)
[587.166297] Subtest common-hpd-after-suspend: SKIP (0.000s)
[588.007929] [FACT kms_chamelium_hpd (common-hpd-after-suspend)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[588.009076] [FACT kms_chamelium_hpd (common-hpd-after-suspend)] new: kernel.kmod_is_loaded.i915: true
[588.012607] [094/131] (430s left) sysfs_heartbeat_interval (idempotent)
[588.080473] Starting subtest: idempotent
[588.082885] Starting dynamic subtest: vecs0
[588.085236] Dynamic subtest vecs0: SUCCESS (0.001s)
[588.096244] Starting dynamic subtest: ccs0
[588.098560] Dynamic subtest ccs0: SUCCESS (0.001s)
[588.107254] Starting dynamic subtest: vcs0
[588.109499] Dynamic subtest vcs0: SUCCESS (0.000s)
[588.117955] Starting dynamic subtest: bcs0
[588.120138] Dynamic subtest bcs0: SUCCESS (0.000s)
[588.128107] Starting dynamic subtest: rcs0
[588.130271] Dynamic subtest rcs0: SUCCESS (0.001s)
[588.138123] Starting dynamic subtest: vcs1
[588.140293] Dynamic subtest vcs1: SUCCESS (0.000s)
[588.142491] Subtest idempotent: SUCCESS (0.007s)
[588.200848] [095/131] (430s left) kms_universal_plane (disable-primary-vs-flip)
[588.302092] Starting subtest: disable-primary-vs-flip
[588.304368] Starting dynamic subtest: pipe-A-eDP-1
[589.821094] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.518s)
[589.831100] Starting dynamic subtest: pipe-B-eDP-1
[592.181565] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.356s)
[592.192869] Starting dynamic subtest: pipe-C-eDP-1
[594.621655] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.438s)
[594.632502] Starting dynamic subtest: pipe-D-eDP-1
[596.936500] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.312s)
[596.938875] Subtest disable-primary-vs-flip: SUCCESS (8.631s)
[597.947437] [096/131] (420s left) kms_addfb_basic (invalid-get-prop)
[598.011295] Starting subtest: invalid-get-prop
[598.013215] Subtest invalid-get-prop: SUCCESS (0.000s)
[598.165342] [097/131] (420s left) syncobj_wait (wait-for-submit-delayed-submit)
[598.225208] Starting subtest: wait-for-submit-delayed-submit
[598.326062] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[598.403772] [098/131] (420s left) core_getversion (all-cards)
[598.444642] Starting subtest: all-cards
[598.453075] Subtest all-cards: SUCCESS (0.011s)
[598.491392] [099/131] (420s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[598.610513] Starting subtest: flip-vs-cursor-crc-legacy
[599.224962] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.616s)
[600.076185] [100/131] (418s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[600.174937] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[600.179121] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[600.286337] [101/131] (418s left) gem_ctx_persistence (legacy-engines-queued)
[600.350394] Starting subtest: legacy-engines-queued
[600.352747] Starting dynamic subtest: render
[600.469609] Dynamic subtest render: SUCCESS (0.118s)
[600.481464] Starting dynamic subtest: bsd1
[601.873655] Dynamic subtest bsd1: SUCCESS (1.399s)
[601.885924] Starting dynamic subtest: bsd2
[603.855271] Dynamic subtest bsd2: SUCCESS (1.978s)
[603.867361] Starting dynamic subtest: blt
[603.931382] Dynamic subtest blt: SUCCESS (0.075s)
[603.943515] Starting dynamic subtest: vebox
[605.904704] Dynamic subtest vebox: SUCCESS (1.969s)
[605.907754] Subtest legacy-engines-queued: SUCCESS (5.553s)
[605.983319] [102/131] (413s left) kms_atomic (plane-primary-legacy)
[606.088101] Starting subtest: plane-primary-legacy
[606.090429] Starting dynamic subtest: pipe-A-eDP-1
[606.540204] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.450s)
[606.542547] Subtest plane-primary-legacy: SUCCESS (0.451s)
[607.404575] [103/131] (411s left) gem_exec_balancer (bonded-pair)
[607.461453] Starting subtest: bonded-pair
[607.466103] Subtest bonded-pair: SKIP (0.000s)
[607.768330] [104/131] (411s left) sw_sync (alloc_fence_invalid_timeline)
[607.798105] Starting subtest: alloc_fence_invalid_timeline
[607.800418] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[607.854931] [105/131] (411s left) gem_mmap_gtt (basic-copy)
[607.907832] Subtest basic-copy: SKIP (0.000s)
[607.973517] [106/131] (411s left) kms_psr (fbc-psr-primary-blt)
[608.064640] Starting subtest: fbc-psr-primary-blt
[608.066827] Starting dynamic subtest: eDP-1
[608.071216] Dynamic subtest eDP-1: SKIP (0.000s)
[608.075664] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[608.136906] [107/131] (411s left) gem_mmap_wc (set-cache-level)
[608.186910] Subtest set-cache-level: SKIP (0.000s)
[608.241970] [108/131] (411s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[608.352090] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[612.023537] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.676s)
[613.209690] [109/131] (406s left) sw_sync (sync_merge)
[613.246690] Starting subtest: sync_merge
[613.249212] Subtest sync_merge: SUCCESS (0.000s)
[613.298221] [110/131] (406s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[613.388883] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[613.393440] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[613.477850] [111/131] (406s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[613.584652] Starting subtest: 4-tiled-addfb-size-offset-overflow
[613.586606] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[613.712242] [112/131] (405s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[613.808101] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[613.818818] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s)
[613.891323] [113/131] (405s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[613.957407] Starting subtest: basic-batch-kernel-default-cmd
[613.961628] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[614.142656] [114/131] (405s left) gem_ctx_bad_destroy (invalid-pad)
[614.191823] Starting subtest: invalid-pad
[614.194183] Subtest invalid-pad: SUCCESS (0.000s)
[614.267283] [115/131] (405s left) perf (invalid-remove-userspace-config)
[614.392487] Starting subtest: invalid-remove-userspace-config
[614.397568] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[614.445526] [116/131] (405s left) gem_media_vme
[614.599990] [117/131] (405s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[614.645297] Starting subtest: multi-wait-all-available-submitted-signaled
[614.647615] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[614.768214] [118/131] (405s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[614.851429] Starting subtest: compare-crc-sanitycheck-xr24
[614.853772] Starting dynamic subtest: pipe-A-eDP-1
[615.456223] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s)
[615.466421] Starting dynamic subtest: pipe-B-eDP-1
[616.735821] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.277s)
[616.746111] Starting dynamic subtest: pipe-C-eDP-1
[617.918893] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.181s)
[617.928911] Starting dynamic subtest: pipe-D-eDP-1
[619.148556] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[619.150985] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.296s)
[620.008404] [119/131] (399s left) kms_writeback (writeback-invalid-parameters)
[620.112244] Subtest writeback-invalid-parameters: SKIP (0.000s)
[620.157523] [120/131] (399s left) perf (enable-disable)
[620.238362] Starting subtest: enable-disable
[620.240692] Starting dynamic subtest: 0-rcs0
[622.490123] Dynamic subtest 0-rcs0: SUCCESS (2.250s)
[622.501082] Starting dynamic subtest: 1-vcs1
[626.939578] Dynamic subtest 1-vcs1: SUCCESS (4.448s)
[626.941777] Subtest enable-disable: SUCCESS (6.699s)
[626.980752] [121/131] (392s left) syncobj_timeline (host-signal-points)
[627.036658] Starting subtest: host-signal-points
[627.041785] Subtest host-signal-points: SUCCESS (0.005s)
[627.160113] [122/131] (392s left) kms_atomic_transition (plane-all-modeset-transition)
[627.263601] Starting subtest: plane-all-modeset-transition
[627.268115] Subtest plane-all-modeset-transition: SKIP (0.000s)
[627.332572] [123/131] (392s left) gem_ctx_isolation (preservation-s3)
[627.399262] Starting subtest: preservation-S3
[627.401651] Starting dynamic subtest: rcs0
[643.206182] Dynamic subtest rcs0: SUCCESS (1.334s)
[643.217261] Starting dynamic subtest: bcs0
[659.120779] Dynamic subtest bcs0: SUCCESS (1.261s)
[659.130876] Starting dynamic subtest: vcs0
[675.136423] Dynamic subtest vcs0: SUCCESS (2.944s)
[675.148952] Starting dynamic subtest: vcs1
[693.187319] Dynamic subtest vcs1: SUCCESS (5.028s)
[693.197071] Starting dynamic subtest: vecs0
[711.199323] Dynamic subtest vecs0: SUCCESS (4.981s)
[711.209932] Starting dynamic subtest: ccs0
[729.137704] Dynamic subtest ccs0: SUCCESS (3.130s)
[729.140311] Subtest preservation-S3: SUCCESS (18.683s)
[729.367433] [124/131] (290s left) gem_create (create-ext-placement-sanity-check)
[729.547481] Starting subtest: create-ext-placement-sanity-check
[729.554895] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[729.656131] [125/131] (290s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[729.747357] Starting subtest: primary-y-tiled-reflect-x-0
[729.810434] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s)
[729.915539] [126/131] (290s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[730.011614] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[737.217035] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.205s)
[737.366614] [127/131] (282s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[737.484330] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[737.488757] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[737.590545] [128/131] (282s left) gem_exec_nop (basic-sequential)
[737.657627] Starting subtest: basic-sequential
[752.466764] Subtest basic-sequential: SUCCESS (14.808s)
[752.703631] [129/131] (267s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt)
[752.798886] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt
[759.509239] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (6.710s)
[759.649328] [130/131] (260s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[759.740443] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[759.743283] Starting dynamic subtest: pipe-A-eDP-1
[760.460475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[760.470045] Starting dynamic subtest: pipe-B-eDP-1
[762.203494] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.741s)
[762.214027] Starting dynamic subtest: pipe-C-eDP-1
[763.946230] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.741s)
[763.956615] Starting dynamic subtest: pipe-D-eDP-1
[765.683347] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.736s)
[765.685989] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.931s)
[766.830639] [131/131] (253s left) gem_mmap_offset (clear-via-pagefault)
[766.894140] Starting subtest: clear-via-pagefault
[766.896609] Starting dynamic subtest: smem0
[799.595316] Dynamic subtest smem0: SUCCESS (32.694s)
[799.597871] Subtest clear-via-pagefault: SUCCESS (32.696s)
[799.706836] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: kms_async_flips
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_properties
results: parsing output: 4/ for test: i915_hangman
results: parsing output: 5/ for test: dmabuf_sync_file
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: gem_reg_read
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_plane_lowres
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_softpin
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: kms_invalid_mode
results: parsing output: 23/ for test: gem_exec_whisper
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_addfb_basic
results: parsing output: 30/ for test: kms_dsc
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: kms_addfb_basic
results: parsing output: 35/ for test: gem_exec_basic
results: parsing output: 36/ for test: gem_mmap_wc
results: parsing output: 37/ for test: i915_pm_rpm
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_chamelium_edid
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: api_intel_bb
results: parsing output: 43/ for test: kms_hdr
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_exec_await
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_exec_parallel
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_rotation_crc
results: parsing output: 54/ for test: kms_plane_scaling
results: parsing output: 55/ for test: gem_ctx_create
results: parsing output: 56/ for test: gem_ctx_param
results: parsing output: 57/ for test: prime_busy
results: parsing output: 58/ for test: kms_lease
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: gem_exec_gttfill
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_exec_flush
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: drm_read
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: prime_vgem
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gen3_mixed_blits
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_dp_linktrain_fallback
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: gem_render_copy
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: gen9_exec_parse
results: parsing output: 80/ for test: kms_scaling_modes
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: gen7_exec_parse
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_pxp
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: i915_module_load
results: parsing output: 92/ for test: kms_chamelium_hpd
results: parsing output: 93/ for test: sysfs_heartbeat_interval
results: parsing output: 94/ for test: kms_universal_plane
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: core_getversion
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: kms_atomic
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: sw_sync
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: sw_sync
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: gem_exec_flush
results: parsing output: 113/ for test: gem_ctx_bad_destroy
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: gem_media_vme
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: kms_writeback
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_atomic_transition
results: parsing output: 122/ for test: gem_ctx_isolation
results: parsing output: 123/ for test: gem_create
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_nop
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: gem_mmap_offset
Done.