[59.277456] Initializing watchdogs
[59.277505]   /dev/watchdog0
[59.293116] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.297933] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.300537] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.302861] [001/156] (960s left) kms_psr (psr-cursor-render)
[59.396693] Starting subtest: psr-cursor-render
[59.397472] Starting dynamic subtest: eDP-1
[61.162830] Dynamic subtest eDP-1: SUCCESS (1.770s)
[61.163793] Subtest psr-cursor-render: SUCCESS (1.771s)
[62.034370] [002/156] (957s left) syncobj_timeline (wait-zero-handles)
[62.078964] Starting subtest: wait-zero-handles
[62.080644] Subtest wait-zero-handles: SUCCESS (0.000s)
[62.190467] [003/156] (957s left) gem_exec_capture (capture)
[62.252238] Starting subtest: capture
[62.253278] Starting dynamic subtest: rcs0-smem
[63.053465] Dynamic subtest rcs0-smem: SUCCESS (0.803s)
[63.060854] Starting dynamic subtest: bcs0-smem
[64.362223] Dynamic subtest bcs0-smem: SUCCESS (1.310s)
[64.369823] Starting dynamic subtest: vcs0-smem
[65.164959] Dynamic subtest vcs0-smem: SUCCESS (0.804s)
[65.175179] Starting dynamic subtest: vcs1-smem
[65.971737] Dynamic subtest vcs1-smem: SUCCESS (0.808s)
[65.980615] Starting dynamic subtest: vecs0-smem
[67.319102] Dynamic subtest vecs0-smem: FAIL (1.327s)
[67.325096] Starting dynamic subtest: ccs0-smem
[68.621425] Dynamic subtest ccs0-smem: SUCCESS (1.324s)
[68.622305] Subtest capture: FAIL (6.377s)
[68.732068] [004/156] (951s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[68.824826] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[68.827071] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[68.915679] [005/156] (951s left) gem_partial_pwrite_pread (write-uncached)
[68.976563] Subtest write-uncached: SKIP (0.000s)
[69.046194] [006/156] (950s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[69.149228] Starting subtest: 4-tiled-64bpp-rotate-180
[70.838646] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.691s)
[70.997532] [007/156] (948s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[71.094855] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[79.094528] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (8.003s)
[79.197819] [008/156] (940s left) kms_cursor_crc (cursor-offscreen-128x42)
[79.419849] Starting subtest: cursor-offscreen-128x42
[79.469584] Subtest cursor-offscreen-128x42: SKIP (0.046s)
[79.674071] [009/156] (940s left) syncobj_timeline (single-wait-all-signaled)
[79.732423] Starting subtest: single-wait-all-signaled
[79.733644] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[79.821316] [010/156] (940s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[79.905442] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[79.906503] Starting dynamic subtest: pipe-A-eDP-1
[79.932106] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[79.939809] Starting dynamic subtest: pipe-B-eDP-1
[79.964573] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[79.972077] Starting dynamic subtest: pipe-C-eDP-1
[79.993237] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[80.001238] Starting dynamic subtest: pipe-D-eDP-1
[80.025238] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[80.026908] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.007s)
[82.218346] [011/156] (937s left) perf_pmu (rc6)
[82.254102] Starting subtest: rc6
[82.255044] Starting dynamic subtest: gt0
[88.659810] Dynamic subtest gt0: SUCCESS (6.359s)
[88.666573] Starting dynamic subtest: runtime-pm-gt0
[96.353061] Dynamic subtest runtime-pm-gt0: SUCCESS (7.728s)
[96.363324] Starting dynamic subtest: runtime-pm-long-gt0
[108.786486] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.432s)
[108.796912] Starting dynamic subtest: other-idle-gt0
[115.129940] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[115.140025] Starting dynamic subtest: gt1
[121.470726] Dynamic subtest gt1: SUCCESS (6.340s)
[121.480872] Starting dynamic subtest: runtime-pm-gt1
[128.990301] Dynamic subtest runtime-pm-gt1: SUCCESS (7.518s)
[129.000315] Starting dynamic subtest: runtime-pm-long-gt1
[141.436729] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.445s)
[141.447517] Starting dynamic subtest: other-idle-gt1
[147.780747] Dynamic subtest other-idle-gt1: SUCCESS (6.343s)
[147.782073] Subtest rc6: SUCCESS (65.516s)
[148.410123] [012/156] (871s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[148.504599] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[148.506533] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[148.579577] [013/156] (871s left) gem_softpin (full)
[148.627642] Starting subtest: full
[148.635660] Subtest full: SUCCESS (0.008s)
[148.737172] [014/156] (871s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[148.823076] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[148.824679] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[148.901464] [015/156] (871s left) kms_psr (fbc-psr-cursor-plane-onoff)
[148.986780] Starting subtest: fbc-psr-cursor-plane-onoff
[148.988089] Starting dynamic subtest: eDP-1
[148.989941] Dynamic subtest eDP-1: SKIP (0.000s)
[148.991825] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[149.028598] [016/156] (871s left) kms_vblank (query-forked-hang)
[149.110292] Starting subtest: query-forked-hang
[149.111576] Starting dynamic subtest: pipe-A-eDP-1
[175.066780] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.954s)
[175.077437] Starting dynamic subtest: pipe-D-eDP-1
[200.093384] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.024s)
[200.094901] Subtest query-forked-hang: SUCCESS (50.983s)
[200.882327] [017/156] (819s left) kms_dsc (dsc-with-bpc)
[200.971970] Starting subtest: dsc-with-bpc
[200.985445] Subtest dsc-with-bpc: SKIP (0.001s)
[201.013162] [018/156] (819s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[201.108614] Starting subtest: psr-rgb101010-draw-pwrite
[209.210901] Subtest psr-rgb101010-draw-pwrite: SUCCESS (8.104s)
[209.316709] [019/156] (811s left) gem_tiled_swapping (non-threaded)
[209.365992] Subtest non-threaded: SKIP (0.000s)
[209.412237] [020/156] (810s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[209.499451] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[209.500990] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[209.576521] [021/156] (810s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[209.677379] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[209.679054] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[209.749185] [022/156] (810s left) api_intel_allocator (execbuf-with-allocator)
[209.800443] Starting subtest: execbuf-with-allocator
[209.805418] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[209.876272] [023/156] (810s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[209.967273] Starting subtest: fbcpsr-indfb-scaledprimary
[215.703209] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.737s)
[215.795727] [024/156] (804s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[215.877505] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[215.889078] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[215.933696] [025/156] (804s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[216.028470] Starting subtest: fbc-psr2-primary-mmap-cpu
[216.029286] Starting dynamic subtest: eDP-1
[216.030855] Dynamic subtest eDP-1: SKIP (0.000s)
[216.032552] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[216.092050] [026/156] (804s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[216.189211] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[216.190316] Starting dynamic subtest: pipe-A
[217.237377] Dynamic subtest pipe-A: SUCCESS (1.050s)
[217.244456] Starting dynamic subtest: pipe-B
[219.376212] Dynamic subtest pipe-B: SUCCESS (2.138s)
[219.384447] Starting dynamic subtest: pipe-C
[220.573431] Dynamic subtest pipe-C: SUCCESS (1.196s)
[220.580453] Starting dynamic subtest: pipe-D
[221.807589] Dynamic subtest pipe-D: SUCCESS (1.234s)
[221.808579] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.620s)
[222.981969] [027/156] (797s left) gem_readwrite (beyond-eob)
[223.029303] Subtest beyond-EOB: SKIP (0.000s)
[223.091108] [028/156] (797s left) gen9_exec_parse (basic-rejected-ctx-param)
[223.140339] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[223.205284] [029/156] (797s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[223.299395] Starting subtest: psr2-cursor-plane-update-sf
[223.300281] Starting dynamic subtest: pipe-A-eDP-1
[223.876754] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s)
[223.886650] Starting dynamic subtest: pipe-B-eDP-1
[225.202723] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.323s)
[225.204465] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.904s)
[226.041669] [030/156] (794s left) kms_flip (flip-vs-expired-vblank-interruptible)
[226.132054] Starting subtest: flip-vs-expired-vblank-interruptible
[226.133174] Starting dynamic subtest: A-eDP1
[234.810835] Dynamic subtest A-eDP1: SUCCESS (8.652s)
[234.817781] Starting dynamic subtest: B-eDP1
[243.443394] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[243.453231] Starting dynamic subtest: C-eDP1
[252.063356] Dynamic subtest C-eDP1: SUCCESS (8.608s)
[252.073547] Starting dynamic subtest: D-eDP1
[260.693225] Dynamic subtest D-eDP1: SUCCESS (8.626s)
[260.694187] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.528s)
[261.802160] [031/156] (758s left) kms_flip (flip-vs-suspend-interruptible)
[261.898581] Starting subtest: flip-vs-suspend-interruptible
[261.899600] Starting dynamic subtest: A-eDP1
[375.885802] Dynamic subtest A-eDP1: SUCCESS (12.486s)
[375.888022] Subtest flip-vs-suspend-interruptible: SUCCESS (12.489s)
[383.009867] [032/156] (644s left) gem_wait (wait)
[383.066503] Starting subtest: wait
[383.067586] Starting dynamic subtest: all-engines
[384.802718] Dynamic subtest all-engines: SUCCESS (1.732s)
[384.811323] Starting dynamic subtest: rcs0
[385.842560] Dynamic subtest rcs0: SUCCESS (1.052s)
[385.855397] Starting dynamic subtest: bcs0
[386.890813] Dynamic subtest bcs0: SUCCESS (1.051s)
[386.901881] Starting dynamic subtest: vcs0
[387.936872] Dynamic subtest vcs0: SUCCESS (1.048s)
[387.949227] Starting dynamic subtest: vcs1
[388.983166] Dynamic subtest vcs1: SUCCESS (1.048s)
[388.995484] Starting dynamic subtest: vecs0
[390.027400] Dynamic subtest vecs0: SUCCESS (1.045s)
[390.038309] Starting dynamic subtest: ccs0
[391.074026] Dynamic subtest ccs0: SUCCESS (1.048s)
[391.075621] Subtest wait: SUCCESS (8.039s)
[391.246636] [033/156] (636s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[391.331737] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[391.333368] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[391.373749] [034/156] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[391.465300] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[398.510304] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.060s)
[398.631506] [035/156] (629s left) gem_exec_balancer (full-late-pulse)
[398.699690] Starting subtest: full-late-pulse
[403.747554] Subtest full-late-pulse: SUCCESS (5.054s)
[404.033145] [036/156] (623s left) kms_big_fb (linear-16bpp-rotate-180)
[404.137877] Starting subtest: linear-16bpp-rotate-180
[405.450757] Subtest linear-16bpp-rotate-180: SUCCESS (1.314s)
[405.543302] [037/156] (622s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[405.920654] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[406.706648] [038/156] (621s left) gem_exec_params (no-blt)
[406.758722] Starting subtest: no-blt
[406.759617] Subtest no-blt: SUCCESS (0.002s)
[406.843328] [039/156] (621s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[406.934405] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[406.936319] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[407.003797] [040/156] (621s left) kms_pm_rpm (cursor-dpms)
[409.034609] Starting subtest: cursor-dpms
[409.037664] Subtest cursor-dpms: SKIP (0.000s)
[409.385579] [041/156] (618s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[409.764070] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[410.606865] [042/156] (617s left) kms_properties (colorop-properties-atomic)
[410.697239] Starting subtest: colorop-properties-atomic
[410.698099] Starting dynamic subtest: pipe-A-eDP-1
[411.053859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.356s)
[411.062331] Starting dynamic subtest: pipe-B-eDP-1
[412.096943] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.042s)
[412.106773] Starting dynamic subtest: pipe-C-eDP-1
[413.139348] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.042s)
[413.149866] Starting dynamic subtest: pipe-D-eDP-1
[414.186962] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.047s)
[414.188244] Subtest colorop-properties-atomic: SUCCESS (3.492s)
[415.048440] [043/156] (613s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[415.162804] Starting subtest: short-flip-before-cursor-toggle
[416.078115] Subtest short-flip-before-cursor-toggle: SUCCESS (0.915s)
[416.881219] [044/156] (611s left) kms_cursor_legacy (forked-move)
[416.993930] Starting subtest: forked-move
[416.995161] Starting dynamic subtest: pipe-A
[422.530464] Dynamic subtest pipe-A: SUCCESS (5.491s)
[422.543800] Starting dynamic subtest: pipe-B
[428.000697] Dynamic subtest pipe-B: SUCCESS (5.470s)
[428.013199] Starting dynamic subtest: pipe-C
[433.488026] Dynamic subtest pipe-C: SUCCESS (5.488s)
[433.498443] Starting dynamic subtest: pipe-D
[438.954185] Dynamic subtest pipe-D: SUCCESS (5.466s)
[438.966220] Starting dynamic subtest: all-pipes
[444.441651] Dynamic subtest all-pipes: SUCCESS (5.489s)
[444.442570] Subtest forked-move: SUCCESS (27.416s)
[444.511130] [045/156] (583s left) gem_exec_parallel (engines)
[444.572570] Starting subtest: engines
[444.573375] Starting dynamic subtest: basic
[447.845945] Dynamic subtest basic: SUCCESS (3.266s)
[447.857632] Starting dynamic subtest: contexts
[452.137492] Dynamic subtest contexts: SUCCESS (4.291s)
[452.146081] Starting dynamic subtest: fds
[455.963150] Dynamic subtest fds: SUCCESS (3.826s)
[455.973003] Starting dynamic subtest: userptr
[457.826730] Dynamic subtest userptr: SUCCESS (1.863s)
[457.827805] Subtest engines: SUCCESS (13.254s)
[457.981985] [046/156] (570s left) gem_exec_schedule (preempt-self)
[458.045369] Starting subtest: preempt-self
[458.046510] Starting dynamic subtest: rcs0
[458.079735] Dynamic subtest rcs0: SUCCESS (0.035s)
[458.090207] Starting dynamic subtest: bcs0
[458.109700] Dynamic subtest bcs0: SUCCESS (0.029s)
[458.122438] Starting dynamic subtest: vcs0
[458.141121] Dynamic subtest vcs0: SUCCESS (0.031s)
[458.153709] Starting dynamic subtest: vcs1
[458.169009] Dynamic subtest vcs1: SUCCESS (0.027s)
[458.177459] Starting dynamic subtest: vecs0
[458.198146] Dynamic subtest vecs0: SUCCESS (0.028s)
[458.207317] Starting dynamic subtest: ccs0
[458.232503] Dynamic subtest ccs0: SUCCESS (0.033s)
[458.233823] Subtest preempt-self: SUCCESS (0.188s)
[459.864112] [047/156] (568s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[459.955483] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[459.957307] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[460.037246] [048/156] (568s left) gem_eio (wait-wedge-immediate)
[460.269519] Starting subtest: wait-wedge-immediate
[461.929178] Subtest wait-wedge-immediate: SUCCESS (1.660s)
[462.016688] [049/156] (566s left) gem_ctx_persistence (file)
[462.074061] Starting subtest: file
[462.193646] Subtest file: SUCCESS (0.119s)
[462.283043] [050/156] (566s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[462.375290] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[462.376982] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[462.448915] [051/156] (565s left) syncobj_timeline (etime-multi-wait-submitted)
[462.505571] Starting subtest: etime-multi-wait-submitted
[462.613628] Subtest etime-multi-wait-submitted: SUCCESS (0.107s)
[462.660868] [052/156] (565s left) kms_async_flips (crc-atomic)
[462.751322] Starting subtest: crc-atomic
[463.144498] Starting dynamic subtest: pipe-A-eDP-1
[466.108774] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.965s)
[466.489279] Starting dynamic subtest: pipe-B-eDP-1
[469.435269] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.956s)
[469.809819] Starting dynamic subtest: pipe-C-eDP-1
[472.739164] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.939s)
[473.099461] Starting dynamic subtest: pipe-D-eDP-1
[475.966758] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.878s)
[475.967602] Subtest crc-atomic: SUCCESS (13.224s)
[477.110234] [053/156] (551s left) gem_lmem_swapping (heavy-verify-random-ccs)
[477.149910] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[477.179869] [054/156] (551s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[477.280512] Starting subtest: pipe-fbc-rte
[477.283502] Starting dynamic subtest: pipe-B-eDP-1
[482.816485] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.533s)
[482.822515] Subtest pipe-fbc-rte: SUCCESS (5.535s)
[485.040494] [055/156] (543s left) gem_exec_whisper (basic-contexts-priority-all)
[485.100370] Starting subtest: basic-contexts-priority-all
[508.081457] Subtest basic-contexts-priority-all: SUCCESS (22.959s)
[508.231576] [056/156] (520s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[508.324241] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[508.326129] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[509.408190] [057/156] (519s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[509.507397] Starting subtest: fbc-1p-pri-indfb-multidraw
[522.767042] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.259s)
[524.147474] [058/156] (504s left) kms_atomic (crtc-invalid-params-fence)
[524.233287] Starting subtest: crtc-invalid-params-fence
[524.234231] Starting dynamic subtest: pipe-A-eDP-1
[524.658225] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[524.659152] Subtest crtc-invalid-params-fence: SUCCESS (0.425s)
[525.477513] [059/156] (503s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[525.573296] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[529.320589] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.749s)
[530.468498] [060/156] (498s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-msflip-blt)
[530.560497] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-msflip-blt
[530.562104] Subtest fbcpsrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[530.627797] [061/156] (498s left) gem_lmem_swapping (verify-random)
[530.664555] Subtest verify-random: SKIP (0.000s)
[530.699825] [062/156] (498s left) kms_cursor_crc (cursor-random-32x10)
[530.855702] Starting subtest: cursor-random-32x10
[530.898653] Subtest cursor-random-32x10: SKIP (0.042s)
[531.145055] [063/156] (497s left) kms_lease (lease-get)
[531.228259] Starting subtest: lease-get
[531.229192] Starting dynamic subtest: pipe-A-eDP-1
[531.230238] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[531.241333] Starting dynamic subtest: pipe-B-eDP-1
[531.242237] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[531.251234] Starting dynamic subtest: pipe-C-eDP-1
[531.252221] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[531.260833] Starting dynamic subtest: pipe-D-eDP-1
[531.261670] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[531.262594] Subtest lease-get: SUCCESS (0.016s)
[531.334198] [064/156] (497s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-rte)
[531.428693] Starting subtest: fbcpsrhdr-1p-rte
[531.430683] Subtest fbcpsrhdr-1p-rte: SKIP (0.000s)
[531.500700] [065/156] (497s left) gem_exec_fence (syncobj-import)
[531.994117] Starting subtest: syncobj-import
[531.998948] Subtest syncobj-import: SUCCESS (0.005s)
[533.904771] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[533.906993] [066/156] (495s left) kms_properties (crtc-properties-atomic)
[534.001797] Starting subtest: crtc-properties-atomic
[534.003216] Starting dynamic subtest: pipe-A-eDP-1
[534.446426] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[534.455708] Starting dynamic subtest: pipe-B-eDP-1
[535.641137] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.193s)
[535.652512] Starting dynamic subtest: pipe-C-eDP-1
[536.758570] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[536.768196] Starting dynamic subtest: pipe-D-eDP-1
[537.901131] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[537.902284] Subtest crtc-properties-atomic: SUCCESS (3.899s)
[538.685336] [067/156] (490s left) api_intel_bb (object-noreloc-keep-cache-simple)
[538.739875] Starting subtest: object-noreloc-keep-cache-simple
[538.744447] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[538.843344] [068/156] (490s left) drm_read (short-buffer-wakeup)
[538.988113] Starting subtest: short-buffer-wakeup
[571.205764] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[571.308136] [069/156] (457s left) kms_frontbuffer_tracking (psrhdr-suspend)
[571.408865] Starting subtest: psrhdr-suspend
[571.410566] Subtest psrhdr-suspend: SKIP (0.000s)
[571.486126] [070/156] (457s left) kms_vrr (seamless-rr-switch-vrr)
[571.566200] Starting subtest: seamless-rr-switch-vrr
[571.568515] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[571.610684] [071/156] (457s left) sriov_basic (enable-vfs-autoprobe-on)
[571.663180] Starting subtest: enable-vfs-autoprobe-on
[571.664239] Starting dynamic subtest: numvfs-1
[571.666032] Dynamic subtest numvfs-1: SKIP (0.001s)
[571.676544] Starting dynamic subtest: numvfs-2
[571.678140] Dynamic subtest numvfs-2: SKIP (0.001s)
[571.686981] Starting dynamic subtest: numvfs-3
[571.688843] Dynamic subtest numvfs-3: SKIP (0.001s)
[571.697840] Starting dynamic subtest: numvfs-4
[571.699582] Dynamic subtest numvfs-4: SKIP (0.001s)
[571.708376] Starting dynamic subtest: numvfs-5
[571.710337] Dynamic subtest numvfs-5: SKIP (0.001s)
[571.719038] Starting dynamic subtest: numvfs-6
[571.720749] Dynamic subtest numvfs-6: SKIP (0.001s)
[571.729550] Starting dynamic subtest: numvfs-7
[571.731270] Dynamic subtest numvfs-7: SKIP (0.001s)
[571.740040] Starting dynamic subtest: numvfs-random
[571.741852] Dynamic subtest numvfs-random: SKIP (0.001s)
[571.750448] Starting dynamic subtest: numvfs-all
[571.752184] Dynamic subtest numvfs-all: SKIP (0.001s)
[571.753808] Subtest enable-vfs-autoprobe-on: SKIP (0.011s)
[571.786989] [072/156] (457s left) kms_psr (psr2-cursor-mmap-gtt)
[571.870358] Starting subtest: psr2-cursor-mmap-gtt
[571.871301] Starting dynamic subtest: eDP-1
[573.587301] Dynamic subtest eDP-1: SUCCESS (1.716s)
[573.588320] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.718s)
[574.441773] [073/156] (454s left) gem_workarounds (basic-read-fd)
[574.498735] Starting subtest: basic-read-fd
[574.508470] Subtest basic-read-fd: SUCCESS (0.010s)
[574.593561] [074/156] (454s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[574.689277] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[575.370261] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[575.494280] [075/156] (453s left) gem_exec_reloc (basic-cpu-wc-active)
[575.552479] Subtest basic-cpu-wc-active: SKIP (0.000s)
[575.626449] [076/156] (453s left) kms_cursor_edge_walk (256x256-right-edge)
[575.716307] Starting subtest: 256x256-right-edge
[575.717223] Starting dynamic subtest: pipe-A-eDP-1
[579.241348] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.526s)
[579.252934] Starting dynamic subtest: pipe-D-eDP-1
[582.459098] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.216s)
[582.460104] Subtest 256x256-right-edge: SUCCESS (6.746s)
[583.248984] [077/156] (446s left) gem_mmap_wc (bad-offset)
[583.304833] Subtest bad-offset: SKIP (0.000s)
[583.361713] [078/156] (445s left) kms_psr (psr-primary-render)
[583.457219] Starting subtest: psr-primary-render
[583.458281] Starting dynamic subtest: eDP-1
[585.168085] Dynamic subtest eDP-1: SUCCESS (1.709s)
[585.169115] Subtest psr-primary-render: SUCCESS (1.710s)
[586.017397] [079/156] (443s left) prime_vgem (basic-fence-read)
[586.089636] Starting subtest: basic-fence-read
[586.100248] Subtest basic-fence-read: SKIP (0.010s)
[586.186602] [080/156] (443s left) gem_exec_schedule (out-order)
[586.248613] Starting subtest: out-order
[586.249472] Starting dynamic subtest: rcs0
[586.352236] Dynamic subtest rcs0: SUCCESS (0.104s)
[586.363615] Starting dynamic subtest: vcs0
[586.434821] Dynamic subtest vcs0: SUCCESS (0.083s)
[586.448365] Starting dynamic subtest: vcs1
[586.522858] Dynamic subtest vcs1: SUCCESS (0.087s)
[586.534920] Starting dynamic subtest: vecs0
[586.602319] Dynamic subtest vecs0: SUCCESS (0.079s)
[586.615720] Starting dynamic subtest: ccs0
[586.698510] Dynamic subtest ccs0: SUCCESS (0.095s)
[586.699708] Subtest out-order: SUCCESS (0.453s)
[587.867351] [081/156] (441s left) syncobj_timeline (device-signal-unordered)
[587.923098] Starting subtest: device-signal-unordered
[587.924080] Subtest device-signal-unordered: SUCCESS (0.000s)
[587.983277] [082/156] (441s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[588.078660] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[592.449631] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.375s)
[593.647485] [083/156] (435s left) sw_sync (alloc_merge_fence)
[593.678082] Starting subtest: alloc_merge_fence
[593.678857] Subtest alloc_merge_fence: SUCCESS (0.000s)
[593.711139] [084/156] (435s left) gem_ctx_create (basic-files)
[593.769431] Starting subtest: basic-files
[595.782494] Subtest basic-files: SUCCESS (2.013s)
[596.135052] [085/156] (433s left) kms_color (deep-color)
[596.235781] Starting subtest: deep-color
[597.339633] Starting dynamic subtest: pipe-A-eDP-1-gamma
[598.065061] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.725s)
[598.077122] Starting dynamic subtest: pipe-A-eDP-1-degamma
[599.561768] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.496s)
[599.571126] Starting dynamic subtest: pipe-A-eDP-1-ctm
[601.064393] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.504s)
[601.831760] Starting dynamic subtest: pipe-B-eDP-1-gamma
[602.546406] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.724s)
[602.555421] Starting dynamic subtest: pipe-B-eDP-1-degamma
[604.041126] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.495s)
[604.050462] Starting dynamic subtest: pipe-B-eDP-1-ctm
[605.469844] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.428s)
[606.242853] Starting dynamic subtest: pipe-C-eDP-1-gamma
[606.931804] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.699s)
[606.942282] Starting dynamic subtest: pipe-C-eDP-1-degamma
[608.335123] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.402s)
[608.344515] Starting dynamic subtest: pipe-C-eDP-1-ctm
[609.761427] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.425s)
[610.569928] Starting dynamic subtest: pipe-D-eDP-1-gamma
[611.265763] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.705s)
[611.275717] Starting dynamic subtest: pipe-D-eDP-1-degamma
[612.729966] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.463s)
[612.739308] Starting dynamic subtest: pipe-D-eDP-1-ctm
[614.158071] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.427s)
[614.159469] Subtest deep-color: SUCCESS (17.922s)
[614.984223] [086/156] (414s left) gem_exec_reloc (basic-wc-cpu)
[615.048929] Subtest basic-wc-cpu: SKIP (0.000s)
[615.121296] [087/156] (414s left) gem_exec_reloc (basic-cpu-gtt)
[615.171502] Subtest basic-cpu-gtt: SKIP (0.000s)
[615.227008] [088/156] (414s left) syncobj_timeline (multi-wait-available-signaled)
[615.277455] Starting subtest: multi-wait-available-signaled
[615.278274] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[615.342285] [089/156] (414s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[615.429760] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[615.431737] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[615.474617] [090/156] (414s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[615.534344] Starting subtest: y-tiled-to-vebox-yf-tiled
[615.536302] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[615.690338] [091/156] (414s left) kms_joiner (invalid-modeset-force-big-joiner)
[615.780451] Starting subtest: invalid-modeset-force-big-joiner
[615.782133] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[615.823413] [092/156] (414s left) i915_suspend (sysfs-reader)
[615.871451] Starting subtest: sysfs-reader
[634.856375] Subtest sysfs-reader: SUCCESS (3.513s)
[641.978290] [093/156] (394s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[642.080904] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[642.082686] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[642.163965] [094/156] (394s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[642.250008] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[642.250769] Starting dynamic subtest: pipe-A-eDP-1
[642.258803] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[642.268798] Starting dynamic subtest: pipe-B-eDP-1
[642.277888] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[642.289798] Starting dynamic subtest: pipe-C-eDP-1
[642.297565] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[642.306807] Starting dynamic subtest: pipe-D-eDP-1
[642.314912] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[642.316468] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[644.464528] [095/156] (392s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[644.548503] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[644.550234] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[644.626191] [096/156] (392s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[644.708318] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[644.709299] Starting dynamic subtest: pipe-A-default-mode
[645.845152] Dynamic subtest pipe-A-default-mode: SKIP (1.139s)
[645.847481] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.141s)
[645.962645] [097/156] (391s left) syncobj_wait (invalid-reset-bad-pad)
[646.019954] Starting subtest: invalid-reset-bad-pad
[646.021091] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[646.093661] [098/156] (391s left) kms_chamelium_color (ctm-0-50)
[646.185698] Subtest ctm-0-50: SKIP (0.000s)
[646.232139] [099/156] (390s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[646.314249] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[646.315861] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[646.378824] [100/156] (390s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[646.472408] Starting subtest: primary-yf-tiled-reflect-x-270
[646.474449] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[646.521250] [101/156] (390s left) gem_ctx_shared (exec-shared-gtt)
[646.570072] Starting subtest: exec-shared-gtt
[646.571185] Starting dynamic subtest: rcs0
[646.578397] Dynamic subtest rcs0: SUCCESS (0.008s)
[646.588407] Starting dynamic subtest: bcs0
[646.589262] Dynamic subtest bcs0: SUCCESS (0.007s)
[646.599107] Starting dynamic subtest: vcs0
[646.600058] Dynamic subtest vcs0: SUCCESS (0.008s)
[646.609155] Starting dynamic subtest: vcs1
[646.610009] Dynamic subtest vcs1: SUCCESS (0.007s)
[646.619292] Starting dynamic subtest: vecs0
[646.620251] Dynamic subtest vecs0: SUCCESS (0.005s)
[646.629364] Starting dynamic subtest: ccs0
[646.630221] Dynamic subtest ccs0: SUCCESS (0.005s)
[646.631105] Subtest exec-shared-gtt: SUCCESS (0.045s)
[646.773407] [102/156] (390s left) gem_mmap_gtt (basic-small-copy-xy)
[646.814002] Subtest basic-small-copy-XY: SKIP (0.000s)
[646.859515] [103/156] (390s left) gem_mmap (big-bo)
[646.908719] Subtest big-bo: SKIP (0.000s)
[646.970673] [104/156] (390s left) gem_basic (create-fd-close)
[647.019962] Starting subtest: create-fd-close
[647.021576] Subtest create-fd-close: SUCCESS (0.000s)
[647.099943] [105/156] (390s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[647.191090] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[647.192846] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[647.270992] [106/156] (390s left) gem_render_copy (y-tiled-ccs-to-linear)
[647.326432] Starting subtest: y-tiled-ccs-to-linear
[647.327972] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[647.493974] [107/156] (389s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[647.583379] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[647.584362] Starting dynamic subtest: pipe-A-eDP-1
[647.593082] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[647.602971] Starting dynamic subtest: pipe-B-eDP-1
[647.611667] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[647.621712] Starting dynamic subtest: pipe-C-eDP-1
[647.630444] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[647.639571] Starting dynamic subtest: pipe-D-eDP-1
[647.649034] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[647.650804] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[649.849759] [108/156] (387s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[649.897083] Starting subtest: multi-wait-available-unsubmitted-submitted
[649.898230] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[649.973117] [109/156] (387s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt)
[650.063463] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt
[650.065078] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[650.140381] [110/156] (387s left) gem_eio (throttle)
[650.369284] Starting subtest: throttle
[650.717614] Subtest throttle: SUCCESS (0.349s)
[650.804402] [111/156] (386s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[650.902254] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[657.908749] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.019s)
[658.004508] [112/156] (379s left) kms_vrr (lobf)
[658.094932] Starting subtest: lobf
[658.096493] Subtest lobf: SKIP (0.000s)
[658.142420] [113/156] (379s left) fbdev (read)
[658.175958] Starting subtest: read
[658.726558] Subtest read: SUCCESS (0.540s)
[658.763221] [114/156] (378s left) i915_fb_tiling (basic-x-tiling)
[658.817854] Subtest basic-x-tiling: SKIP (0.000s)
[658.876236] [115/156] (378s left) gem_pxp (reject-modify-context-protection-off-2)
[659.002065] Starting subtest: reject-modify-context-protection-off-2
[659.003444] Subtest reject-modify-context-protection-off-2: SUCCESS (0.001s)
[659.083445] [116/156] (378s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[659.178330] Starting subtest: y-tiled-64bpp-rotate-270
[659.180386] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[659.249749] [117/156] (378s left) gem_userptr_blits (sync-overlap)
[659.310561] Starting subtest: sync-overlap
[659.311708] Subtest sync-overlap: SUCCESS (0.000s)
[659.402918] [118/156] (378s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[659.501651] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[659.503474] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[659.570021] [119/156] (378s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-render)
[659.661866] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-render
[659.663781] Subtest hdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[659.732572] [120/156] (378s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[659.835247] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[659.836916] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[659.896471] [121/156] (378s left) kms_pm_rpm (modeset-pc8-residency-stress)
[661.529323] Starting subtest: modeset-pc8-residency-stress
[661.532551] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[662.116913] [122/156] (375s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[662.206934] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[662.208652] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[662.266506] [123/156] (375s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[662.399410] Starting subtest: dp-mst-lic-type-0-hdcp14
[662.401937] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[662.498116] [124/156] (375s left) gem_tiled_blits (interruptible)
[662.565092] Subtest interruptible: SKIP (0.000s)
[662.637721] [125/156] (375s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[662.731079] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[670.076915] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.352s)
[670.201401] [126/156] (367s left) perf_pmu (most-busy-check-all)
[670.235324] Starting subtest: most-busy-check-all
[670.236384] Starting dynamic subtest: rcs0
[672.272073] Dynamic subtest rcs0: SUCCESS (2.028s)
[672.282463] Starting dynamic subtest: bcs0
[674.319816] Dynamic subtest bcs0: SUCCESS (2.046s)
[674.334129] Starting dynamic subtest: vcs0
[676.304091] Dynamic subtest vcs0: SUCCESS (1.980s)
[676.315370] Starting dynamic subtest: vcs1
[678.287774] Dynamic subtest vcs1: SUCCESS (1.980s)
[678.299547] Starting dynamic subtest: vecs0
[680.337751] Dynamic subtest vecs0: SUCCESS (2.047s)
[680.347296] Starting dynamic subtest: ccs0
[682.319800] Dynamic subtest ccs0: SUCCESS (1.979s)
[682.320989] Subtest most-busy-check-all: SUCCESS (12.076s)
[682.387193] [127/156] (355s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[682.474466] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[682.476321] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[682.544254] [128/156] (355s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[682.633304] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[682.635117] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[682.710498] [129/156] (355s left) gem_ctx_persistence (userptr)
[682.776559] Starting subtest: userptr
[682.958555] Subtest userptr: SUCCESS (0.181s)
[683.009598] [130/156] (355s left) kms_atomic_interruptible (universal-setplane-primary)
[683.104625] Starting subtest: universal-setplane-primary
[683.105482] Starting dynamic subtest: pipe-A-eDP-1
[690.494387] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.388s)
[690.495225] Subtest universal-setplane-primary: SUCCESS (7.389s)
[691.314443] [131/156] (346s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[691.406296] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[691.408061] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[691.476754] [132/156] (346s left) i915_pm_rps (min-max-config-idle)
[691.534730] Starting subtest: min-max-config-idle
[691.536846] Subtest min-max-config-idle: SKIP (0.000s)
[691.603294] [133/156] (346s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[691.699211] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[699.243119] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.546s)
[699.341190] [134/156] (339s left) gem_create (create-clear)
[699.386396] Starting subtest: create-clear
[699.387346] Starting dynamic subtest: smem0
[732.251156] Dynamic subtest smem0: SUCCESS (32.873s)
[732.252463] Subtest create-clear: SUCCESS (32.876s)
[732.417280] [135/156] (306s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[732.505113] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[732.506207] Starting dynamic subtest: pipe-A
[732.526968] Dynamic subtest pipe-A: SKIP (0.019s)
[732.539102] Starting dynamic subtest: pipe-B
[732.559444] Dynamic subtest pipe-B: SKIP (0.032s)
[732.569234] Starting dynamic subtest: pipe-C
[732.592544] Dynamic subtest pipe-C: SKIP (0.032s)
[732.602277] Starting dynamic subtest: pipe-D
[732.624797] Dynamic subtest pipe-D: SKIP (0.032s)
[732.626843] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.119s)
[732.711394] [136/156] (305s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[732.814294] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[732.816225] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[732.882262] [137/156] (305s left) gem_ctx_bad_destroy (invalid-ctx)
[732.935439] Starting subtest: invalid-ctx
[732.936547] Subtest invalid-ctx: SUCCESS (0.000s)
[732.983181] [138/156] (305s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[733.076464] Starting subtest: fbc-modesetfrombusy
[736.807090] Subtest fbc-modesetfrombusy: SUCCESS (3.734s)
[737.945666] [139/156] (300s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[738.033107] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[738.034720] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[738.110668] [140/156] (300s left) kms_pipe_crc_basic (suspend-read-crc)
[738.207433] Starting subtest: suspend-read-crc
[738.208389] Starting dynamic subtest: pipe-A-eDP-1
[756.786214] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.956s)
[756.796164] Starting dynamic subtest: pipe-B-eDP-1
[775.808628] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.575s)
[775.819487] Starting dynamic subtest: pipe-C-eDP-1
[794.775232] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.486s)
[794.785276] Starting dynamic subtest: pipe-D-eDP-1
[813.748270] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.389s)
[813.749377] Subtest suspend-read-crc: SUCCESS (13.413s)
[819.604704] [141/156] (224s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[819.695351] Starting subtest: psr2-plane-move-sf-dmg-area
[819.696365] Starting dynamic subtest: pipe-A-eDP-1
[824.223156] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.520s)
[824.234135] Starting dynamic subtest: pipe-B-eDP-1
[829.542356] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.313s)
[829.543252] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.836s)
[830.424245] [142/156] (213s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[830.533184] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[862.650502] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (32.110s)
[863.444473] [143/156] (180s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[863.539370] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[867.684150] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.147s)
[868.856355] [144/156] (175s left) kms_flip (2x-flip-vs-expired-vblank)
[868.948359] Starting subtest: 2x-flip-vs-expired-vblank
[868.958206] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[869.013131] [145/156] (174s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[869.112080] Starting subtest: x-tiled-64bpp-rotate-180
[870.760303] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.648s)
[870.878922] [146/156] (173s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[870.966783] Starting subtest: fbcpsrhdr-modesetfrombusy
[870.969278] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[871.032810] [147/156] (172s left) i915_drm_fdinfo (memory-info-shared)
[871.068606] Starting subtest: memory-info-shared
[871.069665] Starting dynamic subtest: smem0
[871.127718] Dynamic subtest smem0: SUCCESS (0.059s)
[871.129415] Subtest memory-info-shared: SUCCESS (0.059s)
[871.176765] [148/156] (172s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[871.270086] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[871.272224] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[871.341629] [149/156] (172s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[871.438453] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[871.440097] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[871.500326] [150/156] (172s left) gem_mmap_gtt (basic-short)
[871.548462] Subtest basic-short: SKIP (0.000s)
[871.619759] [151/156] (172s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt)
[871.713338] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt
[871.715159] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[871.785057] [152/156] (172s left) syncobj_wait (wait-any-interrupted)
[871.841320] Starting subtest: wait-any-interrupted
[871.958315] Subtest wait-any-interrupted: SUCCESS (0.108s)
[872.000063] [153/156] (172s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[872.096731] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[872.098826] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[872.165159] [154/156] (172s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[872.255037] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[872.256129] Starting dynamic subtest: pipe-A-eDP-1
[872.318509] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[872.330054] Starting dynamic subtest: pipe-B-eDP-1
[872.384345] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.063s)
[872.394464] Starting dynamic subtest: pipe-C-eDP-1
[872.446797] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[872.458034] Starting dynamic subtest: pipe-D-eDP-1
[872.509056] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[872.509981] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.256s)
[874.839437] [155/156] (169s left) gem_mmap_gtt (pf-nonblock)
[874.936996] Subtest pf-nonblock: SKIP (0.000s)
[875.037317] [156/156] (169s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[875.168970] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[875.171026] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[875.298526] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_exec_capture
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_partial_pwrite_pread
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_softpin
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: kms_dsc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_tiled_swapping
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: api_intel_allocator
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: gem_readwrite
results: parsing output: 27/ for test: gen9_exec_parse
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_wait
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_chamelium_edid
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: kms_properties
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: gem_exec_parallel
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_eio
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_async_flips
results: parsing output: 52/ for test: gem_lmem_swapping
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_whisper
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_atomic
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: kms_lease
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: kms_properties
results: parsing output: 66/ for test: api_intel_bb
results: parsing output: 67/ for test: drm_read
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_vrr
results: parsing output: 70/ for test: sriov_basic
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_workarounds
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_cursor_edge_walk
results: parsing output: 76/ for test: gem_mmap_wc
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: prime_vgem
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: sw_sync
results: parsing output: 83/ for test: gem_ctx_create
results: parsing output: 84/ for test: kms_color
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_plane
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: kms_joiner
results: parsing output: 91/ for test: i915_suspend
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_chamelium_color
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: gem_ctx_shared
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: gem_mmap
results: parsing output: 103/ for test: gem_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_vrr
results: parsing output: 112/ for test: fbdev
results: parsing output: 113/ for test: i915_fb_tiling
results: parsing output: 114/ for test: gem_pxp
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: gem_userptr_blits
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_frontbuffer_tracking
results: parsing output: 120/ for test: kms_pm_rpm
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: gem_tiled_blits
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: perf_pmu
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: kms_atomic_interruptible
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: i915_pm_rps
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_create
results: parsing output: 134/ for test: kms_plane_scaling
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_ctx_bad_destroy
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_pipe_crc_basic
results: parsing output: 140/ for test: kms_psr2_sf
results: parsing output: 141/ for test: kms_cursor_legacy
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_flip
results: parsing output: 144/ for test: kms_big_fb
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: i915_drm_fdinfo
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_mmap_gtt
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: syncobj_wait
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_ccs
results: parsing output: 154/ for test: gem_mmap_gtt
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.